builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1461670900.9 results: success (0) buildid: 20160426041155 builduid: b276353ccef4403fbd9a0f0b50b16148 revision: 7353d8e2cef652857f730e3b9ce39425e388e832 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:40.897843) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:40.904033) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:40.904322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:40.928072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:40.928397) ========= 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=523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 04:41:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-26 04:41:41 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081497 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:41.023397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:41.023695) ========= 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=523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017261 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:41.119807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 04:41:41.120373) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7353d8e2cef652857f730e3b9ce39425e388e832 --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 7353d8e2cef652857f730e3b9ce39425e388e832 --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=523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 04:41:42,002 truncating revision to first 12 chars 2016-04-26 04:41:42,002 Setting DEBUG logging. 2016-04-26 04:41:42,002 attempt 1/10 2016-04-26 04:41:42,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7353d8e2cef6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 04:41:43,053 unpacking tar archive at: fx-team-7353d8e2cef6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.311960 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 04:41:42.451811) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:42.452127) ========= script_repo_revision: 7353d8e2cef652857f730e3b9ce39425e388e832 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:42.452542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:42.452837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 04:41:42.462150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-26 04:41:42.462492) ========= /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=523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:41:43 INFO - MultiFileLogger online at 20160426 04:41:43 in /builds/slave/test 04:41:43 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 04:41:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:43 INFO - {'append_to_log': False, 04:41:43 INFO - 'base_work_dir': '/builds/slave/test', 04:41:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:41:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:43 INFO - 'branch': 'Fx-Team-Non-PGO', 04:41:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:43 INFO - 'config_files': ('talos/linux_config.py',), 04:41:43 INFO - 'default_actions': ('clobber', 04:41:43 INFO - 'read-buildbot-config', 04:41:43 INFO - 'download-and-extract', 04:41:43 INFO - 'populate-webroot', 04:41:43 INFO - 'create-virtualenv', 04:41:43 INFO - 'install', 04:41:43 INFO - 'run-tests'), 04:41:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:43 INFO - 'download_minidump_stackwalk': True, 04:41:43 INFO - 'download_symbols': 'ondemand', 04:41:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:43 INFO - 'installer_path': 'installer.exe', 04:41:43 INFO - 'log_level': 'info', 04:41:43 INFO - 'log_name': 'talos', 04:41:43 INFO - 'log_to_console': True, 04:41:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:41:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:41:43 INFO - 'opt_config_files': (), 04:41:43 INFO - 'pip_index': False, 04:41:43 INFO - 'sps_profile': False, 04:41:43 INFO - 'sps_profile_interval': 0, 04:41:43 INFO - 'suite': 'dromaeojs', 04:41:43 INFO - 'system_bits': '32', 04:41:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:43 INFO - 'title': 'talos-linux64-ix-065', 04:41:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:43 INFO - 'use_talos_json': True, 04:41:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:43 INFO - 'work_dir': 'build'} 04:41:43 INFO - ##### 04:41:43 INFO - ##### Running clobber step. 04:41:43 INFO - ##### 04:41:43 INFO - Running pre-action listener: _resource_record_pre_action 04:41:43 INFO - Running main action method: clobber 04:41:43 INFO - rmtree: /builds/slave/test/build 04:41:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:44 INFO - Running post-action listener: _resource_record_post_action 04:41:44 INFO - ##### 04:41:44 INFO - ##### Running read-buildbot-config step. 04:41:44 INFO - ##### 04:41:44 INFO - Running pre-action listener: _resource_record_pre_action 04:41:44 INFO - Running main action method: read_buildbot_config 04:41:44 INFO - Using buildbot properties: 04:41:44 INFO - { 04:41:44 INFO - "project": "", 04:41:44 INFO - "product": "firefox", 04:41:44 INFO - "script_repo_revision": "production", 04:41:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:41:44 INFO - "repository": "", 04:41:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:41:44 INFO - "buildid": "20160426041155", 04:41:44 INFO - "pgo_build": "False", 04:41:44 INFO - "basedir": "/builds/slave/test", 04:41:44 INFO - "buildnumber": 2889, 04:41:44 INFO - "slavename": "talos-linux64-ix-065", 04:41:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:41:44 INFO - "platform": "ubuntu64_hw", 04:41:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:41:44 INFO - "branch": "fx-team", 04:41:44 INFO - "repo_path": "integration/fx-team", 04:41:44 INFO - "revision": "7353d8e2cef652857f730e3b9ce39425e388e832", 04:41:44 INFO - "stage_platform": "linux64", 04:41:44 INFO - "builduid": "b276353ccef4403fbd9a0f0b50b16148", 04:41:44 INFO - "slavebuilddir": "test" 04:41:44 INFO - } 04:41:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:41:44 INFO - Running post-action listener: _resource_record_post_action 04:41:44 INFO - ##### 04:41:44 INFO - ##### Running download-and-extract step. 04:41:44 INFO - ##### 04:41:44 INFO - Running pre-action listener: _resource_record_pre_action 04:41:44 INFO - Running main action method: download_and_extract 04:41:44 INFO - mkdir: /builds/slave/test/build/tests 04:41:44 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')]} 04:41:44 INFO - https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:41:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:41:48 INFO - Downloaded 1361 bytes. 04:41:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:48 INFO - Using the following test package requirements: 04:41:48 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:41:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:41:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:48 INFO - u'jsshell-linux-x86_64.zip'], 04:41:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:41:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:41:48 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:41:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:41:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:41:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:41:48 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')]} 04:41:48 INFO - https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:41:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:41:49 INFO - Downloaded 22290132 bytes. 04:41:49 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'] 04:41:49 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 04:41:50 INFO - Return code: 0 04:41:50 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 04:41:50 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')]} 04:41:50 INFO - https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:41:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:41:57 INFO - Downloaded 22290132 bytes. 04:41:57 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'] 04:41:57 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 04:41:59 INFO - Return code: 0 04:41:59 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')]} 04:41:59 INFO - https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:42:00 INFO - Downloaded 10840145 bytes. 04:42:00 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'] 04:42:00 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 04:42:00 INFO - Return code: 0 04:42:00 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')]} 04:42:00 INFO - https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:42:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:42:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:42:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:42:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T10-GfifRMSfOb_HKtiCmw/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 04:42:02 INFO - Downloaded 54818173 bytes. 04:42:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:42:02 INFO - mkdir: /builds/slave/test/properties 04:42:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:02 INFO - Contents: 04:42:02 INFO - build_url:https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:42:03 INFO - Running post-action listener: _resource_record_post_action 04:42:03 INFO - Running post-action listener: set_extra_try_arguments 04:42:03 INFO - ##### 04:42:03 INFO - ##### Running populate-webroot step. 04:42:03 INFO - ##### 04:42:03 INFO - Running pre-action listener: _resource_record_pre_action 04:42:03 INFO - Running main action method: populate_webroot 04:42:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:03 INFO - '--tppagecycles', 04:42:03 INFO - '7'], 04:42:03 INFO - 'tests': ['tsvgm']}}, 04:42:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:03 INFO - 'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:03 INFO - 'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['damp', 'tps']}, 04:42:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:03 INFO - 'tests': ['damp', 'tps']}, 04:42:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['dromaeo_dom']}, 04:42:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['a11yr', 04:42:03 INFO - 'ts_paint', 04:42:03 INFO - 'tpaint', 04:42:03 INFO - 'sessionrestore', 04:42:03 INFO - 'sessionrestore_no_auto_restore', 04:42:03 INFO - 'tabpaint']}, 04:42:03 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:03 INFO - 'ts_paint', 04:42:03 INFO - 'tpaint', 04:42:03 INFO - 'sessionrestore', 04:42:03 INFO - 'sessionrestore_no_auto_restore', 04:42:03 INFO - 'tabpaint']}, 04:42:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:03 INFO - 'ts_paint', 04:42:03 INFO - 'tpaint', 04:42:03 INFO - 'sessionrestore', 04:42:03 INFO - 'sessionrestore_no_auto_restore', 04:42:03 INFO - 'tabpaint']}, 04:42:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:03 INFO - 'ts_paint', 04:42:03 INFO - 'tpaint', 04:42:03 INFO - 'sessionrestore', 04:42:03 INFO - 'sessionrestore_no_auto_restore', 04:42:03 INFO - 'tabpaint']}, 04:42:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['a11yr', 04:42:03 INFO - 'ts_paint', 04:42:03 INFO - 'tpaint', 04:42:03 INFO - 'sessionrestore', 04:42:03 INFO - 'sessionrestore_no_auto_restore', 04:42:03 INFO - 'tabpaint']}, 04:42:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['a11yr', 04:42:03 INFO - 'ts_paint', 04:42:03 INFO - 'tpaint', 04:42:03 INFO - 'sessionrestore', 04:42:03 INFO - 'sessionrestore_no_auto_restore', 04:42:03 INFO - 'tabpaint']}, 04:42:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['tsvgx', 04:42:03 INFO - 'tsvgr_opacity', 04:42:03 INFO - 'tart', 04:42:03 INFO - 'tscrollx', 04:42:03 INFO - 'cart']}, 04:42:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:03 INFO - 'tsvgr_opacity', 04:42:03 INFO - 'tart', 04:42:03 INFO - 'tscrollx', 04:42:03 INFO - 'cart']}, 04:42:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:03 INFO - 'talos_options': ['--disable-e10s'], 04:42:03 INFO - 'tests': ['tp5o']}, 04:42:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:03 INFO - 'tests': ['tp5o']}, 04:42:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:03 INFO - 'talos_options': ['--disable-e10s', 04:42:03 INFO - '--xperf_path', 04:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:03 INFO - 'tests': ['tp5n']}, 04:42:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:03 INFO - 'talos_options': ['--xperf_path', 04:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:03 INFO - 'tests': ['tp5n']}}, 04:42:03 INFO - 'talos.zip': {'path': '', 04:42:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:03 INFO - Running post-action listener: _resource_record_post_action 04:42:03 INFO - ##### 04:42:03 INFO - ##### Running create-virtualenv step. 04:42:03 INFO - ##### 04:42:03 INFO - Running pre-action listener: _resource_record_pre_action 04:42:03 INFO - Running main action method: create_virtualenv 04:42:03 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:03 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 04:42:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:03 INFO - Using real prefix '/usr' 04:42:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:03 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:05 INFO - Installing pip.................done. 04:42:05 INFO - Return code: 0 04:42:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:05 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')]} 04:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:05 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')]} 04:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:05 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:05 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 04:42:05 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 04:42:05 INFO - Using env: {'DISPLAY': ':0', 04:42:05 INFO - 'HOME': '/home/cltbld', 04:42:05 INFO - 'LANG': 'en_US.UTF-8', 04:42:05 INFO - 'LANGUAGE': 'en_US:en', 04:42:05 INFO - 'LOGNAME': 'cltbld', 04:42:05 INFO - 'MAIL': '/var/mail/cltbld', 04:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:05 INFO - 'MOZ_NO_REMOTE': '1', 04:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:05 INFO - 'NO_EM_RESTART': '1', 04:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:05 INFO - 'PWD': '/builds/slave/test', 04:42:05 INFO - 'SHELL': '/bin/bash', 04:42:05 INFO - 'SHLVL': '1', 04:42:05 INFO - 'TERM': 'linux', 04:42:05 INFO - 'TMOUT': '86400', 04:42:05 INFO - 'USER': 'cltbld', 04:42:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:05 INFO - '_': '/tools/buildbot/bin/python'} 04:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:05 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 04:42:05 INFO - Cleaning up... 04:42:05 INFO - Return code: 0 04:42:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:42:05 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')]} 04:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:05 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')]} 04:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:05 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:05 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 04:42:05 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 04:42:05 INFO - Using env: {'DISPLAY': ':0', 04:42:05 INFO - 'HOME': '/home/cltbld', 04:42:05 INFO - 'LANG': 'en_US.UTF-8', 04:42:05 INFO - 'LANGUAGE': 'en_US:en', 04:42:05 INFO - 'LOGNAME': 'cltbld', 04:42:05 INFO - 'MAIL': '/var/mail/cltbld', 04:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:05 INFO - 'MOZ_NO_REMOTE': '1', 04:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:05 INFO - 'NO_EM_RESTART': '1', 04:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:05 INFO - 'PWD': '/builds/slave/test', 04:42:05 INFO - 'SHELL': '/bin/bash', 04:42:05 INFO - 'SHLVL': '1', 04:42:05 INFO - 'TERM': 'linux', 04:42:05 INFO - 'TMOUT': '86400', 04:42:05 INFO - 'USER': 'cltbld', 04:42:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:05 INFO - '_': '/tools/buildbot/bin/python'} 04:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:06 INFO - Downloading/unpacking psutil>=0.7.1 04:42:06 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 04:42:06 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 04:42:06 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 04:42:06 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 04:42:06 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 04:42:06 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 04:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:08 INFO - Installing collected packages: psutil 04:42:08 INFO - Running setup.py install for psutil 04:42:08 INFO - building 'psutil._psutil_linux' extension 04:42:08 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 04:42:08 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 04:42:08 INFO - building 'psutil._psutil_posix' extension 04:42:08 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 04:42:08 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 04:42:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:08 INFO - Successfully installed psutil 04:42:08 INFO - Cleaning up... 04:42:08 INFO - Return code: 0 04:42:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:42:08 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')]} 04:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:08 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')]} 04:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:08 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:08 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 04:42:08 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 04:42:08 INFO - Using env: {'DISPLAY': ':0', 04:42:08 INFO - 'HOME': '/home/cltbld', 04:42:08 INFO - 'LANG': 'en_US.UTF-8', 04:42:08 INFO - 'LANGUAGE': 'en_US:en', 04:42:08 INFO - 'LOGNAME': 'cltbld', 04:42:08 INFO - 'MAIL': '/var/mail/cltbld', 04:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:08 INFO - 'MOZ_NO_REMOTE': '1', 04:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:08 INFO - 'NO_EM_RESTART': '1', 04:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:08 INFO - 'PWD': '/builds/slave/test', 04:42:08 INFO - 'SHELL': '/bin/bash', 04:42:08 INFO - 'SHLVL': '1', 04:42:08 INFO - 'TERM': 'linux', 04:42:08 INFO - 'TMOUT': '86400', 04:42:08 INFO - 'USER': 'cltbld', 04:42:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:08 INFO - '_': '/tools/buildbot/bin/python'} 04:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:42:08 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 04:42:08 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 04:42:08 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 04:42:08 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 04:42:08 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 04:42:08 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 04:42:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:42:10 INFO - Installing collected packages: mozsystemmonitor 04:42:10 INFO - Running setup.py install for mozsystemmonitor 04:42:10 INFO - Successfully installed mozsystemmonitor 04:42:10 INFO - Cleaning up... 04:42:10 INFO - Return code: 0 04:42:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:10 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')]} 04:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:10 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')]} 04:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:10 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:10 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 04:42:10 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 04:42:10 INFO - Using env: {'DISPLAY': ':0', 04:42:10 INFO - 'HOME': '/home/cltbld', 04:42:10 INFO - 'LANG': 'en_US.UTF-8', 04:42:10 INFO - 'LANGUAGE': 'en_US:en', 04:42:10 INFO - 'LOGNAME': 'cltbld', 04:42:10 INFO - 'MAIL': '/var/mail/cltbld', 04:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:10 INFO - 'MOZ_NO_REMOTE': '1', 04:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:10 INFO - 'NO_EM_RESTART': '1', 04:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:10 INFO - 'PWD': '/builds/slave/test', 04:42:10 INFO - 'SHELL': '/bin/bash', 04:42:10 INFO - 'SHLVL': '1', 04:42:10 INFO - 'TERM': 'linux', 04:42:10 INFO - 'TMOUT': '86400', 04:42:10 INFO - 'USER': 'cltbld', 04:42:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:10 INFO - '_': '/tools/buildbot/bin/python'} 04:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:11 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:11 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 04:42:11 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 04:42:11 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 04:42:11 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 04:42:11 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 04:42:11 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 04:42:13 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 INFO - Downloading docopt-0.6.1.tar.gz 04:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:13 INFO - Running setup.py install for blobuploader 04:42:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:13 INFO - Running setup.py install for requests 04:42:14 INFO - Running setup.py install for docopt 04:42:14 INFO - Successfully installed blobuploader requests docopt 04:42:14 INFO - Cleaning up... 04:42:14 INFO - Return code: 0 04:42:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:14 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')]} 04:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:14 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')]} 04:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:14 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:14 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 04:42:14 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 04:42:14 INFO - Using env: {'DISPLAY': ':0', 04:42:14 INFO - 'HOME': '/home/cltbld', 04:42:14 INFO - 'LANG': 'en_US.UTF-8', 04:42:14 INFO - 'LANGUAGE': 'en_US:en', 04:42:14 INFO - 'LOGNAME': 'cltbld', 04:42:14 INFO - 'MAIL': '/var/mail/cltbld', 04:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:14 INFO - 'MOZ_NO_REMOTE': '1', 04:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:14 INFO - 'NO_EM_RESTART': '1', 04:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:14 INFO - 'PWD': '/builds/slave/test', 04:42:14 INFO - 'SHELL': '/bin/bash', 04:42:14 INFO - 'SHLVL': '1', 04:42:14 INFO - 'TERM': 'linux', 04:42:14 INFO - 'TMOUT': '86400', 04:42:14 INFO - 'USER': 'cltbld', 04:42:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:14 INFO - '_': '/tools/buildbot/bin/python'} 04:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:14 INFO - Running setup.py (path:/tmp/pip-LuUhna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:14 INFO - Running setup.py (path:/tmp/pip-l2iEFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:14 INFO - Running setup.py (path:/tmp/pip-hV2PaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:14 INFO - Running setup.py (path:/tmp/pip-7rIM40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:14 INFO - Running setup.py (path:/tmp/pip-EyINGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:14 INFO - Running setup.py (path:/tmp/pip-oupQlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:15 INFO - Running setup.py (path:/tmp/pip-qPNaRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:15 INFO - Running setup.py (path:/tmp/pip-ZoNmI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:15 INFO - Running setup.py (path:/tmp/pip-WcmaYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:15 INFO - Running setup.py (path:/tmp/pip-FH6yDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:15 INFO - Running setup.py (path:/tmp/pip-WhNpcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:15 INFO - Running setup.py (path:/tmp/pip-dxZk3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:15 INFO - Running setup.py (path:/tmp/pip-YXl9TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:15 INFO - Running setup.py (path:/tmp/pip-Zuraaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:15 INFO - Running setup.py (path:/tmp/pip-MjmVwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:15 INFO - Running setup.py (path:/tmp/pip-YVddst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:15 INFO - Running setup.py (path:/tmp/pip-9yindl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:15 INFO - Running setup.py install for manifestparser 04:42:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:15 INFO - Running setup.py install for mozcrash 04:42:16 INFO - Running setup.py install for mozdebug 04:42:16 INFO - Running setup.py install for mozdevice 04:42:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Running setup.py install for mozfile 04:42:16 INFO - Running setup.py install for mozhttpd 04:42:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Running setup.py install for mozinfo 04:42:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Running setup.py install for mozInstall 04:42:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Running setup.py install for mozleak 04:42:16 INFO - Running setup.py install for mozlog 04:42:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Running setup.py install for moznetwork 04:42:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:16 INFO - Running setup.py install for mozprocess 04:42:17 INFO - Running setup.py install for mozprofile 04:42:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:17 INFO - Running setup.py install for mozrunner 04:42:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:17 INFO - Running setup.py install for mozscreenshot 04:42:17 INFO - Running setup.py install for moztest 04:42:17 INFO - Running setup.py install for mozversion 04:42:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:17 INFO - Cleaning up... 04:42:17 INFO - Return code: 0 04:42:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:17 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')]} 04:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:17 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')]} 04:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:17 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:17 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 04:42:17 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 04:42:17 INFO - Using env: {'DISPLAY': ':0', 04:42:17 INFO - 'HOME': '/home/cltbld', 04:42:17 INFO - 'LANG': 'en_US.UTF-8', 04:42:17 INFO - 'LANGUAGE': 'en_US:en', 04:42:17 INFO - 'LOGNAME': 'cltbld', 04:42:17 INFO - 'MAIL': '/var/mail/cltbld', 04:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:17 INFO - 'MOZ_NO_REMOTE': '1', 04:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:17 INFO - 'NO_EM_RESTART': '1', 04:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:17 INFO - 'PWD': '/builds/slave/test', 04:42:17 INFO - 'SHELL': '/bin/bash', 04:42:17 INFO - 'SHLVL': '1', 04:42:17 INFO - 'TERM': 'linux', 04:42:17 INFO - 'TMOUT': '86400', 04:42:17 INFO - 'USER': 'cltbld', 04:42:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:17 INFO - '_': '/tools/buildbot/bin/python'} 04:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:17 INFO - Running setup.py (path:/tmp/pip-_GtSIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:17 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)) 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:17 INFO - Running setup.py (path:/tmp/pip-tVJ2Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:17 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)) 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:17 INFO - Running setup.py (path:/tmp/pip-K7aJrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:18 INFO - Running setup.py (path:/tmp/pip-BBkTnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:18 INFO - Running setup.py (path:/tmp/pip-m7gKC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:18 INFO - Running setup.py (path:/tmp/pip-DBlGwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:18 INFO - Running setup.py (path:/tmp/pip-bXp9Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:18 INFO - Running setup.py (path:/tmp/pip-wWJY_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:18 INFO - Running setup.py (path:/tmp/pip-YplmHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:18 INFO - Running setup.py (path:/tmp/pip-N6meec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:18 INFO - Running setup.py (path:/tmp/pip-2HdlSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:18 INFO - Running setup.py (path:/tmp/pip-oKUafn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:18 INFO - Running setup.py (path:/tmp/pip-_zF3C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:18 INFO - Running setup.py (path:/tmp/pip-8TXayS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:18 INFO - Running setup.py (path:/tmp/pip-fhzySy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:18 INFO - Running setup.py (path:/tmp/pip-qObLDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:18 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)) 04:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:18 INFO - Running setup.py (path:/tmp/pip-o5yKfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:19 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)) 04:42:19 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)) 04:42:19 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)) 04:42:19 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)) 04:42:19 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)) 04:42:19 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)) 04:42:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:19 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 04:42:19 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 04:42:19 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 04:42:19 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 04:42:19 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 04:42:19 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 04:42:20 INFO - Downloading blessings-1.6.tar.gz 04:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:21 INFO - Installing collected packages: blessings 04:42:21 INFO - Running setup.py install for blessings 04:42:21 INFO - Successfully installed blessings 04:42:21 INFO - Cleaning up... 04:42:21 INFO - Return code: 0 04:42:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:21 INFO - Reading from file tmpfile_stdout 04:42:21 INFO - Current package versions: 04:42:21 INFO - argparse == 1.2.1 04:42:21 INFO - blessings == 1.6 04:42:21 INFO - blobuploader == 1.2.4 04:42:21 INFO - docopt == 0.6.1 04:42:21 INFO - manifestparser == 1.1 04:42:21 INFO - mozInstall == 1.12 04:42:21 INFO - mozcrash == 0.17 04:42:21 INFO - mozdebug == 0.1 04:42:21 INFO - mozdevice == 0.48 04:42:21 INFO - mozfile == 1.2 04:42:21 INFO - mozhttpd == 0.7 04:42:21 INFO - mozinfo == 0.9 04:42:21 INFO - mozleak == 0.1 04:42:21 INFO - mozlog == 3.1 04:42:21 INFO - moznetwork == 0.27 04:42:21 INFO - mozprocess == 0.22 04:42:21 INFO - mozprofile == 0.28 04:42:21 INFO - mozrunner == 6.11 04:42:21 INFO - mozscreenshot == 0.1 04:42:21 INFO - mozsystemmonitor == 0.0 04:42:21 INFO - moztest == 0.7 04:42:21 INFO - mozversion == 1.4 04:42:21 INFO - psutil == 3.1.1 04:42:21 INFO - requests == 1.2.3 04:42:21 INFO - wsgiref == 0.1.2 04:42:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:21 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')]} 04:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:21 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')]} 04:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:21 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:21 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 04:42:21 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 04:42:21 INFO - Using env: {'DISPLAY': ':0', 04:42:21 INFO - 'HOME': '/home/cltbld', 04:42:21 INFO - 'LANG': 'en_US.UTF-8', 04:42:21 INFO - 'LANGUAGE': 'en_US:en', 04:42:21 INFO - 'LOGNAME': 'cltbld', 04:42:21 INFO - 'MAIL': '/var/mail/cltbld', 04:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:21 INFO - 'MOZ_NO_REMOTE': '1', 04:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:21 INFO - 'NO_EM_RESTART': '1', 04:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:21 INFO - 'PWD': '/builds/slave/test', 04:42:21 INFO - 'SHELL': '/bin/bash', 04:42:21 INFO - 'SHLVL': '1', 04:42:21 INFO - 'TERM': 'linux', 04:42:21 INFO - 'TMOUT': '86400', 04:42:21 INFO - 'USER': 'cltbld', 04:42:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:21 INFO - '_': '/tools/buildbot/bin/python'} 04:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 INFO - Cleaning up... 04:42:21 INFO - Return code: 0 04:42:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42:21 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')]} 04:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:21 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')]} 04:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:21 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:21 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 04:42:21 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 04:42:21 INFO - Using env: {'DISPLAY': ':0', 04:42:21 INFO - 'HOME': '/home/cltbld', 04:42:21 INFO - 'LANG': 'en_US.UTF-8', 04:42:21 INFO - 'LANGUAGE': 'en_US:en', 04:42:21 INFO - 'LOGNAME': 'cltbld', 04:42:21 INFO - 'MAIL': '/var/mail/cltbld', 04:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:21 INFO - 'MOZ_NO_REMOTE': '1', 04:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:21 INFO - 'NO_EM_RESTART': '1', 04:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:21 INFO - 'PWD': '/builds/slave/test', 04:42:21 INFO - 'SHELL': '/bin/bash', 04:42:21 INFO - 'SHLVL': '1', 04:42:21 INFO - 'TERM': 'linux', 04:42:21 INFO - 'TMOUT': '86400', 04:42:21 INFO - 'USER': 'cltbld', 04:42:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:21 INFO - '_': '/tools/buildbot/bin/python'} 04:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:21 INFO - Downloading/unpacking jsonschema 04:42:21 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 04:42:21 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 04:42:21 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 04:42:21 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 04:42:21 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 04:42:21 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 04:42:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:23 INFO - Downloading/unpacking functools32 (from jsonschema) 04:42:23 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 04:42:23 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 04:42:23 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 04:42:23 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 04:42:23 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 04:42:23 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 04:42:23 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:23 INFO - warning: no files found matching '*.txt' 04:42:23 INFO - no previously-included directories found matching 'build' 04:42:23 INFO - no previously-included directories found matching 'dist' 04:42:23 INFO - no previously-included directories found matching '.git*' 04:42:23 INFO - Installing collected packages: jsonschema, functools32 04:42:24 INFO - Running setup.py install for functools32 04:42:24 INFO - warning: no files found matching '*.txt' 04:42:24 INFO - no previously-included directories found matching 'build' 04:42:24 INFO - no previously-included directories found matching 'dist' 04:42:24 INFO - no previously-included directories found matching '.git*' 04:42:24 INFO - Successfully installed jsonschema functools32 04:42:24 INFO - Cleaning up... 04:42:24 INFO - Return code: 0 04:42:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:24 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 0x7f9bb9eaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', '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 04:42:24 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 04:42:24 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 04:42:24 INFO - Using env: {'DISPLAY': ':0', 04:42:24 INFO - 'HOME': '/home/cltbld', 04:42:24 INFO - 'LANG': 'en_US.UTF-8', 04:42:24 INFO - 'LANGUAGE': 'en_US:en', 04:42:24 INFO - 'LOGNAME': 'cltbld', 04:42:24 INFO - 'MAIL': '/var/mail/cltbld', 04:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:24 INFO - 'MOZ_NO_REMOTE': '1', 04:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:24 INFO - 'NO_EM_RESTART': '1', 04:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:24 INFO - 'PWD': '/builds/slave/test', 04:42:24 INFO - 'SHELL': '/bin/bash', 04:42:24 INFO - 'SHLVL': '1', 04:42:24 INFO - 'TERM': 'linux', 04:42:24 INFO - 'TMOUT': '86400', 04:42:24 INFO - 'USER': 'cltbld', 04:42:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:24 INFO - '_': '/tools/buildbot/bin/python'} 04:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:24 INFO - Downloading/unpacking flake8 04:42:24 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 04:42:24 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 04:42:24 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 04:42:24 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 04:42:24 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 04:42:24 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 04:42:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:42:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:42:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:42:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:26 INFO - no previously-included directories found matching 'docs/_build' 04:42:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:42:27 INFO - Running setup.py install for pep8 04:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:27 INFO - no previously-included directories found matching 'docs/_build' 04:42:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:42:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:42:27 INFO - Cleaning up... 04:42:27 INFO - Return code: 0 04:42:27 INFO - Running post-action listener: _resource_record_post_action 04:42:27 INFO - Running post-action listener: _start_resource_monitoring 04:42:27 INFO - Starting resource monitoring. 04:42:27 INFO - ##### 04:42:27 INFO - ##### Running install step. 04:42:27 INFO - ##### 04:42:27 INFO - Running pre-action listener: _resource_record_pre_action 04:42:27 INFO - Running main action method: install 04:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:27 INFO - Reading from file tmpfile_stdout 04:42:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:27 INFO - Reading from file tmpfile_stdout 04:42:27 INFO - Output received: 04:42:27 INFO - Usage: mozinstall [options] installer 04:42:27 INFO - Options: 04:42:27 INFO - -h, --help show this help message and exit 04:42:27 INFO - -d DEST, --destination=DEST 04:42:27 INFO - Directory to install application into. [default: 04:42:27 INFO - "/builds/slave/test"] 04:42:27 INFO - --app=APP Application being installed. [default: firefox] 04:42:27 INFO - mkdir: /builds/slave/test/build/application 04:42:27 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'] 04:42:27 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 04:42:43 INFO - Reading from file tmpfile_stdout 04:42:43 INFO - Output received: 04:42:43 INFO - /builds/slave/test/build/application/firefox/firefox 04:42:43 INFO - Running post-action listener: _resource_record_post_action 04:42:43 INFO - ##### 04:42:43 INFO - ##### Running run-tests step. 04:42:43 INFO - ##### 04:42:43 INFO - Running pre-action listener: _resource_record_pre_action 04:42:43 INFO - Running main action method: run_tests 04:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:43 INFO - Python 2.7.3 04:42:43 INFO - Return code: 0 04:42:43 INFO - grabbing minidump binary from tooltool 04:42:43 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')]} 04:42:43 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 0xf24410>, '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 0xf25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf257a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:43 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 04:42:43 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 04:42:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:43 INFO - Return code: 0 04:42:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:42:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:42:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:42:44 INFO - Return code: 0 04:42:44 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/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 04:42:44 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/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 04:42:44 INFO - Using env: {'DISPLAY': ':0', 04:42:44 INFO - 'HOME': '/home/cltbld', 04:42:44 INFO - 'LANG': 'en_US.UTF-8', 04:42:44 INFO - 'LANGUAGE': 'en_US:en', 04:42:44 INFO - 'LOGNAME': 'cltbld', 04:42:44 INFO - 'MAIL': '/var/mail/cltbld', 04:42:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:44 INFO - 'MOZ_NO_REMOTE': '1', 04:42:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:44 INFO - 'NO_EM_RESTART': '1', 04:42:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:44 INFO - 'PWD': '/builds/slave/test', 04:42:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:44 INFO - 'SHELL': '/bin/bash', 04:42:44 INFO - 'SHLVL': '1', 04:42:44 INFO - 'TERM': 'linux', 04:42:44 INFO - 'TMOUT': '86400', 04:42:44 INFO - 'USER': 'cltbld', 04:42:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901', 04:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:44 INFO - '_': '/tools/buildbot/bin/python'} 04:42:44 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/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 04:42:44 INFO - mozversion application_buildid: 20160426041155 04:42:44 INFO - mozversion application_changeset: 7353d8e2cef652857f730e3b9ce39425e388e832 04:42:44 INFO - mozversion application_display_name: Nightly 04:42:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:44 INFO - mozversion application_name: Firefox 04:42:44 INFO - mozversion application_remotingname: firefox 04:42:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:42:44 INFO - mozversion application_vendor: Mozilla 04:42:44 INFO - mozversion application_version: 49.0a1 04:42:44 INFO - mozversion platform_buildid: 20160426041155 04:42:44 INFO - mozversion platform_changeset: 7353d8e2cef652857f730e3b9ce39425e388e832 04:42:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:42:44 INFO - mozversion platform_version: 49.0a1 04:42:44 INFO - using testdate: 1461670964 04:42:44 INFO - actual date: 1461670964 04:42:44 INFO - starting webserver on 'localhost:44019' 04:42:44 INFO - SUITE-START | Running 2 tests 04:42:44 INFO - TEST-START | dromaeo_css 04:42:44 INFO - operating with platform_type : linux_ 04:42:44 INFO - Initialising browser for dromaeo_css test... 04:42:44 INFO - TEST-INFO | started process 18374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNHhPAh/profile http://localhost:44019/getInfo.html) 04:42:48 INFO - PROCESS | 18374 | __metrics Screen width/height:1600/1200 04:42:48 INFO - PROCESS | 18374 | colorDepth:24 04:42:48 INFO - PROCESS | 18374 | Browser inner width/height: 1024/697 04:42:48 INFO - PROCESS | 18374 | __metrics 04:42:49 ERROR - PROCESS | 18374 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:42:50 INFO - TEST-INFO | 18374: exit 0 04:42:50 INFO - Browser initialized. 04:42:50 INFO - Running cycle 1/1 for dromaeo_css test... 04:42:50 INFO - TEST-INFO | started process 18455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNHhPAh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:02 INFO - PROCESS | 18455 | RSS: Main: 156413952 04:43:02 INFO - PROCESS | 18455 | 04:43:53 INFO - PROCESS | 18455 | 1461671033767 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] 04:46:04 INFO - PROCESS | 18455 | Cycle 1(1): loaded http://localhost:44019/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44019/tests/dromaeo/cssquery-ext.html) 04:46:06 INFO - PROCESS | 18455 | RSS: Main: 278970368 04:46:06 INFO - PROCESS | 18455 | 04:49:08 INFO - PROCESS | 18455 | Cycle 1(1): loaded http://localhost:44019/tests/dromaeo/cssquery-ext.html (next: http://localhost:44019/tests/dromaeo/cssquery-jquery.html) 04:49:09 INFO - PROCESS | 18455 | RSS: Main: 246829056 04:49:09 INFO - PROCESS | 18455 | 04:52:11 INFO - PROCESS | 18455 | Cycle 1(1): loaded http://localhost:44019/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44019/tests/dromaeo/cssquery-mootools.html) 04:52:11 INFO - PROCESS | 18455 | RSS: Main: 250814464 04:52:11 INFO - PROCESS | 18455 | 04:55:14 INFO - PROCESS | 18455 | Cycle 1(1): loaded http://localhost:44019/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44019/tests/dromaeo/cssquery-prototype.html) 04:55:14 INFO - PROCESS | 18455 | RSS: Main: 234938368 04:55:14 INFO - PROCESS | 18455 | 04:58:17 INFO - PROCESS | 18455 | Cycle 1(1): loaded http://localhost:44019/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44019/tests/dromaeo/cssquery-yui.html) 04:58:18 INFO - PROCESS | 18455 | RSS: Main: 205434880 04:58:18 INFO - PROCESS | 18455 | 05:01:20 INFO - PROCESS | 18455 | Cycle 1(1): loaded http://localhost:44019/tests/dromaeo/cssquery-yui.html (next: http://localhost:44019/tests/dromaeo/cssquery-dojo.html) 05:01:21 INFO - PROCESS | 18455 | RSS: Main: 272527360 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - PROCESS | 18455 | __start_tp_report 05:01:21 INFO - PROCESS | 18455 | _x_x_mozilla_page_load 05:01:21 INFO - PROCESS | 18455 | _x_x_mozilla_page_load_details 05:01:21 INFO - PROCESS | 18455 | |i|pagename|runs| 05:01:21 INFO - PROCESS | 18455 | |0;dojo.html;2548.608378126603;2622.2002289301768;2625.2649258207707;2638.3799807045343;2658.3354161459633;4491.438570178728;4560.885977850551;4570.0631370569;4597.54024597541;4598.770061496924;4547.431571053618;4568.474625418078;4598.425196850394;4648.581627653511;4670.813167473306;4133.3386658134705;4188.623023927838;4194.958050419487;4226.598473145046;4351.630111440531;4298.871033868973;4314.525402205755;4320.3735458358515;4364.7817609119575;4368.803403846835;4099.590040995877;4167.2082304362075;4211;4255.957440425603;4263.5736426357425;4229.069604686964;4230.746155230696;4239.682023848224;4255.17024180285;4294.119705460374;4218.261804184286;4245.448091748084;4260.169266992907;4270.807813648394;4296.119295544406;4297.957020429787;4445.977770111161;4525.343825145335;4534.264155842861;4588.426446694163;4885.389326334208;4903.877403064952;4910.288008238821;4911.312416261726;4928.975355123237;4900.779464924051;4908.533689299511;4936.210206367;4940.851774446773;4973.079980203674;4455.933161002587;4574.6340292776495;4603.677742558022;4669;4672.789724462407;5045.41977672565;5058.494150584986;5067.417247016567;5071.771770270347;5072.391313042459;4847.563719265283;4850.514948505192;4862.513748625109;4873.41519017713;4893.02139572087;4708.529147085264;4935.432425271139;5012.548870601663;5028;5037.622178336639;4820.373351464287;4831.396075490564;4840.75796210188;4869.975650121727;4879.487653796371;4811.518848115231;4820.25286080658;4821.54195351441;4835.492273311322;4867.829625963074;4052.77709725962;4126.8761937141935;4127.33962565994;4131.421600975866;4193.35003074524;3653.6711695947492;3677.9080522986606;3679.3745063339297;3680.1535646801385;3681.5582130144016;4094.877153685394;4142.378643203483;4194.727342722713;4267.146570685875;4270.786460677016;4861.197902346144;4884.413870335582;4889.266610008527;4896.5837903777865;4952.801887924515;4222.472190976128;4223.577642235752;4224.514180869178;4230.513490948519;4269.530351661315;4277.978610106992;4420.911581768347;4482.439695038121;4510.864674059783;4514.119746649372;4560.247559152703;4566.725996440225;4568.520305367955;4576.313552967015;4633.4671512775785;4758.524147585353;4802.327674125695;4818.1327361073945;4818.229083346648;4897.755112244445;4612.238980568169;4684.718916864999;4699.318598803086;4700.905981880412;4707.482176960463;4830;4844.46710861812;4849.733264670477;4870.439899411472;4911.484294149063;4894.853154405374;4907.386576677915;4913.975430122827;4914.385701787277;4963.652544322007;4586.72479651222;4715.693479923794;4753.954130091374;4796.9280460792415;4815.783289751899;4761.904761904712;4770.833020844254;4772.880677983078;4781.474037855903;4815.012922350979;4697.365855609449;4701.529847015271;4708.529147085264;4709.317149013305;4746.691465054761;4635.397398338329;4765.166095933268;4852.2479015752615;4871.147549178951;4875.731834748981;4671.299305104261;4681.274402467623;4690.437147542317;4707.670463067552;4724.952750472588 05:01:21 INFO - PROCESS | 18455 | |1;ext.html;552.3732607470997;584.7485581200084;600;613.4448324266539;614.3794767285041;26660.73339266607;34276.31447371054;34697.47953780689;35132.824335878315;35395.82302088486;36721.632783672154;37101.44347834784;37181.814090929576;37226.8138659307;37612.24775504488;7059.505834591555;7475;7680.731174408897;7681.654325555335;7682.270184332508;9386;9649.228061755042;9649.372790768577;9654.71035868925;9655.27585431092;9652.710418687415;9877.70366888991;9879.110880020797;9879.703608891745;9886.209103271722;9641.903580964206;9737.853932191023;9744.171745401649;9758.707238782848;9759.219262458986;9648.083432073941;9785.804283914353;9788.804223915553;10008.549615267257;10035.949820250926;37727.81136094329;38510.80744596259;38546.80726596377;38557.61442385568;38633.227335453135;3105.9223519412194;3161.984190079058;3254.969266384598;3276.836158192081;3737.6262373762406;28600.427991440054;29484.557731634042;29621.407571848657;29634;29697.25756856096;3441.4149594568985;3482.6343233960574;3493.9825300873586;3563.910902227465;3597.388443964532;220839;222536;223038;223428;224879.8756006226;49818.50181498211;50880.74559627178;51249;51294.48705512972;51325.48674513207;54055.72972135114;54098.729506353004;54268;54282.7285863576;54306;14237.928810355881;14657.267136643126;14668.853311466748;14670.266486675624;14679.853201468062;11055.668329950115;11092.778144437067;11103.278286911325;11139.498722557504;11209.775804483865;14827.851721482863;15429.379915108977;15445.922770386076;15470.458533951258;15580.532584022498;5520.834374968757;5536.916946245809;5713;5713.257276554022;5819.709014549256;855.8630619101039;865.5023361567124;871.1462766488877;876.5792419638609;959.2421986630484;24802.875985620318;25179.87410062938;25432.872835636073;25467.10865119712;26094;918.5085979001202;943.2124176312856;956.8614147380599;1006.954687039085;1051.2483574244452;12928.353582320846;13687.452501899812;14015.159090454605;14199.78700319496;14211.431542738175;322425;329243;329675;330117;330824;47557.52442475531;47897.521024789305;48046.27930581044;48130.75934620375;48198.27702584464;1059.904608585231;1135.7103938495632;1226.5032661771818;1269.428757059327;1347.58109193997;24446.51106977815;25567.74432255728;25690.229293121236;25855.482890342464;25981.610275845498;35153.47269791007;35689.46465803067;35727.82136089303;35767.821160894026;35802;174246;176997;177608;177837;177840;20756.792432075486;22457.32628021162;22676.433089172904;23107.88446057826;24041.158559451036;37875.24249514939;39191.216175675756;39435.60564394434;39445;40495.59504405036;33116;33460.66539334576;33698.32603347969;33738.831305844295;34158.82920585381;33214.66785332213;33422.66577334293;33628.32743345071;33832.98501044972;33959.66040339565;33275.33449331048;33327.66672333342;33849;33890.32219355649;33909.66090339164;28331.291717707223;30213.546796797626;30375.69624303817;30714.84642576773;30912.69087309188;23856.761432385454;23863.88068059718;24253.151139710026;24346.391340216636;24534.754652453248 05:01:21 INFO - PROCESS | 18455 | |2;jquery.html;378.4323514727908;387.1289598403592;390.2760379496035;396.6727449853871;403.5641507172254;14017.579472615813;14643.41426342945;15713.764293535593;17356.132193390327;17422.216000279986;15828.129452880086;15892.602684932883;16345.673086538261;16347.26437310321;16700.58248543787;4930.457649658535;5036.194208926581;5169.431362550116;5186.662866913657;5206.947930520703;4940.580050695695;5104.642675012732;5136.845894623168;5137.6403651744395;5144.09978253806;5085.364329458817;5095.261187127864;5095.745212739367;5156.329677141966;6740;7071.080759501283;7075.681594328267;7081.9291807082045;7122.074130363046;7131.7503887363955;6610.107635469199;6976.790696279119;6985.685644146026;7004.299570043006;7005.369516743517;23073.76926230733;23146.421339466648;23327.533449331087;23760.524789504114;24180.2745917621;2148.9247876324253;2156.9784302156936;2367.289813056076;2457.103157347573;2639.2478143729136;14057.830506441685;14326.426942922271;14793.630159245997;14872.033317834306;15288.464903728316;1833.51411875853;1915.6360291544702;1928.9421317360502;1941.5825597496605;1987.3044434447972;76484.61757691232;80058.59970700109;80395;80788.99999999942;81045.18954810435;16181.838181618268;16414.343426262814;16514.83485165157;16859.241334139748;17017.574560636083;24150.87924560366;25550.488990220092;30105.247368815955;30119.849400752857;30128.397432051235;8948.328875334377;9278.443293402283;9583.808323833624;9609.135177834029;9664.855027174597;7845;7877.487963282483;7991.480553763987;8084.7574572762915;8097.35221182304;8000.679972801139;8294.58527073656;8417.202194749058;8457.873131903027;8650.91349086501;3142.701443362877;3323.966760332414;3461.930761384758;3468.150303175738;3473.7915725056578;805.4160733468188;831.5883637599306;832.7834762961674;846;906.4380084347747;16116.113613751357;16823.41118060862;16929.661406771796;17090.48728538121;17213.536849367945;827.3133299361516;831.4387788243033;847.5423271433357;852.2585350744768;872.7774417523618;8611.181937715906;9475.384100033476;9497.192738617296;9625.32622716403;9754.707643703723;368513;372968;382338;383169;384321;73117.6344118276;76773.61613191899;77039.61480192676;77050.61474692702;77252;929.5631053404888;930.6510058727977;952.4904176265665;954.6706386296717;959.2278216036018;14725.631859203606;14974.925125374739;14989.40042398292;15175.24123793828;15240.466583669519;32917.67082329146;34288.657113429545;34572.13569660678;35589;35906.8204658975;44732.77633611811;47337.763311183226;49133;49531.50468495269;49547.50452495429;8129.552874591955;8163.469374490639;8179.631916563888;8208.671653134046;8256.752297431087;11569.6529104127;11982.820257695967;12107.33409662477;12183.878161218274;12301.815472768094;10708.73228169302;10785.648281549711;10802.189835762507;10851.077658399125;10916.78166436651;9503.19222866064;9507.524623768646;9527.047295270417;9662.3236373456;10178.440185789852;9455.385399948982;10665.840012399975;10676.252662313564;10745.623903163352;11060.557577697124;7926.564038977912;7930.60346982637;8156.10282868872;8290.502569845828;8361.623726932181;8149.79625509367;9731.41611503312;10392.792144157225;10672.466376680979;10719.839202412126 05:01:21 INFO - PROCESS | 18455 | |3;mootools.html;1236.6784635994638;1415.0519152168047;1449.3333066789276;1581.462302817042;1776.2450958342693;6140.7850725224625;7344;7509.061367329077;7509.286617771303;7521.135069467013;7061.293870612949;7220.819479513015;7229.746958856441;7244.094488188976;7246.420286377091;1838.7058070708622;1897.9240830366837;1905.104600837604;2158.363282831561;2190.5509370578993;2181.3892110209167;2259.164109279569;2259.548090381922;2260.062074239189;2262.3552287598036;2144.924927627533;2190.9780902190932;2203.911843526257;2214.678871563622;2217.3569664797187;1781.4121339957783;1866.915988780508;2156.9892150539226;2158.967615485769;2171.0230396321717;2083.239617539587;2177.031221106608;2180.3132013415725;2180.716506854115;2184.3119417383473;7235.167955685111;7288.271172882723;7297.233790451979;7300.233475485104;7304.671289791919;4304.870853874389;4466.151431228089;4489.730616163008;4490.977545112286;4494.483134439516;2684.704682484925;2744.464829358256;2944.1461976026926;2950.3066779306846;2954.6897575754665;904.7511934218077;910.1762904571374;913.6756451459703;927.4018258223408;944.5513381143902;10161.18710503158;10167.644132455402;10183.745406364826;10204.795904081877;10243.334183278062;4128.050548373891;4147.440095587118;4152.211079894811;4179.644730197967;4196.034911970264;8679.913200868037;8748.43135196223;8751.737447876447;8787.604557794786;8812;4551.362809206714;4564.041551274269;4584.724916505021;4595.218812801765;4598.609118224921;3381.814000229962;3897.785621790772;4067.983004248938;4090.6318431341324;4207.116505533811;3470.8091054991714;3490.5985811631986;3544.078539579676;3573.8034408107806;3595.19108200658;1140.6749076513154;1146.925449845774;1156.1675593572613;1176.211938001541;1198.3469009389903;833.5873742497381;847.2671139464319;849.9915000850036;878.4597472554333;886.4459712679575;4912.189488734319;5019.816379874766;5097.057044446789;5153.123968925292;5214.478552144755;942.5852624845046;944.0323668240109;963.8120566489607;966.2221911361281;976.2677991506371;3277.9672203278137;3404.744644151649;3425.3663072331697;3436.037909385376;3521.9471707924404;9092.772680683036;9331.90668093324;9466.337356385126;9479.383840050512;9480.24158067353;9187.77030574241;9384.95307523458;9388.483633400092;9390.154886060287;9402.623895044258;6742.898856517156;6785.55893866907;6813;6850.0752398426575;6866.622335771481;4818.566329030264;4982.75086245679;5046.167382382013;5053.974730126326;5071.847844564669;7966.442349035512;8143.18568143181;8196.67213311461;8277.917220827714;8321.375896807886;8360.414770965974;8397.538135402612;8439.831203376021;8539.658413663385;8548.91451085506;5347.893042139213;6040.456358927718;6162.568620196723;6207;6318.557700961072;7226.168990566152;7276.527025743309;7306.123265208209;7357.153927298429;7379.151397589131;6491.707873145625;6649.667516624053;6666.2333831609985;6768.221654509597;6810.62541560219;6443.935560644333;6495;6559.7376104957175;6617.602943823386;6645.302243264581;6065.72704228302;6102.786402475892;6141.570090093829;6142.938570614237;6149.016157414792;4277.657787377065;4301.655867530528;4401.317795741666;4405;4421.40311058003;4130.834766609422;4316.050468896838;4425.623821975039;4508.526604706459;4558.270676691714 05:01:21 INFO - PROCESS | 18455 | |4;prototype.html;301.09370793910335;305.31913832154294;306.20081587057774;306.765324526737;308.67126510266576;4764.618830493561;4780.378550788397;4781.378420805299;4809.783559739816;4842.322074909515;4694.174247987896;4709.0346478971815;4728.929066064012;4735.218688916325;4737.289406589013;3525.7307369347013;3641.927161456769;3645.8541658333634;3661.304352173092;3666.7983260920637;3639.781613103209;3698.4637227601984;3736.7579452328523;3769.3026790043928;3781.394976803712;3688.889333320005;3738.738288319819;3746.8501259949708;3752.437134429844;3778.489903862971;3643.2531331077066;3699.9260014799825;3756.1173124315765;3757;3767.510223670919;3309.25541753106;3316.651751566075;3323.3187196624635;3334.5998480182534;3336.6830151135605;4525.479569849444;4555.703879247872;4557.612602928722;4559.384483094773;4561.201789686825;4256.893577660552;4266.168097221043;4282.143571285756;4283.164782867311;4295.484541854966;4755.524447555217;4942.233953737176;4964.30159531148;4967.205247160437;4990.750462476862;3597.2086141048926;3603.0992251937014;3625.7461977661574;3639.1266096136737;3640.5631324240994;5157.5616072633875;5188.8183913563225;5210.270562121306;5212.166053431432;5217.817376391846;3394.3890099781784;3625.1843335249887;3718.795466249382;3723.702103831687;3726.6832319252626;3630.7458477906293;3639.9818000909827;3654.488371627974;3655.7258205634685;3672.559292884871;4124.010237542968;4163.562825903297;4168.958310416857;4171.290880550314;4184.28867092595;5011.273365362002;5031.924521132186;5033.84898453047;5039.470855560114;5039.77321020555;1306.8627794081485;1335.6126723250343;1350.4598160735784;1351.9053666243465;1358.9728205435836;888.2583043159035;890.9486805569361;896.7847716548112;909.4270609515962;914.8444764390069;4198.433211516467;4335.349697545394;4353.738775673406;4377.824887004548;4396.934045989313;5012.548870601663;5116.590672746172;5135.815794207615;5188.7405629719115;5207.307625021807;4401.713888597231;4411.139827733626;4435.933460998088;4439.4006809080365;4454.532274111237;2815.577663350514;2927.5901373807683;2936.427396657674;2937;2952.35048289376;5175.480673142224;5208.114620514521;5210.609204309692;5220.295260139908;5222.3472065991755;5566;5619.1290349995;5677.971610141923;5695.145728140729;5695.857603559944;5191.117510023229;5200.8959820803375;5201.713905735145;5219.817306394258;5227.477252274742;5542.7782888684005;5543.473370029841;5550.361708403585;5566;5569.05326094573;5250.737463126905;5442.727863606883;5456.890862182655;5461.1808228766;5461.371942226695;5174;5195.519277006035;5215.869603259949;5216.765245564035;5222.060029194781;3841.5582208045316;3850.3646898261472;3851.287511810324;3853.788041657736;3855.4795102660783;5353.598480113929;5492.093804522209;5528.364238112668;5558.055130627884;5567.3040869891265;5313.415524292247;5341.786328546815;5344.812931547533;5351.411344752152;5363.383210930637;5344.893102138013;5346.930613877318;5352.919706204488;5364.544013758874;5364.9731751341;4688.2733176357715;4952.727599982036;4974.900501989868;4996.875078123076;5252.632315737862;4704.223803072455;4849.95150048495;4995.500449954975;5035.446100928822;5057.418396884405;4939.209726443752;4950.702957822542;4960.6031517477795;4963.429205641398;4967.60259179272 05:01:21 INFO - PROCESS | 18455 | |5;yui.html;692.7921623512945;692.9168499780027;725.1008749151055;736.5838301359731;756.8032311598986;12058.336791476466;12362.505499779998;12376;12709.173903696254;12721.491140354387;11966.521339146424;12032.578859739911;12041.879581204184;12070.275783452998;12070.698232544191;649.5972497051835;810.2828996338225;820.0978923184509;823.7158180427773;824.8474032304013;793.3217099380005;813.8657121574963;816.9223923727236;817.6361519123992;817.6851912013888;864.7751584588021;869.0657543141149;873.9737807865743;874.4665753890122;874.921257086862;673.4982438083659;691.6126968897433;856.4475913036088;863.447393668053;863.8617821148649;506.3114164735956;612.5130521235628;622.2066864747438;623.4357906094991;624.2166081567649;12398.31809250491;12426.627201183888;12474;12489.562865299762;12603.684907877285;11823;12376.195547289397;13243.73512529744;13248.735025299537;13255.204687718768;9378.624855005792;9407.952960235156;9661.758456038586;9678.128968392879;9937.155341795957;3261.445554255782;3301.5873015873017;3351.6480769519094;3372.814495202763;3383.915402114942;44418.11163776739;44511.55488445106;44556.3316550252;44927.10145797098;45018.099638007385;9579.281553883488;9623.807523849484;9822.361546499455;9867.11195992364;9906.157976571927;16797.244124014203;16811.91594042022;16960.57598560046;17047;17073.146342682816;6634.104395906491;6830.248672646105;6846.520743547904;6892.379685828299;6894.310568943166;3829.1384438501673;3841.5774264830848;3859.456765512086;3920;3973.145773658677;2787.5957986091903;2834.2347566157023;2854.8572571371346;2882.437924604682;2891.4361699468823;505.683947532792;511.75180037681696;518.3106468397023;521.2311840035917;522.255785505653;529.2563947653553;608.8082254089948;612.3111499562991;626.9905452221919;653.4511010750992;7640.617969101522;7812.53124812513;7836.843263134705;7874.330681891989;7887.645055972495;599.937006614308;633.1673848888696;639.1084437210066;641.3169973977699;641.403494749887;3522.876699315512;3637.342049667173;3709.642298632103;3813.3136035513876;3818.6443812446737;52609.736951315;53618;53684.46315536873;53899;55292.44707552953;45742.313865292046;47132.5286747135;47481.76259118682;47623.28565071527;48249;42920;43234.78382608067;43370.7831460847;43839;44127.77936110299;6829.829254268484;6888.279129743823;6902.309769023058;6910.343517365842;6923.619200943795;28548.286292842015;28802.567961480174;29004.564931525623;29344;29374.853125734233;36344.636553634125;38797.80601096976;39520.407193892686;39555;39577;9002.639894404412;9352.392094513834;9467.763305917408;9568.138867501959;9713.70858874235;9439.339246252972;9662.75843103928;9767.511624418892;9961.252906031932;10680.198985075995;9312.767180820534;9437.245020398488;9446.338756287269;9519.286053545873;9749.853752193865;9757.951210243904;9867.358621689567;10035;10070.144037756872;10149.695509134737;9441.339106262496;9486.146246837818;9546.093121153479;9856.359336643096;9905.306628536222;8343.916560834557;8643.481391116553;8856.955715221382;8970.282377409661;9051.637934482547;7860.410469214946;8056.355491560544;8148.668370116891;8265.710700125466;8312.127226641116 05:01:21 INFO - PROCESS | 18455 | __end_tp_report 05:01:21 INFO - PROCESS | 18455 | __start_cc_report 05:01:21 INFO - PROCESS | 18455 | _x_x_mozilla_cycle_collect,1119 05:01:21 INFO - PROCESS | 18455 | __end_cc_report 05:01:21 INFO - PROCESS | 18455 | __startTimestamp1461672081003__endTimestamp 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - PROCESS | 18455 | ------- Summary: start ------- 05:01:21 INFO - PROCESS | 18455 | Number of tests: 6 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - PROCESS | 18455 | [#0] dojo.html Cycles:165 Average:4535.31 Median:4671.30 stddev:463.98 (9.9%) stddev-sans-first:438.44 05:01:21 INFO - PROCESS | 18455 | Values: 2548.6 2622.2 2625.3 2638.4 2658.3 4491.4 4560.9 4570.1 4597.5 4598.8 4547.4 4568.5 4598.4 4648.6 4670.8 4133.3 4188.6 4195.0 4226.6 4351.6 4298.9 4314.5 4320.4 4364.8 4368.8 4099.6 4167.2 4211.0 4256.0 4263.6 4229.1 4230.7 4239.7 4255.2 4294.1 4218.3 4245.4 4260.2 4270.8 4296.1 4298.0 4446.0 4525.3 4534.3 4588.4 4885.4 4903.9 4910.3 4911.3 4929.0 4900.8 4908.5 4936.2 4940.9 4973.1 4455.9 4574.6 4603.7 4669.0 4672.8 5045.4 5058.5 5067.4 5071.8 5072.4 4847.6 4850.5 4862.5 4873.4 4893.0 4708.5 4935.4 5012.5 5028.0 5037.6 4820.4 4831.4 4840.8 4870.0 4879.5 4811.5 4820.3 4821.5 4835.5 4867.8 4052.8 4126.9 4127.3 4131.4 4193.4 3653.7 3677.9 3679.4 3680.2 3681.6 4094.9 4142.4 4194.7 4267.1 4270.8 4861.2 4884.4 4889.3 4896.6 4952.8 4222.5 4223.6 4224.5 4230.5 4269.5 4278.0 4420.9 4482.4 4510.9 4514.1 4560.2 4566.7 4568.5 4576.3 4633.5 4758.5 4802.3 4818.1 4818.2 4897.8 4612.2 4684.7 4699.3 4700.9 4707.5 4830.0 4844.5 4849.7 4870.4 4911.5 4894.9 4907.4 4914.0 4914.4 4963.7 4586.7 4715.7 4754.0 4796.9 4815.8 4761.9 4770.8 4772.9 4781.5 4815.0 4697.4 4701.5 4708.5 4709.3 4746.7 4635.4 4765.2 4852.2 4871.1 4875.7 4671.3 4681.3 4690.4 4707.7 4725.0 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - PROCESS | 18455 | [#1] ext.html Cycles:180 Average:40020.50 Median:33899.99 stddev:65730.00 (193.9%) stddev-sans-first:65847.59 05:01:21 INFO - PROCESS | 18455 | Values: 552.4 584.7 600.0 613.4 614.4 26660.7 34276.3 34697.5 35132.8 35395.8 36721.6 37101.4 37181.8 37226.8 37612.2 7059.5 7475.0 7680.7 7681.7 7682.3 9386.0 9649.2 9649.4 9654.7 9655.3 9652.7 9877.7 9879.1 9879.7 9886.2 9641.9 9737.9 9744.2 9758.7 9759.2 9648.1 9785.8 9788.8 10008.5 10035.9 37727.8 38510.8 38546.8 38557.6 38633.2 3105.9 3162.0 3255.0 3276.8 3737.6 28600.4 29484.6 29621.4 29634.0 29697.3 3441.4 3482.6 3494.0 3563.9 3597.4 220839.0 222536.0 223038.0 223428.0 224879.9 49818.5 50880.7 51249.0 51294.5 51325.5 54055.7 54098.7 54268.0 54282.7 54306.0 14237.9 14657.3 14668.9 14670.3 14679.9 11055.7 11092.8 11103.3 11139.5 11209.8 14827.9 15429.4 15445.9 15470.5 15580.5 5520.8 5536.9 5713.0 5713.3 5819.7 855.9 865.5 871.1 876.6 959.2 24802.9 25179.9 25432.9 25467.1 26094.0 918.5 943.2 956.9 1007.0 1051.2 12928.4 13687.5 14015.2 14199.8 14211.4 322425.0 329243.0 329675.0 330117.0 330824.0 47557.5 47897.5 48046.3 48130.8 48198.3 1059.9 1135.7 1226.5 1269.4 1347.6 24446.5 25567.7 25690.2 25855.5 25981.6 35153.5 35689.5 35727.8 35767.8 35802.0 174246.0 176997.0 177608.0 177837.0 177840.0 20756.8 22457.3 22676.4 23107.9 24041.2 37875.2 39191.2 39435.6 39445.0 40495.6 33116.0 33460.7 33698.3 33738.8 34158.8 33214.7 33422.7 33628.3 33833.0 33959.7 33275.3 33327.7 33849.0 33890.3 33909.7 28331.3 30213.5 30375.7 30714.8 30912.7 23856.8 23863.9 24253.2 24346.4 24534.8 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - PROCESS | 18455 | [#2] jquery.html Cycles:180 Average:25234.05 Median:27031.73 stddev:62527.40 (231.3%) stddev-sans-first:62674.96 05:01:21 INFO - PROCESS | 18455 | Values: 378.4 387.1 390.3 396.7 403.6 14017.6 14643.4 15713.8 17356.1 17422.2 15828.1 15892.6 16345.7 16347.3 16700.6 4930.5 5036.2 5169.4 5186.7 5206.9 4940.6 5104.6 5136.8 5137.6 5144.1 5085.4 5095.3 5095.7 5156.3 6740.0 7071.1 7075.7 7081.9 7122.1 7131.8 6610.1 6976.8 6985.7 7004.3 7005.4 23073.8 23146.4 23327.5 23760.5 24180.3 2148.9 2157.0 2367.3 2457.1 2639.2 14057.8 14326.4 14793.6 14872.0 15288.5 1833.5 1915.6 1928.9 1941.6 1987.3 76484.6 80058.6 80395.0 80789.0 81045.2 16181.8 16414.3 16514.8 16859.2 17017.6 24150.9 25550.5 30105.2 30119.8 30128.4 8948.3 9278.4 9583.8 9609.1 9664.9 7845.0 7877.5 7991.5 8084.8 8097.4 8000.7 8294.6 8417.2 8457.9 8650.9 3142.7 3324.0 3461.9 3468.2 3473.8 805.4 831.6 832.8 846.0 906.4 16116.1 16823.4 16929.7 17090.5 17213.5 827.3 831.4 847.5 852.3 872.8 8611.2 9475.4 9497.2 9625.3 9754.7 368513.0 372968.0 382338.0 383169.0 384321.0 73117.6 76773.6 77039.6 77050.6 77252.0 929.6 930.7 952.5 954.7 959.2 14725.6 14974.9 14989.4 15175.2 15240.5 32917.7 34288.7 34572.1 35589.0 35906.8 44732.8 47337.8 49133.0 49531.5 49547.5 8129.6 8163.5 8179.6 8208.7 8256.8 11569.7 11982.8 12107.3 12183.9 12301.8 10708.7 10785.6 10802.2 10851.1 10916.8 9503.2 9507.5 9527.0 9662.3 10178.4 9455.4 10665.8 10676.3 10745.6 11060.6 7926.6 7930.6 8156.1 8290.5 8361.6 8149.8 9731.4 10392.8 10672.5 10719.8 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - PROCESS | 18455 | [#3] mootools.html Cycles:180 Average:4923.53 Median:5062.91 stddev:2713.74 (53.6%) stddev-sans-first:2707.20 05:01:21 INFO - PROCESS | 18455 | Values: 1236.7 1415.1 1449.3 1581.5 1776.2 6140.8 7344.0 7509.1 7509.3 7521.1 7061.3 7220.8 7229.7 7244.1 7246.4 1838.7 1897.9 1905.1 2158.4 2190.6 2181.4 2259.2 2259.5 2260.1 2262.4 2144.9 2191.0 2203.9 2214.7 2217.4 1781.4 1866.9 2157.0 2159.0 2171.0 2083.2 2177.0 2180.3 2180.7 2184.3 7235.2 7288.3 7297.2 7300.2 7304.7 4304.9 4466.2 4489.7 4491.0 4494.5 2684.7 2744.5 2944.1 2950.3 2954.7 904.8 910.2 913.7 927.4 944.6 10161.2 10167.6 10183.7 10204.8 10243.3 4128.1 4147.4 4152.2 4179.6 4196.0 8679.9 8748.4 8751.7 8787.6 8812.0 4551.4 4564.0 4584.7 4595.2 4598.6 3381.8 3897.8 4068.0 4090.6 4207.1 3470.8 3490.6 3544.1 3573.8 3595.2 1140.7 1146.9 1156.2 1176.2 1198.3 833.6 847.3 850.0 878.5 886.4 4912.2 5019.8 5097.1 5153.1 5214.5 942.6 944.0 963.8 966.2 976.3 3278.0 3404.7 3425.4 3436.0 3521.9 9092.8 9331.9 9466.3 9479.4 9480.2 9187.8 9385.0 9388.5 9390.2 9402.6 6742.9 6785.6 6813.0 6850.1 6866.6 4818.6 4982.8 5046.2 5054.0 5071.8 7966.4 8143.2 8196.7 8277.9 8321.4 8360.4 8397.5 8439.8 8539.7 8548.9 5347.9 6040.5 6162.6 6207.0 6318.6 7226.2 7276.5 7306.1 7357.2 7379.2 6491.7 6649.7 6666.2 6768.2 6810.6 6443.9 6495.0 6559.7 6617.6 6645.3 6065.7 6102.8 6141.6 6142.9 6149.0 4277.7 4301.7 4401.3 4405.0 4421.4 4130.8 4316.1 4425.6 4508.5 4558.3 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - PROCESS | 18455 | [#4] prototype.html Cycles:180 Average:4255.92 Median:4736.25 stddev:1263.03 (26.7%) stddev-sans-first:1231.20 05:01:21 INFO - PROCESS | 18455 | Values: 301.1 305.3 306.2 306.8 308.7 4764.6 4780.4 4781.4 4809.8 4842.3 4694.2 4709.0 4728.9 4735.2 4737.3 3525.7 3641.9 3645.9 3661.3 3666.8 3639.8 3698.5 3736.8 3769.3 3781.4 3688.9 3738.7 3746.9 3752.4 3778.5 3643.3 3699.9 3756.1 3757.0 3767.5 3309.3 3316.7 3323.3 3334.6 3336.7 4525.5 4555.7 4557.6 4559.4 4561.2 4256.9 4266.2 4282.1 4283.2 4295.5 4755.5 4942.2 4964.3 4967.2 4990.8 3597.2 3603.1 3625.7 3639.1 3640.6 5157.6 5188.8 5210.3 5212.2 5217.8 3394.4 3625.2 3718.8 3723.7 3726.7 3630.7 3640.0 3654.5 3655.7 3672.6 4124.0 4163.6 4169.0 4171.3 4184.3 5011.3 5031.9 5033.8 5039.5 5039.8 1306.9 1335.6 1350.5 1351.9 1359.0 888.3 890.9 896.8 909.4 914.8 4198.4 4335.3 4353.7 4377.8 4396.9 5012.5 5116.6 5135.8 5188.7 5207.3 4401.7 4411.1 4435.9 4439.4 4454.5 2815.6 2927.6 2936.4 2937.0 2952.4 5175.5 5208.1 5210.6 5220.3 5222.3 5566.0 5619.1 5678.0 5695.1 5695.9 5191.1 5200.9 5201.7 5219.8 5227.5 5542.8 5543.5 5550.4 5566.0 5569.1 5250.7 5442.7 5456.9 5461.2 5461.4 5174.0 5195.5 5215.9 5216.8 5222.1 3841.6 3850.4 3851.3 3853.8 3855.5 5353.6 5492.1 5528.4 5558.1 5567.3 5313.4 5341.8 5344.8 5351.4 5363.4 5344.9 5346.9 5352.9 5364.5 5365.0 4688.3 4952.7 4974.9 4996.9 5252.6 4704.2 4850.0 4995.5 5035.4 5057.4 4939.2 4950.7 4960.6 4963.4 4967.6 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - PROCESS | 18455 | [#5] yui.html Cycles:180 Average:12501.31 Median:622.82 stddev:14621.64 (2347.6%) stddev-sans-first:14635.77 05:01:21 INFO - PROCESS | 18455 | Values: 692.8 692.9 725.1 736.6 756.8 12058.3 12362.5 12376.0 12709.2 12721.5 11966.5 12032.6 12041.9 12070.3 12070.7 649.6 810.3 820.1 823.7 824.8 793.3 813.9 816.9 817.6 817.7 864.8 869.1 874.0 874.5 874.9 673.5 691.6 856.4 863.4 863.9 506.3 612.5 622.2 623.4 624.2 12398.3 12426.6 12474.0 12489.6 12603.7 11823.0 12376.2 13243.7 13248.7 13255.2 9378.6 9408.0 9661.8 9678.1 9937.2 3261.4 3301.6 3351.6 3372.8 3383.9 44418.1 44511.6 44556.3 44927.1 45018.1 9579.3 9623.8 9822.4 9867.1 9906.2 16797.2 16811.9 16960.6 17047.0 17073.1 6634.1 6830.2 6846.5 6892.4 6894.3 3829.1 3841.6 3859.5 3920.0 3973.1 2787.6 2834.2 2854.9 2882.4 2891.4 505.7 511.8 518.3 521.2 522.3 529.3 608.8 612.3 627.0 653.5 7640.6 7812.5 7836.8 7874.3 7887.6 599.9 633.2 639.1 641.3 641.4 3522.9 3637.3 3709.6 3813.3 3818.6 52609.7 53618.0 53684.5 53899.0 55292.4 45742.3 47132.5 47481.8 47623.3 48249.0 42920.0 43234.8 43370.8 43839.0 44127.8 6829.8 6888.3 6902.3 6910.3 6923.6 28548.3 28802.6 29004.6 29344.0 29374.9 36344.6 38797.8 39520.4 39555.0 39577.0 9002.6 9352.4 9467.8 9568.1 9713.7 9439.3 9662.8 9767.5 9961.3 10680.2 9312.8 9437.2 9446.3 9519.3 9749.9 9758.0 9867.4 10035.0 10070.1 10149.7 9441.3 9486.1 9546.1 9856.4 9905.3 8343.9 8643.5 8857.0 8970.3 9051.6 7860.4 8056.4 8148.7 8265.7 8312.1 05:01:21 INFO - PROCESS | 18455 | -------- Summary: end -------- 05:01:21 INFO - PROCESS | 18455 | 05:01:21 INFO - TEST-INFO | 18455: exit 0 05:01:21 INFO - TEST-OK | dromaeo_css | took 1117308ms 05:01:21 INFO - TEST-START | kraken 05:01:21 INFO - operating with platform_type : linux_ 05:01:21 INFO - Initialising browser for kraken test... 05:01:21 INFO - TEST-INFO | started process 18641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOHre4O/profile http://localhost:44019/getInfo.html) 05:01:25 INFO - PROCESS | 18641 | __metrics Screen width/height:1600/1200 05:01:25 INFO - PROCESS | 18641 | colorDepth:24 05:01:25 INFO - PROCESS | 18641 | Browser inner width/height: 1024/697 05:01:25 INFO - PROCESS | 18641 | __metrics 05:01:26 ERROR - PROCESS | 18641 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:01:27 INFO - TEST-INFO | 18641: exit 0 05:01:27 INFO - Browser initialized. 05:01:27 INFO - Running cycle 1/1 for kraken test... 05:01:27 INFO - TEST-INFO | started process 18721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOHre4O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:39 INFO - PROCESS | 18721 | RSS: Main: 156315648 05:01:39 INFO - PROCESS | 18721 | 05:01:42 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44019/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:43 INFO - PROCESS | 18721 | RSS: Main: 210964480 05:01:43 INFO - PROCESS | 18721 | 05:01:46 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44019/tests/kraken/driver.html?testName=audio-dft) 05:01:46 INFO - PROCESS | 18721 | RSS: Main: 196190208 05:01:46 INFO - PROCESS | 18721 | 05:01:50 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44019/tests/kraken/driver.html?testName=audio-fft) 05:01:50 INFO - PROCESS | 18721 | RSS: Main: 267218944 05:01:50 INFO - PROCESS | 18721 | 05:01:52 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44019/tests/kraken/driver.html?testName=audio-oscillator) 05:01:53 INFO - PROCESS | 18721 | RSS: Main: 174977024 05:01:53 INFO - PROCESS | 18721 | 05:01:55 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44019/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:01:56 INFO - PROCESS | 18721 | RSS: Main: 178958336 05:01:56 INFO - PROCESS | 18721 | 05:01:59 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44019/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:00 INFO - PROCESS | 18721 | RSS: Main: 215142400 05:02:00 INFO - PROCESS | 18721 | 05:02:03 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44019/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:04 INFO - PROCESS | 18721 | RSS: Main: 213704704 05:02:04 INFO - PROCESS | 18721 | 05:02:06 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44019/tests/kraken/driver.html?testName=json-parse-financial) 05:02:07 INFO - PROCESS | 18721 | RSS: Main: 215740416 05:02:07 INFO - PROCESS | 18721 | 05:02:09 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44019/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:09 INFO - PROCESS | 18721 | RSS: Main: 201334784 05:02:09 INFO - PROCESS | 18721 | 05:02:11 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44019/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:12 INFO - PROCESS | 18721 | RSS: Main: 202784768 05:02:12 INFO - PROCESS | 18721 | 05:02:14 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44019/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:15 INFO - PROCESS | 18721 | RSS: Main: 215302144 05:02:15 INFO - PROCESS | 18721 | 05:02:17 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:18 INFO - PROCESS | 18721 | RSS: Main: 223772672 05:02:18 INFO - PROCESS | 18721 | 05:02:21 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:22 INFO - PROCESS | 18721 | RSS: Main: 219795456 05:02:22 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | Cycle 1(1): loaded http://localhost:44019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44019/tests/kraken/driver.html?testName=ai-astar) 05:02:24 INFO - PROCESS | 18721 | RSS: Main: 283123712 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | __start_tp_report 05:02:24 INFO - PROCESS | 18721 | _x_x_mozilla_page_load 05:02:24 INFO - PROCESS | 18721 | _x_x_mozilla_page_load_details 05:02:24 INFO - PROCESS | 18721 | |i|pagename|runs| 05:02:24 INFO - PROCESS | 18721 | |0;ai-astar;113;114;112;115;116;113;106;116;115;116 05:02:24 INFO - PROCESS | 18721 | |1;audio-beat-detection;172;132;162;189;134;160;163;137;188;133 05:02:24 INFO - PROCESS | 18721 | |2;audio-dft;162;161;162;161;161;162;162;161;161;163 05:02:24 INFO - PROCESS | 18721 | |3;audio-fft;73;73;110;107;76;75;73;125;103;73 05:02:24 INFO - PROCESS | 18721 | |4;audio-oscillator;96;94;148;93;95;94;146;93;93;143 05:02:24 INFO - PROCESS | 18721 | |5;imaging-gaussian-blur;118;117;117;117;117;116;117;116;117;117 05:02:24 INFO - PROCESS | 18721 | |6;imaging-darkroom;147;146;146;147;146;146;146;149;145;147 05:02:24 INFO - PROCESS | 18721 | |7;imaging-desaturate;94;95;94;95;94;95;95;95;95;95 05:02:24 INFO - PROCESS | 18721 | |8;json-parse-financial;67;67;67;66;67;67;67;82;66;64 05:02:24 INFO - PROCESS | 18721 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;65;65;65 05:02:24 INFO - PROCESS | 18721 | |10;stanford-crypto-aes;79;79;78;79;87;80;81;78;80;78 05:02:24 INFO - PROCESS | 18721 | |11;stanford-crypto-ccm;130;129;128;127;128;128;128;136;169;136 05:02:24 INFO - PROCESS | 18721 | |12;stanford-crypto-pbkdf2;184;179;186;183;179;184;182;178;179;177 05:02:24 INFO - PROCESS | 18721 | |13;stanford-crypto-sha256-iterative;73;74;74;75;72;74;72;72;74;76 05:02:24 INFO - PROCESS | 18721 | __end_tp_report 05:02:24 INFO - PROCESS | 18721 | __start_cc_report 05:02:24 INFO - PROCESS | 18721 | _x_x_mozilla_cycle_collect,1897 05:02:24 INFO - PROCESS | 18721 | __end_cc_report 05:02:24 INFO - PROCESS | 18721 | __startTimestamp1461672144303__endTimestamp 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | ------- Summary: start ------- 05:02:24 INFO - PROCESS | 18721 | Number of tests: 14 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.03 (2.6%) stddev-sans-first:3.20 05:02:24 INFO - PROCESS | 18721 | Values: 113.0 114.0 112.0 115.0 116.0 113.0 106.0 116.0 115.0 116.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:162.50 stddev:22.14 (13.6%) stddev-sans-first:22.80 05:02:24 INFO - PROCESS | 18721 | Values: 172.0 132.0 162.0 189.0 134.0 160.0 163.0 137.0 188.0 133.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 05:02:24 INFO - PROCESS | 18721 | Values: 162.0 161.0 162.0 161.0 161.0 162.0 162.0 161.0 161.0 163.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#3] audio-fft Cycles:10 Average:88.80 Median:73.00 stddev:20.13 (27.6%) stddev-sans-first:20.52 05:02:24 INFO - PROCESS | 18721 | Values: 73.0 73.0 110.0 107.0 76.0 75.0 73.0 125.0 103.0 73.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.50 stddev:25.00 (26.7%) stddev-sans-first:26.04 05:02:24 INFO - PROCESS | 18721 | Values: 96.0 94.0 148.0 93.0 95.0 94.0 146.0 93.0 93.0 143.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 05:02:24 INFO - PROCESS | 18721 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 05:02:24 INFO - PROCESS | 18721 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 149.0 145.0 147.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:02:24 INFO - PROCESS | 18721 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:67.00 stddev:5.01 (7.5%) stddev-sans-first:5.30 05:02:24 INFO - PROCESS | 18721 | Values: 67.0 67.0 67.0 66.0 67.0 67.0 67.0 82.0 66.0 64.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 05:02:24 INFO - PROCESS | 18721 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:2.69 (3.4%) stddev-sans-first:2.83 05:02:24 INFO - PROCESS | 18721 | Values: 79.0 79.0 78.0 79.0 87.0 80.0 81.0 78.0 80.0 78.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:129.50 stddev:12.77 (9.9%) stddev-sans-first:13.46 05:02:24 INFO - PROCESS | 18721 | Values: 130.0 129.0 128.0 127.0 128.0 128.0 128.0 136.0 169.0 136.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:182.50 stddev:3.07 (1.7%) stddev-sans-first:3.07 05:02:24 INFO - PROCESS | 18721 | Values: 184.0 179.0 186.0 183.0 179.0 184.0 182.0 178.0 179.0 177.0 05:02:24 INFO - PROCESS | 18721 | 05:02:24 INFO - PROCESS | 18721 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:1.35 (1.8%) stddev-sans-first:1.41 05:02:24 INFO - PROCESS | 18721 | Values: 73.0 74.0 74.0 75.0 72.0 74.0 72.0 72.0 74.0 76.0 05:02:24 INFO - PROCESS | 18721 | -------- Summary: end -------- 05:02:24 INFO - PROCESS | 18721 | 05:02:25 INFO - TEST-INFO | 18721: exit 0 05:02:25 INFO - TEST-OK | kraken | took 63571ms 05:02:25 INFO - SUITE-END | took 1180s 05:02:25 INFO - Completed test suite (00:19:40) 05:02:25 INFO - javascript benchmark 05:02:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.608378126603, 2622.2002289301768, 2625.2649258207707, 2638.3799807045343, 2658.3354161459633, 4491.438570178728, 4560.885977850551, 4570.0631370569, 4597.54024597541, 4598.770061496924, 4547.431571053618, 4568.474625418078, 4598.425196850394, 4648.581627653511, 4670.813167473306, 4133.3386658134705, 4188.623023927838, 4194.958050419487, 4226.598473145046, 4351.630111440531, 4298.871033868973, 4314.525402205755, 4320.3735458358515, 4364.7817609119575, 4368.803403846835, 4099.590040995877, 4167.2082304362075, 4211.0, 4255.957440425603, 4263.5736426357425, 4229.069604686964, 4230.746155230696, 4239.682023848224, 4255.17024180285, 4294.119705460374, 4218.261804184286, 4245.448091748084, 4260.169266992907, 4270.807813648394, 4296.119295544406, 4297.957020429787, 4445.977770111161, 4525.343825145335, 4534.264155842861, 4588.426446694163, 4885.389326334208, 4903.877403064952, 4910.288008238821, 4911.312416261726, 4928.975355123237, 4900.779464924051, 4908.533689299511, 4936.210206367, 4940.851774446773, 4973.079980203674, 4455.933161002587, 4574.6340292776495, 4603.677742558022, 4669.0, 4672.789724462407, 5045.41977672565, 5058.494150584986, 5067.417247016567, 5071.771770270347, 5072.391313042459, 4847.563719265283, 4850.514948505192, 4862.513748625109, 4873.41519017713, 4893.02139572087, 4708.529147085264, 4935.432425271139, 5012.548870601663, 5028.0, 5037.622178336639, 4820.373351464287, 4831.396075490564, 4840.75796210188, 4869.975650121727, 4879.487653796371, 4811.518848115231, 4820.25286080658, 4821.54195351441, 4835.492273311322, 4867.829625963074, 4052.77709725962, 4126.8761937141935, 4127.33962565994, 4131.421600975866, 4193.35003074524, 3653.6711695947492, 3677.9080522986606, 3679.3745063339297, 3680.1535646801385, 3681.5582130144016, 4094.877153685394, 4142.378643203483, 4194.727342722713, 4267.146570685875, 4270.786460677016, 4861.197902346144, 4884.413870335582, 4889.266610008527, 4896.5837903777865, 4952.801887924515, 4222.472190976128, 4223.577642235752, 4224.514180869178, 4230.513490948519, 4269.530351661315, 4277.978610106992, 4420.911581768347, 4482.439695038121, 4510.864674059783, 4514.119746649372, 4560.247559152703, 4566.725996440225, 4568.520305367955, 4576.313552967015, 4633.4671512775785, 4758.524147585353, 4802.327674125695, 4818.1327361073945, 4818.229083346648, 4897.755112244445, 4612.238980568169, 4684.718916864999, 4699.318598803086, 4700.905981880412, 4707.482176960463, 4830.0, 4844.46710861812, 4849.733264670477, 4870.439899411472, 4911.484294149063, 4894.853154405374, 4907.386576677915, 4913.975430122827, 4914.385701787277, 4963.652544322007, 4586.72479651222, 4715.693479923794, 4753.954130091374, 4796.9280460792415, 4815.783289751899, 4761.904761904712, 4770.833020844254, 4772.880677983078, 4781.474037855903, 4815.012922350979, 4697.365855609449, 4701.529847015271, 4708.529147085264, 4709.317149013305, 4746.691465054761, 4635.397398338329, 4765.166095933268, 4852.2479015752615, 4871.147549178951, 4875.731834748981, 4671.299305104261, 4681.274402467623, 4690.437147542317, 4707.670463067552, 4724.952750472588], "value": 4506.772198733376, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.3732607470997, 584.7485581200084, 600.0, 613.4448324266539, 614.3794767285041, 26660.73339266607, 34276.31447371054, 34697.47953780689, 35132.824335878315, 35395.82302088486, 36721.632783672154, 37101.44347834784, 37181.814090929576, 37226.8138659307, 37612.24775504488, 7059.505834591555, 7475.0, 7680.731174408897, 7681.654325555335, 7682.270184332508, 9386.0, 9649.228061755042, 9649.372790768577, 9654.71035868925, 9655.27585431092, 9652.710418687415, 9877.70366888991, 9879.110880020797, 9879.703608891745, 9886.209103271722, 9641.903580964206, 9737.853932191023, 9744.171745401649, 9758.707238782848, 9759.219262458986, 9648.083432073941, 9785.804283914353, 9788.804223915553, 10008.549615267257, 10035.949820250926, 37727.81136094329, 38510.80744596259, 38546.80726596377, 38557.61442385568, 38633.227335453135, 3105.9223519412194, 3161.984190079058, 3254.969266384598, 3276.836158192081, 3737.6262373762406, 28600.427991440054, 29484.557731634042, 29621.407571848657, 29634.0, 29697.25756856096, 3441.4149594568985, 3482.6343233960574, 3493.9825300873586, 3563.910902227465, 3597.388443964532, 220839.0, 222536.0, 223038.0, 223428.0, 224879.8756006226, 49818.50181498211, 50880.74559627178, 51249.0, 51294.48705512972, 51325.48674513207, 54055.72972135114, 54098.729506353004, 54268.0, 54282.7285863576, 54306.0, 14237.928810355881, 14657.267136643126, 14668.853311466748, 14670.266486675624, 14679.853201468062, 11055.668329950115, 11092.778144437067, 11103.278286911325, 11139.498722557504, 11209.775804483865, 14827.851721482863, 15429.379915108977, 15445.922770386076, 15470.458533951258, 15580.532584022498, 5520.834374968757, 5536.916946245809, 5713.0, 5713.257276554022, 5819.709014549256, 855.8630619101039, 865.5023361567124, 871.1462766488877, 876.5792419638609, 959.2421986630484, 24802.875985620318, 25179.87410062938, 25432.872835636073, 25467.10865119712, 26094.0, 918.5085979001202, 943.2124176312856, 956.8614147380599, 1006.954687039085, 1051.2483574244452, 12928.353582320846, 13687.452501899812, 14015.159090454605, 14199.78700319496, 14211.431542738175, 322425.0, 329243.0, 329675.0, 330117.0, 330824.0, 47557.52442475531, 47897.521024789305, 48046.27930581044, 48130.75934620375, 48198.27702584464, 1059.904608585231, 1135.7103938495632, 1226.5032661771818, 1269.428757059327, 1347.58109193997, 24446.51106977815, 25567.74432255728, 25690.229293121236, 25855.482890342464, 25981.610275845498, 35153.47269791007, 35689.46465803067, 35727.82136089303, 35767.821160894026, 35802.0, 174246.0, 176997.0, 177608.0, 177837.0, 177840.0, 20756.792432075486, 22457.32628021162, 22676.433089172904, 23107.88446057826, 24041.158559451036, 37875.24249514939, 39191.216175675756, 39435.60564394434, 39445.0, 40495.59504405036, 33116.0, 33460.66539334576, 33698.32603347969, 33738.831305844295, 34158.82920585381, 33214.66785332213, 33422.66577334293, 33628.32743345071, 33832.98501044972, 33959.66040339565, 33275.33449331048, 33327.66672333342, 33849.0, 33890.32219355649, 33909.66090339164, 28331.291717707223, 30213.546796797626, 30375.69624303817, 30714.84642576773, 30912.69087309188, 23856.761432385454, 23863.88068059718, 24253.151139710026, 24346.391340216636, 24534.754652453248], "value": 16802.48388317589, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.4323514727908, 387.1289598403592, 390.2760379496035, 396.6727449853871, 403.5641507172254, 14017.579472615813, 14643.41426342945, 15713.764293535593, 17356.132193390327, 17422.216000279986, 15828.129452880086, 15892.602684932883, 16345.673086538261, 16347.26437310321, 16700.58248543787, 4930.457649658535, 5036.194208926581, 5169.431362550116, 5186.662866913657, 5206.947930520703, 4940.580050695695, 5104.642675012732, 5136.845894623168, 5137.6403651744395, 5144.09978253806, 5085.364329458817, 5095.261187127864, 5095.745212739367, 5156.329677141966, 6740.0, 7071.080759501283, 7075.681594328267, 7081.9291807082045, 7122.074130363046, 7131.7503887363955, 6610.107635469199, 6976.790696279119, 6985.685644146026, 7004.299570043006, 7005.369516743517, 23073.76926230733, 23146.421339466648, 23327.533449331087, 23760.524789504114, 24180.2745917621, 2148.9247876324253, 2156.9784302156936, 2367.289813056076, 2457.103157347573, 2639.2478143729136, 14057.830506441685, 14326.426942922271, 14793.630159245997, 14872.033317834306, 15288.464903728316, 1833.51411875853, 1915.6360291544702, 1928.9421317360502, 1941.5825597496605, 1987.3044434447972, 76484.61757691232, 80058.59970700109, 80395.0, 80788.99999999942, 81045.18954810435, 16181.838181618268, 16414.343426262814, 16514.83485165157, 16859.241334139748, 17017.574560636083, 24150.87924560366, 25550.488990220092, 30105.247368815955, 30119.849400752857, 30128.397432051235, 8948.328875334377, 9278.443293402283, 9583.808323833624, 9609.135177834029, 9664.855027174597, 7845.0, 7877.487963282483, 7991.480553763987, 8084.7574572762915, 8097.35221182304, 8000.679972801139, 8294.58527073656, 8417.202194749058, 8457.873131903027, 8650.91349086501, 3142.701443362877, 3323.966760332414, 3461.930761384758, 3468.150303175738, 3473.7915725056578, 805.4160733468188, 831.5883637599306, 832.7834762961674, 846.0, 906.4380084347747, 16116.113613751357, 16823.41118060862, 16929.661406771796, 17090.48728538121, 17213.536849367945, 827.3133299361516, 831.4387788243033, 847.5423271433357, 852.2585350744768, 872.7774417523618, 8611.181937715906, 9475.384100033476, 9497.192738617296, 9625.32622716403, 9754.707643703723, 368513.0, 372968.0, 382338.0, 383169.0, 384321.0, 73117.6344118276, 76773.61613191899, 77039.61480192676, 77050.61474692702, 77252.0, 929.5631053404888, 930.6510058727977, 952.4904176265665, 954.6706386296717, 959.2278216036018, 14725.631859203606, 14974.925125374739, 14989.40042398292, 15175.24123793828, 15240.466583669519, 32917.67082329146, 34288.657113429545, 34572.13569660678, 35589.0, 35906.8204658975, 44732.77633611811, 47337.763311183226, 49133.0, 49531.50468495269, 49547.50452495429, 8129.552874591955, 8163.469374490639, 8179.631916563888, 8208.671653134046, 8256.752297431087, 11569.6529104127, 11982.820257695967, 12107.33409662477, 12183.878161218274, 12301.815472768094, 10708.73228169302, 10785.648281549711, 10802.189835762507, 10851.077658399125, 10916.78166436651, 9503.19222866064, 9507.524623768646, 9527.047295270417, 9662.3236373456, 10178.440185789852, 9455.385399948982, 10665.840012399975, 10676.252662313564, 10745.623903163352, 11060.557577697124, 7926.564038977912, 7930.60346982637, 8156.10282868872, 8290.502569845828, 8361.623726932181, 8149.79625509367, 9731.41611503312, 10392.792144157225, 10672.466376680979, 10719.839202412126], "value": 9239.526864918376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.6784635994638, 1415.0519152168047, 1449.3333066789276, 1581.462302817042, 1776.2450958342693, 6140.7850725224625, 7344.0, 7509.061367329077, 7509.286617771303, 7521.135069467013, 7061.293870612949, 7220.819479513015, 7229.746958856441, 7244.094488188976, 7246.420286377091, 1838.7058070708622, 1897.9240830366837, 1905.104600837604, 2158.363282831561, 2190.5509370578993, 2181.3892110209167, 2259.164109279569, 2259.548090381922, 2260.062074239189, 2262.3552287598036, 2144.924927627533, 2190.9780902190932, 2203.911843526257, 2214.678871563622, 2217.3569664797187, 1781.4121339957783, 1866.915988780508, 2156.9892150539226, 2158.967615485769, 2171.0230396321717, 2083.239617539587, 2177.031221106608, 2180.3132013415725, 2180.716506854115, 2184.3119417383473, 7235.167955685111, 7288.271172882723, 7297.233790451979, 7300.233475485104, 7304.671289791919, 4304.870853874389, 4466.151431228089, 4489.730616163008, 4490.977545112286, 4494.483134439516, 2684.704682484925, 2744.464829358256, 2944.1461976026926, 2950.3066779306846, 2954.6897575754665, 904.7511934218077, 910.1762904571374, 913.6756451459703, 927.4018258223408, 944.5513381143902, 10161.18710503158, 10167.644132455402, 10183.745406364826, 10204.795904081877, 10243.334183278062, 4128.050548373891, 4147.440095587118, 4152.211079894811, 4179.644730197967, 4196.034911970264, 8679.913200868037, 8748.43135196223, 8751.737447876447, 8787.604557794786, 8812.0, 4551.362809206714, 4564.041551274269, 4584.724916505021, 4595.218812801765, 4598.609118224921, 3381.814000229962, 3897.785621790772, 4067.983004248938, 4090.6318431341324, 4207.116505533811, 3470.8091054991714, 3490.5985811631986, 3544.078539579676, 3573.8034408107806, 3595.19108200658, 1140.6749076513154, 1146.925449845774, 1156.1675593572613, 1176.211938001541, 1198.3469009389903, 833.5873742497381, 847.2671139464319, 849.9915000850036, 878.4597472554333, 886.4459712679575, 4912.189488734319, 5019.816379874766, 5097.057044446789, 5153.123968925292, 5214.478552144755, 942.5852624845046, 944.0323668240109, 963.8120566489607, 966.2221911361281, 976.2677991506371, 3277.9672203278137, 3404.744644151649, 3425.3663072331697, 3436.037909385376, 3521.9471707924404, 9092.772680683036, 9331.90668093324, 9466.337356385126, 9479.383840050512, 9480.24158067353, 9187.77030574241, 9384.95307523458, 9388.483633400092, 9390.154886060287, 9402.623895044258, 6742.898856517156, 6785.55893866907, 6813.0, 6850.0752398426575, 6866.622335771481, 4818.566329030264, 4982.75086245679, 5046.167382382013, 5053.974730126326, 5071.847844564669, 7966.442349035512, 8143.18568143181, 8196.67213311461, 8277.917220827714, 8321.375896807886, 8360.414770965974, 8397.538135402612, 8439.831203376021, 8539.658413663385, 8548.91451085506, 5347.893042139213, 6040.456358927718, 6162.568620196723, 6207.0, 6318.557700961072, 7226.168990566152, 7276.527025743309, 7306.123265208209, 7357.153927298429, 7379.151397589131, 6491.707873145625, 6649.667516624053, 6666.2333831609985, 6768.221654509597, 6810.62541560219, 6443.935560644333, 6495.0, 6559.7376104957175, 6617.602943823386, 6645.302243264581, 6065.72704228302, 6102.786402475892, 6141.570090093829, 6142.938570614237, 6149.016157414792, 4277.657787377065, 4301.655867530528, 4401.317795741666, 4405.0, 4421.40311058003, 4130.834766609422, 4316.050468896838, 4425.623821975039, 4508.526604706459, 4558.270676691714], "value": 4010.6247305327965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.09370793910335, 305.31913832154294, 306.20081587057774, 306.765324526737, 308.67126510266576, 4764.618830493561, 4780.378550788397, 4781.378420805299, 4809.783559739816, 4842.322074909515, 4694.174247987896, 4709.0346478971815, 4728.929066064012, 4735.218688916325, 4737.289406589013, 3525.7307369347013, 3641.927161456769, 3645.8541658333634, 3661.304352173092, 3666.7983260920637, 3639.781613103209, 3698.4637227601984, 3736.7579452328523, 3769.3026790043928, 3781.394976803712, 3688.889333320005, 3738.738288319819, 3746.8501259949708, 3752.437134429844, 3778.489903862971, 3643.2531331077066, 3699.9260014799825, 3756.1173124315765, 3757.0, 3767.510223670919, 3309.25541753106, 3316.651751566075, 3323.3187196624635, 3334.5998480182534, 3336.6830151135605, 4525.479569849444, 4555.703879247872, 4557.612602928722, 4559.384483094773, 4561.201789686825, 4256.893577660552, 4266.168097221043, 4282.143571285756, 4283.164782867311, 4295.484541854966, 4755.524447555217, 4942.233953737176, 4964.30159531148, 4967.205247160437, 4990.750462476862, 3597.2086141048926, 3603.0992251937014, 3625.7461977661574, 3639.1266096136737, 3640.5631324240994, 5157.5616072633875, 5188.8183913563225, 5210.270562121306, 5212.166053431432, 5217.817376391846, 3394.3890099781784, 3625.1843335249887, 3718.795466249382, 3723.702103831687, 3726.6832319252626, 3630.7458477906293, 3639.9818000909827, 3654.488371627974, 3655.7258205634685, 3672.559292884871, 4124.010237542968, 4163.562825903297, 4168.958310416857, 4171.290880550314, 4184.28867092595, 5011.273365362002, 5031.924521132186, 5033.84898453047, 5039.470855560114, 5039.77321020555, 1306.8627794081485, 1335.6126723250343, 1350.4598160735784, 1351.9053666243465, 1358.9728205435836, 888.2583043159035, 890.9486805569361, 896.7847716548112, 909.4270609515962, 914.8444764390069, 4198.433211516467, 4335.349697545394, 4353.738775673406, 4377.824887004548, 4396.934045989313, 5012.548870601663, 5116.590672746172, 5135.815794207615, 5188.7405629719115, 5207.307625021807, 4401.713888597231, 4411.139827733626, 4435.933460998088, 4439.4006809080365, 4454.532274111237, 2815.577663350514, 2927.5901373807683, 2936.427396657674, 2937.0, 2952.35048289376, 5175.480673142224, 5208.114620514521, 5210.609204309692, 5220.295260139908, 5222.3472065991755, 5566.0, 5619.1290349995, 5677.971610141923, 5695.145728140729, 5695.857603559944, 5191.117510023229, 5200.8959820803375, 5201.713905735145, 5219.817306394258, 5227.477252274742, 5542.7782888684005, 5543.473370029841, 5550.361708403585, 5566.0, 5569.05326094573, 5250.737463126905, 5442.727863606883, 5456.890862182655, 5461.1808228766, 5461.371942226695, 5174.0, 5195.519277006035, 5215.869603259949, 5216.765245564035, 5222.060029194781, 3841.5582208045316, 3850.3646898261472, 3851.287511810324, 3853.788041657736, 3855.4795102660783, 5353.598480113929, 5492.093804522209, 5528.364238112668, 5558.055130627884, 5567.3040869891265, 5313.415524292247, 5341.786328546815, 5344.812931547533, 5351.411344752152, 5363.383210930637, 5344.893102138013, 5346.930613877318, 5352.919706204488, 5364.544013758874, 5364.9731751341, 4688.2733176357715, 4952.727599982036, 4974.900501989868, 4996.875078123076, 5252.632315737862, 4704.223803072455, 4849.95150048495, 4995.500449954975, 5035.446100928822, 5057.418396884405, 4939.209726443752, 4950.702957822542, 4960.6031517477795, 4963.429205641398, 4967.60259179272], "value": 3861.9051091913457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.7921623512945, 692.9168499780027, 725.1008749151055, 736.5838301359731, 756.8032311598986, 12058.336791476466, 12362.505499779998, 12376.0, 12709.173903696254, 12721.491140354387, 11966.521339146424, 12032.578859739911, 12041.879581204184, 12070.275783452998, 12070.698232544191, 649.5972497051835, 810.2828996338225, 820.0978923184509, 823.7158180427773, 824.8474032304013, 793.3217099380005, 813.8657121574963, 816.9223923727236, 817.6361519123992, 817.6851912013888, 864.7751584588021, 869.0657543141149, 873.9737807865743, 874.4665753890122, 874.921257086862, 673.4982438083659, 691.6126968897433, 856.4475913036088, 863.447393668053, 863.8617821148649, 506.3114164735956, 612.5130521235628, 622.2066864747438, 623.4357906094991, 624.2166081567649, 12398.31809250491, 12426.627201183888, 12474.0, 12489.562865299762, 12603.684907877285, 11823.0, 12376.195547289397, 13243.73512529744, 13248.735025299537, 13255.204687718768, 9378.624855005792, 9407.952960235156, 9661.758456038586, 9678.128968392879, 9937.155341795957, 3261.445554255782, 3301.5873015873017, 3351.6480769519094, 3372.814495202763, 3383.915402114942, 44418.11163776739, 44511.55488445106, 44556.3316550252, 44927.10145797098, 45018.099638007385, 9579.281553883488, 9623.807523849484, 9822.361546499455, 9867.11195992364, 9906.157976571927, 16797.244124014203, 16811.91594042022, 16960.57598560046, 17047.0, 17073.146342682816, 6634.104395906491, 6830.248672646105, 6846.520743547904, 6892.379685828299, 6894.310568943166, 3829.1384438501673, 3841.5774264830848, 3859.456765512086, 3920.0, 3973.145773658677, 2787.5957986091903, 2834.2347566157023, 2854.8572571371346, 2882.437924604682, 2891.4361699468823, 505.683947532792, 511.75180037681696, 518.3106468397023, 521.2311840035917, 522.255785505653, 529.2563947653553, 608.8082254089948, 612.3111499562991, 626.9905452221919, 653.4511010750992, 7640.617969101522, 7812.53124812513, 7836.843263134705, 7874.330681891989, 7887.645055972495, 599.937006614308, 633.1673848888696, 639.1084437210066, 641.3169973977699, 641.403494749887, 3522.876699315512, 3637.342049667173, 3709.642298632103, 3813.3136035513876, 3818.6443812446737, 52609.736951315, 53618.0, 53684.46315536873, 53899.0, 55292.44707552953, 45742.313865292046, 47132.5286747135, 47481.76259118682, 47623.28565071527, 48249.0, 42920.0, 43234.78382608067, 43370.7831460847, 43839.0, 44127.77936110299, 6829.829254268484, 6888.279129743823, 6902.309769023058, 6910.343517365842, 6923.619200943795, 28548.286292842015, 28802.567961480174, 29004.564931525623, 29344.0, 29374.853125734233, 36344.636553634125, 38797.80601096976, 39520.407193892686, 39555.0, 39577.0, 9002.639894404412, 9352.392094513834, 9467.763305917408, 9568.138867501959, 9713.70858874235, 9439.339246252972, 9662.75843103928, 9767.511624418892, 9961.252906031932, 10680.198985075995, 9312.767180820534, 9437.245020398488, 9446.338756287269, 9519.286053545873, 9749.853752193865, 9757.951210243904, 9867.358621689567, 10035.0, 10070.144037756872, 10149.695509134737, 9441.339106262496, 9486.146246837818, 9546.093121153479, 9856.359336643096, 9905.306628536222, 8343.916560834557, 8643.481391116553, 8856.955715221382, 8970.282377409661, 9051.637934482547, 7860.410469214946, 8056.355491560544, 8148.668370116891, 8265.710700125466, 8312.127226641116], "value": 5763.555106137639, "unit": "score"}], "name": "dromaeo_css", "value": 6299.0359440627035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 112.0, 115.0, 116.0, 113.0, 106.0, 116.0, 115.0, 116.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 132.0, 162.0, 189.0, 134.0, 160.0, 163.0, 137.0, 188.0, 133.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 110.0, 107.0, 76.0, 75.0, 73.0, 125.0, 103.0, 73.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 148.0, 93.0, 95.0, 94.0, 146.0, 93.0, 93.0, 143.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 149.0, 145.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 82.0, 66.0, 64.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 87.0, 80.0, 81.0, 78.0, 80.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 128.0, 127.0, 128.0, 128.0, 128.0, 136.0, 169.0, 136.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 186.0, 183.0, 179.0, 184.0, 182.0, 178.0, 179.0, 177.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 75.0, 72.0, 74.0, 72.0, 72.0, 74.0, 76.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1590.3, "alertThreshold": 2.0}]} 05:02:25 INFO - Return code: 0 05:02:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:02:25 ERROR - # TBPL SUCCESS # 05:02:25 INFO - Running post-action listener: _resource_record_post_action 05:02:25 INFO - Running post-run listener: _resource_record_post_run 05:02:26 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 518225920; Read time: 0; Write time: 511096 05:02:26 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234614784; Read time: 0; Write time: 310140 05:02:26 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 283508736; Read time: 0; Write time: 200956 05:02:26 INFO - Running post-run listener: _upload_blobber_files 05:02:26 INFO - Blob upload gear active. 05:02:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:26 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 05:02:26 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'] 05:02:26 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 05:02:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:27 INFO - (blobuploader) - INFO - Done attempting. 05:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:02:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:28 INFO - (blobuploader) - INFO - Done attempting. 05:02:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:02:28 INFO - Return code: 0 05:02:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:02:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:02:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f11ce5d63ce1211d61022b2c0da37ff4f70879b413b21cc49bf892e2f4e2f8fbba1861190037d861bcf4aec9db126fa7c776d445ccc39f2b42d46bd460b3784", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c05052bc0bfa8519e4d9657df95fed4f96472075e199a143533f44ea86f6164523762505e07646b3c70fc990a25d199e6af14b0b02511ae3799bbaae258cac20"} 05:02:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:02:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:02:28 INFO - Contents: 05:02:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f11ce5d63ce1211d61022b2c0da37ff4f70879b413b21cc49bf892e2f4e2f8fbba1861190037d861bcf4aec9db126fa7c776d445ccc39f2b42d46bd460b3784", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c05052bc0bfa8519e4d9657df95fed4f96472075e199a143533f44ea86f6164523762505e07646b3c70fc990a25d199e6af14b0b02511ae3799bbaae258cac20"} 05:02:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:02:28 INFO - Copying logs to upload dir... 05:02:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:02:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.414989 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-26 05:02:27.882494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 05:02:27.886136) ========= 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=523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901 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/4f11ce5d63ce1211d61022b2c0da37ff4f70879b413b21cc49bf892e2f4e2f8fbba1861190037d861bcf4aec9db126fa7c776d445ccc39f2b42d46bd460b3784", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c05052bc0bfa8519e4d9657df95fed4f96472075e199a143533f44ea86f6164523762505e07646b3c70fc990a25d199e6af14b0b02511ae3799bbaae258cac20"} build_url:https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/T10-GfifRMSfOb_HKtiCmw/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/4f11ce5d63ce1211d61022b2c0da37ff4f70879b413b21cc49bf892e2f4e2f8fbba1861190037d861bcf4aec9db126fa7c776d445ccc39f2b42d46bd460b3784", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c05052bc0bfa8519e4d9657df95fed4f96472075e199a143533f44ea86f6164523762505e07646b3c70fc990a25d199e6af14b0b02511ae3799bbaae258cac20"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 05:02:27.910817) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:02:27.911141) ========= 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=523ca41ca1e0623de333ad52000001bf-1461668727.413401-2057145901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:02:27.995017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 05:02:27.995328) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 05:02:27.995616) ========= ========= Total master_lag: 0.21 =========