builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1461664033.03 results: success (0) buildid: 20160426013609 builduid: a5e98f8cff294f8f9c4a821f14d5edb9 revision: 99fbe8621fa73724446ea9f828a0d30642faa6f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.032928) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.033411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.033724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.100350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.100769) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1461664032.797256-473003316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 02:47:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-04-26 02:47:13 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110741 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.300392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.300722) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1461664032.797256-473003316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016103 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.328611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:13.329041) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99fbe8621fa73724446ea9f828a0d30642faa6f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 99fbe8621fa73724446ea9f828a0d30642faa6f9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1461664032.797256-473003316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 02:47:13,827 truncating revision to first 12 chars 2016-04-26 02:47:13,827 Setting DEBUG logging. 2016-04-26 02:47:13,827 attempt 1/10 2016-04-26 02:47:13,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99fbe8621fa7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 02:47:14,186 unpacking tar archive at: fx-team-99fbe8621fa7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.858933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:14.200906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:14.201222) ========= script_repo_revision: 99fbe8621fa73724446ea9f828a0d30642faa6f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:14.201609) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:14.201900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 02:47:14.211697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-26 02:47:14.212080) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1461664032.797256-473003316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:47:14 INFO - MultiFileLogger online at 20160426 02:47:14 in /builds/slave/test 02:47:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:47:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:47:14 INFO - {'append_to_log': False, 02:47:14 INFO - 'base_work_dir': '/builds/slave/test', 02:47:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:47:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:47:14 INFO - 'branch': 'Fx-Team-Non-PGO', 02:47:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:14 INFO - 'config_files': ('talos/linux_config.py',), 02:47:14 INFO - 'default_actions': ('clobber', 02:47:14 INFO - 'read-buildbot-config', 02:47:14 INFO - 'download-and-extract', 02:47:14 INFO - 'populate-webroot', 02:47:14 INFO - 'create-virtualenv', 02:47:14 INFO - 'install', 02:47:14 INFO - 'run-tests'), 02:47:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:14 INFO - 'download_minidump_stackwalk': True, 02:47:14 INFO - 'download_symbols': 'ondemand', 02:47:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:47:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:47:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:47:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:47:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:14 INFO - 'installer_path': 'installer.exe', 02:47:14 INFO - 'log_level': 'info', 02:47:14 INFO - 'log_name': 'talos', 02:47:14 INFO - 'log_to_console': True, 02:47:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:47:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:47:14 INFO - 'opt_config_files': (), 02:47:14 INFO - 'pip_index': False, 02:47:14 INFO - 'sps_profile': False, 02:47:14 INFO - 'sps_profile_interval': 0, 02:47:14 INFO - 'suite': 'dromaeojs', 02:47:14 INFO - 'system_bits': '32', 02:47:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:14 INFO - 'title': 'talos-linux64-ix-045', 02:47:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:14 INFO - 'use_talos_json': True, 02:47:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:47:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:14 INFO - 'work_dir': 'build'} 02:47:14 INFO - ##### 02:47:14 INFO - ##### Running clobber step. 02:47:14 INFO - ##### 02:47:14 INFO - Running pre-action listener: _resource_record_pre_action 02:47:14 INFO - Running main action method: clobber 02:47:14 INFO - rmtree: /builds/slave/test/build 02:47:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:47:15 INFO - Running post-action listener: _resource_record_post_action 02:47:15 INFO - ##### 02:47:15 INFO - ##### Running read-buildbot-config step. 02:47:15 INFO - ##### 02:47:15 INFO - Running pre-action listener: _resource_record_pre_action 02:47:15 INFO - Running main action method: read_buildbot_config 02:47:15 INFO - Using buildbot properties: 02:47:15 INFO - { 02:47:15 INFO - "project": "", 02:47:15 INFO - "product": "firefox", 02:47:15 INFO - "script_repo_revision": "production", 02:47:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:47:15 INFO - "repository": "", 02:47:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:47:15 INFO - "buildid": "20160426013609", 02:47:15 INFO - "pgo_build": "False", 02:47:15 INFO - "basedir": "/builds/slave/test", 02:47:15 INFO - "buildnumber": 2888, 02:47:15 INFO - "slavename": "talos-linux64-ix-045", 02:47:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:47:15 INFO - "platform": "ubuntu64_hw", 02:47:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:47:15 INFO - "branch": "fx-team", 02:47:15 INFO - "repo_path": "integration/fx-team", 02:47:15 INFO - "revision": "99fbe8621fa73724446ea9f828a0d30642faa6f9", 02:47:15 INFO - "stage_platform": "linux64", 02:47:15 INFO - "builduid": "a5e98f8cff294f8f9c4a821f14d5edb9", 02:47:15 INFO - "slavebuilddir": "test" 02:47:15 INFO - } 02:47:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:47:15 INFO - Running post-action listener: _resource_record_post_action 02:47:15 INFO - ##### 02:47:15 INFO - ##### Running download-and-extract step. 02:47:15 INFO - ##### 02:47:15 INFO - Running pre-action listener: _resource_record_pre_action 02:47:15 INFO - Running main action method: download_and_extract 02:47:15 INFO - mkdir: /builds/slave/test/build/tests 02:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:15 INFO - https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:47:16 INFO - Downloaded 1361 bytes. 02:47:16 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:47:16 INFO - Using the following test package requirements: 02:47:16 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:47:16 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:47:16 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:47:16 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:16 INFO - u'jsshell-linux-x86_64.zip'], 02:47:16 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:47:16 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:47:16 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:47:16 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:47:16 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:47:16 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:47:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:16 INFO - https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:47:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:47:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:47:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:47:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:47:18 INFO - Downloaded 22290132 bytes. 02:47:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:47:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:47:19 INFO - Return code: 0 02:47:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:19 INFO - https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:47:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:47:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:47:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:47:22 INFO - Downloaded 22290132 bytes. 02:47:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:47:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:47:23 INFO - Return code: 0 02:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:23 INFO - https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:47:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:47:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:47:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:47:24 INFO - Downloaded 10840145 bytes. 02:47:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:47:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:47:24 INFO - Return code: 0 02:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:24 INFO - https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:47:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:47:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:47:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:47:26 INFO - Downloaded 54817537 bytes. 02:47:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:47:26 INFO - mkdir: /builds/slave/test/properties 02:47:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:47:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:47:26 INFO - Contents: 02:47:26 INFO - build_url:https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:47:26 INFO - Running post-action listener: _resource_record_post_action 02:47:26 INFO - Running post-action listener: set_extra_try_arguments 02:47:26 INFO - ##### 02:47:26 INFO - ##### Running populate-webroot step. 02:47:26 INFO - ##### 02:47:26 INFO - Running pre-action listener: _resource_record_pre_action 02:47:26 INFO - Running main action method: populate_webroot 02:47:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:47:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:47:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:47:26 INFO - '--tppagecycles', 02:47:26 INFO - '7'], 02:47:26 INFO - 'tests': ['tsvgm']}}, 02:47:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:47:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:47:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:47:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:47:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:26 INFO - 'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:26 INFO - 'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['damp', 'tps']}, 02:47:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:26 INFO - 'tests': ['damp', 'tps']}, 02:47:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['dromaeo_dom']}, 02:47:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:47:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['a11yr', 02:47:26 INFO - 'ts_paint', 02:47:26 INFO - 'tpaint', 02:47:26 INFO - 'sessionrestore', 02:47:26 INFO - 'sessionrestore_no_auto_restore', 02:47:26 INFO - 'tabpaint']}, 02:47:26 INFO - 'other-e10s': {'tests': ['a11yr', 02:47:26 INFO - 'ts_paint', 02:47:26 INFO - 'tpaint', 02:47:26 INFO - 'sessionrestore', 02:47:26 INFO - 'sessionrestore_no_auto_restore', 02:47:26 INFO - 'tabpaint']}, 02:47:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:47:26 INFO - 'ts_paint', 02:47:26 INFO - 'tpaint', 02:47:26 INFO - 'sessionrestore', 02:47:26 INFO - 'sessionrestore_no_auto_restore', 02:47:26 INFO - 'tabpaint']}, 02:47:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:47:26 INFO - 'ts_paint', 02:47:26 INFO - 'tpaint', 02:47:26 INFO - 'sessionrestore', 02:47:26 INFO - 'sessionrestore_no_auto_restore', 02:47:26 INFO - 'tabpaint']}, 02:47:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['a11yr', 02:47:26 INFO - 'ts_paint', 02:47:26 INFO - 'tpaint', 02:47:26 INFO - 'sessionrestore', 02:47:26 INFO - 'sessionrestore_no_auto_restore', 02:47:26 INFO - 'tabpaint']}, 02:47:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['a11yr', 02:47:26 INFO - 'ts_paint', 02:47:26 INFO - 'tpaint', 02:47:26 INFO - 'sessionrestore', 02:47:26 INFO - 'sessionrestore_no_auto_restore', 02:47:26 INFO - 'tabpaint']}, 02:47:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['tsvgx', 02:47:26 INFO - 'tsvgr_opacity', 02:47:26 INFO - 'tart', 02:47:26 INFO - 'tscrollx', 02:47:26 INFO - 'cart']}, 02:47:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:47:26 INFO - 'tsvgr_opacity', 02:47:26 INFO - 'tart', 02:47:26 INFO - 'tscrollx', 02:47:26 INFO - 'cart']}, 02:47:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:26 INFO - 'talos_options': ['--disable-e10s'], 02:47:26 INFO - 'tests': ['tp5o']}, 02:47:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:26 INFO - 'tests': ['tp5o']}, 02:47:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:26 INFO - 'talos_options': ['--disable-e10s', 02:47:26 INFO - '--xperf_path', 02:47:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:26 INFO - 'tests': ['tp5n']}, 02:47:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:26 INFO - 'talos_options': ['--xperf_path', 02:47:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:26 INFO - 'tests': ['tp5n']}}, 02:47:26 INFO - 'talos.zip': {'path': '', 02:47:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:47:26 INFO - Running post-action listener: _resource_record_post_action 02:47:26 INFO - ##### 02:47:26 INFO - ##### Running create-virtualenv step. 02:47:26 INFO - ##### 02:47:26 INFO - Running pre-action listener: _resource_record_pre_action 02:47:26 INFO - Running main action method: create_virtualenv 02:47:26 INFO - Creating virtualenv /builds/slave/test/build/venv 02:47:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:47:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:47:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:47:27 INFO - Using real prefix '/usr' 02:47:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:47:27 INFO - Installing distribute.............................................................................................................................................................................................done. 02:47:29 INFO - Installing pip.................done. 02:47:29 INFO - Return code: 0 02:47:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:47:29 INFO - Using env: {'DISPLAY': ':0', 02:47:29 INFO - 'HOME': '/home/cltbld', 02:47:29 INFO - 'LANG': 'en_US.UTF-8', 02:47:29 INFO - 'LANGUAGE': 'en_US:en', 02:47:29 INFO - 'LOGNAME': 'cltbld', 02:47:29 INFO - 'MAIL': '/var/mail/cltbld', 02:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:29 INFO - 'MOZ_NO_REMOTE': '1', 02:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:29 INFO - 'NO_EM_RESTART': '1', 02:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:29 INFO - 'PWD': '/builds/slave/test', 02:47:29 INFO - 'SHELL': '/bin/bash', 02:47:29 INFO - 'SHLVL': '1', 02:47:29 INFO - 'TERM': 'linux', 02:47:29 INFO - 'TMOUT': '86400', 02:47:29 INFO - 'USER': 'cltbld', 02:47:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:29 INFO - '_': '/tools/buildbot/bin/python'} 02:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:47:29 INFO - Cleaning up... 02:47:29 INFO - Return code: 0 02:47:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:47:29 INFO - Using env: {'DISPLAY': ':0', 02:47:29 INFO - 'HOME': '/home/cltbld', 02:47:29 INFO - 'LANG': 'en_US.UTF-8', 02:47:29 INFO - 'LANGUAGE': 'en_US:en', 02:47:29 INFO - 'LOGNAME': 'cltbld', 02:47:29 INFO - 'MAIL': '/var/mail/cltbld', 02:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:29 INFO - 'MOZ_NO_REMOTE': '1', 02:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:29 INFO - 'NO_EM_RESTART': '1', 02:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:29 INFO - 'PWD': '/builds/slave/test', 02:47:29 INFO - 'SHELL': '/bin/bash', 02:47:29 INFO - 'SHLVL': '1', 02:47:29 INFO - 'TERM': 'linux', 02:47:29 INFO - 'TMOUT': '86400', 02:47:29 INFO - 'USER': 'cltbld', 02:47:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:29 INFO - '_': '/tools/buildbot/bin/python'} 02:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:29 INFO - Downloading/unpacking psutil>=0.7.1 02:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:47:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:31 INFO - Installing collected packages: psutil 02:47:31 INFO - Running setup.py install for psutil 02:47:32 INFO - building 'psutil._psutil_linux' extension 02:47:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:47:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:47:32 INFO - building 'psutil._psutil_posix' extension 02:47:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:47:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:47:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:32 INFO - Successfully installed psutil 02:47:32 INFO - Cleaning up... 02:47:32 INFO - Return code: 0 02:47:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:47:32 INFO - Using env: {'DISPLAY': ':0', 02:47:32 INFO - 'HOME': '/home/cltbld', 02:47:32 INFO - 'LANG': 'en_US.UTF-8', 02:47:32 INFO - 'LANGUAGE': 'en_US:en', 02:47:32 INFO - 'LOGNAME': 'cltbld', 02:47:32 INFO - 'MAIL': '/var/mail/cltbld', 02:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:32 INFO - 'MOZ_NO_REMOTE': '1', 02:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:32 INFO - 'NO_EM_RESTART': '1', 02:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:32 INFO - 'PWD': '/builds/slave/test', 02:47:32 INFO - 'SHELL': '/bin/bash', 02:47:32 INFO - 'SHLVL': '1', 02:47:32 INFO - 'TERM': 'linux', 02:47:32 INFO - 'TMOUT': '86400', 02:47:32 INFO - 'USER': 'cltbld', 02:47:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:32 INFO - '_': '/tools/buildbot/bin/python'} 02:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:47:34 INFO - Installing collected packages: mozsystemmonitor 02:47:34 INFO - Running setup.py install for mozsystemmonitor 02:47:34 INFO - Successfully installed mozsystemmonitor 02:47:34 INFO - Cleaning up... 02:47:34 INFO - Return code: 0 02:47:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:47:34 INFO - Using env: {'DISPLAY': ':0', 02:47:34 INFO - 'HOME': '/home/cltbld', 02:47:34 INFO - 'LANG': 'en_US.UTF-8', 02:47:34 INFO - 'LANGUAGE': 'en_US:en', 02:47:34 INFO - 'LOGNAME': 'cltbld', 02:47:34 INFO - 'MAIL': '/var/mail/cltbld', 02:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:34 INFO - 'MOZ_NO_REMOTE': '1', 02:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:34 INFO - 'NO_EM_RESTART': '1', 02:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:34 INFO - 'PWD': '/builds/slave/test', 02:47:34 INFO - 'SHELL': '/bin/bash', 02:47:34 INFO - 'SHLVL': '1', 02:47:34 INFO - 'TERM': 'linux', 02:47:34 INFO - 'TMOUT': '86400', 02:47:34 INFO - 'USER': 'cltbld', 02:47:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:34 INFO - '_': '/tools/buildbot/bin/python'} 02:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:34 INFO - Downloading/unpacking blobuploader==1.2.4 02:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:47:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:47:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:37 INFO - Downloading docopt-0.6.1.tar.gz 02:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:47:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:47:37 INFO - Running setup.py install for blobuploader 02:47:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:47:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:47:37 INFO - Running setup.py install for requests 02:47:37 INFO - Running setup.py install for docopt 02:47:38 INFO - Successfully installed blobuploader requests docopt 02:47:38 INFO - Cleaning up... 02:47:38 INFO - Return code: 0 02:47:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:47:38 INFO - Using env: {'DISPLAY': ':0', 02:47:38 INFO - 'HOME': '/home/cltbld', 02:47:38 INFO - 'LANG': 'en_US.UTF-8', 02:47:38 INFO - 'LANGUAGE': 'en_US:en', 02:47:38 INFO - 'LOGNAME': 'cltbld', 02:47:38 INFO - 'MAIL': '/var/mail/cltbld', 02:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:38 INFO - 'MOZ_NO_REMOTE': '1', 02:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:38 INFO - 'NO_EM_RESTART': '1', 02:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:38 INFO - 'PWD': '/builds/slave/test', 02:47:38 INFO - 'SHELL': '/bin/bash', 02:47:38 INFO - 'SHLVL': '1', 02:47:38 INFO - 'TERM': 'linux', 02:47:38 INFO - 'TMOUT': '86400', 02:47:38 INFO - 'USER': 'cltbld', 02:47:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:38 INFO - '_': '/tools/buildbot/bin/python'} 02:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:38 INFO - Running setup.py (path:/tmp/pip-qnlns1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:38 INFO - Running setup.py (path:/tmp/pip-659MlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:38 INFO - Running setup.py (path:/tmp/pip-HJndUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:38 INFO - Running setup.py (path:/tmp/pip-r2e6LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:38 INFO - Running setup.py (path:/tmp/pip-lTeiUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:38 INFO - Running setup.py (path:/tmp/pip-dD1PgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:38 INFO - Running setup.py (path:/tmp/pip-Gf4e7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:38 INFO - Running setup.py (path:/tmp/pip-hcgLFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:38 INFO - Running setup.py (path:/tmp/pip-A9rq0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:39 INFO - Running setup.py (path:/tmp/pip-uXRitx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:39 INFO - Running setup.py (path:/tmp/pip-FFZyeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:39 INFO - Running setup.py (path:/tmp/pip-eZ3J0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:39 INFO - Running setup.py (path:/tmp/pip-zH3wlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:39 INFO - Running setup.py (path:/tmp/pip-XFJ0os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:39 INFO - Running setup.py (path:/tmp/pip-ez0iJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:39 INFO - Running setup.py (path:/tmp/pip-h7IlG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:39 INFO - Running setup.py (path:/tmp/pip-nK9msY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:47:39 INFO - Running setup.py install for manifestparser 02:47:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:47:39 INFO - Running setup.py install for mozcrash 02:47:39 INFO - Running setup.py install for mozdebug 02:47:39 INFO - Running setup.py install for mozdevice 02:47:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Running setup.py install for mozfile 02:47:40 INFO - Running setup.py install for mozhttpd 02:47:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Running setup.py install for mozinfo 02:47:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Running setup.py install for mozInstall 02:47:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Running setup.py install for mozleak 02:47:40 INFO - Running setup.py install for mozlog 02:47:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Running setup.py install for moznetwork 02:47:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Running setup.py install for mozprocess 02:47:40 INFO - Running setup.py install for mozprofile 02:47:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:47:40 INFO - Running setup.py install for mozrunner 02:47:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:47:41 INFO - Running setup.py install for mozscreenshot 02:47:41 INFO - Running setup.py install for moztest 02:47:41 INFO - Running setup.py install for mozversion 02:47:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:47:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:47:41 INFO - Cleaning up... 02:47:41 INFO - Return code: 0 02:47:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:47:41 INFO - Using env: {'DISPLAY': ':0', 02:47:41 INFO - 'HOME': '/home/cltbld', 02:47:41 INFO - 'LANG': 'en_US.UTF-8', 02:47:41 INFO - 'LANGUAGE': 'en_US:en', 02:47:41 INFO - 'LOGNAME': 'cltbld', 02:47:41 INFO - 'MAIL': '/var/mail/cltbld', 02:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:41 INFO - 'MOZ_NO_REMOTE': '1', 02:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:41 INFO - 'NO_EM_RESTART': '1', 02:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:41 INFO - 'PWD': '/builds/slave/test', 02:47:41 INFO - 'SHELL': '/bin/bash', 02:47:41 INFO - 'SHLVL': '1', 02:47:41 INFO - 'TERM': 'linux', 02:47:41 INFO - 'TMOUT': '86400', 02:47:41 INFO - 'USER': 'cltbld', 02:47:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:41 INFO - '_': '/tools/buildbot/bin/python'} 02:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:41 INFO - Running setup.py (path:/tmp/pip-OSJ5_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:41 INFO - Running setup.py (path:/tmp/pip-oa3Glm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:41 INFO - Running setup.py (path:/tmp/pip-2vnLRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:41 INFO - Running setup.py (path:/tmp/pip-sAKMB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:41 INFO - Running setup.py (path:/tmp/pip-cyBG3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:41 INFO - Running setup.py (path:/tmp/pip-anIRRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:42 INFO - Running setup.py (path:/tmp/pip-_yaQIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:42 INFO - Running setup.py (path:/tmp/pip-Am4cJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:42 INFO - Running setup.py (path:/tmp/pip-EzXaz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:42 INFO - Running setup.py (path:/tmp/pip-ftSsRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:42 INFO - Running setup.py (path:/tmp/pip-mvnQfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:42 INFO - Running setup.py (path:/tmp/pip-qXywYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:42 INFO - Running setup.py (path:/tmp/pip-i_9JaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:42 INFO - Running setup.py (path:/tmp/pip-p7KMWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:42 INFO - Running setup.py (path:/tmp/pip-5LgPOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:42 INFO - Running setup.py (path:/tmp/pip-VsD0UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:42 INFO - Running setup.py (path:/tmp/pip-vb2aEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:47:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:44 INFO - Downloading blessings-1.6.tar.gz 02:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:47:44 INFO - Installing collected packages: blessings 02:47:44 INFO - Running setup.py install for blessings 02:47:44 INFO - Successfully installed blessings 02:47:44 INFO - Cleaning up... 02:47:44 INFO - Return code: 0 02:47:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:45 INFO - Reading from file tmpfile_stdout 02:47:45 INFO - Current package versions: 02:47:45 INFO - argparse == 1.2.1 02:47:45 INFO - blessings == 1.6 02:47:45 INFO - blobuploader == 1.2.4 02:47:45 INFO - docopt == 0.6.1 02:47:45 INFO - manifestparser == 1.1 02:47:45 INFO - mozInstall == 1.12 02:47:45 INFO - mozcrash == 0.17 02:47:45 INFO - mozdebug == 0.1 02:47:45 INFO - mozdevice == 0.48 02:47:45 INFO - mozfile == 1.2 02:47:45 INFO - mozhttpd == 0.7 02:47:45 INFO - mozinfo == 0.9 02:47:45 INFO - mozleak == 0.1 02:47:45 INFO - mozlog == 3.1 02:47:45 INFO - moznetwork == 0.27 02:47:45 INFO - mozprocess == 0.22 02:47:45 INFO - mozprofile == 0.28 02:47:45 INFO - mozrunner == 6.11 02:47:45 INFO - mozscreenshot == 0.1 02:47:45 INFO - mozsystemmonitor == 0.0 02:47:45 INFO - moztest == 0.7 02:47:45 INFO - mozversion == 1.4 02:47:45 INFO - psutil == 3.1.1 02:47:45 INFO - requests == 1.2.3 02:47:45 INFO - wsgiref == 0.1.2 02:47:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:47:45 INFO - Using env: {'DISPLAY': ':0', 02:47:45 INFO - 'HOME': '/home/cltbld', 02:47:45 INFO - 'LANG': 'en_US.UTF-8', 02:47:45 INFO - 'LANGUAGE': 'en_US:en', 02:47:45 INFO - 'LOGNAME': 'cltbld', 02:47:45 INFO - 'MAIL': '/var/mail/cltbld', 02:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:45 INFO - 'MOZ_NO_REMOTE': '1', 02:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:45 INFO - 'NO_EM_RESTART': '1', 02:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:45 INFO - 'PWD': '/builds/slave/test', 02:47:45 INFO - 'SHELL': '/bin/bash', 02:47:45 INFO - 'SHLVL': '1', 02:47:45 INFO - 'TERM': 'linux', 02:47:45 INFO - 'TMOUT': '86400', 02:47:45 INFO - 'USER': 'cltbld', 02:47:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:45 INFO - '_': '/tools/buildbot/bin/python'} 02:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:47:45 INFO - Cleaning up... 02:47:45 INFO - Return code: 0 02:47:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:47:45 INFO - Using env: {'DISPLAY': ':0', 02:47:45 INFO - 'HOME': '/home/cltbld', 02:47:45 INFO - 'LANG': 'en_US.UTF-8', 02:47:45 INFO - 'LANGUAGE': 'en_US:en', 02:47:45 INFO - 'LOGNAME': 'cltbld', 02:47:45 INFO - 'MAIL': '/var/mail/cltbld', 02:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:45 INFO - 'MOZ_NO_REMOTE': '1', 02:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:45 INFO - 'NO_EM_RESTART': '1', 02:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:45 INFO - 'PWD': '/builds/slave/test', 02:47:45 INFO - 'SHELL': '/bin/bash', 02:47:45 INFO - 'SHLVL': '1', 02:47:45 INFO - 'TERM': 'linux', 02:47:45 INFO - 'TMOUT': '86400', 02:47:45 INFO - 'USER': 'cltbld', 02:47:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:45 INFO - '_': '/tools/buildbot/bin/python'} 02:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:45 INFO - Downloading/unpacking jsonschema 02:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:47:47 INFO - Downloading/unpacking functools32 (from jsonschema) 02:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:47 INFO - Downloading functools32-3.2.3-2.tar.gz 02:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:47:47 INFO - warning: no files found matching '*.txt' 02:47:47 INFO - no previously-included directories found matching 'build' 02:47:47 INFO - no previously-included directories found matching 'dist' 02:47:47 INFO - no previously-included directories found matching '.git*' 02:47:47 INFO - Installing collected packages: jsonschema, functools32 02:47:47 INFO - Running setup.py install for functools32 02:47:47 INFO - warning: no files found matching '*.txt' 02:47:47 INFO - no previously-included directories found matching 'build' 02:47:47 INFO - no previously-included directories found matching 'dist' 02:47:47 INFO - no previously-included directories found matching '.git*' 02:47:47 INFO - Successfully installed jsonschema functools32 02:47:47 INFO - Cleaning up... 02:47:47 INFO - Return code: 0 02:47:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b0d8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:47:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:47:47 INFO - Using env: {'DISPLAY': ':0', 02:47:47 INFO - 'HOME': '/home/cltbld', 02:47:47 INFO - 'LANG': 'en_US.UTF-8', 02:47:47 INFO - 'LANGUAGE': 'en_US:en', 02:47:47 INFO - 'LOGNAME': 'cltbld', 02:47:47 INFO - 'MAIL': '/var/mail/cltbld', 02:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:47 INFO - 'MOZ_NO_REMOTE': '1', 02:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:47 INFO - 'NO_EM_RESTART': '1', 02:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:47 INFO - 'PWD': '/builds/slave/test', 02:47:47 INFO - 'SHELL': '/bin/bash', 02:47:47 INFO - 'SHLVL': '1', 02:47:47 INFO - 'TERM': 'linux', 02:47:47 INFO - 'TMOUT': '86400', 02:47:47 INFO - 'USER': 'cltbld', 02:47:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:47 INFO - '_': '/tools/buildbot/bin/python'} 02:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:48 INFO - Downloading/unpacking flake8 02:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:47:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:47:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:47:50 INFO - no previously-included directories found matching 'docs/_build' 02:47:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:47:50 INFO - Running setup.py install for pep8 02:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:47:50 INFO - no previously-included directories found matching 'docs/_build' 02:47:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:47:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:47:50 INFO - Cleaning up... 02:47:51 INFO - Return code: 0 02:47:51 INFO - Running post-action listener: _resource_record_post_action 02:47:51 INFO - Running post-action listener: _start_resource_monitoring 02:47:51 INFO - Starting resource monitoring. 02:47:51 INFO - ##### 02:47:51 INFO - ##### Running install step. 02:47:51 INFO - ##### 02:47:51 INFO - Running pre-action listener: _resource_record_pre_action 02:47:51 INFO - Running main action method: install 02:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:51 INFO - Reading from file tmpfile_stdout 02:47:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:47:51 INFO - Reading from file tmpfile_stdout 02:47:51 INFO - Output received: 02:47:51 INFO - Usage: mozinstall [options] installer 02:47:51 INFO - Options: 02:47:51 INFO - -h, --help show this help message and exit 02:47:51 INFO - -d DEST, --destination=DEST 02:47:51 INFO - Directory to install application into. [default: 02:47:51 INFO - "/builds/slave/test"] 02:47:51 INFO - --app=APP Application being installed. [default: firefox] 02:47:51 INFO - mkdir: /builds/slave/test/build/application 02:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:48:07 INFO - Reading from file tmpfile_stdout 02:48:07 INFO - Output received: 02:48:07 INFO - /builds/slave/test/build/application/firefox/firefox 02:48:07 INFO - Running post-action listener: _resource_record_post_action 02:48:07 INFO - ##### 02:48:07 INFO - ##### Running run-tests step. 02:48:07 INFO - ##### 02:48:07 INFO - Running pre-action listener: _resource_record_pre_action 02:48:07 INFO - Running main action method: run_tests 02:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:48:07 INFO - Python 2.7.3 02:48:07 INFO - Return code: 0 02:48:07 INFO - grabbing minidump binary from tooltool 02:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:48:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:48:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:48:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:48:07 INFO - Return code: 0 02:48:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:48:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:48:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:48:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:48:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:48:08 INFO - Return code: 0 02:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:48:08 INFO - Using env: {'DISPLAY': ':0', 02:48:08 INFO - 'HOME': '/home/cltbld', 02:48:08 INFO - 'LANG': 'en_US.UTF-8', 02:48:08 INFO - 'LANGUAGE': 'en_US:en', 02:48:08 INFO - 'LOGNAME': 'cltbld', 02:48:08 INFO - 'MAIL': '/var/mail/cltbld', 02:48:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:48:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:08 INFO - 'MOZ_NO_REMOTE': '1', 02:48:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:08 INFO - 'NO_EM_RESTART': '1', 02:48:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:08 INFO - 'PWD': '/builds/slave/test', 02:48:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:48:08 INFO - 'SHELL': '/bin/bash', 02:48:08 INFO - 'SHLVL': '1', 02:48:08 INFO - 'TERM': 'linux', 02:48:08 INFO - 'TMOUT': '86400', 02:48:08 INFO - 'USER': 'cltbld', 02:48:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461664032.797256-473003316', 02:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:08 INFO - '_': '/tools/buildbot/bin/python'} 02:48:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:48:08 INFO - mozversion application_buildid: 20160426013609 02:48:08 INFO - mozversion application_changeset: 99fbe8621fa73724446ea9f828a0d30642faa6f9 02:48:08 INFO - mozversion application_display_name: Nightly 02:48:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:48:08 INFO - mozversion application_name: Firefox 02:48:08 INFO - mozversion application_remotingname: firefox 02:48:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:48:08 INFO - mozversion application_vendor: Mozilla 02:48:08 INFO - mozversion application_version: 49.0a1 02:48:08 INFO - mozversion platform_buildid: 20160426013609 02:48:08 INFO - mozversion platform_changeset: 99fbe8621fa73724446ea9f828a0d30642faa6f9 02:48:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:48:08 INFO - mozversion platform_version: 49.0a1 02:48:08 INFO - using testdate: 1461664088 02:48:08 INFO - actual date: 1461664088 02:48:08 INFO - starting webserver on 'localhost:59933' 02:48:08 INFO - SUITE-START | Running 2 tests 02:48:08 INFO - TEST-START | dromaeo_css 02:48:08 INFO - operating with platform_type : linux_ 02:48:08 INFO - Initialising browser for dromaeo_css test... 02:48:08 INFO - TEST-INFO | started process 18510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSxhWEt/profile http://localhost:59933/getInfo.html) 02:48:12 INFO - PROCESS | 18510 | __metrics Screen width/height:1600/1200 02:48:12 INFO - PROCESS | 18510 | colorDepth:24 02:48:12 INFO - PROCESS | 18510 | Browser inner width/height: 1024/697 02:48:12 INFO - PROCESS | 18510 | __metrics 02:48:13 ERROR - PROCESS | 18510 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:48:14 INFO - TEST-INFO | 18510: exit 0 02:48:14 INFO - Browser initialized. 02:48:14 INFO - Running cycle 1/1 for dromaeo_css test... 02:48:14 INFO - TEST-INFO | started process 18590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSxhWEt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:26 INFO - PROCESS | 18590 | RSS: Main: 155807744 02:48:26 INFO - PROCESS | 18590 | 02:49:17 INFO - PROCESS | 18590 | 1461664157677 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:51:29 INFO - PROCESS | 18590 | Cycle 1(1): loaded http://localhost:59933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59933/tests/dromaeo/cssquery-ext.html) 02:51:30 INFO - PROCESS | 18590 | RSS: Main: 255754240 02:51:30 INFO - PROCESS | 18590 | 02:54:32 INFO - PROCESS | 18590 | Cycle 1(1): loaded http://localhost:59933/tests/dromaeo/cssquery-ext.html (next: http://localhost:59933/tests/dromaeo/cssquery-jquery.html) 02:54:33 INFO - PROCESS | 18590 | RSS: Main: 239685632 02:54:33 INFO - PROCESS | 18590 | 02:57:35 INFO - PROCESS | 18590 | Cycle 1(1): loaded http://localhost:59933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59933/tests/dromaeo/cssquery-mootools.html) 02:57:35 INFO - PROCESS | 18590 | RSS: Main: 241848320 02:57:35 INFO - PROCESS | 18590 | 03:00:37 INFO - PROCESS | 18590 | Cycle 1(1): loaded http://localhost:59933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59933/tests/dromaeo/cssquery-prototype.html) 03:00:38 INFO - PROCESS | 18590 | RSS: Main: 231522304 03:00:38 INFO - PROCESS | 18590 | 03:03:41 INFO - PROCESS | 18590 | Cycle 1(1): loaded http://localhost:59933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59933/tests/dromaeo/cssquery-yui.html) 03:03:42 INFO - PROCESS | 18590 | RSS: Main: 216924160 03:03:42 INFO - PROCESS | 18590 | 03:06:44 INFO - PROCESS | 18590 | Cycle 1(1): loaded http://localhost:59933/tests/dromaeo/cssquery-yui.html (next: http://localhost:59933/tests/dromaeo/cssquery-dojo.html) 03:06:45 INFO - PROCESS | 18590 | RSS: Main: 274763776 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - PROCESS | 18590 | __start_tp_report 03:06:45 INFO - PROCESS | 18590 | _x_x_mozilla_page_load 03:06:45 INFO - PROCESS | 18590 | _x_x_mozilla_page_load_details 03:06:45 INFO - PROCESS | 18590 | |i|pagename|runs| 03:06:45 INFO - PROCESS | 18590 | |0;dojo.html;2561.385267535791;2608.934776630584;2617.306413800344;2632.512985097757;2680.3299175206193;4546.545345465452;4560.429946256718;4585.770711464426;4634.95365046349;4644.6516511261625;4580.061087477067;4617.284320930253;4677.1347300749385;4714.198586240339;4738.834140805073;4193.769342686151;4194.601512856274;4207.453031105952;4217.43064686268;4373.868783936487;4330.523642399334;4337.63130133939;4352.151330490556;4390.429244198266;4391.36325232841;4212.810423530948;4266.509351424595;4303.074838909618;4305.806238719265;4309.935350969738;4215.262329092397;4261.998430368861;4262.403263543107;4264.87205383839;4308.763018034007;4273.038566322583;4300.892477688051;4303.117860838521;4323.6757243206885;4334.371516130143;4330.718503297276;4489;4584.426946631671;4596.724196548184;4604.861854144381;4946.851594452172;4961.18140506816;4963.1810751226;4963.950360496421;5008.574271186917;4949.975250123726;4971.751412429364;4986.40163180417;4996.875078123039;5030.547250747413;4475.239209334421;4573.794179261941;4612.5156858530045;4654.534546545318;4655.185342565038;4989.90020199594;5014.323066385991;5056.140456122468;5065.11360511909;5065.645404821627;4727.692699974491;4857.8299759508245;4859.246816743411;4863.513648635108;4919.606431485473;4940.135476291634;5022.723750193702;5034.0686972910125;5037.622178336639;5042.42012168598;4857.635677324215;4871.634627402959;4873.244647079638;4884.902301954012;4932.235503496964;4809.206480930678;4856.878578035577;4856.902861942742;4881.316615673809;4917.311576379309;4128.195001974646;4172.77049762266;4173.08192197716;4174.4364510791265;4176.540580536139;3677.3196958562216;3683.4658974448553;3741.513603231617;3748.8125593720206;3777.414500752388;4285.914281714348;4287.63555097814;4287.785610719451;4307.870763877088;4331.5884990925815;4946.4558898521855;4972.751362431936;4990.126727822617;4995.725235112103;5039.21892106724;4197.034682023091;4250.787460627018;4281.636060934856;4303.634191093792;4334.869953901388;4476.753778542146;4500.932486012713;4503.211937910853;4505.774711264424;4549.181147393501;4641.396618439581;4707.646926480459;4711.8350857719815;4717.551832575899;4750.026244619845;4827.131116399082;4929.876753081202;5015.04714104319;5027.673201241908;5036.29491871131;4654.16225079489;4664.696794708333;4667.369905062773;4685.882852928704;4706.129366067288;4815.662903596714;4857.465678775403;4859.007340160412;4859.635527335535;4910.042541704333;4852.805887764591;4873.390826146731;4932.4081110267;4964;4983.078130545716;4720.291956206596;4736.19484687597;4763.54746299101;4766.3327134200545;4808.639352048541;4609.953900460952;4766.308885211555;4778.904421911612;4779.283107533898;4831.396075490564;4722.362481065013;4727.929081063718;4775.952240477551;4797.880052998703;4832.371791667061;4836.540528649773;4869.172240719157;4874.731889746098;4878.707277563358;4930.556249937523;4624.745638989888;4704.270838020112;4778.139934811628;4780.95219047805;4816.20532612115 03:06:45 INFO - PROCESS | 18590 | |1;ext.html;549.5596901277892;575.7437940116648;582.2518064287389;596.4333882811329;604.1662505742075;27154.321141971435;27780.861095694494;27826;33543;34928.82535587325;38091;38790.8060459698;38830.417543736796;38876.80561597188;38893.61106388935;7381.409487241035;7660.310572048515;7664.348530374925;7667.501612395176;7671.424643151758;7598.772036838904;7737.226277372246;7761.41789365797;7771.494852834576;7777;7902.881456778153;7966.5618390988475;7987.440879138463;7987.920120798775;7993.44045916786;7864.331531819745;7880.330171935364;7930.722424715107;7946.483478573903;7961.72133975308;7674.46278760487;7792.727254546064;7808.960955195244;7809.101953275333;7810.570418626973;37326;37948;38022.23955520902;38139.42790858139;38404.23191536154;3066.23344163959;3177.3486435280943;3214.212517933098;3554.608993010767;3680.061584296014;29147.562786558217;29254.41491170186;29709;30187.09438716842;30641.846790766125;3507.7018453431233;3535.3636345457808;3546.078019714893;3555.928881422357;3743.8689645862537;243118;243625;244475.5538445385;244644;245090.61820363367;30255;30544.847275763925;30698.23254418613;30827.69172308293;53495.73252133792;31840.840795795873;32017.519737203962;32058.839705801787;32090;32091.518627220612;13705.246211458267;13954.162750234815;13956.581302560939;13957.79063314051;13962.930185349009;11479.598214062635;11598.768024639628;11636;11639.825402618968;11796.587119450778;8123.903273058179;8174.877376839352;8205.671773129128;8263.297619702273;8281.710140145187;3158.8578513966468;3208.2941752814345;3213.084270982759;3246.188452886778;3257.299680568689;883.8762573239752;894.2577660541734;911.8449863523217;926.7822061815468;1061.9203559732896;27628.723712763018;28498.715012849607;28656;28967.855160724484;29236.26909327284;990.8860481044628;994.0755097759153;1003.4130033930232;1029.8300780371305;1077.8221593437152;15013.898990704141;15433;15618.609534761494;15687.68624627501;15850.286737096858;330494;333172;336860;337075;337444;50669.49330506648;51348.74325628423;51526.22710659343;51563.74218128961;51600.22599661008;1072.7371793910386;1253.6489782860813;1261.9873801262054;1277.1506947879557;1359.2592037339673;25783;26433.60349594719;26768.33079173036;27973.860130699217;28576.714232857405;34698.479522807684;34810.82594587011;34848.340924202595;34860.477092844136;34918.47622285617;184088;184354.48632379904;184856;184937;185702;20958.735803258674;23632.645510317703;24341.634875477237;24389.3902652428;25687;36938.44592331171;37393.6260637401;37442.812785935894;38054.80972595119;38393.23213535658;32727;32886.177845553095;34848.128796780285;35455;35609.93170204898;33931.4910276351;33994.490082649274;34621;34929.65070349264;35058.298834022666;33339.333213335114;34512.48231276483;34553.30893382068;34790.65209347874;34820.477692835135;29270.70729292765;29684.25789355197;30207.395852083275;31297.687023130387;32256;24455.266342009767;24650.63024054605;24693.753062469146;24975.3653113873;25142 03:06:45 INFO - PROCESS | 18590 | |2;jquery.html;374.84631301166525;384.6691845013288;390.8690588652801;396.85713143268435;401.76295985368625;16558.751618725713;17123.31506739732;18093.638127237464;18122.728159077607;18139.637207255848;16102.59743506413;16550.66898662026;16568.75146872798;16765.91617041916;16780.66438671226;4971.776270067838;5096.4648711885275;5153.1754919212935;5160.483951604847;5166.863290076177;3746.775193488386;3954.4266081418177;5464.890702185954;5937.821865344046;5952.970235148819;5822.272215973004;5865.35481097079;5875.529957603403;5879.11813228017;5907.025340818781;5744.080947048473;5852;5884.117382392633;5886.440788125143;5889.381614930435;3434.107132145635;4985.376827896513;5256.92114618281;5258.6581872178185;5259.894802103975;19681.40955771329;19850.20599176031;21253.256136035165;22490;22527.211547595754;2133.807957283852;2199.4941163532317;2550.3114159176916;2641.867906604662;2719.116287206646;12907.806382904264;13589.184648921097;13959.930200349036;14448.711025779425;14836.925815370962;1789.0965062643281;1811.473989154921;1812.6586326118577;1837.4395809278165;1865.4776662534512;77236.61381693055;79922;80236.59881700554;81331.18668813354;81361;16215.756763648555;16371.508854734377;16479.752803707954;16834;16998.57503562421;30154.09537713872;30454.390912182076;30516.237094072825;30595.38809223803;30663.84668076645;8557.700480483278;8689.348298877483;8892.688755893512;8947.284217262733;9385.62457501706;7236.782896513113;7338.743143990041;7423.85152296951;7550.509216900884;7554;8434.831303373898;8521.659133634708;8533.53065581399;8557.743267701979;8632.870506942401;2791.6650001999483;3191.1064901827526;3214.533892585562;3298.7690861639453;3626.9818650906577;827.210014436212;864.9437786543855;891.1534042659499;948.5399581203111;981.5582987655583;16066.27701753424;16486.587835303973;17508.12459377026;18591.90704046471;18623.90688046551;838.9748307550783;875.6409871952469;899.1862364560084;912.2975309012156;993.9900600993898;9401;9804.264680149017;9896.406215627085;9908.603655853829;9990.200783937267;373094;379014;381568;383899;389523;79203;83899.5805020971;86708.56645716731;86904.13095869088;87065.56467217623;944.3625552751865;957.9568919398644;977.8777652793401;980.8332583460972;982.9655962041294;15509.224538773242;15726.528204153894;15825.36698532092;16021;16287.51137465878;36536.81731591325;37303;37352.43971340378;37411.81294093621;37578;51472.48527514677;51521;52032;52704;53068;7569.3566046884425;7742.419318551244;7912.36701063902;8009.799755006172;8190.754277371689;9968.40189588627;10916.94541527319;11220.99011089006;11558.826617600575;11791.115666324888;6682.431993280626;9825.66404788627;9859.556319965475;10013.499325033865;10111.544980476043;9663.661771837951;10526.631567895087;10584.682459526226;10590.470476475992;10670.57317707314;10274.845877311996;10716.571337146426;10864.674059778219;11147.163962702667;11311.490982905625;7750.534967901718;7956.761297161094;8057.476264042818;8252.793680158044;8286.047104582809;9812.705618831447;10669.946650266698;10903.509342079784;10928.562857485611;11165.385903775046 03:06:45 INFO - PROCESS | 18590 | |3;mootools.html;1232.4330807828399;1427.150845247078;1459.8102246707926;1599.8480144386288;1766.2846547148401;7040.753573624924;7395.223501532342;7401.62991850408;7406.9629651851665;7409.666565004574;7173.175084865242;7369.520981136222;7375.741849035271;7393.03890494235;7398;1816.727490876366;2122.607317646233;2174.402039439155;2203.4050806282294;2204.4599073227;2221.733391992955;2235.0724449353497;2235.698180745595;2236.6197746383073;2238.205437069841;2137.177186783092;2149.1296025109855;2201.7137772089604;2205.7683943185975;2206.856554323972;1780.97328540072;2054.7123402723632;2122.4693826543366;2131.5843410534953;2142.0682003328525;2065.731454910867;2088.446561661146;2088.6031653985847;2091.9267825626184;2092.3618296419586;7379.3727533159745;7486.850262994764;7493.175750667422;7503.962480187564;7510.436717246228;4248.468941382327;4340.848070317524;4349.978250108729;4361.454818147731;4379.912401751979;2600.8049396295355;2787.3310405502734;2798.8880444782185;2815.7184281571886;2821.125451110142;872.8603423452281;887.4497811357;916.5829547555912;951.0679534056594;955.6702937486556;9622.13400793932;9653.662121825702;9663.999999999929;9665.178459830922;9665.226781857506;4056.492938382702;4072.5927407259037;4157.771322577227;4183.623473887304;4191.413202151702;8318.916810831935;8331.791705207419;8342.833143337099;8343.249107580346;8346.791330216673;4498.167838949739;4527.388802511685;4533.0933813236825;4534.342520334533;4538.636909047268;3437.8968630941113;4044.8988775280854;4155.480564929384;4159.625633692922;4168.91662166761;3477.7739446935866;3491.4239150539875;3521.366154092288;3557.9822100889846;3627.238279961238;1148.4085695866636;1157.8436911017072;1171.3206340322592;1178.2223732336618;1182.7634473105413;822.4695071678734;843.1821133500495;844.5228445928032;869.4131461263622;870.5821205821242;5029.220470827027;5064.7214403207445;5094.133997220481;5151.639385242997;5188.5330320270605;413.63600031971674;417.9393987871742;419.24954331745835;419.70410860343384;432.3212556286663;3476.1483436558206;3486.89539313821;3521.154922818505;3541.964580354215;3572.8749493767596;8544.18830211129;8823.735287941372;9024.503652299056;9033.77415564603;9044.8643270351;8945.418547794372;8947.32895032875;8954.238889694449;8958.193762561401;8969.686060987964;6788.422984046312;6855.383015528626;6870.45036397097;6917.688704008332;6924.58452492852;4933.210686290176;4996.50034996512;5028.874278143076;5090.923636145387;5126.231065340229;8280.254777070093;8340.374471914753;8352.707655232038;8360.958195208985;8444.873326900224;7994.440389172702;8272.131426200162;8275.50346979183;8294.294984926108;8454.196851299117;5541.113421852484;6230.43926046658;6277.874442511033;6391.169148010729;6441.259255185526;7038.3665470107935;7039.859202816017;7104.254053324326;7107.715691372287;7126.465515086493;6130.172426722335;6422.582532135396;6426.550141490238;6472.223333200046;6557.803265902031;6118.388161184024;6187.504999600112;6256;6265.906011409741;6406.839829004312;6265.498760099273;6269.467095296768;6310.368963103837;6344.492440604648;6347.39699728525;4472.262076757429;4534.161180181677;4598.839040633562;4601.28680054592;4659.161350956861;4210.179015092028;4249;4406.964363374668;4427.5572442755465;4506.639468842551 03:06:45 INFO - PROCESS | 18590 | |4;prototype.html;289.191709172862;303.63563723531763;304.65726058184543;305.2445198134616;311.0419906687403;4451.953790859146;4591.380163677903;4591.494935557094;4633.791479383427;4679.953200467994;4480.148771733377;4641.7214967102;4656.580907718305;4670.462896766873;4681.548719896834;3683.5395575553057;3687.5390576178047;3696;3696.796676182809;3729.440583912408;3525.700315473188;3562.2163124112653;3696.907577310562;3703.888883333491;3710.721695872807;3623.4564815277654;3636.5817930937883;3664.72514561409;3666.1567839396953;3672.173760903802;3631.9128740570304;3639.854405823764;3641.908952276188;3644.1254099016046;3650.3611867923273;3234.7384520037203;3240.4329242382487;3242.7892187008006;3246.155999440139;3269.901902942892;4332.458442694663;4547.590716835501;4554.248548989446;4564.2240819060835;4587.24310488769;4138.379243113527;4165.812538435777;4171.958280417188;4174.373843923406;4175.227582897173;4715.3634259374885;4861.854144375674;4889.755512224375;4896.632752543574;4923.113839508887;3480.617132115465;3492.2142517933517;3510.1926556891804;3512.4906888501278;3522.5949015862993;5029.817992771696;5060.696358218519;5120.2831603575905;5139.15203991341;5139.689379208316;3570.803605801706;3582.1223800169128;3592.2276710506844;3596.9100772480897;3605.387084195693;3431.1422144463886;3616.0779001355013;3620.87326943561;3645.1069487975087;3678.7424880258127;4103.9179216416105;4114.526829414595;4145.91708165835;4150.418941348214;4181.289180839264;4628.870719469082;4857.53853383928;4925.310456536088;4928.926066109011;4933.728644924492;1277.1698396042646;1316.5194703933187;1317.9934100329438;1321.3261236769317;1328.435414948643;869.3740506835069;878.969236076747;886.6098916476858;896.8699538566872;898.4923518212189;4528.298113792367;4540.273556230987;4547.977260113678;4553;4554.726716397026;5322.946770532322;5328.6802791832615;5333.866653333697;5337.146056630921;5356.276902618175;4422.557744225616;4528.6150677192145;4530.093981203772;4531.84138555149;4561.885952851139;2825.4631619992138;2863.2412410711177;2868.1252218073687;2871.1817132117662;2875.1374587623627;5024.321716568216;5027.79888804451;5038.118329292359;5040.193569029011;5053.797848086109;5254.868628284324;5446.836594902159;5455.945440545624;5466.180072989084;5478.369987451494;4975.353204083373;4999.200127979651;5000.824971126066;5005.199168133154;5015.27278544609;5235.895282094413;5266.683998960075;5296.867578310573;5307.363116426053;5307.416184219655;4676.8129274828625;4964.851054468371;4976.30331753562;5176.948230517797;5177.508136727005;4761.428628564456;4766.380370551806;4775.2598347256235;4795.808167673394;4807.663463557517;3549.2901419716677;3584.2473080653353;3590.515280437108;3593.1915319053005;3604.4232922733286;4815.22956326986;5034.697918124924;5051.494850514919;5116.079105760999;5120.18077107661;4905.2151655734915;4933.383327084114;4942.456329803646;4959.429665588504;4964.733992831949;4880.902381952412;4924.212126059813;4938.38270216223;4941.2835138905375;4958.628102892226;4555.772211389483;4811.133995880775;4869.561739443467;4885.389326334208;4906.3376444181;4947.876303092451;4955.35580374549;4960.70235785854;4961.925571116509;4979.526944940225;4879.146149423907;4881.755912204305;4908.141075311734;4908.779104940215;4909.607231421406 03:06:45 INFO - PROCESS | 18590 | |5;yui.html;722.1765043265754;738.778366490053;773.2267732267728;773.4353921637208;785.8781888807237;11600.187986840925;11916.880831191686;12088.33514156721;12129.454174562145;12150.513979440833;11544.191906566544;11594.53621855127;11611.941940290286;11631.127665425085;11666.708332291697;639.6322114784018;760.3423039071218;799.4363973398755;812.8740045292989;812.9349652027853;802.3420794948145;804.6700852650414;807.261355859388;807.2815194476921;808.0101875202888;851.9659213631447;858.845407826591;859.2352806002663;859.8796168536379;860.2859626509982;679.748493057567;829.6722794496201;850.7958090058403;851.9701810436636;853.5902766672001;623.1960770605913;623.544812287033;623.9407256310643;624.5752888036134;625.1903784598956;12074.939625301817;12133.393330333449;12141.332226727527;12142.878571214264;12171.33057681827;11691.181617286793;12279.93860030703;12294.692632684166;12341.876581234163;12460.376981150997;9192.770180745469;9809.362391444532;9979.10188083076;10083.495825208784;10199.286049976505;4142.316517774563;4219.7046206765535;4222.493300803892;4238.300680387732;4296.226679197744;40328.99177520556;40415.797921010504;40887.795561022;40969.79515102435;41010.58989410097;9257.444553326823;9320.440773553473;9376.67181648639;9402.43585384879;9560;16442.095684737455;16469.423570174986;17162.742558861628;17216.139193040548;17234.82765172332;6784.151981002375;6863.485238607124;6877.552959057645;6911.308869113149;7004.4396448284015;3707.4994875691436;3760.830762615689;3790.1282704977457;3831.59768224338;3962.5443074046275;2751.1883994221753;2818.070036887822;2818.126380821952;2818.5490321548864;2821.463921854841;505.89376230991166;505.9342285502861;511.2357026245786;516.8165301318053;522.0889547739143;485.2987433159122;572.4390097704273;616.2235583165154;625.0811307378146;627.4447114303874;7733.458657894006;7947.086085100287;7948.542602007908;7955.08516520596;7970.880436793453;608.7017361492836;630.6941133550224;632.7253523582713;650.3366566102643;656.9474442044625;3725.8509659613856;3859.112404147062;3869.245497128033;4008.9198216036098;4029.093453972833;48781;50018.499815001385;51095.744521277156;51404.48595513997;52049;41484.79257603753;44673;46114.308285375744;47169.29246061243;47498.76250618794;39764.40353394643;42623.786881065396;43453.130937381706;44617.55382446134;44799.32801007987;8454.408191426786;8481.533515656698;8600.144857077537;8618.138186181332;8748.1251874812;29122.708772912;29834;29999.400012000075;30209.848950755106;31037.379252415278;37513.2497350046;38673.226535469694;39418.802905985285;39533.2093358137;40490.59509404868;10688.465576721288;10757.677269681923;10809.621663242064;11034.613788517363;11273.210875238654;11069.501872415922;11226.382548959886;11303.491342889425;11725.88274117248;12133.939330303292;10516.57933682644;10589.735256618646;10828.187885908746;11019.614313498989;11252.774944500901;10510.264281500222;10744.677659670222;10894.67315980522;10986.505607247533;11210.439478025903;10320.535575898952;10460.215483838894;10562.735931601772;10688.305260158066;10858.945705271422;9382.765430864283;9615.951920240354;9815;9818.846700386677;10020.947800480844;8649.567521623767;9170.29476304505;9410.390660484387;9560.713178604654;9612.423254604746 03:06:45 INFO - PROCESS | 18590 | __end_tp_report 03:06:45 INFO - PROCESS | 18590 | __start_cc_report 03:06:45 INFO - PROCESS | 18590 | _x_x_mozilla_cycle_collect,887 03:06:45 INFO - PROCESS | 18590 | __end_cc_report 03:06:45 INFO - PROCESS | 18590 | __startTimestamp1461665205139__endTimestamp 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - PROCESS | 18590 | ------- Summary: start ------- 03:06:45 INFO - PROCESS | 18590 | Number of tests: 6 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - PROCESS | 18590 | [#0] dojo.html Cycles:165 Average:4576.93 Median:4707.65 stddev:466.68 (9.9%) stddev-sans-first:440.51 03:06:45 INFO - PROCESS | 18590 | Values: 2561.4 2608.9 2617.3 2632.5 2680.3 4546.5 4560.4 4585.8 4635.0 4644.7 4580.1 4617.3 4677.1 4714.2 4738.8 4193.8 4194.6 4207.5 4217.4 4373.9 4330.5 4337.6 4352.2 4390.4 4391.4 4212.8 4266.5 4303.1 4305.8 4309.9 4215.3 4262.0 4262.4 4264.9 4308.8 4273.0 4300.9 4303.1 4323.7 4334.4 4330.7 4489.0 4584.4 4596.7 4604.9 4946.9 4961.2 4963.2 4964.0 5008.6 4950.0 4971.8 4986.4 4996.9 5030.5 4475.2 4573.8 4612.5 4654.5 4655.2 4989.9 5014.3 5056.1 5065.1 5065.6 4727.7 4857.8 4859.2 4863.5 4919.6 4940.1 5022.7 5034.1 5037.6 5042.4 4857.6 4871.6 4873.2 4884.9 4932.2 4809.2 4856.9 4856.9 4881.3 4917.3 4128.2 4172.8 4173.1 4174.4 4176.5 3677.3 3683.5 3741.5 3748.8 3777.4 4285.9 4287.6 4287.8 4307.9 4331.6 4946.5 4972.8 4990.1 4995.7 5039.2 4197.0 4250.8 4281.6 4303.6 4334.9 4476.8 4500.9 4503.2 4505.8 4549.2 4641.4 4707.6 4711.8 4717.6 4750.0 4827.1 4929.9 5015.0 5027.7 5036.3 4654.2 4664.7 4667.4 4685.9 4706.1 4815.7 4857.5 4859.0 4859.6 4910.0 4852.8 4873.4 4932.4 4964.0 4983.1 4720.3 4736.2 4763.5 4766.3 4808.6 4610.0 4766.3 4778.9 4779.3 4831.4 4722.4 4727.9 4776.0 4797.9 4832.4 4836.5 4869.2 4874.7 4878.7 4930.6 4624.7 4704.3 4778.1 4781.0 4816.2 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - PROCESS | 18590 | [#1] ext.html Cycles:180 Average:39775.47 Median:336967.50 stddev:68834.80 (20.4%) stddev-sans-first:68964.89 03:06:45 INFO - PROCESS | 18590 | Values: 549.6 575.7 582.3 596.4 604.2 27154.3 27780.9 27826.0 33543.0 34928.8 38091.0 38790.8 38830.4 38876.8 38893.6 7381.4 7660.3 7664.3 7667.5 7671.4 7598.8 7737.2 7761.4 7771.5 7777.0 7902.9 7966.6 7987.4 7987.9 7993.4 7864.3 7880.3 7930.7 7946.5 7961.7 7674.5 7792.7 7809.0 7809.1 7810.6 37326.0 37948.0 38022.2 38139.4 38404.2 3066.2 3177.3 3214.2 3554.6 3680.1 29147.6 29254.4 29709.0 30187.1 30641.8 3507.7 3535.4 3546.1 3555.9 3743.9 243118.0 243625.0 244475.6 244644.0 245090.6 30255.0 30544.8 30698.2 30827.7 53495.7 31840.8 32017.5 32058.8 32090.0 32091.5 13705.2 13954.2 13956.6 13957.8 13962.9 11479.6 11598.8 11636.0 11639.8 11796.6 8123.9 8174.9 8205.7 8263.3 8281.7 3158.9 3208.3 3213.1 3246.2 3257.3 883.9 894.3 911.8 926.8 1061.9 27628.7 28498.7 28656.0 28967.9 29236.3 990.9 994.1 1003.4 1029.8 1077.8 15013.9 15433.0 15618.6 15687.7 15850.3 330494.0 333172.0 336860.0 337075.0 337444.0 50669.5 51348.7 51526.2 51563.7 51600.2 1072.7 1253.6 1262.0 1277.2 1359.3 25783.0 26433.6 26768.3 27973.9 28576.7 34698.5 34810.8 34848.3 34860.5 34918.5 184088.0 184354.5 184856.0 184937.0 185702.0 20958.7 23632.6 24341.6 24389.4 25687.0 36938.4 37393.6 37442.8 38054.8 38393.2 32727.0 32886.2 34848.1 35455.0 35609.9 33931.5 33994.5 34621.0 34929.7 35058.3 33339.3 34512.5 34553.3 34790.7 34820.5 29270.7 29684.3 30207.4 31297.7 32256.0 24455.3 24650.6 24693.8 24975.4 25142.0 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - PROCESS | 18590 | [#2] jquery.html Cycles:180 Average:25709.50 Median:399.31 stddev:63325.37 (15858.7%) stddev-sans-first:63474.44 03:06:45 INFO - PROCESS | 18590 | Values: 374.8 384.7 390.9 396.9 401.8 16558.8 17123.3 18093.6 18122.7 18139.6 16102.6 16550.7 16568.8 16765.9 16780.7 4971.8 5096.5 5153.2 5160.5 5166.9 3746.8 3954.4 5464.9 5937.8 5953.0 5822.3 5865.4 5875.5 5879.1 5907.0 5744.1 5852.0 5884.1 5886.4 5889.4 3434.1 4985.4 5256.9 5258.7 5259.9 19681.4 19850.2 21253.3 22490.0 22527.2 2133.8 2199.5 2550.3 2641.9 2719.1 12907.8 13589.2 13959.9 14448.7 14836.9 1789.1 1811.5 1812.7 1837.4 1865.5 77236.6 79922.0 80236.6 81331.2 81361.0 16215.8 16371.5 16479.8 16834.0 16998.6 30154.1 30454.4 30516.2 30595.4 30663.8 8557.7 8689.3 8892.7 8947.3 9385.6 7236.8 7338.7 7423.9 7550.5 7554.0 8434.8 8521.7 8533.5 8557.7 8632.9 2791.7 3191.1 3214.5 3298.8 3627.0 827.2 864.9 891.2 948.5 981.6 16066.3 16486.6 17508.1 18591.9 18623.9 839.0 875.6 899.2 912.3 994.0 9401.0 9804.3 9896.4 9908.6 9990.2 373094.0 379014.0 381568.0 383899.0 389523.0 79203.0 83899.6 86708.6 86904.1 87065.6 944.4 958.0 977.9 980.8 983.0 15509.2 15726.5 15825.4 16021.0 16287.5 36536.8 37303.0 37352.4 37411.8 37578.0 51472.5 51521.0 52032.0 52704.0 53068.0 7569.4 7742.4 7912.4 8009.8 8190.8 9968.4 10916.9 11221.0 11558.8 11791.1 6682.4 9825.7 9859.6 10013.5 10111.5 9663.7 10526.6 10584.7 10590.5 10670.6 10274.8 10716.6 10864.7 11147.2 11311.5 7750.5 7956.8 8057.5 8252.8 8286.0 9812.7 10669.9 10903.5 10928.6 11165.4 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - PROCESS | 18590 | [#3] mootools.html Cycles:180 Average:4863.12 Median:5092.53 stddev:2653.82 (52.1%) stddev-sans-first:2647.23 03:06:45 INFO - PROCESS | 18590 | Values: 1232.4 1427.2 1459.8 1599.8 1766.3 7040.8 7395.2 7401.6 7407.0 7409.7 7173.2 7369.5 7375.7 7393.0 7398.0 1816.7 2122.6 2174.4 2203.4 2204.5 2221.7 2235.1 2235.7 2236.6 2238.2 2137.2 2149.1 2201.7 2205.8 2206.9 1781.0 2054.7 2122.5 2131.6 2142.1 2065.7 2088.4 2088.6 2091.9 2092.4 7379.4 7486.9 7493.2 7504.0 7510.4 4248.5 4340.8 4350.0 4361.5 4379.9 2600.8 2787.3 2798.9 2815.7 2821.1 872.9 887.4 916.6 951.1 955.7 9622.1 9653.7 9664.0 9665.2 9665.2 4056.5 4072.6 4157.8 4183.6 4191.4 8318.9 8331.8 8342.8 8343.2 8346.8 4498.2 4527.4 4533.1 4534.3 4538.6 3437.9 4044.9 4155.5 4159.6 4168.9 3477.8 3491.4 3521.4 3558.0 3627.2 1148.4 1157.8 1171.3 1178.2 1182.8 822.5 843.2 844.5 869.4 870.6 5029.2 5064.7 5094.1 5151.6 5188.5 413.6 417.9 419.2 419.7 432.3 3476.1 3486.9 3521.2 3542.0 3572.9 8544.2 8823.7 9024.5 9033.8 9044.9 8945.4 8947.3 8954.2 8958.2 8969.7 6788.4 6855.4 6870.5 6917.7 6924.6 4933.2 4996.5 5028.9 5090.9 5126.2 8280.3 8340.4 8352.7 8361.0 8444.9 7994.4 8272.1 8275.5 8294.3 8454.2 5541.1 6230.4 6277.9 6391.2 6441.3 7038.4 7039.9 7104.3 7107.7 7126.5 6130.2 6422.6 6426.6 6472.2 6557.8 6118.4 6187.5 6256.0 6265.9 6406.8 6265.5 6269.5 6310.4 6344.5 6347.4 4472.3 4534.2 4598.8 4601.3 4659.2 4210.2 4249.0 4407.0 4427.6 4506.6 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - PROCESS | 18590 | [#4] prototype.html Cycles:180 Average:4134.36 Median:4631.33 stddev:1202.27 (26.0%) stddev-sans-first:1170.49 03:06:45 INFO - PROCESS | 18590 | Values: 289.2 303.6 304.7 305.2 311.0 4452.0 4591.4 4591.5 4633.8 4680.0 4480.1 4641.7 4656.6 4670.5 4681.5 3683.5 3687.5 3696.0 3696.8 3729.4 3525.7 3562.2 3696.9 3703.9 3710.7 3623.5 3636.6 3664.7 3666.2 3672.2 3631.9 3639.9 3641.9 3644.1 3650.4 3234.7 3240.4 3242.8 3246.2 3269.9 4332.5 4547.6 4554.2 4564.2 4587.2 4138.4 4165.8 4172.0 4174.4 4175.2 4715.4 4861.9 4889.8 4896.6 4923.1 3480.6 3492.2 3510.2 3512.5 3522.6 5029.8 5060.7 5120.3 5139.2 5139.7 3570.8 3582.1 3592.2 3596.9 3605.4 3431.1 3616.1 3620.9 3645.1 3678.7 4103.9 4114.5 4145.9 4150.4 4181.3 4628.9 4857.5 4925.3 4928.9 4933.7 1277.2 1316.5 1318.0 1321.3 1328.4 869.4 879.0 886.6 896.9 898.5 4528.3 4540.3 4548.0 4553.0 4554.7 5322.9 5328.7 5333.9 5337.1 5356.3 4422.6 4528.6 4530.1 4531.8 4561.9 2825.5 2863.2 2868.1 2871.2 2875.1 5024.3 5027.8 5038.1 5040.2 5053.8 5254.9 5446.8 5455.9 5466.2 5478.4 4975.4 4999.2 5000.8 5005.2 5015.3 5235.9 5266.7 5296.9 5307.4 5307.4 4676.8 4964.9 4976.3 5176.9 5177.5 4761.4 4766.4 4775.3 4795.8 4807.7 3549.3 3584.2 3590.5 3593.2 3604.4 4815.2 5034.7 5051.5 5116.1 5120.2 4905.2 4933.4 4942.5 4959.4 4964.7 4880.9 4924.2 4938.4 4941.3 4958.6 4555.8 4811.1 4869.6 4885.4 4906.3 4947.9 4955.4 4960.7 4961.9 4979.5 4879.1 4881.8 4908.1 4908.8 4909.6 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - PROCESS | 18590 | [#5] yui.html Cycles:180 Average:12534.84 Median:23874.68 stddev:13979.99 (58.6%) stddev-sans-first:13991.06 03:06:45 INFO - PROCESS | 18590 | Values: 722.2 738.8 773.2 773.4 785.9 11600.2 11916.9 12088.3 12129.5 12150.5 11544.2 11594.5 11611.9 11631.1 11666.7 639.6 760.3 799.4 812.9 812.9 802.3 804.7 807.3 807.3 808.0 852.0 858.8 859.2 859.9 860.3 679.7 829.7 850.8 852.0 853.6 623.2 623.5 623.9 624.6 625.2 12074.9 12133.4 12141.3 12142.9 12171.3 11691.2 12279.9 12294.7 12341.9 12460.4 9192.8 9809.4 9979.1 10083.5 10199.3 4142.3 4219.7 4222.5 4238.3 4296.2 40329.0 40415.8 40887.8 40969.8 41010.6 9257.4 9320.4 9376.7 9402.4 9560.0 16442.1 16469.4 17162.7 17216.1 17234.8 6784.2 6863.5 6877.6 6911.3 7004.4 3707.5 3760.8 3790.1 3831.6 3962.5 2751.2 2818.1 2818.1 2818.5 2821.5 505.9 505.9 511.2 516.8 522.1 485.3 572.4 616.2 625.1 627.4 7733.5 7947.1 7948.5 7955.1 7970.9 608.7 630.7 632.7 650.3 656.9 3725.9 3859.1 3869.2 4008.9 4029.1 48781.0 50018.5 51095.7 51404.5 52049.0 41484.8 44673.0 46114.3 47169.3 47498.8 39764.4 42623.8 43453.1 44617.6 44799.3 8454.4 8481.5 8600.1 8618.1 8748.1 29122.7 29834.0 29999.4 30209.8 31037.4 37513.2 38673.2 39418.8 39533.2 40490.6 10688.5 10757.7 10809.6 11034.6 11273.2 11069.5 11226.4 11303.5 11725.9 12133.9 10516.6 10589.7 10828.2 11019.6 11252.8 10510.3 10744.7 10894.7 10986.5 11210.4 10320.5 10460.2 10562.7 10688.3 10858.9 9382.8 9616.0 9815.0 9818.8 10020.9 8649.6 9170.3 9410.4 9560.7 9612.4 03:06:45 INFO - PROCESS | 18590 | -------- Summary: end -------- 03:06:45 INFO - PROCESS | 18590 | 03:06:45 INFO - TEST-INFO | 18590: exit 0 03:06:45 INFO - TEST-OK | dromaeo_css | took 1117618ms 03:06:45 INFO - TEST-START | kraken 03:06:45 INFO - operating with platform_type : linux_ 03:06:45 INFO - Initialising browser for kraken test... 03:06:45 INFO - TEST-INFO | started process 18766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmfKd8u/profile http://localhost:59933/getInfo.html) 03:06:50 INFO - PROCESS | 18766 | __metrics Screen width/height:1600/1200 03:06:50 INFO - PROCESS | 18766 | colorDepth:24 03:06:50 INFO - PROCESS | 18766 | Browser inner width/height: 1024/697 03:06:50 INFO - PROCESS | 18766 | __metrics 03:06:51 ERROR - PROCESS | 18766 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:06:52 INFO - TEST-INFO | 18766: exit 0 03:06:52 INFO - Browser initialized. 03:06:52 INFO - Running cycle 1/1 for kraken test... 03:06:52 INFO - TEST-INFO | started process 18845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmfKd8u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:04 INFO - PROCESS | 18845 | RSS: Main: 156553216 03:07:04 INFO - PROCESS | 18845 | 03:07:06 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59933/tests/kraken/driver.html?testName=audio-beat-detection) 03:07:07 INFO - PROCESS | 18845 | RSS: Main: 210575360 03:07:07 INFO - PROCESS | 18845 | 03:07:10 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59933/tests/kraken/driver.html?testName=audio-dft) 03:07:11 INFO - PROCESS | 18845 | RSS: Main: 196780032 03:07:11 INFO - PROCESS | 18845 | 03:07:14 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59933/tests/kraken/driver.html?testName=audio-fft) 03:07:15 INFO - PROCESS | 18845 | RSS: Main: 267169792 03:07:15 INFO - PROCESS | 18845 | 03:07:17 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59933/tests/kraken/driver.html?testName=audio-oscillator) 03:07:17 INFO - PROCESS | 18845 | RSS: Main: 175378432 03:07:17 INFO - PROCESS | 18845 | 03:07:20 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:07:20 INFO - PROCESS | 18845 | RSS: Main: 179556352 03:07:20 INFO - PROCESS | 18845 | 03:07:23 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59933/tests/kraken/driver.html?testName=imaging-darkroom) 03:07:24 INFO - PROCESS | 18845 | RSS: Main: 216170496 03:07:24 INFO - PROCESS | 18845 | 03:07:27 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59933/tests/kraken/driver.html?testName=imaging-desaturate) 03:07:28 INFO - PROCESS | 18845 | RSS: Main: 216539136 03:07:28 INFO - PROCESS | 18845 | 03:07:31 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59933/tests/kraken/driver.html?testName=json-parse-financial) 03:07:32 INFO - PROCESS | 18845 | RSS: Main: 217112576 03:07:32 INFO - PROCESS | 18845 | 03:07:33 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:07:34 INFO - PROCESS | 18845 | RSS: Main: 203030528 03:07:34 INFO - PROCESS | 18845 | 03:07:36 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59933/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:07:36 INFO - PROCESS | 18845 | RSS: Main: 206954496 03:07:36 INFO - PROCESS | 18845 | 03:07:38 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:07:39 INFO - PROCESS | 18845 | RSS: Main: 217288704 03:07:39 INFO - PROCESS | 18845 | 03:07:42 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:07:43 INFO - PROCESS | 18845 | RSS: Main: 225828864 03:07:43 INFO - PROCESS | 18845 | 03:07:46 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:07:46 INFO - PROCESS | 18845 | RSS: Main: 221753344 03:07:46 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | Cycle 1(1): loaded http://localhost:59933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59933/tests/kraken/driver.html?testName=ai-astar) 03:07:48 INFO - PROCESS | 18845 | RSS: Main: 285163520 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | __start_tp_report 03:07:48 INFO - PROCESS | 18845 | _x_x_mozilla_page_load 03:07:48 INFO - PROCESS | 18845 | _x_x_mozilla_page_load_details 03:07:48 INFO - PROCESS | 18845 | |i|pagename|runs| 03:07:48 INFO - PROCESS | 18845 | |0;ai-astar;112;116;110;113;114;115;103;114;115;115 03:07:48 INFO - PROCESS | 18845 | |1;audio-beat-detection;165;140;159;181;134;154;168;138;186;134 03:07:48 INFO - PROCESS | 18845 | |2;audio-dft;162;161;161;167;163;161;162;162;163;163 03:07:48 INFO - PROCESS | 18845 | |3;audio-fft;76;73;109;108;74;73;73;117;106;74 03:07:48 INFO - PROCESS | 18845 | |4;audio-oscillator;94;95;147;94;93;95;144;93;93;147 03:07:48 INFO - PROCESS | 18845 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;117;117 03:07:48 INFO - PROCESS | 18845 | |6;imaging-darkroom;146;146;146;146;145;146;147;146;145;146 03:07:48 INFO - PROCESS | 18845 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 03:07:48 INFO - PROCESS | 18845 | |8;json-parse-financial;66;66;66;79;66;66;67;78;66;64 03:07:48 INFO - PROCESS | 18845 | |9;json-stringify-tinderbox;65;65;66;65;65;65;65;65;66;64 03:07:48 INFO - PROCESS | 18845 | |10;stanford-crypto-aes;80;80;81;77;89;81;81;80;89;80 03:07:48 INFO - PROCESS | 18845 | |11;stanford-crypto-ccm;138;132;141;128;130;130;127;130;169;129 03:07:48 INFO - PROCESS | 18845 | |12;stanford-crypto-pbkdf2;180;181;178;177;177;179;186;180;179;181 03:07:48 INFO - PROCESS | 18845 | |13;stanford-crypto-sha256-iterative;76;83;74;79;74;73;75;72;74;72 03:07:48 INFO - PROCESS | 18845 | __end_tp_report 03:07:48 INFO - PROCESS | 18845 | __start_cc_report 03:07:48 INFO - PROCESS | 18845 | _x_x_mozilla_cycle_collect,1921 03:07:48 INFO - PROCESS | 18845 | __end_cc_report 03:07:48 INFO - PROCESS | 18845 | __startTimestamp1461665268736__endTimestamp 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | ------- Summary: start ------- 03:07:48 INFO - PROCESS | 18845 | Number of tests: 14 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.50 stddev:3.83 (3.3%) stddev-sans-first:4.06 03:07:48 INFO - PROCESS | 18845 | Values: 112.0 116.0 110.0 113.0 114.0 115.0 103.0 114.0 115.0 115.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:162.00 stddev:19.18 (11.8%) stddev-sans-first:20.06 03:07:48 INFO - PROCESS | 18845 | Values: 165.0 140.0 159.0 181.0 134.0 154.0 168.0 138.0 186.0 134.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.78 (1.1%) stddev-sans-first:1.88 03:07:48 INFO - PROCESS | 18845 | Values: 162.0 161.0 161.0 167.0 163.0 161.0 162.0 162.0 163.0 163.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#3] audio-fft Cycles:10 Average:88.30 Median:73.00 stddev:18.90 (25.9%) stddev-sans-first:19.52 03:07:48 INFO - PROCESS | 18845 | Values: 76.0 73.0 109.0 108.0 74.0 73.0 73.0 117.0 106.0 74.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.50 stddev:25.21 (27.0%) stddev-sans-first:26.11 03:07:48 INFO - PROCESS | 18845 | Values: 94.0 95.0 147.0 94.0 93.0 95.0 144.0 93.0 93.0 147.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:07:48 INFO - PROCESS | 18845 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:07:48 INFO - PROCESS | 18845 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 147.0 146.0 145.0 146.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:07:48 INFO - PROCESS | 18845 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:66.00 stddev:5.38 (8.1%) stddev-sans-first:5.63 03:07:48 INFO - PROCESS | 18845 | Values: 66.0 66.0 66.0 79.0 66.0 66.0 67.0 78.0 66.0 64.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 03:07:48 INFO - PROCESS | 18845 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 64.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:3.97 (4.9%) stddev-sans-first:4.15 03:07:48 INFO - PROCESS | 18845 | Values: 80.0 80.0 81.0 77.0 89.0 81.0 81.0 80.0 89.0 80.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:131.00 stddev:12.62 (9.6%) stddev-sans-first:13.35 03:07:48 INFO - PROCESS | 18845 | Values: 138.0 132.0 141.0 128.0 130.0 130.0 127.0 130.0 169.0 129.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:180.00 stddev:2.62 (1.5%) stddev-sans-first:2.77 03:07:48 INFO - PROCESS | 18845 | Values: 180.0 181.0 178.0 177.0 177.0 179.0 186.0 180.0 179.0 181.0 03:07:48 INFO - PROCESS | 18845 | 03:07:48 INFO - PROCESS | 18845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:74.50 stddev:3.43 (4.6%) stddev-sans-first:3.62 03:07:48 INFO - PROCESS | 18845 | Values: 76.0 83.0 74.0 79.0 74.0 73.0 75.0 72.0 74.0 72.0 03:07:48 INFO - PROCESS | 18845 | -------- Summary: end -------- 03:07:48 INFO - PROCESS | 18845 | 03:07:49 INFO - TEST-INFO | 18845: exit 0 03:07:49 INFO - TEST-OK | kraken | took 63789ms 03:07:49 INFO - SUITE-END | took 1181s 03:07:49 INFO - Completed test suite (00:19:41) 03:07:49 INFO - javascript benchmark 03:07:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.385267535791, 2608.934776630584, 2617.306413800344, 2632.512985097757, 2680.3299175206193, 4546.545345465452, 4560.429946256718, 4585.770711464426, 4634.95365046349, 4644.6516511261625, 4580.061087477067, 4617.284320930253, 4677.1347300749385, 4714.198586240339, 4738.834140805073, 4193.769342686151, 4194.601512856274, 4207.453031105952, 4217.43064686268, 4373.868783936487, 4330.523642399334, 4337.63130133939, 4352.151330490556, 4390.429244198266, 4391.36325232841, 4212.810423530948, 4266.509351424595, 4303.074838909618, 4305.806238719265, 4309.935350969738, 4215.262329092397, 4261.998430368861, 4262.403263543107, 4264.87205383839, 4308.763018034007, 4273.038566322583, 4300.892477688051, 4303.117860838521, 4323.6757243206885, 4334.371516130143, 4330.718503297276, 4489.0, 4584.426946631671, 4596.724196548184, 4604.861854144381, 4946.851594452172, 4961.18140506816, 4963.1810751226, 4963.950360496421, 5008.574271186917, 4949.975250123726, 4971.751412429364, 4986.40163180417, 4996.875078123039, 5030.547250747413, 4475.239209334421, 4573.794179261941, 4612.5156858530045, 4654.534546545318, 4655.185342565038, 4989.90020199594, 5014.323066385991, 5056.140456122468, 5065.11360511909, 5065.645404821627, 4727.692699974491, 4857.8299759508245, 4859.246816743411, 4863.513648635108, 4919.606431485473, 4940.135476291634, 5022.723750193702, 5034.0686972910125, 5037.622178336639, 5042.42012168598, 4857.635677324215, 4871.634627402959, 4873.244647079638, 4884.902301954012, 4932.235503496964, 4809.206480930678, 4856.878578035577, 4856.902861942742, 4881.316615673809, 4917.311576379309, 4128.195001974646, 4172.77049762266, 4173.08192197716, 4174.4364510791265, 4176.540580536139, 3677.3196958562216, 3683.4658974448553, 3741.513603231617, 3748.8125593720206, 3777.414500752388, 4285.914281714348, 4287.63555097814, 4287.785610719451, 4307.870763877088, 4331.5884990925815, 4946.4558898521855, 4972.751362431936, 4990.126727822617, 4995.725235112103, 5039.21892106724, 4197.034682023091, 4250.787460627018, 4281.636060934856, 4303.634191093792, 4334.869953901388, 4476.753778542146, 4500.932486012713, 4503.211937910853, 4505.774711264424, 4549.181147393501, 4641.396618439581, 4707.646926480459, 4711.8350857719815, 4717.551832575899, 4750.026244619845, 4827.131116399082, 4929.876753081202, 5015.04714104319, 5027.673201241908, 5036.29491871131, 4654.16225079489, 4664.696794708333, 4667.369905062773, 4685.882852928704, 4706.129366067288, 4815.662903596714, 4857.465678775403, 4859.007340160412, 4859.635527335535, 4910.042541704333, 4852.805887764591, 4873.390826146731, 4932.4081110267, 4964.0, 4983.078130545716, 4720.291956206596, 4736.19484687597, 4763.54746299101, 4766.3327134200545, 4808.639352048541, 4609.953900460952, 4766.308885211555, 4778.904421911612, 4779.283107533898, 4831.396075490564, 4722.362481065013, 4727.929081063718, 4775.952240477551, 4797.880052998703, 4832.371791667061, 4836.540528649773, 4869.172240719157, 4874.731889746098, 4878.707277563358, 4930.556249937523, 4624.745638989888, 4704.270838020112, 4778.139934811628, 4780.95219047805, 4816.20532612115], "value": 4548.038769997148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5596901277892, 575.7437940116648, 582.2518064287389, 596.4333882811329, 604.1662505742075, 27154.321141971435, 27780.861095694494, 27826.0, 33543.0, 34928.82535587325, 38091.0, 38790.8060459698, 38830.417543736796, 38876.80561597188, 38893.61106388935, 7381.409487241035, 7660.310572048515, 7664.348530374925, 7667.501612395176, 7671.424643151758, 7598.772036838904, 7737.226277372246, 7761.41789365797, 7771.494852834576, 7777.0, 7902.881456778153, 7966.5618390988475, 7987.440879138463, 7987.920120798775, 7993.44045916786, 7864.331531819745, 7880.330171935364, 7930.722424715107, 7946.483478573903, 7961.72133975308, 7674.46278760487, 7792.727254546064, 7808.960955195244, 7809.101953275333, 7810.570418626973, 37326.0, 37948.0, 38022.23955520902, 38139.42790858139, 38404.23191536154, 3066.23344163959, 3177.3486435280943, 3214.212517933098, 3554.608993010767, 3680.061584296014, 29147.562786558217, 29254.41491170186, 29709.0, 30187.09438716842, 30641.846790766125, 3507.7018453431233, 3535.3636345457808, 3546.078019714893, 3555.928881422357, 3743.8689645862537, 243118.0, 243625.0, 244475.5538445385, 244644.0, 245090.61820363367, 30255.0, 30544.847275763925, 30698.23254418613, 30827.69172308293, 53495.73252133792, 31840.840795795873, 32017.519737203962, 32058.839705801787, 32090.0, 32091.518627220612, 13705.246211458267, 13954.162750234815, 13956.581302560939, 13957.79063314051, 13962.930185349009, 11479.598214062635, 11598.768024639628, 11636.0, 11639.825402618968, 11796.587119450778, 8123.903273058179, 8174.877376839352, 8205.671773129128, 8263.297619702273, 8281.710140145187, 3158.8578513966468, 3208.2941752814345, 3213.084270982759, 3246.188452886778, 3257.299680568689, 883.8762573239752, 894.2577660541734, 911.8449863523217, 926.7822061815468, 1061.9203559732896, 27628.723712763018, 28498.715012849607, 28656.0, 28967.855160724484, 29236.26909327284, 990.8860481044628, 994.0755097759153, 1003.4130033930232, 1029.8300780371305, 1077.8221593437152, 15013.898990704141, 15433.0, 15618.609534761494, 15687.68624627501, 15850.286737096858, 330494.0, 333172.0, 336860.0, 337075.0, 337444.0, 50669.49330506648, 51348.74325628423, 51526.22710659343, 51563.74218128961, 51600.22599661008, 1072.7371793910386, 1253.6489782860813, 1261.9873801262054, 1277.1506947879557, 1359.2592037339673, 25783.0, 26433.60349594719, 26768.33079173036, 27973.860130699217, 28576.714232857405, 34698.479522807684, 34810.82594587011, 34848.340924202595, 34860.477092844136, 34918.47622285617, 184088.0, 184354.48632379904, 184856.0, 184937.0, 185702.0, 20958.735803258674, 23632.645510317703, 24341.634875477237, 24389.3902652428, 25687.0, 36938.44592331171, 37393.6260637401, 37442.812785935894, 38054.80972595119, 38393.23213535658, 32727.0, 32886.177845553095, 34848.128796780285, 35455.0, 35609.93170204898, 33931.4910276351, 33994.490082649274, 34621.0, 34929.65070349264, 35058.298834022666, 33339.333213335114, 34512.48231276483, 34553.30893382068, 34790.65209347874, 34820.477692835135, 29270.70729292765, 29684.25789355197, 30207.395852083275, 31297.687023130387, 32256.0, 24455.266342009767, 24650.63024054605, 24693.753062469146, 24975.3653113873, 25142.0], "value": 15784.2197884114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.84631301166525, 384.6691845013288, 390.8690588652801, 396.85713143268435, 401.76295985368625, 16558.751618725713, 17123.31506739732, 18093.638127237464, 18122.728159077607, 18139.637207255848, 16102.59743506413, 16550.66898662026, 16568.75146872798, 16765.91617041916, 16780.66438671226, 4971.776270067838, 5096.4648711885275, 5153.1754919212935, 5160.483951604847, 5166.863290076177, 3746.775193488386, 3954.4266081418177, 5464.890702185954, 5937.821865344046, 5952.970235148819, 5822.272215973004, 5865.35481097079, 5875.529957603403, 5879.11813228017, 5907.025340818781, 5744.080947048473, 5852.0, 5884.117382392633, 5886.440788125143, 5889.381614930435, 3434.107132145635, 4985.376827896513, 5256.92114618281, 5258.6581872178185, 5259.894802103975, 19681.40955771329, 19850.20599176031, 21253.256136035165, 22490.0, 22527.211547595754, 2133.807957283852, 2199.4941163532317, 2550.3114159176916, 2641.867906604662, 2719.116287206646, 12907.806382904264, 13589.184648921097, 13959.930200349036, 14448.711025779425, 14836.925815370962, 1789.0965062643281, 1811.473989154921, 1812.6586326118577, 1837.4395809278165, 1865.4776662534512, 77236.61381693055, 79922.0, 80236.59881700554, 81331.18668813354, 81361.0, 16215.756763648555, 16371.508854734377, 16479.752803707954, 16834.0, 16998.57503562421, 30154.09537713872, 30454.390912182076, 30516.237094072825, 30595.38809223803, 30663.84668076645, 8557.700480483278, 8689.348298877483, 8892.688755893512, 8947.284217262733, 9385.62457501706, 7236.782896513113, 7338.743143990041, 7423.85152296951, 7550.509216900884, 7554.0, 8434.831303373898, 8521.659133634708, 8533.53065581399, 8557.743267701979, 8632.870506942401, 2791.6650001999483, 3191.1064901827526, 3214.533892585562, 3298.7690861639453, 3626.9818650906577, 827.210014436212, 864.9437786543855, 891.1534042659499, 948.5399581203111, 981.5582987655583, 16066.27701753424, 16486.587835303973, 17508.12459377026, 18591.90704046471, 18623.90688046551, 838.9748307550783, 875.6409871952469, 899.1862364560084, 912.2975309012156, 993.9900600993898, 9401.0, 9804.264680149017, 9896.406215627085, 9908.603655853829, 9990.200783937267, 373094.0, 379014.0, 381568.0, 383899.0, 389523.0, 79203.0, 83899.5805020971, 86708.56645716731, 86904.13095869088, 87065.56467217623, 944.3625552751865, 957.9568919398644, 977.8777652793401, 980.8332583460972, 982.9655962041294, 15509.224538773242, 15726.528204153894, 15825.36698532092, 16021.0, 16287.51137465878, 36536.81731591325, 37303.0, 37352.43971340378, 37411.81294093621, 37578.0, 51472.48527514677, 51521.0, 52032.0, 52704.0, 53068.0, 7569.3566046884425, 7742.419318551244, 7912.36701063902, 8009.799755006172, 8190.754277371689, 9968.40189588627, 10916.94541527319, 11220.99011089006, 11558.826617600575, 11791.115666324888, 6682.431993280626, 9825.66404788627, 9859.556319965475, 10013.499325033865, 10111.544980476043, 9663.661771837951, 10526.631567895087, 10584.682459526226, 10590.470476475992, 10670.57317707314, 10274.845877311996, 10716.571337146426, 10864.674059778219, 11147.163962702667, 11311.490982905625, 7750.534967901718, 7956.761297161094, 8057.476264042818, 8252.793680158044, 8286.047104582809, 9812.705618831447, 10669.946650266698, 10903.509342079784, 10928.562857485611, 11165.385903775046], "value": 9203.085331641585, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.4330807828399, 1427.150845247078, 1459.8102246707926, 1599.8480144386288, 1766.2846547148401, 7040.753573624924, 7395.223501532342, 7401.62991850408, 7406.9629651851665, 7409.666565004574, 7173.175084865242, 7369.520981136222, 7375.741849035271, 7393.03890494235, 7398.0, 1816.727490876366, 2122.607317646233, 2174.402039439155, 2203.4050806282294, 2204.4599073227, 2221.733391992955, 2235.0724449353497, 2235.698180745595, 2236.6197746383073, 2238.205437069841, 2137.177186783092, 2149.1296025109855, 2201.7137772089604, 2205.7683943185975, 2206.856554323972, 1780.97328540072, 2054.7123402723632, 2122.4693826543366, 2131.5843410534953, 2142.0682003328525, 2065.731454910867, 2088.446561661146, 2088.6031653985847, 2091.9267825626184, 2092.3618296419586, 7379.3727533159745, 7486.850262994764, 7493.175750667422, 7503.962480187564, 7510.436717246228, 4248.468941382327, 4340.848070317524, 4349.978250108729, 4361.454818147731, 4379.912401751979, 2600.8049396295355, 2787.3310405502734, 2798.8880444782185, 2815.7184281571886, 2821.125451110142, 872.8603423452281, 887.4497811357, 916.5829547555912, 951.0679534056594, 955.6702937486556, 9622.13400793932, 9653.662121825702, 9663.999999999929, 9665.178459830922, 9665.226781857506, 4056.492938382702, 4072.5927407259037, 4157.771322577227, 4183.623473887304, 4191.413202151702, 8318.916810831935, 8331.791705207419, 8342.833143337099, 8343.249107580346, 8346.791330216673, 4498.167838949739, 4527.388802511685, 4533.0933813236825, 4534.342520334533, 4538.636909047268, 3437.8968630941113, 4044.8988775280854, 4155.480564929384, 4159.625633692922, 4168.91662166761, 3477.7739446935866, 3491.4239150539875, 3521.366154092288, 3557.9822100889846, 3627.238279961238, 1148.4085695866636, 1157.8436911017072, 1171.3206340322592, 1178.2223732336618, 1182.7634473105413, 822.4695071678734, 843.1821133500495, 844.5228445928032, 869.4131461263622, 870.5821205821242, 5029.220470827027, 5064.7214403207445, 5094.133997220481, 5151.639385242997, 5188.5330320270605, 413.63600031971674, 417.9393987871742, 419.24954331745835, 419.70410860343384, 432.3212556286663, 3476.1483436558206, 3486.89539313821, 3521.154922818505, 3541.964580354215, 3572.8749493767596, 8544.18830211129, 8823.735287941372, 9024.503652299056, 9033.77415564603, 9044.8643270351, 8945.418547794372, 8947.32895032875, 8954.238889694449, 8958.193762561401, 8969.686060987964, 6788.422984046312, 6855.383015528626, 6870.45036397097, 6917.688704008332, 6924.58452492852, 4933.210686290176, 4996.50034996512, 5028.874278143076, 5090.923636145387, 5126.231065340229, 8280.254777070093, 8340.374471914753, 8352.707655232038, 8360.958195208985, 8444.873326900224, 7994.440389172702, 8272.131426200162, 8275.50346979183, 8294.294984926108, 8454.196851299117, 5541.113421852484, 6230.43926046658, 6277.874442511033, 6391.169148010729, 6441.259255185526, 7038.3665470107935, 7039.859202816017, 7104.254053324326, 7107.715691372287, 7126.465515086493, 6130.172426722335, 6422.582532135396, 6426.550141490238, 6472.223333200046, 6557.803265902031, 6118.388161184024, 6187.504999600112, 6256.0, 6265.906011409741, 6406.839829004312, 6265.498760099273, 6269.467095296768, 6310.368963103837, 6344.492440604648, 6347.39699728525, 4472.262076757429, 4534.161180181677, 4598.839040633562, 4601.28680054592, 4659.161350956861, 4210.179015092028, 4249.0, 4406.964363374668, 4427.5572442755465, 4506.639468842551], "value": 3902.2856613211193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.191709172862, 303.63563723531763, 304.65726058184543, 305.2445198134616, 311.0419906687403, 4451.953790859146, 4591.380163677903, 4591.494935557094, 4633.791479383427, 4679.953200467994, 4480.148771733377, 4641.7214967102, 4656.580907718305, 4670.462896766873, 4681.548719896834, 3683.5395575553057, 3687.5390576178047, 3696.0, 3696.796676182809, 3729.440583912408, 3525.700315473188, 3562.2163124112653, 3696.907577310562, 3703.888883333491, 3710.721695872807, 3623.4564815277654, 3636.5817930937883, 3664.72514561409, 3666.1567839396953, 3672.173760903802, 3631.9128740570304, 3639.854405823764, 3641.908952276188, 3644.1254099016046, 3650.3611867923273, 3234.7384520037203, 3240.4329242382487, 3242.7892187008006, 3246.155999440139, 3269.901902942892, 4332.458442694663, 4547.590716835501, 4554.248548989446, 4564.2240819060835, 4587.24310488769, 4138.379243113527, 4165.812538435777, 4171.958280417188, 4174.373843923406, 4175.227582897173, 4715.3634259374885, 4861.854144375674, 4889.755512224375, 4896.632752543574, 4923.113839508887, 3480.617132115465, 3492.2142517933517, 3510.1926556891804, 3512.4906888501278, 3522.5949015862993, 5029.817992771696, 5060.696358218519, 5120.2831603575905, 5139.15203991341, 5139.689379208316, 3570.803605801706, 3582.1223800169128, 3592.2276710506844, 3596.9100772480897, 3605.387084195693, 3431.1422144463886, 3616.0779001355013, 3620.87326943561, 3645.1069487975087, 3678.7424880258127, 4103.9179216416105, 4114.526829414595, 4145.91708165835, 4150.418941348214, 4181.289180839264, 4628.870719469082, 4857.53853383928, 4925.310456536088, 4928.926066109011, 4933.728644924492, 1277.1698396042646, 1316.5194703933187, 1317.9934100329438, 1321.3261236769317, 1328.435414948643, 869.3740506835069, 878.969236076747, 886.6098916476858, 896.8699538566872, 898.4923518212189, 4528.298113792367, 4540.273556230987, 4547.977260113678, 4553.0, 4554.726716397026, 5322.946770532322, 5328.6802791832615, 5333.866653333697, 5337.146056630921, 5356.276902618175, 4422.557744225616, 4528.6150677192145, 4530.093981203772, 4531.84138555149, 4561.885952851139, 2825.4631619992138, 2863.2412410711177, 2868.1252218073687, 2871.1817132117662, 2875.1374587623627, 5024.321716568216, 5027.79888804451, 5038.118329292359, 5040.193569029011, 5053.797848086109, 5254.868628284324, 5446.836594902159, 5455.945440545624, 5466.180072989084, 5478.369987451494, 4975.353204083373, 4999.200127979651, 5000.824971126066, 5005.199168133154, 5015.27278544609, 5235.895282094413, 5266.683998960075, 5296.867578310573, 5307.363116426053, 5307.416184219655, 4676.8129274828625, 4964.851054468371, 4976.30331753562, 5176.948230517797, 5177.508136727005, 4761.428628564456, 4766.380370551806, 4775.2598347256235, 4795.808167673394, 4807.663463557517, 3549.2901419716677, 3584.2473080653353, 3590.515280437108, 3593.1915319053005, 3604.4232922733286, 4815.22956326986, 5034.697918124924, 5051.494850514919, 5116.079105760999, 5120.18077107661, 4905.2151655734915, 4933.383327084114, 4942.456329803646, 4959.429665588504, 4964.733992831949, 4880.902381952412, 4924.212126059813, 4938.38270216223, 4941.2835138905375, 4958.628102892226, 4555.772211389483, 4811.133995880775, 4869.561739443467, 4885.389326334208, 4906.3376444181, 4947.876303092451, 4955.35580374549, 4960.70235785854, 4961.925571116509, 4979.526944940225, 4879.146149423907, 4881.755912204305, 4908.141075311734, 4908.779104940215, 4909.607231421406], "value": 3760.2924816682907, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.1765043265754, 738.778366490053, 773.2267732267728, 773.4353921637208, 785.8781888807237, 11600.187986840925, 11916.880831191686, 12088.33514156721, 12129.454174562145, 12150.513979440833, 11544.191906566544, 11594.53621855127, 11611.941940290286, 11631.127665425085, 11666.708332291697, 639.6322114784018, 760.3423039071218, 799.4363973398755, 812.8740045292989, 812.9349652027853, 802.3420794948145, 804.6700852650414, 807.261355859388, 807.2815194476921, 808.0101875202888, 851.9659213631447, 858.845407826591, 859.2352806002663, 859.8796168536379, 860.2859626509982, 679.748493057567, 829.6722794496201, 850.7958090058403, 851.9701810436636, 853.5902766672001, 623.1960770605913, 623.544812287033, 623.9407256310643, 624.5752888036134, 625.1903784598956, 12074.939625301817, 12133.393330333449, 12141.332226727527, 12142.878571214264, 12171.33057681827, 11691.181617286793, 12279.93860030703, 12294.692632684166, 12341.876581234163, 12460.376981150997, 9192.770180745469, 9809.362391444532, 9979.10188083076, 10083.495825208784, 10199.286049976505, 4142.316517774563, 4219.7046206765535, 4222.493300803892, 4238.300680387732, 4296.226679197744, 40328.99177520556, 40415.797921010504, 40887.795561022, 40969.79515102435, 41010.58989410097, 9257.444553326823, 9320.440773553473, 9376.67181648639, 9402.43585384879, 9560.0, 16442.095684737455, 16469.423570174986, 17162.742558861628, 17216.139193040548, 17234.82765172332, 6784.151981002375, 6863.485238607124, 6877.552959057645, 6911.308869113149, 7004.4396448284015, 3707.4994875691436, 3760.830762615689, 3790.1282704977457, 3831.59768224338, 3962.5443074046275, 2751.1883994221753, 2818.070036887822, 2818.126380821952, 2818.5490321548864, 2821.463921854841, 505.89376230991166, 505.9342285502861, 511.2357026245786, 516.8165301318053, 522.0889547739143, 485.2987433159122, 572.4390097704273, 616.2235583165154, 625.0811307378146, 627.4447114303874, 7733.458657894006, 7947.086085100287, 7948.542602007908, 7955.08516520596, 7970.880436793453, 608.7017361492836, 630.6941133550224, 632.7253523582713, 650.3366566102643, 656.9474442044625, 3725.8509659613856, 3859.112404147062, 3869.245497128033, 4008.9198216036098, 4029.093453972833, 48781.0, 50018.499815001385, 51095.744521277156, 51404.48595513997, 52049.0, 41484.79257603753, 44673.0, 46114.308285375744, 47169.29246061243, 47498.76250618794, 39764.40353394643, 42623.786881065396, 43453.130937381706, 44617.55382446134, 44799.32801007987, 8454.408191426786, 8481.533515656698, 8600.144857077537, 8618.138186181332, 8748.1251874812, 29122.708772912, 29834.0, 29999.400012000075, 30209.848950755106, 31037.379252415278, 37513.2497350046, 38673.226535469694, 39418.802905985285, 39533.2093358137, 40490.59509404868, 10688.465576721288, 10757.677269681923, 10809.621663242064, 11034.613788517363, 11273.210875238654, 11069.501872415922, 11226.382548959886, 11303.491342889425, 11725.88274117248, 12133.939330303292, 10516.57933682644, 10589.735256618646, 10828.187885908746, 11019.614313498989, 11252.774944500901, 10510.264281500222, 10744.677659670222, 10894.67315980522, 10986.505607247533, 11210.439478025903, 10320.535575898952, 10460.215483838894, 10562.735931601772, 10688.305260158066, 10858.945705271422, 9382.765430864283, 9615.951920240354, 9815.0, 9818.846700386677, 10020.947800480844, 8649.567521623767, 9170.29476304505, 9410.390660484387, 9560.713178604654, 9612.423254604746], "value": 5934.7259411455, "unit": "score"}], "name": "dromaeo_css", "value": 6213.39276784056, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 110.0, 113.0, 114.0, 115.0, 103.0, 114.0, 115.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 140.0, 159.0, 181.0, 134.0, 154.0, 168.0, 138.0, 186.0, 134.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 167.0, 163.0, 161.0, 162.0, 162.0, 163.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 109.0, 108.0, 74.0, 73.0, 73.0, 117.0, 106.0, 74.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 147.0, 94.0, 93.0, 95.0, 144.0, 93.0, 93.0, 147.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 79.0, 66.0, 66.0, 67.0, 78.0, 66.0, 64.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 77.0, 89.0, 81.0, 81.0, 80.0, 89.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 141.0, 128.0, 130.0, 130.0, 127.0, 130.0, 169.0, 129.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 178.0, 177.0, 177.0, 179.0, 186.0, 180.0, 179.0, 181.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 74.0, 79.0, 74.0, 73.0, 75.0, 72.0, 74.0, 72.0], "value": 75.2, "unit": "score"}], "name": "kraken", "value": 1592.6, "alertThreshold": 2.0}]} 03:07:49 INFO - Return code: 0 03:07:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:07:50 ERROR - # TBPL SUCCESS # 03:07:50 INFO - Running post-action listener: _resource_record_post_action 03:07:50 INFO - Running post-run listener: _resource_record_post_run 03:07:51 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518070272; Read time: 16; Write time: 436616 03:07:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234737664; Read time: 0; Write time: 222076 03:07:51 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283332608; Read time: 16; Write time: 214540 03:07:51 INFO - Running post-run listener: _upload_blobber_files 03:07:51 INFO - Blob upload gear active. 03:07:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:07:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:07:51 INFO - (blobuploader) - INFO - Open directory for files ... 03:07:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:07:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:07:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:52 INFO - (blobuploader) - INFO - Done attempting. 03:07:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:07:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:07:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:53 INFO - (blobuploader) - INFO - Done attempting. 03:07:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:07:53 INFO - Return code: 0 03:07:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:07:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:07:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0fe60a2dac131d674e4f1ec0c045ac1476637dc904fb06bbc0d511cf40994b5129c4bae8fde116fd03b69ac0deaf8bc8ee36a8eb7958b17317af44e6381cd4d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63db812668b22344bbee7def544c508426b00afa4671f21449225367a64d56b7602d9bc91e67ff454a40b7065b20b73446eee78cdc4cb6e2194e65e411660178"} 03:07:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:07:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:07:53 INFO - Contents: 03:07:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0fe60a2dac131d674e4f1ec0c045ac1476637dc904fb06bbc0d511cf40994b5129c4bae8fde116fd03b69ac0deaf8bc8ee36a8eb7958b17317af44e6381cd4d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63db812668b22344bbee7def544c508426b00afa4671f21449225367a64d56b7602d9bc91e67ff454a40b7065b20b73446eee78cdc4cb6e2194e65e411660178"} 03:07:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:07:53 INFO - Copying logs to upload dir... 03:07:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:07:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.759761 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-26 03:07:52.994974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 03:07:52.998153) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1461664032.797256-473003316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0fe60a2dac131d674e4f1ec0c045ac1476637dc904fb06bbc0d511cf40994b5129c4bae8fde116fd03b69ac0deaf8bc8ee36a8eb7958b17317af44e6381cd4d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63db812668b22344bbee7def544c508426b00afa4671f21449225367a64d56b7602d9bc91e67ff454a40b7065b20b73446eee78cdc4cb6e2194e65e411660178"} build_url:https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/BejLNajrSqiAoPNKQ-5QaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0fe60a2dac131d674e4f1ec0c045ac1476637dc904fb06bbc0d511cf40994b5129c4bae8fde116fd03b69ac0deaf8bc8ee36a8eb7958b17317af44e6381cd4d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63db812668b22344bbee7def544c508426b00afa4671f21449225367a64d56b7602d9bc91e67ff454a40b7065b20b73446eee78cdc4cb6e2194e65e411660178"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 03:07:53.023860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 03:07:53.024182) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1461664032.797256-473003316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004765 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 03:07:53.107912) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 03:07:53.108245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 03:07:53.108560) ========= ========= Total master_lag: 0.23 =========