builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1462801174.78 results: success (0) buildid: 20160509045548 builduid: 039db17d53974ffb91704586ba114135 revision: da2b27e1aabd9e23870c09072753faba6ad0a42d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:34.779665) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:34.780156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:34.780470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:34.798900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:34.799165) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:39:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-05-09 06:39:35 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:34.959697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:34.960029) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015013 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:35.023871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:35.024214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev da2b27e1aabd9e23870c09072753faba6ad0a42d --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 da2b27e1aabd9e23870c09072753faba6ad0a42d --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=6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:39:35,595 truncating revision to first 12 chars 2016-05-09 06:39:35,595 Setting DEBUG logging. 2016-05-09 06:39:35,595 attempt 1/10 2016-05-09 06:39:35,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/da2b27e1aabd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:39:36,076 unpacking tar archive at: fx-team-da2b27e1aabd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.775237 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:35.812995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:35.813304) ========= script_repo_revision: da2b27e1aabd9e23870c09072753faba6ad0a42d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:35.813722) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:35.813994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:35.822741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-09 06:39:35.823017) ========= /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=6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:39:36 INFO - MultiFileLogger online at 20160509 06:39:36 in /builds/slave/test 06:39:36 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 06:39:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:39:36 INFO - {'append_to_log': False, 06:39:36 INFO - 'base_work_dir': '/builds/slave/test', 06:39:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:39:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:39:36 INFO - 'branch': 'Fx-Team-Non-PGO', 06:39:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:39:36 INFO - 'config_files': ('talos/linux_config.py',), 06:39:36 INFO - 'default_actions': ('clobber', 06:39:36 INFO - 'read-buildbot-config', 06:39:36 INFO - 'download-and-extract', 06:39:36 INFO - 'populate-webroot', 06:39:36 INFO - 'create-virtualenv', 06:39:36 INFO - 'install', 06:39:36 INFO - 'run-tests'), 06:39:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:39:36 INFO - 'download_minidump_stackwalk': True, 06:39:36 INFO - 'download_symbols': 'ondemand', 06:39:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:39:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:39:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:39:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:39:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:39:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:39:36 INFO - 'installer_path': 'installer.exe', 06:39:36 INFO - 'log_level': 'info', 06:39:36 INFO - 'log_name': 'talos', 06:39:36 INFO - 'log_to_console': True, 06:39:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:39:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:39:36 INFO - 'opt_config_files': (), 06:39:36 INFO - 'pip_index': False, 06:39:36 INFO - 'sps_profile': False, 06:39:36 INFO - 'sps_profile_interval': 0, 06:39:36 INFO - 'suite': 'dromaeojs', 06:39:36 INFO - 'system_bits': '32', 06:39:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:39:36 INFO - 'title': 'talos-linux64-ix-023', 06:39:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:39:36 INFO - 'use_talos_json': True, 06:39:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:39:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:39:36 INFO - 'work_dir': 'build'} 06:39:36 INFO - ##### 06:39:36 INFO - ##### Running clobber step. 06:39:36 INFO - ##### 06:39:36 INFO - Running pre-action listener: _resource_record_pre_action 06:39:36 INFO - Running main action method: clobber 06:39:36 INFO - rmtree: /builds/slave/test/build 06:39:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:39:36 INFO - Running post-action listener: _resource_record_post_action 06:39:36 INFO - ##### 06:39:36 INFO - ##### Finished clobber step (success) 06:39:36 INFO - ##### 06:39:36 INFO - ##### 06:39:36 INFO - ##### Running read-buildbot-config step. 06:39:36 INFO - ##### 06:39:36 INFO - Running pre-action listener: _resource_record_pre_action 06:39:36 INFO - Running main action method: read_buildbot_config 06:39:36 INFO - Using buildbot properties: 06:39:36 INFO - { 06:39:36 INFO - "project": "", 06:39:36 INFO - "product": "firefox", 06:39:36 INFO - "script_repo_revision": "production", 06:39:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:39:36 INFO - "repository": "", 06:39:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:39:36 INFO - "buildid": "20160509045548", 06:39:36 INFO - "pgo_build": "False", 06:39:36 INFO - "basedir": "/builds/slave/test", 06:39:36 INFO - "buildnumber": 1737, 06:39:36 INFO - "slavename": "talos-linux64-ix-023", 06:39:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:39:36 INFO - "platform": "ubuntu64_hw", 06:39:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:39:36 INFO - "branch": "fx-team", 06:39:36 INFO - "repo_path": "integration/fx-team", 06:39:36 INFO - "revision": "da2b27e1aabd9e23870c09072753faba6ad0a42d", 06:39:36 INFO - "stage_platform": "linux64", 06:39:36 INFO - "builduid": "039db17d53974ffb91704586ba114135", 06:39:36 INFO - "slavebuilddir": "test" 06:39:36 INFO - } 06:39:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:39:36 INFO - Running post-action listener: _resource_record_post_action 06:39:36 INFO - ##### 06:39:36 INFO - ##### Finished read-buildbot-config step (success) 06:39:36 INFO - ##### 06:39:36 INFO - ##### 06:39:36 INFO - ##### Running download-and-extract step. 06:39:36 INFO - ##### 06:39:36 INFO - Running pre-action listener: _resource_record_pre_action 06:39:36 INFO - Running main action method: download_and_extract 06:39:36 INFO - mkdir: /builds/slave/test/build/tests 06:39:36 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')]} 06:39:36 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:39:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:39:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:39:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:37 INFO - Downloaded 1361 bytes. 06:39:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:39:37 INFO - Using the following test package requirements: 06:39:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:39:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:39:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:37 INFO - u'jsshell-linux-x86_64.zip'], 06:39:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:39:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:39:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:39:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:39:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:39:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:39:37 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')]} 06:39:37 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:39:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:38 INFO - Downloaded 22322863 bytes. 06:39:38 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'] 06:39:38 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 06:39:39 INFO - Return code: 0 06:39:39 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 06:39:39 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')]} 06:39:39 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:41 INFO - Downloaded 22322863 bytes. 06:39:41 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'] 06:39:41 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 06:39:42 INFO - Return code: 0 06:39:42 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')]} 06:39:42 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:43 INFO - Downloaded 10840152 bytes. 06:39:43 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'] 06:39:43 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 06:39:43 INFO - Return code: 0 06:39: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')]} 06:39:43 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:39:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:39:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:39:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/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 06:39:44 INFO - Downloaded 54862390 bytes. 06:39:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:39:44 INFO - mkdir: /builds/slave/test/properties 06:39:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:39:44 INFO - Writing to file /builds/slave/test/properties/build_url 06:39:44 INFO - Contents: 06:39:44 INFO - build_url:https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:39:45 INFO - Running post-action listener: _resource_record_post_action 06:39:45 INFO - Running post-action listener: set_extra_try_arguments 06:39:45 INFO - ##### 06:39:45 INFO - ##### Finished download-and-extract step (success) 06:39:45 INFO - ##### 06:39:45 INFO - ##### 06:39:45 INFO - ##### Running populate-webroot step. 06:39:45 INFO - ##### 06:39:45 INFO - Running pre-action listener: _resource_record_pre_action 06:39:45 INFO - Running main action method: populate_webroot 06:39:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:39:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:39:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:39:45 INFO - '--tppagecycles', 06:39:45 INFO - '7'], 06:39:45 INFO - 'tests': ['tsvgm']}}, 06:39:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:39:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:39:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:39:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:39:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:45 INFO - 'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:45 INFO - 'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['damp', 'tps']}, 06:39:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:45 INFO - 'tests': ['damp', 'tps']}, 06:39:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['dromaeo_dom']}, 06:39:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:39:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['a11yr', 06:39:45 INFO - 'ts_paint', 06:39:45 INFO - 'tpaint', 06:39:45 INFO - 'sessionrestore', 06:39:45 INFO - 'sessionrestore_no_auto_restore', 06:39:45 INFO - 'tabpaint']}, 06:39:45 INFO - 'other-e10s': {'tests': ['a11yr', 06:39:45 INFO - 'ts_paint', 06:39:45 INFO - 'tpaint', 06:39:45 INFO - 'sessionrestore', 06:39:45 INFO - 'sessionrestore_no_auto_restore', 06:39:45 INFO - 'tabpaint']}, 06:39:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:39:45 INFO - 'ts_paint', 06:39:45 INFO - 'tpaint', 06:39:45 INFO - 'sessionrestore', 06:39:45 INFO - 'sessionrestore_no_auto_restore', 06:39:45 INFO - 'tabpaint']}, 06:39:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:39:45 INFO - 'ts_paint', 06:39:45 INFO - 'tpaint', 06:39:45 INFO - 'sessionrestore', 06:39:45 INFO - 'sessionrestore_no_auto_restore', 06:39:45 INFO - 'tabpaint']}, 06:39:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['a11yr', 06:39:45 INFO - 'ts_paint', 06:39:45 INFO - 'tpaint', 06:39:45 INFO - 'sessionrestore', 06:39:45 INFO - 'sessionrestore_no_auto_restore', 06:39:45 INFO - 'tabpaint']}, 06:39:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['a11yr', 06:39:45 INFO - 'ts_paint', 06:39:45 INFO - 'tpaint', 06:39:45 INFO - 'sessionrestore', 06:39:45 INFO - 'sessionrestore_no_auto_restore', 06:39:45 INFO - 'tabpaint']}, 06:39:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['tsvgx', 06:39:45 INFO - 'tsvgr_opacity', 06:39:45 INFO - 'tart', 06:39:45 INFO - 'tscrollx', 06:39:45 INFO - 'cart']}, 06:39:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:39:45 INFO - 'tsvgr_opacity', 06:39:45 INFO - 'tart', 06:39:45 INFO - 'tscrollx', 06:39:45 INFO - 'cart']}, 06:39:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:45 INFO - 'talos_options': ['--disable-e10s'], 06:39:45 INFO - 'tests': ['tp5o']}, 06:39:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:45 INFO - 'tests': ['tp5o']}, 06:39:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:45 INFO - 'talos_options': ['--disable-e10s', 06:39:45 INFO - '--xperf_path', 06:39:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:45 INFO - 'tests': ['tp5n']}, 06:39:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:45 INFO - 'talos_options': ['--xperf_path', 06:39:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:45 INFO - 'tests': ['tp5n']}}, 06:39:45 INFO - 'talos.zip': {'path': '', 06:39:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:39:45 INFO - Running post-action listener: _resource_record_post_action 06:39:45 INFO - ##### 06:39:45 INFO - ##### Finished populate-webroot step (success) 06:39:45 INFO - ##### 06:39:45 INFO - ##### 06:39:45 INFO - ##### Running create-virtualenv step. 06:39:45 INFO - ##### 06:39:45 INFO - Running pre-action listener: _resource_record_pre_action 06:39:45 INFO - Running main action method: create_virtualenv 06:39:45 INFO - Creating virtualenv /builds/slave/test/build/venv 06:39:45 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 06:39:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:39:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:39:45 INFO - Using real prefix '/usr' 06:39:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:39:46 INFO - Installing distribute.............................................................................................................................................................................................done. 06:39:48 INFO - Installing pip.................done. 06:39:48 INFO - Return code: 0 06:39:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:48 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:39:48 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 06:39:48 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 06:39:48 INFO - Using env: {'DISPLAY': ':0', 06:39:48 INFO - 'HOME': '/home/cltbld', 06:39:48 INFO - 'LANG': 'en_US.UTF-8', 06:39:48 INFO - 'LANGUAGE': 'en_US:en', 06:39:48 INFO - 'LOGNAME': 'cltbld', 06:39:48 INFO - 'MAIL': '/var/mail/cltbld', 06:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:48 INFO - 'MOZ_NO_REMOTE': '1', 06:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:48 INFO - 'NO_EM_RESTART': '1', 06:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:48 INFO - 'PWD': '/builds/slave/test', 06:39:48 INFO - 'SHELL': '/bin/bash', 06:39:48 INFO - 'SHLVL': '1', 06:39:48 INFO - 'TERM': 'linux', 06:39:48 INFO - 'TMOUT': '86400', 06:39:48 INFO - 'USER': 'cltbld', 06:39:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:48 INFO - '_': '/tools/buildbot/bin/python'} 06:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:48 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 06:39:48 INFO - Cleaning up... 06:39:48 INFO - Return code: 0 06:39:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:48 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:39:48 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 06:39:48 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 06:39:48 INFO - Using env: {'DISPLAY': ':0', 06:39:48 INFO - 'HOME': '/home/cltbld', 06:39:48 INFO - 'LANG': 'en_US.UTF-8', 06:39:48 INFO - 'LANGUAGE': 'en_US:en', 06:39:48 INFO - 'LOGNAME': 'cltbld', 06:39:48 INFO - 'MAIL': '/var/mail/cltbld', 06:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:48 INFO - 'MOZ_NO_REMOTE': '1', 06:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:48 INFO - 'NO_EM_RESTART': '1', 06:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:48 INFO - 'PWD': '/builds/slave/test', 06:39:48 INFO - 'SHELL': '/bin/bash', 06:39:48 INFO - 'SHLVL': '1', 06:39:48 INFO - 'TERM': 'linux', 06:39:48 INFO - 'TMOUT': '86400', 06:39:48 INFO - 'USER': 'cltbld', 06:39:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:48 INFO - '_': '/tools/buildbot/bin/python'} 06:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:48 INFO - Downloading/unpacking psutil>=0.7.1 06:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:39:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:50 INFO - Installing collected packages: psutil 06:39:50 INFO - Running setup.py install for psutil 06:39:50 INFO - building 'psutil._psutil_linux' extension 06:39:50 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 06:39:51 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 06:39:51 INFO - building 'psutil._psutil_posix' extension 06:39:51 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 06:39:51 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 06:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:51 INFO - Successfully installed psutil 06:39:51 INFO - Cleaning up... 06:39:51 INFO - Return code: 0 06:39:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:39:51 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')]} 06:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:51 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')]} 06:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:51 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:39:51 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 06:39:51 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 06:39:51 INFO - Using env: {'DISPLAY': ':0', 06:39:51 INFO - 'HOME': '/home/cltbld', 06:39:51 INFO - 'LANG': 'en_US.UTF-8', 06:39:51 INFO - 'LANGUAGE': 'en_US:en', 06:39:51 INFO - 'LOGNAME': 'cltbld', 06:39:51 INFO - 'MAIL': '/var/mail/cltbld', 06:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:51 INFO - 'MOZ_NO_REMOTE': '1', 06:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:51 INFO - 'NO_EM_RESTART': '1', 06:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:51 INFO - 'PWD': '/builds/slave/test', 06:39:51 INFO - 'SHELL': '/bin/bash', 06:39:51 INFO - 'SHLVL': '1', 06:39:51 INFO - 'TERM': 'linux', 06:39:51 INFO - 'TMOUT': '86400', 06:39:51 INFO - 'USER': 'cltbld', 06:39:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:51 INFO - '_': '/tools/buildbot/bin/python'} 06:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:39:51 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 06:39:51 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 06:39:51 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 06:39:51 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 06:39:51 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 06:39:51 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 06:39:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:39:53 INFO - Installing collected packages: mozsystemmonitor 06:39:53 INFO - Running setup.py install for mozsystemmonitor 06:39:53 INFO - Successfully installed mozsystemmonitor 06:39:53 INFO - Cleaning up... 06:39:53 INFO - Return code: 0 06:39:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:39:53 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')]} 06:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:53 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')]} 06:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:53 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:39:53 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 06:39:53 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 06:39:53 INFO - Using env: {'DISPLAY': ':0', 06:39:53 INFO - 'HOME': '/home/cltbld', 06:39:53 INFO - 'LANG': 'en_US.UTF-8', 06:39:53 INFO - 'LANGUAGE': 'en_US:en', 06:39:53 INFO - 'LOGNAME': 'cltbld', 06:39:53 INFO - 'MAIL': '/var/mail/cltbld', 06:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:53 INFO - 'MOZ_NO_REMOTE': '1', 06:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:53 INFO - 'NO_EM_RESTART': '1', 06:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:53 INFO - 'PWD': '/builds/slave/test', 06:39:53 INFO - 'SHELL': '/bin/bash', 06:39:53 INFO - 'SHLVL': '1', 06:39:53 INFO - 'TERM': 'linux', 06:39:53 INFO - 'TMOUT': '86400', 06:39:53 INFO - 'USER': 'cltbld', 06:39:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:53 INFO - '_': '/tools/buildbot/bin/python'} 06:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:53 INFO - Downloading/unpacking blobuploader==1.2.4 06:39:53 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 06:39:53 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 06:39:53 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 06:39:53 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 06:39:53 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 06:39:53 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 06:39:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:39:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:39:55 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 06:39:55 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 06:39:55 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 06:39:55 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 06:39:55 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 06:39:55 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 06:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:39:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:39:56 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 06:39:56 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 06:39:56 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 06:39:56 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 06:39:56 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 06:39:56 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 06:39:56 INFO - Downloading docopt-0.6.1.tar.gz 06:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:39:56 INFO - Installing collected packages: blobuploader, requests, docopt 06:39:56 INFO - Running setup.py install for blobuploader 06:39:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:39:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:39:56 INFO - Running setup.py install for requests 06:39:56 INFO - Running setup.py install for docopt 06:39:57 INFO - Successfully installed blobuploader requests docopt 06:39:57 INFO - Cleaning up... 06:39:57 INFO - Return code: 0 06:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:57 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')]} 06:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:57 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')]} 06:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:57 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:39:57 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 06:39:57 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 06:39:57 INFO - Using env: {'DISPLAY': ':0', 06:39:57 INFO - 'HOME': '/home/cltbld', 06:39:57 INFO - 'LANG': 'en_US.UTF-8', 06:39:57 INFO - 'LANGUAGE': 'en_US:en', 06:39:57 INFO - 'LOGNAME': 'cltbld', 06:39:57 INFO - 'MAIL': '/var/mail/cltbld', 06:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:57 INFO - 'MOZ_NO_REMOTE': '1', 06:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:57 INFO - 'NO_EM_RESTART': '1', 06:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:57 INFO - 'PWD': '/builds/slave/test', 06:39:57 INFO - 'SHELL': '/bin/bash', 06:39:57 INFO - 'SHLVL': '1', 06:39:57 INFO - 'TERM': 'linux', 06:39:57 INFO - 'TMOUT': '86400', 06:39:57 INFO - 'USER': 'cltbld', 06:39:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:57 INFO - '_': '/tools/buildbot/bin/python'} 06:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:57 INFO - Running setup.py (path:/tmp/pip-IhNmrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:57 INFO - Running setup.py (path:/tmp/pip-AH1cqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:57 INFO - Running setup.py (path:/tmp/pip-edrWmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:57 INFO - Running setup.py (path:/tmp/pip-9IvucZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:57 INFO - Running setup.py (path:/tmp/pip-8t3MVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:57 INFO - Running setup.py (path:/tmp/pip-m8BPdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:57 INFO - Running setup.py (path:/tmp/pip-XM7kEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:57 INFO - Running setup.py (path:/tmp/pip-j2P8T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:57 INFO - Running setup.py (path:/tmp/pip-dI2NJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:58 INFO - Running setup.py (path:/tmp/pip-vZAUq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:58 INFO - Running setup.py (path:/tmp/pip-0iaVUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:58 INFO - Running setup.py (path:/tmp/pip-AnDaZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:58 INFO - Running setup.py (path:/tmp/pip-LlptLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:58 INFO - Running setup.py (path:/tmp/pip-93BQZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:58 INFO - Running setup.py (path:/tmp/pip-Z0NqbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:58 INFO - Running setup.py (path:/tmp/pip-Pn8efV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:58 INFO - Running setup.py (path:/tmp/pip-W4sBjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:39:58 INFO - Running setup.py install for manifestparser 06:39:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:39:58 INFO - Running setup.py install for mozcrash 06:39:58 INFO - Running setup.py install for mozdebug 06:39:58 INFO - Running setup.py install for mozdevice 06:39:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Running setup.py install for mozfile 06:39:59 INFO - Running setup.py install for mozhttpd 06:39:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Running setup.py install for mozinfo 06:39:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Running setup.py install for mozInstall 06:39:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Running setup.py install for mozleak 06:39:59 INFO - Running setup.py install for mozlog 06:39:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Running setup.py install for moznetwork 06:39:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Running setup.py install for mozprocess 06:39:59 INFO - Running setup.py install for mozprofile 06:39:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Running setup.py install for mozrunner 06:40:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Running setup.py install for mozscreenshot 06:40:00 INFO - Running setup.py install for moztest 06:40:00 INFO - Running setup.py install for mozversion 06:40:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:40:00 INFO - Cleaning up... 06:40:00 INFO - Return code: 0 06:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40: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')]} 06:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40: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')]} 06:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:00 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:40:00 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 06:40:00 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 06:40:00 INFO - Using env: {'DISPLAY': ':0', 06:40:00 INFO - 'HOME': '/home/cltbld', 06:40:00 INFO - 'LANG': 'en_US.UTF-8', 06:40:00 INFO - 'LANGUAGE': 'en_US:en', 06:40:00 INFO - 'LOGNAME': 'cltbld', 06:40:00 INFO - 'MAIL': '/var/mail/cltbld', 06:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:00 INFO - 'MOZ_NO_REMOTE': '1', 06:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:00 INFO - 'NO_EM_RESTART': '1', 06:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:00 INFO - 'PWD': '/builds/slave/test', 06:40:00 INFO - 'SHELL': '/bin/bash', 06:40:00 INFO - 'SHLVL': '1', 06:40:00 INFO - 'TERM': 'linux', 06:40:00 INFO - 'TMOUT': '86400', 06:40:00 INFO - 'USER': 'cltbld', 06:40:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:00 INFO - '_': '/tools/buildbot/bin/python'} 06:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:00 INFO - Running setup.py (path:/tmp/pip-1MRE7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:00 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)) 06:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:00 INFO - Running setup.py (path:/tmp/pip-r2u7Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:00 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)) 06:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:00 INFO - Running setup.py (path:/tmp/pip-DH82kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:00 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)) 06:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:00 INFO - Running setup.py (path:/tmp/pip-vtBAju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:00 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)) 06:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:00 INFO - Running setup.py (path:/tmp/pip-16pgYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:00 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)) 06:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:00 INFO - Running setup.py (path:/tmp/pip-1GZDk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:01 INFO - Running setup.py (path:/tmp/pip-J5jByF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:40:01 INFO - Running setup.py (path:/tmp/pip-Sw9ttP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:40:01 INFO - Running setup.py (path:/tmp/pip-lbJ_z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:40:01 INFO - Running setup.py (path:/tmp/pip-dKaYFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:40:01 INFO - Running setup.py (path:/tmp/pip-svV1jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:40:01 INFO - Running setup.py (path:/tmp/pip-SWozOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:40:01 INFO - Running setup.py (path:/tmp/pip-6lZ4Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:40:01 INFO - Running setup.py (path:/tmp/pip-LY1XNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:01 INFO - Running setup.py (path:/tmp/pip-YX17BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:40:01 INFO - Running setup.py (path:/tmp/pip-o27_GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:40:01 INFO - Running setup.py (path:/tmp/pip-cjOeyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:40:01 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)) 06:40:01 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)) 06:40:01 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)) 06:40:01 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)) 06:40:01 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)) 06:40:01 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)) 06:40:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:40:01 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 06:40:01 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 06:40:01 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 06:40:01 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 06:40:01 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 06:40:01 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 06:40:03 INFO - Downloading blessings-1.6.tar.gz 06:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:40:03 INFO - Installing collected packages: blessings 06:40:03 INFO - Running setup.py install for blessings 06:40:03 INFO - Successfully installed blessings 06:40:03 INFO - Cleaning up... 06:40:04 INFO - Return code: 0 06:40:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:40:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:04 INFO - Reading from file tmpfile_stdout 06:40:04 INFO - Current package versions: 06:40:04 INFO - argparse == 1.2.1 06:40:04 INFO - blessings == 1.6 06:40:04 INFO - blobuploader == 1.2.4 06:40:04 INFO - docopt == 0.6.1 06:40:04 INFO - manifestparser == 1.1 06:40:04 INFO - mozInstall == 1.12 06:40:04 INFO - mozcrash == 0.17 06:40:04 INFO - mozdebug == 0.1 06:40:04 INFO - mozdevice == 0.48 06:40:04 INFO - mozfile == 1.2 06:40:04 INFO - mozhttpd == 0.7 06:40:04 INFO - mozinfo == 0.9 06:40:04 INFO - mozleak == 0.1 06:40:04 INFO - mozlog == 3.1 06:40:04 INFO - moznetwork == 0.27 06:40:04 INFO - mozprocess == 0.22 06:40:04 INFO - mozprofile == 0.28 06:40:04 INFO - mozrunner == 6.11 06:40:04 INFO - mozscreenshot == 0.1 06:40:04 INFO - mozsystemmonitor == 0.0 06:40:04 INFO - moztest == 0.7 06:40:04 INFO - mozversion == 1.4 06:40:04 INFO - psutil == 3.1.1 06:40:04 INFO - requests == 1.2.3 06:40:04 INFO - wsgiref == 0.1.2 06:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:04 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')]} 06:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:04 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')]} 06:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:04 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:40:04 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 06:40:04 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 06:40:04 INFO - Using env: {'DISPLAY': ':0', 06:40:04 INFO - 'HOME': '/home/cltbld', 06:40:04 INFO - 'LANG': 'en_US.UTF-8', 06:40:04 INFO - 'LANGUAGE': 'en_US:en', 06:40:04 INFO - 'LOGNAME': 'cltbld', 06:40:04 INFO - 'MAIL': '/var/mail/cltbld', 06:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:04 INFO - 'MOZ_NO_REMOTE': '1', 06:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:04 INFO - 'NO_EM_RESTART': '1', 06:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:04 INFO - 'PWD': '/builds/slave/test', 06:40:04 INFO - 'SHELL': '/bin/bash', 06:40:04 INFO - 'SHLVL': '1', 06:40:04 INFO - 'TERM': 'linux', 06:40:04 INFO - 'TMOUT': '86400', 06:40:04 INFO - 'USER': 'cltbld', 06:40:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:04 INFO - '_': '/tools/buildbot/bin/python'} 06:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 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)) 06:40:04 INFO - Cleaning up... 06:40:04 INFO - Return code: 0 06:40:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:40:04 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')]} 06:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:04 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')]} 06:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:04 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:40:04 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 06:40:04 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 06:40:04 INFO - Using env: {'DISPLAY': ':0', 06:40:04 INFO - 'HOME': '/home/cltbld', 06:40:04 INFO - 'LANG': 'en_US.UTF-8', 06:40:04 INFO - 'LANGUAGE': 'en_US:en', 06:40:04 INFO - 'LOGNAME': 'cltbld', 06:40:04 INFO - 'MAIL': '/var/mail/cltbld', 06:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:04 INFO - 'MOZ_NO_REMOTE': '1', 06:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:04 INFO - 'NO_EM_RESTART': '1', 06:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:04 INFO - 'PWD': '/builds/slave/test', 06:40:04 INFO - 'SHELL': '/bin/bash', 06:40:04 INFO - 'SHLVL': '1', 06:40:04 INFO - 'TERM': 'linux', 06:40:04 INFO - 'TMOUT': '86400', 06:40:04 INFO - 'USER': 'cltbld', 06:40:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:04 INFO - '_': '/tools/buildbot/bin/python'} 06:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:04 INFO - Downloading/unpacking jsonschema 06:40:04 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 06:40:04 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 06:40:04 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 06:40:04 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 06:40:04 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 06:40:04 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 06:40:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:40:06 INFO - Downloading/unpacking functools32 (from jsonschema) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:06 INFO - Downloading functools32-3.2.3-2.tar.gz 06:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:40:06 INFO - warning: no files found matching '*.txt' 06:40:06 INFO - no previously-included directories found matching 'build' 06:40:06 INFO - no previously-included directories found matching 'dist' 06:40:06 INFO - no previously-included directories found matching '.git*' 06:40:06 INFO - Installing collected packages: jsonschema, functools32 06:40:06 INFO - Running setup.py install for functools32 06:40:06 INFO - warning: no files found matching '*.txt' 06:40:06 INFO - no previously-included directories found matching 'build' 06:40:06 INFO - no previously-included directories found matching 'dist' 06:40:06 INFO - no previously-included directories found matching '.git*' 06:40:06 INFO - Successfully installed jsonschema functools32 06:40:06 INFO - Cleaning up... 06:40:07 INFO - Return code: 0 06:40:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:07 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 0x7f72e7d6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', '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 06:40:07 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 06:40:07 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 06:40:07 INFO - Using env: {'DISPLAY': ':0', 06:40:07 INFO - 'HOME': '/home/cltbld', 06:40:07 INFO - 'LANG': 'en_US.UTF-8', 06:40:07 INFO - 'LANGUAGE': 'en_US:en', 06:40:07 INFO - 'LOGNAME': 'cltbld', 06:40:07 INFO - 'MAIL': '/var/mail/cltbld', 06:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:07 INFO - 'MOZ_NO_REMOTE': '1', 06:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:07 INFO - 'NO_EM_RESTART': '1', 06:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:07 INFO - 'PWD': '/builds/slave/test', 06:40:07 INFO - 'SHELL': '/bin/bash', 06:40:07 INFO - 'SHLVL': '1', 06:40:07 INFO - 'TERM': 'linux', 06:40:07 INFO - 'TMOUT': '86400', 06:40:07 INFO - 'USER': 'cltbld', 06:40:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:07 INFO - '_': '/tools/buildbot/bin/python'} 06:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:07 INFO - Downloading/unpacking flake8 06:40:07 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 06:40:07 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 06:40:07 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 06:40:07 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 06:40:07 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 06:40:07 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 06:40:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:40:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:40:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 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 06:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:40:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:40:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:40:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:40:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:40:09 INFO - no previously-included directories found matching 'docs/_build' 06:40:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:40:09 INFO - Running setup.py install for pep8 06:40:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:40:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:40:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:40:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:40:09 INFO - no previously-included directories found matching 'docs/_build' 06:40:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:40:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:40:09 INFO - Cleaning up... 06:40:10 INFO - Return code: 0 06:40:10 INFO - Running post-action listener: _resource_record_post_action 06:40:10 INFO - Running post-action listener: _start_resource_monitoring 06:40:10 INFO - Starting resource monitoring. 06:40:10 INFO - ##### 06:40:10 INFO - ##### Finished create-virtualenv step (success) 06:40:10 INFO - ##### 06:40:10 INFO - ##### 06:40:10 INFO - ##### Running install step. 06:40:10 INFO - ##### 06:40:10 INFO - Running pre-action listener: _resource_record_pre_action 06:40:10 INFO - Running main action method: install 06:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:10 INFO - Reading from file tmpfile_stdout 06:40:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:40:10 INFO - Reading from file tmpfile_stdout 06:40:10 INFO - Output received: 06:40:10 INFO - Usage: mozinstall [options] installer 06:40:10 INFO - Options: 06:40:10 INFO - -h, --help show this help message and exit 06:40:10 INFO - -d DEST, --destination=DEST 06:40:10 INFO - Directory to install application into. [default: 06:40:10 INFO - "/builds/slave/test"] 06:40:10 INFO - --app=APP Application being installed. [default: firefox] 06:40:10 INFO - mkdir: /builds/slave/test/build/application 06:40:10 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'] 06:40:10 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 06:40:26 INFO - Reading from file tmpfile_stdout 06:40:26 INFO - Output received: 06:40:26 INFO - /builds/slave/test/build/application/firefox/firefox 06:40:26 INFO - Running post-action listener: _resource_record_post_action 06:40:26 INFO - ##### 06:40:26 INFO - ##### Finished install step (success) 06:40:26 INFO - ##### 06:40:26 INFO - ##### 06:40:26 INFO - ##### Running run-tests step. 06:40:26 INFO - ##### 06:40:26 INFO - Running pre-action listener: _resource_record_pre_action 06:40:26 INFO - Running main action method: run_tests 06:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:40:26 INFO - Python 2.7.3 06:40:26 INFO - Return code: 0 06:40:26 INFO - grabbing minidump binary from tooltool 06:40:26 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')]} 06:40:26 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 0x2a909c0>, '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 0x2a918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a91d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:40:26 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 06:40:26 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 06:40:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:40:26 INFO - Return code: 0 06:40:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:40:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:40:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:40:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:40:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:40:27 INFO - Return code: 0 06:40:27 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/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 06:40:27 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/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 06:40:27 INFO - Using env: {'DISPLAY': ':0', 06:40:27 INFO - 'HOME': '/home/cltbld', 06:40:27 INFO - 'LANG': 'en_US.UTF-8', 06:40:27 INFO - 'LANGUAGE': 'en_US:en', 06:40:27 INFO - 'LOGNAME': 'cltbld', 06:40:27 INFO - 'MAIL': '/var/mail/cltbld', 06:40:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:40:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:27 INFO - 'MOZ_NO_REMOTE': '1', 06:40:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:27 INFO - 'NO_EM_RESTART': '1', 06:40:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:27 INFO - 'PWD': '/builds/slave/test', 06:40:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:40:27 INFO - 'SHELL': '/bin/bash', 06:40:27 INFO - 'SHLVL': '1', 06:40:27 INFO - 'TERM': 'linux', 06:40:27 INFO - 'TMOUT': '86400', 06:40:27 INFO - 'USER': 'cltbld', 06:40:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579', 06:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:27 INFO - '_': '/tools/buildbot/bin/python'} 06:40:27 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/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 06:40:27 INFO - mozversion application_buildid: 20160509045548 06:40:27 INFO - mozversion application_changeset: da2b27e1aabd9e23870c09072753faba6ad0a42d 06:40:27 INFO - mozversion application_display_name: Nightly 06:40:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:40:27 INFO - mozversion application_name: Firefox 06:40:27 INFO - mozversion application_remotingname: firefox 06:40:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:40:27 INFO - mozversion application_vendor: Mozilla 06:40:27 INFO - mozversion application_version: 49.0a1 06:40:27 INFO - mozversion platform_buildid: 20160509045548 06:40:27 INFO - mozversion platform_changeset: da2b27e1aabd9e23870c09072753faba6ad0a42d 06:40:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:40:27 INFO - mozversion platform_version: 49.0a1 06:40:27 INFO - using testdate: 1462801227 06:40:27 INFO - actual date: 1462801227 06:40:27 INFO - starting webserver on 'localhost:51803' 06:40:27 INFO - SUITE-START | Running 2 tests 06:40:27 INFO - TEST-START | dromaeo_css 06:40:27 INFO - operating with platform_type : linux_ 06:40:27 INFO - Initialising browser for dromaeo_css test... 06:40:27 INFO - TEST-INFO | started process 26104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLieMOm/profile http://localhost:51803/getInfo.html) 06:40:31 INFO - PROCESS | 26104 | __metrics Screen width/height:1600/1200 06:40:31 INFO - PROCESS | 26104 | colorDepth:24 06:40:31 INFO - PROCESS | 26104 | Browser inner width/height: 1024/697 06:40:31 INFO - PROCESS | 26104 | __metrics 06:40:32 ERROR - PROCESS | 26104 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:40:33 INFO - TEST-INFO | 26104: exit 0 06:40:33 INFO - Browser initialized. 06:40:33 INFO - Running cycle 1/1 for dromaeo_css test... 06:40:33 INFO - TEST-INFO | started process 26186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLieMOm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:45 INFO - PROCESS | 26186 | RSS: Main: 154206208 06:40:45 INFO - PROCESS | 26186 | 06:41:37 INFO - PROCESS | 26186 | 1462801297068 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] 06:43:48 INFO - PROCESS | 26186 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51803/tests/dromaeo/cssquery-ext.html) 06:43:50 INFO - PROCESS | 26186 | RSS: Main: 256098304 06:43:50 INFO - PROCESS | 26186 | 06:46:52 INFO - PROCESS | 26186 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-ext.html (next: http://localhost:51803/tests/dromaeo/cssquery-jquery.html) 06:46:53 INFO - PROCESS | 26186 | RSS: Main: 237359104 06:46:53 INFO - PROCESS | 26186 | 06:49:55 INFO - PROCESS | 26186 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51803/tests/dromaeo/cssquery-mootools.html) 06:49:56 INFO - PROCESS | 26186 | RSS: Main: 240037888 06:49:56 INFO - PROCESS | 26186 | 06:52:58 INFO - PROCESS | 26186 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51803/tests/dromaeo/cssquery-prototype.html) 06:52:58 INFO - PROCESS | 26186 | RSS: Main: 232222720 06:52:58 INFO - PROCESS | 26186 | 06:56:01 INFO - PROCESS | 26186 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51803/tests/dromaeo/cssquery-yui.html) 06:56:02 INFO - PROCESS | 26186 | RSS: Main: 218890240 06:56:02 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-yui.html (next: http://localhost:51803/tests/dromaeo/cssquery-dojo.html) 06:59:05 INFO - PROCESS | 26186 | RSS: Main: 272281600 06:59:05 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | __start_tp_report 06:59:05 INFO - PROCESS | 26186 | _x_x_mozilla_page_load 06:59:05 INFO - PROCESS | 26186 | _x_x_mozilla_page_load_details 06:59:05 INFO - PROCESS | 26186 | |i|pagename|runs| 06:59:05 INFO - PROCESS | 26186 | |0;dojo.html;2631.67104111986;2663.6936752273496;2690.5695088785787;2695.299222202228;2702.8513431761257;4507.076049409871;4566.817327306912;4659.091477161951;4753.310769938361;4798.232282834747;4600.493945665974;4734.4081989751285;4764.237721964487;4795.928061079087;4843.079814835179;4291.3777502262155;4330.047389574289;4332.436783218177;4418.094290670413;4450.799714012861;4272.572742725733;4430.313301438282;4443.733375997434;4478.126765280772;4493.7977790999485;4395.7362558246605;4446.533114023029;4447.755373454459;4450.532694067108;4466.575675310856;4181.853635122787;4216.85241016566;4321.2653848845775;4379.75911324877;4388.934165987513;4309.892252693677;4315.633171180453;4332.371806088131;4417.514073451917;4427.048184640318;4676.462206846222;4708.223143181405;4715.64632652549;4718.386609740712;4730.574248317634;4884.5603895649565;5035.320231768701;5075.771590278409;5082.161443361841;5121.231815227746;5099.9490005100215;5105.872353191163;5145.253938178943;5162.406323272834;5171.5862730981435;4775.952240477585;4830.468648448667;4833.00923310724;4833.081714474239;4834.299026641117;4955.1576232039915;5188.195829646411;5194.298769666122;5230.189320655304;5297.629165958423;5001.274815151783;5030.974845125751;5076.314697515862;5079.517445842639;5081.4918508148885;4829.975850120727;5109.182530795055;5113.744312784346;5117.462666420047;5171.4052883918075;4927.43334516528;4952.702837829742;4968.776405061781;4973.776180071905;4995.875103122451;4974.801007959641;4975.601951843843;4977.278294647328;4980.302757613937;5029.119904016782;4172.144710334374;4198.832046718158;4307.289297265978;4313.633341166036;4365.039691267916;3712.1833196696684;3712.5916149223563;3719.4420836874683;3740.251949610089;3774.358359078963;4245.299525578245;4247.044415006599;4248.511421186541;4262.211490874198;4285.571442855689;4854.781534830941;4955.752212389366;4959.727215003138;4965.3048573199785;5015.774290156952;4269.91460170801;4309.396684464177;4322.416473776063;4335.7181783184;4337.175936572041;4606.953930460652;4616.238320677118;4617.399738034102;4638.768061596907;4664.253719404879;4549.067441174618;4709.505501922249;4802.135615589227;4802.351682522884;4803.639727020487;5020.196768517019;5033.546980771748;5109.054824857413;5117.616178786531;5119.6416250862085;4736.881577960578;4755.83354582588;4759.405074365704;4764.452088009784;4802.255650374198;4762.476127626028;4982.501749824988;4987.700737955734;4994.275830004702;4997.5002499749735;5013.072581572421;5014.272930425141;5047.520485553867;5070.340855688737;5071.391433027913;4921;4924.72913989734;4929.654924155275;4933.580645645016;4983.750812459435;4722.598579120676;4856.344393506832;4898.951010489849;4912.82805101834;4963.925541116959;4759.262314341283;4849.709017458964;4877.3903262092235;4891.877703057452;4898.975505122452;4956.10790057793;4966.081274964144;4966.478519755374;5000.924986125284;5005.474425185449;4655.138799322136;4794.736289504111;4848.8302909398;4851.46633870281;4889.046635905964 06:59:05 INFO - PROCESS | 26186 | |1;ext.html;559.8348487196276;589.6874656432093;593.9792107276246;600.603601622929;606.0031248596061;27556;41562.79218603906;42469;42591;42601.36097958533;42317;42692.57307426925;42771.78614106933;42872.142557148916;42962.78518607403;7880.290773830368;8026.277635012848;8029.076656184555;8034.718784842532;8037.316828069621;7880.330171935392;7979.122296547375;7980.162082981262;7984.800379990517;7991.5604641744685;7983.720569780059;8021.157778433268;8030.196980301981;8031.718889838857;8032.1164671886045;7940.960295198516;7981.241782030698;7988.600569971478;7989.999999999942;7991.680332786682;7884.64519096642;7935.48419352746;7935.960320198362;7939.682412703485;7948.642311096015;38709.806450967844;39050.41424378636;39088.80455597732;39122.413163802565;39229.21541569181;3256.072019474462;3373.3927892979254;3379.831008449568;3503.789772613651;4036.4348991141264;27691;30315.242118946982;30778.23054423635;30967.22581935447;31841.36317273665;3210;3227.499737540685;3246.6915643013876;3257.4950882613234;3422.9657703422895;249043;249290;249298;249311;250949;34519.309613807585;58228.708856456295;58368;58930.41069589335;59016.704916475144;36180.09549761277;36216.637833621324;36295.27409451796;36524;36552.26895462076;13613.591592252249;13771.517996870061;13773.724525509635;13783;13785.655358616115;11004;11106.500207490682;11109.611163609236;11112.777744445228;11116.277441966246;8389.53857537829;8511.957440212884;8524.232819046316;8584.914150858536;8613.61238744258;3244.5782048333567;3251.707346338841;3259.5599594054975;3282.491213861855;3290.917727056795;907.981840363189;946.0539460539461;948.4972964328916;978.9167920726818;998.5207100591757;28502.71497285042;29327.560086598718;29565.704342956724;29592.260193495335;29712.257193570334;835.7659855240543;1009.4952523738131;1040.776233109885;1070.6573896353248;1090.6346373964652;15344;15751.291191896393;15810.209489525478;15928.601784955237;16129.596760081093;381638;382437;384406;384577;385843;51640;52075.218871716956;52208.47791522036;52636;52700;1110.9944450277696;1175.8177482490228;1216.8235605837103;1258.8237646729465;1288.7486940046601;27033.45933081367;30137.69862301349;30159.246018849703;30401;30777.230569235948;44571.331430029226;45223;45238.77380613076;45282.77358613186;45327.320090198016;286611;286856.74860888184;287304;287409;287787;19505.512362191057;24350.87824560866;24352.26943191707;25714;26201.868990654926;37019.62980370162;43584.56415435805;43720;44034.55965440305;44299.557004429545;37239.6276037247;37283.81358093192;37405.251894962494;38061.42907856329;38086.80956595199;36932.26135477329;36983.26033479369;37038;37040.814795926926;37560.43659345167;36504.26991460103;36907;36943.44584831283;37746.245075098894;37777.244455110194;32323.35353292968;33907.321853563284;34114.48828267628;34239.14402139966;34351;25453.236402907944;25935.48129037371;26105.347366315993;26144.8692756535;26235 06:59:05 INFO - PROCESS | 26186 | |2;jquery.html;380.1124374585343;381.66604221306375;382.0467932508392;393.8916797880584;396.3816446343704;15636.843631563695;17348.913255433738;17850.196741146647;17914.104294785273;17975.191116399776;16865.241064152113;17208.311667533315;17294.56763580911;17570.912145439288;17625.118744062776;5017.623678224129;5118.744062796864;5137.075326441239;5145.0481660892665;5203.323567936182;3653.799041052741;5559.77760889566;5916.733746981375;5926.851828704273;6014.2181516403025;5893.38119497453;5948.40515948406;5957.940420595782;5970.104484327342;5988.101784732282;3630.945535816965;5749.712514374285;5894.410558944114;5937.22816033915;5940.851478713023;4893.510648935114;5214.191800270964;5219.71291578963;5286.947130528684;5289.471052894718;20127.39617811468;20788.688169677465;20814.687779683318;21083.156673733032;21084.5783084339;2007.1971211515365;2009.5177157482244;2047.5495391013953;2158.0396723458066;2190.233418303581;13103.2138071716;13414.530491432753;13465.798013029813;13936.512222072179;13992.30038498071;1766.2493440287826;1824.5347436403765;1882.745829313039;1904.8476121910353;1915.5019694879431;68442;68701.65649171722;68942.3105768946;69296.6535167321;71130;9443.527823608792;9502.952485237529;9743.805123897482;9945;10073.798524029478;13053.477860885649;13075.280859552817;13160.473581056842;13281.734365312639;13307.66730831737;7128.572285662877;7167.068281123421;7246.7101315946775;7393.852122957511;7523.322900938832;7154.785356439315;7174.928250717426;7191.748288809867;7307.634618269065;7314.305141011595;6121;6343;6354.968225158845;6363.809085727436;6436.259830119596;1573.6065983504125;1650.2408891909615;1752.553098959757;1776.7779027621548;1778.7370966613591;939.281449690987;951.7192428233687;965.2278177458005;1011.145581983223;1012.2863381316155;16966.745498817527;17263.13684315779;17366.826331736775;17521.211545480484;17525.386611468537;906.805036917066;920.2086205863086;920.4937284493502;953.5994882149514;973.5181085362791;9201;10273.897261027294;10381.117605003508;10572.894271057345;10609.787804243872;413134;418367;425380;425638;425723;48087.75956120197;64036.67981660062;81282.59358703287;81963.5901820487;82633.58683206546;994.4580203788952;1001.0790073132736;1014.452195814252;1021.8262895307815;1023.2888142740724;15698.9215053924;15736.60658483547;15868.285927133076;16045.839541604435;16284.918575407048;30238;31099.68900310968;33954.83022584871;34767.30465390729;36219.27561448704;46151;47842;49724.751376242886;52229;54111.75329480244;7427.665755040928;7976.202379761978;7978.202179781975;8018.077921038922;8070.556119413489;7491.587962662106;8503.574821258788;9368.812623747623;12154.817677735018;12212.694682633006;9970.30207885441;10786.784264314827;10923;10952.726181845517;11040.227184097035;10192.847107293544;10594.417307048187;10705.518251678848;10832.458377080957;11107.611233606785;6103.176071230327;6985.825354366181;10662.200334975063;10840.891591084304;10978.780424391627;7990.440669153103;8104.311133553714;8154.347652187692;8298.792530186794;8330.958345208235;9411.670591529264;10714.303570267908;10827.566897324019;10906.236563440483;10931.83602245983 06:59:05 INFO - PROCESS | 26186 | |3;mootools.html;1264.2225031605565;1459.1318165691414;1486.5688950204442;1627.3653275222657;1794.1746796473622;6133.570650054492;6975.093237879075;7230.096237970254;7232.3490885820265;7411.925880741191;7209.062821833168;7333.303336183054;7346.191918888918;7354.3748781353515;7360.521566098213;2138.080625331107;2169.8372622053407;2171.8262538996923;2177.542716029636;2181.803637672609;2109.1457959526415;2127.5425783456553;2164.599549083425;2171.7828217178235;2171.934841954736;2115.6086124067097;2117.026167962739;2132.2217390652377;2136.6367717487988;2164.0478189596606;2091.435312465633;2093.2464312847364;2096.821770149539;2098.4544018555134;2098.8530802843807;2078.8025137611903;2113.9154433822628;2120.5016821047043;2121.7029615853794;2124.2352753008904;7087.220405755363;7245.927540724578;7289.599072051035;7301.89047164293;7306.378957788541;4287.399764033038;4380.036391993756;4381.9561804381865;4399.406080179167;4416.249237629579;2894.493463643854;2930.575066615329;2936.8341247356593;2969.1092672198256;2994.296340360014;921.0060219624572;924.6809850601531;928.2295694573555;935.4574346878794;942.5711301357866;9589.856152157723;9645.517724113837;9653.324267301292;9671.661491847752;9672.56473458696;3853.7302388832513;3912.0024393779972;4017.5379831319774;4020.216057868746;4022.6781857451333;7314.890276645855;7318.560886346836;7337.376323012603;7402.6668799903055;7448.515846470071;4330.566943305645;4363.716358436692;4363.869083927487;4364.192624364503;4372.060007098489;3536.29274145172;3827.5024246847734;3861.768293902319;3918.1771827915886;3935.114599215211;3302.5046243063734;3330.816805075696;3378.7596566309126;3390.847411866472;3401.081707938892;952.7522844060594;1020.3826684855555;1023.467796745688;1027.9537420816082;1030.685640879524;758.8671982403057;784.6429874407131;878.9780255493664;896.2292428511475;911.1617312072909;4893.681910675795;5039.395272567315;5091.541761241432;5094.5160209780015;5101.8724531887;436.1778048378829;445.7904784751162;448.2626080098285;451.85540626999045;457.79399270328486;3583.480395342661;3588.120910376922;3610.1335679436747;3624.0577449863226;3703.2408356286896;8482.194191551916;8811.206991370807;8825.779355516164;8916.910830891738;8940.240079593308;8723.302135829246;8742.956285218534;8819.603117859711;8823.647054117891;8834.823303533893;6546.18172728409;6578.539502234893;6602.636854973022;6628.105205797252;6674.299198584079;5040.117979353672;5079.796808127633;5083.46623604531;5121.615878809179;5136.1268584340005;7857.253560911704;8115.837683246184;8131.552764598004;8145.144759800136;8278.71024514139;7893.092294386219;8343.082260951413;8358.414910956175;8369.665213391396;8437;6065.302490213506;6495.0906873036865;6662.83342916431;6689.09697190873;6822.658867056726;6935.133108361455;7030.859382812213;7087;7106.893396598952;7109.893351599833;6307.180066591497;6370.076338930737;6458.838529036811;6532.248791389051;6541.803745887631;6109.602875813058;6131.294901086254;6155.230596175478;6208.844778880564;6223.937760622336;5825.970870145622;5869.090291004901;5930.851728706817;5936.5844390892225;5965.4929331005615;4236.6187043166265;4449.466064072332;4458.910821783611;4584.747838868894;4652.488226295172;4356.673249506236;4381.40850985113;4412.29403295484;4557.202489564247;4578.954210457853 06:59:05 INFO - PROCESS | 26186 | |4;prototype.html;300.48916841369675;310.4195155060038;314.7560640503609;319.0587766090034;319.54145800775905;4618.538146185379;4719.669623126379;4736.52634736527;4835.202191638376;4850.63620228483;4551.795169217385;4710.505396933324;4712.3638308828295;4715.269133284346;4715.962488252579;3757.361248587733;3787.7537960032646;3789.8294576743974;3795.1650636859845;3803.1062700265416;3614.024213462377;3648.5986541480415;3737.1965027519077;3792;3808.657220850123;3734.906627334311;3760.6427389397963;3769.321522126016;3782.073392018959;3798.772073675588;3781.6785573226307;3782.978595779138;3789.5263092113487;3791.9810400948095;3800.4869342638667;3384.187794929224;3391.1183092396154;3391.2030672791875;3394.949075763841;3398.711109555666;4479.395281637003;4541.750203738826;4560.452745670541;4570.7257564546235;4593.173228818811;4236.894077648052;4261;4263.701540892139;4279.422277992462;4287.892802679958;4911.16510193268;4934.136526107916;4936.086823937583;4944.653874228806;4956.405231372259;3507.9824600877087;3650.7992060436663;3682.1346983458866;3689.612590677967;3700.4264339027495;5142.580184177555;5148.845534633967;5177.37871455424;5200.843974680765;5213.635045546814;3767.3030489359558;3771.9434208486896;3780.432935059763;3783.6405541473514;3785.280796648628;3818.1981783825154;3827.158025234444;3829.8659546915724;3841.2317536492815;3878.7672739635714;4082.6119119499513;4262.829486820492;4290.3993440917675;4307.806148723315;4309.827606895689;4940.950590494121;4961.5286547777905;4966.404031516241;4979.30289759434;4988.900221995613;1226.7853125703145;1255.9058070644737;1258.7985922252396;1259.2066997791333;1259.609521048478;890.4612709310903;906.954652267384;909.4725059465494;909.8498747706686;913.5386629751932;4182.013543566782;4197.580241975778;4214.768187749642;4219.78901054946;4229.915401691949;4851.587615052689;4874.95125048745;4977.701337919736;4979.402471703419;4999.475055119233;4170.582941705866;4204.327307630764;4208.305629571148;4210.389493523422;4211.873643790691;2603.47930413918;2608.2305719812703;2623;2623.8819253133656;2624.8162628615814;4334.263175260214;4624.676272660949;4651.418572678415;4682;4683.227267500824;5034.345535080416;5037.078494473197;5038.294638750578;5042.546170844642;5053.898922021539;4547.795349209294;4610.561996610317;4616.561426664462;4653.418322709661;4679.344891715163;4723.669343145947;4854.514548545118;4862.756862156807;4914.729689867092;4924.064427758858;4784.736839473723;4833.824778849602;4844.2007068834655;4846.613814497885;4865;4635.629149668086;4641.584316783414;4654.720716757005;4656.3946686930485;4660.906781864412;3667.2298817248675;3669.4862719219864;3670.7614005089586;3675.5773086094373;3683.9447408289434;4694.34279200919;4812.398450193726;4820.324719780415;4827.806887724451;4877.244027175793;4741.241401375763;4769.759862435722;4771.856844294677;4779.689320194177;4780.569748722632;4691.765411729468;4722.858314250578;4735.739534325645;4764.904701906012;4779.617630589475;4529.660275479287;4623.332623372217;4703.623710103252;4904.94543673112;4939.6542242042715;4952.083864485082;4974.925376119289;4984.800607975641;4987.451380348086;4992.003198720396;4855.36880205571;4866.221404575251;4880.780364883518;4886.755662216804;4887 06:59:05 INFO - PROCESS | 26186 | |5;yui.html;682.8327059870331;798.8082860113575;812.8861959325692;828.3331917806164;829.7054545636303;11073.72315692107;11557.24877882938;11649.825252621218;11733.7653246935;11748.41257937102;12589.685257868536;12626.558070467536;12629.621111366674;12640;12642.241465512052;657.6021506988275;676.861243445095;677.1603212017112;848.8854004709362;866.1295398124876;685.5372623479157;835.3692961813822;859.621766422772;864.844328020956;868.3227082875368;910.0671811393308;915.1809130827905;918.1277786103195;918.9172974432299;919.0120620333169;909.627052908311;909.8726178335071;910.094456016268;910.658503061352;911.0616065452562;514.072099859753;529.4731741916818;530.4748299183781;654.4241067860253;673.535260670136;11806.468708908034;11811.763764724657;11813.881861181364;11852.525898964032;11862.466189021428;11923.224990375684;12467.812982805175;12547.874521254762;12808.10343275971;12839.165454245443;10786.191035672357;10837.83743243852;10983.450827458675;10998.780024399468;11007.852102176737;3622.8913132606062;3631.2918980798754;3679.4848721179055;3720.4977328060636;3732.533433320835;42713.35929961022;42759.57240427618;42866;42895.92760180989;43009.569904301185;9727.9027209727;10031.949840250752;10184.134348580306;10190.949045254727;10700.839487407695;18075.27698892056;18076.638467230845;18090.547736306697;18137.455876323733;18150.09249537518;6632.237292711304;6635.104260924713;6714.462842972551;6715.529912906148;6862.656867156622;3424.6746559076846;3499.8775042873376;3504.737144714157;3575.4636804479014;3606.13452771333;2899.1157696902224;2940.868915722644;2990.9102726918227;2996.5205567109156;2997.6702562718083;517.3403910014686;523.2622002975786;528.5428104689416;535.4244187498377;536.7450461030979;486.9870669008454;490.0077343379685;505.6738403729574;557.3117200257759;623.8565130020121;7328.193898671142;7585.355244804254;7621.504602200839;7702.8844567331535;7784.610769461504;556.5186114011432;568.4486048532999;580.097947691344;589.6138029590625;593.2969431224013;3295.307985323109;3493.947590786089;3501.9299614007577;3534.720105531969;3583.552055993001;51487.48512514902;52100.739496302274;52324;52761;53325;47664;47875;48283;49119.754401227765;49589.25616115761;43422.34866476942;43511.782441088224;43856.3421548677;44304.3354349685;44427.777861111135;6820.761273355409;6833.145856767904;6876.17485901695;6883.070785443901;6904.102466679299;28424.57363139513;29010.709892901647;29974;29990.55014174833;30161.245968850955;36035.63964360428;37443;38680.2263954725;38799.418008730456;39525.2094958105;8950.194482496607;9315.86026209594;9326.253899688145;9351;9673.70978870635;9311.674091406769;9486.762830929007;9590.520473976134;9723.805523889341;10228.539715712663;8842.425242359226;8975.461472311683;9323.207527359978;9458.763530911783;9479.241660667269;8819.426737262058;8951.910480895107;9063.229625481908;9282.814343713222;9366.344355895022;8741.645045018033;8798.208161265517;8827.69103081389;8880.422772519765;9107.316951228551;7088.184858741311;7224.205337412775;7376.4836461447185;7420.962895185489;7467.626618669154;7730;7843.098043725045;7847.254510821463;7965.123836378109;8000.959995199987 06:59:05 INFO - PROCESS | 26186 | __end_tp_report 06:59:05 INFO - PROCESS | 26186 | __start_cc_report 06:59:05 INFO - PROCESS | 26186 | _x_x_mozilla_cycle_collect,953 06:59:05 INFO - PROCESS | 26186 | __end_cc_report 06:59:05 INFO - PROCESS | 26186 | __startTimestamp1462802345417__endTimestamp 06:59:05 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | ------- Summary: start ------- 06:59:05 INFO - PROCESS | 26186 | Number of tests: 6 06:59:05 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | [#0] dojo.html Cycles:165 Average:4669.57 Median:4802.26 stddev:485.90 (10.1%) stddev-sans-first:460.34 06:59:05 INFO - PROCESS | 26186 | Values: 2631.7 2663.7 2690.6 2695.3 2702.9 4507.1 4566.8 4659.1 4753.3 4798.2 4600.5 4734.4 4764.2 4795.9 4843.1 4291.4 4330.0 4332.4 4418.1 4450.8 4272.6 4430.3 4443.7 4478.1 4493.8 4395.7 4446.5 4447.8 4450.5 4466.6 4181.9 4216.9 4321.3 4379.8 4388.9 4309.9 4315.6 4332.4 4417.5 4427.0 4676.5 4708.2 4715.6 4718.4 4730.6 4884.6 5035.3 5075.8 5082.2 5121.2 5099.9 5105.9 5145.3 5162.4 5171.6 4776.0 4830.5 4833.0 4833.1 4834.3 4955.2 5188.2 5194.3 5230.2 5297.6 5001.3 5031.0 5076.3 5079.5 5081.5 4830.0 5109.2 5113.7 5117.5 5171.4 4927.4 4952.7 4968.8 4973.8 4995.9 4974.8 4975.6 4977.3 4980.3 5029.1 4172.1 4198.8 4307.3 4313.6 4365.0 3712.2 3712.6 3719.4 3740.3 3774.4 4245.3 4247.0 4248.5 4262.2 4285.6 4854.8 4955.8 4959.7 4965.3 5015.8 4269.9 4309.4 4322.4 4335.7 4337.2 4607.0 4616.2 4617.4 4638.8 4664.3 4549.1 4709.5 4802.1 4802.4 4803.6 5020.2 5033.5 5109.1 5117.6 5119.6 4736.9 4755.8 4759.4 4764.5 4802.3 4762.5 4982.5 4987.7 4994.3 4997.5 5013.1 5014.3 5047.5 5070.3 5071.4 4921.0 4924.7 4929.7 4933.6 4983.8 4722.6 4856.3 4899.0 4912.8 4963.9 4759.3 4849.7 4877.4 4891.9 4899.0 4956.1 4966.1 4966.5 5000.9 5005.5 4655.1 4794.7 4848.8 4851.5 4889.0 06:59:05 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | [#1] ext.html Cycles:180 Average:46101.62 Median:37028.81 stddev:82150.70 (221.9%) stddev-sans-first:82309.99 06:59:05 INFO - PROCESS | 26186 | Values: 559.8 589.7 594.0 600.6 606.0 27556.0 41562.8 42469.0 42591.0 42601.4 42317.0 42692.6 42771.8 42872.1 42962.8 7880.3 8026.3 8029.1 8034.7 8037.3 7880.3 7979.1 7980.2 7984.8 7991.6 7983.7 8021.2 8030.2 8031.7 8032.1 7941.0 7981.2 7988.6 7990.0 7991.7 7884.6 7935.5 7936.0 7939.7 7948.6 38709.8 39050.4 39088.8 39122.4 39229.2 3256.1 3373.4 3379.8 3503.8 4036.4 27691.0 30315.2 30778.2 30967.2 31841.4 3210.0 3227.5 3246.7 3257.5 3423.0 249043.0 249290.0 249298.0 249311.0 250949.0 34519.3 58228.7 58368.0 58930.4 59016.7 36180.1 36216.6 36295.3 36524.0 36552.3 13613.6 13771.5 13773.7 13783.0 13785.7 11004.0 11106.5 11109.6 11112.8 11116.3 8389.5 8512.0 8524.2 8584.9 8613.6 3244.6 3251.7 3259.6 3282.5 3290.9 908.0 946.1 948.5 978.9 998.5 28502.7 29327.6 29565.7 29592.3 29712.3 835.8 1009.5 1040.8 1070.7 1090.6 15344.0 15751.3 15810.2 15928.6 16129.6 381638.0 382437.0 384406.0 384577.0 385843.0 51640.0 52075.2 52208.5 52636.0 52700.0 1111.0 1175.8 1216.8 1258.8 1288.7 27033.5 30137.7 30159.2 30401.0 30777.2 44571.3 45223.0 45238.8 45282.8 45327.3 286611.0 286856.7 287304.0 287409.0 287787.0 19505.5 24350.9 24352.3 25714.0 26201.9 37019.6 43584.6 43720.0 44034.6 44299.6 37239.6 37283.8 37405.3 38061.4 38086.8 36932.3 36983.3 37038.0 37040.8 37560.4 36504.3 36907.0 36943.4 37746.2 37777.2 32323.4 33907.3 34114.5 34239.1 34351.0 25453.2 25935.5 26105.3 26144.9 26235.0 06:59:05 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | [#2] jquery.html Cycles:180 Average:25145.35 Median:206765.19 stddev:69294.63 (33.5%) stddev-sans-first:69464.07 06:59:05 INFO - PROCESS | 26186 | Values: 380.1 381.7 382.0 393.9 396.4 15636.8 17348.9 17850.2 17914.1 17975.2 16865.2 17208.3 17294.6 17570.9 17625.1 5017.6 5118.7 5137.1 5145.0 5203.3 3653.8 5559.8 5916.7 5926.9 6014.2 5893.4 5948.4 5957.9 5970.1 5988.1 3630.9 5749.7 5894.4 5937.2 5940.9 4893.5 5214.2 5219.7 5286.9 5289.5 20127.4 20788.7 20814.7 21083.2 21084.6 2007.2 2009.5 2047.5 2158.0 2190.2 13103.2 13414.5 13465.8 13936.5 13992.3 1766.2 1824.5 1882.7 1904.8 1915.5 68442.0 68701.7 68942.3 69296.7 71130.0 9443.5 9503.0 9743.8 9945.0 10073.8 13053.5 13075.3 13160.5 13281.7 13307.7 7128.6 7167.1 7246.7 7393.9 7523.3 7154.8 7174.9 7191.7 7307.6 7314.3 6121.0 6343.0 6355.0 6363.8 6436.3 1573.6 1650.2 1752.6 1776.8 1778.7 939.3 951.7 965.2 1011.1 1012.3 16966.7 17263.1 17366.8 17521.2 17525.4 906.8 920.2 920.5 953.6 973.5 9201.0 10273.9 10381.1 10572.9 10609.8 413134.0 418367.0 425380.0 425638.0 425723.0 48087.8 64036.7 81282.6 81963.6 82633.6 994.5 1001.1 1014.5 1021.8 1023.3 15698.9 15736.6 15868.3 16045.8 16284.9 30238.0 31099.7 33954.8 34767.3 36219.3 46151.0 47842.0 49724.8 52229.0 54111.8 7427.7 7976.2 7978.2 8018.1 8070.6 7491.6 8503.6 9368.8 12154.8 12212.7 9970.3 10786.8 10923.0 10952.7 11040.2 10192.8 10594.4 10705.5 10832.5 11107.6 6103.2 6985.8 10662.2 10840.9 10978.8 7990.4 8104.3 8154.3 8298.8 8331.0 9411.7 10714.3 10827.6 10906.2 10931.8 06:59:05 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | [#3] mootools.html Cycles:180 Average:4783.19 Median:5098.19 stddev:2585.67 (50.7%) stddev-sans-first:2579.40 06:59:05 INFO - PROCESS | 26186 | Values: 1264.2 1459.1 1486.6 1627.4 1794.2 6133.6 6975.1 7230.1 7232.3 7411.9 7209.1 7333.3 7346.2 7354.4 7360.5 2138.1 2169.8 2171.8 2177.5 2181.8 2109.1 2127.5 2164.6 2171.8 2171.9 2115.6 2117.0 2132.2 2136.6 2164.0 2091.4 2093.2 2096.8 2098.5 2098.9 2078.8 2113.9 2120.5 2121.7 2124.2 7087.2 7245.9 7289.6 7301.9 7306.4 4287.4 4380.0 4382.0 4399.4 4416.2 2894.5 2930.6 2936.8 2969.1 2994.3 921.0 924.7 928.2 935.5 942.6 9589.9 9645.5 9653.3 9671.7 9672.6 3853.7 3912.0 4017.5 4020.2 4022.7 7314.9 7318.6 7337.4 7402.7 7448.5 4330.6 4363.7 4363.9 4364.2 4372.1 3536.3 3827.5 3861.8 3918.2 3935.1 3302.5 3330.8 3378.8 3390.8 3401.1 952.8 1020.4 1023.5 1028.0 1030.7 758.9 784.6 879.0 896.2 911.2 4893.7 5039.4 5091.5 5094.5 5101.9 436.2 445.8 448.3 451.9 457.8 3583.5 3588.1 3610.1 3624.1 3703.2 8482.2 8811.2 8825.8 8916.9 8940.2 8723.3 8743.0 8819.6 8823.6 8834.8 6546.2 6578.5 6602.6 6628.1 6674.3 5040.1 5079.8 5083.5 5121.6 5136.1 7857.3 8115.8 8131.6 8145.1 8278.7 7893.1 8343.1 8358.4 8369.7 8437.0 6065.3 6495.1 6662.8 6689.1 6822.7 6935.1 7030.9 7087.0 7106.9 7109.9 6307.2 6370.1 6458.8 6532.2 6541.8 6109.6 6131.3 6155.2 6208.8 6223.9 5826.0 5869.1 5930.9 5936.6 5965.5 4236.6 4449.5 4458.9 4584.7 4652.5 4356.7 4381.4 4412.3 4557.2 4579.0 06:59:05 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | [#4] prototype.html Cycles:180 Average:4080.93 Median:4617.55 stddev:1142.71 (24.7%) stddev-sans-first:1110.13 06:59:05 INFO - PROCESS | 26186 | Values: 300.5 310.4 314.8 319.1 319.5 4618.5 4719.7 4736.5 4835.2 4850.6 4551.8 4710.5 4712.4 4715.3 4716.0 3757.4 3787.8 3789.8 3795.2 3803.1 3614.0 3648.6 3737.2 3792.0 3808.7 3734.9 3760.6 3769.3 3782.1 3798.8 3781.7 3783.0 3789.5 3792.0 3800.5 3384.2 3391.1 3391.2 3394.9 3398.7 4479.4 4541.8 4560.5 4570.7 4593.2 4236.9 4261.0 4263.7 4279.4 4287.9 4911.2 4934.1 4936.1 4944.7 4956.4 3508.0 3650.8 3682.1 3689.6 3700.4 5142.6 5148.8 5177.4 5200.8 5213.6 3767.3 3771.9 3780.4 3783.6 3785.3 3818.2 3827.2 3829.9 3841.2 3878.8 4082.6 4262.8 4290.4 4307.8 4309.8 4941.0 4961.5 4966.4 4979.3 4988.9 1226.8 1255.9 1258.8 1259.2 1259.6 890.5 907.0 909.5 909.8 913.5 4182.0 4197.6 4214.8 4219.8 4229.9 4851.6 4875.0 4977.7 4979.4 4999.5 4170.6 4204.3 4208.3 4210.4 4211.9 2603.5 2608.2 2623.0 2623.9 2624.8 4334.3 4624.7 4651.4 4682.0 4683.2 5034.3 5037.1 5038.3 5042.5 5053.9 4547.8 4610.6 4616.6 4653.4 4679.3 4723.7 4854.5 4862.8 4914.7 4924.1 4784.7 4833.8 4844.2 4846.6 4865.0 4635.6 4641.6 4654.7 4656.4 4660.9 3667.2 3669.5 3670.8 3675.6 3683.9 4694.3 4812.4 4820.3 4827.8 4877.2 4741.2 4769.8 4771.9 4779.7 4780.6 4691.8 4722.9 4735.7 4764.9 4779.6 4529.7 4623.3 4703.6 4904.9 4939.7 4952.1 4974.9 4984.8 4987.5 4992.0 4855.4 4866.2 4880.8 4886.8 4887.0 06:59:05 INFO - PROCESS | 26186 | 06:59:05 INFO - PROCESS | 26186 | [#5] yui.html Cycles:180 Average:12377.43 Median:529.01 stddev:14528.88 (2746.4%) stddev-sans-first:14543.09 06:59:05 INFO - PROCESS | 26186 | Values: 682.8 798.8 812.9 828.3 829.7 11073.7 11557.2 11649.8 11733.8 11748.4 12589.7 12626.6 12629.6 12640.0 12642.2 657.6 676.9 677.2 848.9 866.1 685.5 835.4 859.6 864.8 868.3 910.1 915.2 918.1 918.9 919.0 909.6 909.9 910.1 910.7 911.1 514.1 529.5 530.5 654.4 673.5 11806.5 11811.8 11813.9 11852.5 11862.5 11923.2 12467.8 12547.9 12808.1 12839.2 10786.2 10837.8 10983.5 10998.8 11007.9 3622.9 3631.3 3679.5 3720.5 3732.5 42713.4 42759.6 42866.0 42895.9 43009.6 9727.9 10031.9 10184.1 10190.9 10700.8 18075.3 18076.6 18090.5 18137.5 18150.1 6632.2 6635.1 6714.5 6715.5 6862.7 3424.7 3499.9 3504.7 3575.5 3606.1 2899.1 2940.9 2990.9 2996.5 2997.7 517.3 523.3 528.5 535.4 536.7 487.0 490.0 505.7 557.3 623.9 7328.2 7585.4 7621.5 7702.9 7784.6 556.5 568.4 580.1 589.6 593.3 3295.3 3493.9 3501.9 3534.7 3583.6 51487.5 52100.7 52324.0 52761.0 53325.0 47664.0 47875.0 48283.0 49119.8 49589.3 43422.3 43511.8 43856.3 44304.3 44427.8 6820.8 6833.1 6876.2 6883.1 6904.1 28424.6 29010.7 29974.0 29990.6 30161.2 36035.6 37443.0 38680.2 38799.4 39525.2 8950.2 9315.9 9326.3 9351.0 9673.7 9311.7 9486.8 9590.5 9723.8 10228.5 8842.4 8975.5 9323.2 9458.8 9479.2 8819.4 8951.9 9063.2 9282.8 9366.3 8741.6 8798.2 8827.7 8880.4 9107.3 7088.2 7224.2 7376.5 7421.0 7467.6 7730.0 7843.1 7847.3 7965.1 8001.0 06:59:05 INFO - PROCESS | 26186 | -------- Summary: end -------- 06:59:05 INFO - PROCESS | 26186 | 06:59:06 INFO - TEST-INFO | 26186: exit 0 06:59:06 INFO - TEST-OK | dromaeo_css | took 1118882ms 06:59:06 INFO - TEST-START | kraken 06:59:06 INFO - operating with platform_type : linux_ 06:59:06 INFO - Initialising browser for kraken test... 06:59:06 INFO - TEST-INFO | started process 26361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4hmvQ/profile http://localhost:51803/getInfo.html) 06:59:10 INFO - PROCESS | 26361 | __metrics Screen width/height:1600/1200 06:59:10 INFO - PROCESS | 26361 | colorDepth:24 06:59:10 INFO - PROCESS | 26361 | Browser inner width/height: 1024/697 06:59:10 INFO - PROCESS | 26361 | __metrics 06:59:11 ERROR - PROCESS | 26361 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:59:12 INFO - TEST-INFO | 26361: exit 0 06:59:12 INFO - Browser initialized. 06:59:12 INFO - Running cycle 1/1 for kraken test... 06:59:12 INFO - TEST-INFO | started process 26440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4hmvQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:24 INFO - PROCESS | 26440 | RSS: Main: 153468928 06:59:24 INFO - PROCESS | 26440 | 06:59:27 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51803/tests/kraken/driver.html?testName=audio-beat-detection) 06:59:28 INFO - PROCESS | 26440 | RSS: Main: 209358848 06:59:28 INFO - PROCESS | 26440 | 06:59:30 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51803/tests/kraken/driver.html?testName=audio-dft) 06:59:31 INFO - PROCESS | 26440 | RSS: Main: 197431296 06:59:31 INFO - PROCESS | 26440 | 06:59:34 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51803/tests/kraken/driver.html?testName=audio-fft) 06:59:35 INFO - PROCESS | 26440 | RSS: Main: 266133504 06:59:35 INFO - PROCESS | 26440 | 06:59:37 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51803/tests/kraken/driver.html?testName=audio-oscillator) 06:59:38 INFO - PROCESS | 26440 | RSS: Main: 175542272 06:59:38 INFO - PROCESS | 26440 | 06:59:40 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:59:41 INFO - PROCESS | 26440 | RSS: Main: 179539968 06:59:41 INFO - PROCESS | 26440 | 06:59:44 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51803/tests/kraken/driver.html?testName=imaging-darkroom) 06:59:45 INFO - PROCESS | 26440 | RSS: Main: 215494656 06:59:45 INFO - PROCESS | 26440 | 06:59:48 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51803/tests/kraken/driver.html?testName=imaging-desaturate) 06:59:49 INFO - PROCESS | 26440 | RSS: Main: 213868544 06:59:49 INFO - PROCESS | 26440 | 06:59:52 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51803/tests/kraken/driver.html?testName=json-parse-financial) 06:59:53 INFO - PROCESS | 26440 | RSS: Main: 214847488 06:59:53 INFO - PROCESS | 26440 | 06:59:55 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:59:55 INFO - PROCESS | 26440 | RSS: Main: 210300928 06:59:55 INFO - PROCESS | 26440 | 06:59:57 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:59:58 INFO - PROCESS | 26440 | RSS: Main: 211472384 06:59:58 INFO - PROCESS | 26440 | 07:00:00 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:00:01 INFO - PROCESS | 26440 | RSS: Main: 214040576 07:00:01 INFO - PROCESS | 26440 | 07:00:04 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:00:04 INFO - PROCESS | 26440 | RSS: Main: 218030080 07:00:04 INFO - PROCESS | 26440 | 07:00:07 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:00:08 INFO - PROCESS | 26440 | RSS: Main: 215957504 07:00:08 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51803/tests/kraken/driver.html?testName=ai-astar) 07:00:10 INFO - PROCESS | 26440 | RSS: Main: 262225920 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | __start_tp_report 07:00:10 INFO - PROCESS | 26440 | _x_x_mozilla_page_load 07:00:10 INFO - PROCESS | 26440 | _x_x_mozilla_page_load_details 07:00:10 INFO - PROCESS | 26440 | |i|pagename|runs| 07:00:10 INFO - PROCESS | 26440 | |0;ai-astar;115;112;116;116;114;115;114;113;114;115 07:00:10 INFO - PROCESS | 26440 | |1;audio-beat-detection;170;137;153;219;134;156;161;136;203;130 07:00:10 INFO - PROCESS | 26440 | |2;audio-dft;163;161;161;162;161;162;160;162;161;161 07:00:10 INFO - PROCESS | 26440 | |3;audio-fft;76;76;77;145;76;77;77;76;129;76 07:00:10 INFO - PROCESS | 26440 | |4;audio-oscillator;93;92;146;92;94;92;125;93;92;121 07:00:10 INFO - PROCESS | 26440 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;116 07:00:10 INFO - PROCESS | 26440 | |6;imaging-darkroom;145;146;146;145;145;145;146;145;145;146 07:00:10 INFO - PROCESS | 26440 | |7;imaging-desaturate;95;94;94;95;95;94;94;94;94;94 07:00:10 INFO - PROCESS | 26440 | |8;json-parse-financial;65;65;65;66;65;66;66;67;66;65 07:00:10 INFO - PROCESS | 26440 | |9;json-stringify-tinderbox;64;65;65;64;66;65;64;64;65;64 07:00:10 INFO - PROCESS | 26440 | |10;stanford-crypto-aes;85;88;83;82;81;88;83;82;160;87 07:00:10 INFO - PROCESS | 26440 | |11;stanford-crypto-ccm;134;135;150;131;132;136;139;140;148;132 07:00:10 INFO - PROCESS | 26440 | |12;stanford-crypto-pbkdf2;176;175;177;177;175;177;170;175;176;174 07:00:10 INFO - PROCESS | 26440 | |13;stanford-crypto-sha256-iterative;69;72;67;69;68;67;68;68;69;69 07:00:10 INFO - PROCESS | 26440 | __end_tp_report 07:00:10 INFO - PROCESS | 26440 | __start_cc_report 07:00:10 INFO - PROCESS | 26440 | _x_x_mozilla_cycle_collect,2052 07:00:10 INFO - PROCESS | 26440 | __end_cc_report 07:00:10 INFO - PROCESS | 26440 | __startTimestamp1462802410472__endTimestamp 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | ------- Summary: start ------- 07:00:10 INFO - PROCESS | 26440 | Number of tests: 14 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.26 (1.1%) stddev-sans-first:1.32 07:00:10 INFO - PROCESS | 26440 | Values: 115.0 112.0 116.0 116.0 114.0 115.0 114.0 113.0 114.0 115.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#1] audio-beat-detection Cycles:10 Average:159.90 Median:158.50 stddev:30.14 (19.0%) stddev-sans-first:31.75 07:00:10 INFO - PROCESS | 26440 | Values: 170.0 137.0 153.0 219.0 134.0 156.0 161.0 136.0 203.0 130.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.67 07:00:10 INFO - PROCESS | 26440 | Values: 163.0 161.0 161.0 162.0 161.0 162.0 160.0 162.0 161.0 161.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#3] audio-fft Cycles:10 Average:88.50 Median:76.00 stddev:25.84 (34.0%) stddev-sans-first:27.01 07:00:10 INFO - PROCESS | 26440 | Values: 76.0 76.0 77.0 145.0 76.0 77.0 77.0 76.0 129.0 76.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:92.00 stddev:19.47 (21.2%) stddev-sans-first:20.24 07:00:10 INFO - PROCESS | 26440 | Values: 93.0 92.0 146.0 92.0 94.0 92.0 125.0 93.0 92.0 121.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:00:10 INFO - PROCESS | 26440 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:00:10 INFO - PROCESS | 26440 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:00:10 INFO - PROCESS | 26440 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 07:00:10 INFO - PROCESS | 26440 | Values: 65.0 65.0 65.0 66.0 65.0 66.0 66.0 67.0 66.0 65.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 07:00:10 INFO - PROCESS | 26440 | Values: 64.0 65.0 65.0 64.0 66.0 65.0 64.0 64.0 65.0 64.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:84.00 stddev:24.07 (28.7%) stddev-sans-first:25.40 07:00:10 INFO - PROCESS | 26440 | Values: 85.0 88.0 83.0 82.0 81.0 88.0 83.0 82.0 160.0 87.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:137.50 stddev:6.65 (4.8%) stddev-sans-first:6.92 07:00:10 INFO - PROCESS | 26440 | Values: 134.0 135.0 150.0 131.0 132.0 136.0 139.0 140.0 148.0 132.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:176.00 stddev:2.10 (1.2%) stddev-sans-first:2.20 07:00:10 INFO - PROCESS | 26440 | Values: 176.0 175.0 177.0 177.0 175.0 177.0 170.0 175.0 176.0 174.0 07:00:10 INFO - PROCESS | 26440 | 07:00:10 INFO - PROCESS | 26440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 07:00:10 INFO - PROCESS | 26440 | Values: 69.0 72.0 67.0 69.0 68.0 67.0 68.0 68.0 69.0 69.0 07:00:10 INFO - PROCESS | 26440 | -------- Summary: end -------- 07:00:10 INFO - PROCESS | 26440 | 07:00:11 INFO - TEST-INFO | 26440: exit 0 07:00:11 INFO - TEST-OK | kraken | took 65327ms 07:00:11 INFO - SUITE-END | took 1184s 07:00:11 INFO - Completed test suite (00:19:44) 07:00:11 INFO - javascript benchmark 07:00:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.67104111986, 2663.6936752273496, 2690.5695088785787, 2695.299222202228, 2702.8513431761257, 4507.076049409871, 4566.817327306912, 4659.091477161951, 4753.310769938361, 4798.232282834747, 4600.493945665974, 4734.4081989751285, 4764.237721964487, 4795.928061079087, 4843.079814835179, 4291.3777502262155, 4330.047389574289, 4332.436783218177, 4418.094290670413, 4450.799714012861, 4272.572742725733, 4430.313301438282, 4443.733375997434, 4478.126765280772, 4493.7977790999485, 4395.7362558246605, 4446.533114023029, 4447.755373454459, 4450.532694067108, 4466.575675310856, 4181.853635122787, 4216.85241016566, 4321.2653848845775, 4379.75911324877, 4388.934165987513, 4309.892252693677, 4315.633171180453, 4332.371806088131, 4417.514073451917, 4427.048184640318, 4676.462206846222, 4708.223143181405, 4715.64632652549, 4718.386609740712, 4730.574248317634, 4884.5603895649565, 5035.320231768701, 5075.771590278409, 5082.161443361841, 5121.231815227746, 5099.9490005100215, 5105.872353191163, 5145.253938178943, 5162.406323272834, 5171.5862730981435, 4775.952240477585, 4830.468648448667, 4833.00923310724, 4833.081714474239, 4834.299026641117, 4955.1576232039915, 5188.195829646411, 5194.298769666122, 5230.189320655304, 5297.629165958423, 5001.274815151783, 5030.974845125751, 5076.314697515862, 5079.517445842639, 5081.4918508148885, 4829.975850120727, 5109.182530795055, 5113.744312784346, 5117.462666420047, 5171.4052883918075, 4927.43334516528, 4952.702837829742, 4968.776405061781, 4973.776180071905, 4995.875103122451, 4974.801007959641, 4975.601951843843, 4977.278294647328, 4980.302757613937, 5029.119904016782, 4172.144710334374, 4198.832046718158, 4307.289297265978, 4313.633341166036, 4365.039691267916, 3712.1833196696684, 3712.5916149223563, 3719.4420836874683, 3740.251949610089, 3774.358359078963, 4245.299525578245, 4247.044415006599, 4248.511421186541, 4262.211490874198, 4285.571442855689, 4854.781534830941, 4955.752212389366, 4959.727215003138, 4965.3048573199785, 5015.774290156952, 4269.91460170801, 4309.396684464177, 4322.416473776063, 4335.7181783184, 4337.175936572041, 4606.953930460652, 4616.238320677118, 4617.399738034102, 4638.768061596907, 4664.253719404879, 4549.067441174618, 4709.505501922249, 4802.135615589227, 4802.351682522884, 4803.639727020487, 5020.196768517019, 5033.546980771748, 5109.054824857413, 5117.616178786531, 5119.6416250862085, 4736.881577960578, 4755.83354582588, 4759.405074365704, 4764.452088009784, 4802.255650374198, 4762.476127626028, 4982.501749824988, 4987.700737955734, 4994.275830004702, 4997.5002499749735, 5013.072581572421, 5014.272930425141, 5047.520485553867, 5070.340855688737, 5071.391433027913, 4921.0, 4924.72913989734, 4929.654924155275, 4933.580645645016, 4983.750812459435, 4722.598579120676, 4856.344393506832, 4898.951010489849, 4912.82805101834, 4963.925541116959, 4759.262314341283, 4849.709017458964, 4877.3903262092235, 4891.877703057452, 4898.975505122452, 4956.10790057793, 4966.081274964144, 4966.478519755374, 5000.924986125284, 5005.474425185449, 4655.138799322136, 4794.736289504111, 4848.8302909398, 4851.46633870281, 4889.046635905964], "value": 4639.188257047839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.8348487196276, 589.6874656432093, 593.9792107276246, 600.603601622929, 606.0031248596061, 27556.0, 41562.79218603906, 42469.0, 42591.0, 42601.36097958533, 42317.0, 42692.57307426925, 42771.78614106933, 42872.142557148916, 42962.78518607403, 7880.290773830368, 8026.277635012848, 8029.076656184555, 8034.718784842532, 8037.316828069621, 7880.330171935392, 7979.122296547375, 7980.162082981262, 7984.800379990517, 7991.5604641744685, 7983.720569780059, 8021.157778433268, 8030.196980301981, 8031.718889838857, 8032.1164671886045, 7940.960295198516, 7981.241782030698, 7988.600569971478, 7989.999999999942, 7991.680332786682, 7884.64519096642, 7935.48419352746, 7935.960320198362, 7939.682412703485, 7948.642311096015, 38709.806450967844, 39050.41424378636, 39088.80455597732, 39122.413163802565, 39229.21541569181, 3256.072019474462, 3373.3927892979254, 3379.831008449568, 3503.789772613651, 4036.4348991141264, 27691.0, 30315.242118946982, 30778.23054423635, 30967.22581935447, 31841.36317273665, 3210.0, 3227.499737540685, 3246.6915643013876, 3257.4950882613234, 3422.9657703422895, 249043.0, 249290.0, 249298.0, 249311.0, 250949.0, 34519.309613807585, 58228.708856456295, 58368.0, 58930.41069589335, 59016.704916475144, 36180.09549761277, 36216.637833621324, 36295.27409451796, 36524.0, 36552.26895462076, 13613.591592252249, 13771.517996870061, 13773.724525509635, 13783.0, 13785.655358616115, 11004.0, 11106.500207490682, 11109.611163609236, 11112.777744445228, 11116.277441966246, 8389.53857537829, 8511.957440212884, 8524.232819046316, 8584.914150858536, 8613.61238744258, 3244.5782048333567, 3251.707346338841, 3259.5599594054975, 3282.491213861855, 3290.917727056795, 907.981840363189, 946.0539460539461, 948.4972964328916, 978.9167920726818, 998.5207100591757, 28502.71497285042, 29327.560086598718, 29565.704342956724, 29592.260193495335, 29712.257193570334, 835.7659855240543, 1009.4952523738131, 1040.776233109885, 1070.6573896353248, 1090.6346373964652, 15344.0, 15751.291191896393, 15810.209489525478, 15928.601784955237, 16129.596760081093, 381638.0, 382437.0, 384406.0, 384577.0, 385843.0, 51640.0, 52075.218871716956, 52208.47791522036, 52636.0, 52700.0, 1110.9944450277696, 1175.8177482490228, 1216.8235605837103, 1258.8237646729465, 1288.7486940046601, 27033.45933081367, 30137.69862301349, 30159.246018849703, 30401.0, 30777.230569235948, 44571.331430029226, 45223.0, 45238.77380613076, 45282.77358613186, 45327.320090198016, 286611.0, 286856.74860888184, 287304.0, 287409.0, 287787.0, 19505.512362191057, 24350.87824560866, 24352.26943191707, 25714.0, 26201.868990654926, 37019.62980370162, 43584.56415435805, 43720.0, 44034.55965440305, 44299.557004429545, 37239.6276037247, 37283.81358093192, 37405.251894962494, 38061.42907856329, 38086.80956595199, 36932.26135477329, 36983.26033479369, 37038.0, 37040.814795926926, 37560.43659345167, 36504.26991460103, 36907.0, 36943.44584831283, 37746.245075098894, 37777.244455110194, 32323.35353292968, 33907.321853563284, 34114.48828267628, 34239.14402139966, 34351.0, 25453.236402907944, 25935.48129037371, 26105.347366315993, 26144.8692756535, 26235.0], "value": 16946.38219402029, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.1124374585343, 381.66604221306375, 382.0467932508392, 393.8916797880584, 396.3816446343704, 15636.843631563695, 17348.913255433738, 17850.196741146647, 17914.104294785273, 17975.191116399776, 16865.241064152113, 17208.311667533315, 17294.56763580911, 17570.912145439288, 17625.118744062776, 5017.623678224129, 5118.744062796864, 5137.075326441239, 5145.0481660892665, 5203.323567936182, 3653.799041052741, 5559.77760889566, 5916.733746981375, 5926.851828704273, 6014.2181516403025, 5893.38119497453, 5948.40515948406, 5957.940420595782, 5970.104484327342, 5988.101784732282, 3630.945535816965, 5749.712514374285, 5894.410558944114, 5937.22816033915, 5940.851478713023, 4893.510648935114, 5214.191800270964, 5219.71291578963, 5286.947130528684, 5289.471052894718, 20127.39617811468, 20788.688169677465, 20814.687779683318, 21083.156673733032, 21084.5783084339, 2007.1971211515365, 2009.5177157482244, 2047.5495391013953, 2158.0396723458066, 2190.233418303581, 13103.2138071716, 13414.530491432753, 13465.798013029813, 13936.512222072179, 13992.30038498071, 1766.2493440287826, 1824.5347436403765, 1882.745829313039, 1904.8476121910353, 1915.5019694879431, 68442.0, 68701.65649171722, 68942.3105768946, 69296.6535167321, 71130.0, 9443.527823608792, 9502.952485237529, 9743.805123897482, 9945.0, 10073.798524029478, 13053.477860885649, 13075.280859552817, 13160.473581056842, 13281.734365312639, 13307.66730831737, 7128.572285662877, 7167.068281123421, 7246.7101315946775, 7393.852122957511, 7523.322900938832, 7154.785356439315, 7174.928250717426, 7191.748288809867, 7307.634618269065, 7314.305141011595, 6121.0, 6343.0, 6354.968225158845, 6363.809085727436, 6436.259830119596, 1573.6065983504125, 1650.2408891909615, 1752.553098959757, 1776.7779027621548, 1778.7370966613591, 939.281449690987, 951.7192428233687, 965.2278177458005, 1011.145581983223, 1012.2863381316155, 16966.745498817527, 17263.13684315779, 17366.826331736775, 17521.211545480484, 17525.386611468537, 906.805036917066, 920.2086205863086, 920.4937284493502, 953.5994882149514, 973.5181085362791, 9201.0, 10273.897261027294, 10381.117605003508, 10572.894271057345, 10609.787804243872, 413134.0, 418367.0, 425380.0, 425638.0, 425723.0, 48087.75956120197, 64036.67981660062, 81282.59358703287, 81963.5901820487, 82633.58683206546, 994.4580203788952, 1001.0790073132736, 1014.452195814252, 1021.8262895307815, 1023.2888142740724, 15698.9215053924, 15736.60658483547, 15868.285927133076, 16045.839541604435, 16284.918575407048, 30238.0, 31099.68900310968, 33954.83022584871, 34767.30465390729, 36219.27561448704, 46151.0, 47842.0, 49724.751376242886, 52229.0, 54111.75329480244, 7427.665755040928, 7976.202379761978, 7978.202179781975, 8018.077921038922, 8070.556119413489, 7491.587962662106, 8503.574821258788, 9368.812623747623, 12154.817677735018, 12212.694682633006, 9970.30207885441, 10786.784264314827, 10923.0, 10952.726181845517, 11040.227184097035, 10192.847107293544, 10594.417307048187, 10705.518251678848, 10832.458377080957, 11107.611233606785, 6103.176071230327, 6985.825354366181, 10662.200334975063, 10840.891591084304, 10978.780424391627, 7990.440669153103, 8104.311133553714, 8154.347652187692, 8298.792530186794, 8330.958345208235, 9411.670591529264, 10714.303570267908, 10827.566897324019, 10906.236563440483, 10931.83602245983], "value": 8491.380912334693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.2225031605565, 1459.1318165691414, 1486.5688950204442, 1627.3653275222657, 1794.1746796473622, 6133.570650054492, 6975.093237879075, 7230.096237970254, 7232.3490885820265, 7411.925880741191, 7209.062821833168, 7333.303336183054, 7346.191918888918, 7354.3748781353515, 7360.521566098213, 2138.080625331107, 2169.8372622053407, 2171.8262538996923, 2177.542716029636, 2181.803637672609, 2109.1457959526415, 2127.5425783456553, 2164.599549083425, 2171.7828217178235, 2171.934841954736, 2115.6086124067097, 2117.026167962739, 2132.2217390652377, 2136.6367717487988, 2164.0478189596606, 2091.435312465633, 2093.2464312847364, 2096.821770149539, 2098.4544018555134, 2098.8530802843807, 2078.8025137611903, 2113.9154433822628, 2120.5016821047043, 2121.7029615853794, 2124.2352753008904, 7087.220405755363, 7245.927540724578, 7289.599072051035, 7301.89047164293, 7306.378957788541, 4287.399764033038, 4380.036391993756, 4381.9561804381865, 4399.406080179167, 4416.249237629579, 2894.493463643854, 2930.575066615329, 2936.8341247356593, 2969.1092672198256, 2994.296340360014, 921.0060219624572, 924.6809850601531, 928.2295694573555, 935.4574346878794, 942.5711301357866, 9589.856152157723, 9645.517724113837, 9653.324267301292, 9671.661491847752, 9672.56473458696, 3853.7302388832513, 3912.0024393779972, 4017.5379831319774, 4020.216057868746, 4022.6781857451333, 7314.890276645855, 7318.560886346836, 7337.376323012603, 7402.6668799903055, 7448.515846470071, 4330.566943305645, 4363.716358436692, 4363.869083927487, 4364.192624364503, 4372.060007098489, 3536.29274145172, 3827.5024246847734, 3861.768293902319, 3918.1771827915886, 3935.114599215211, 3302.5046243063734, 3330.816805075696, 3378.7596566309126, 3390.847411866472, 3401.081707938892, 952.7522844060594, 1020.3826684855555, 1023.467796745688, 1027.9537420816082, 1030.685640879524, 758.8671982403057, 784.6429874407131, 878.9780255493664, 896.2292428511475, 911.1617312072909, 4893.681910675795, 5039.395272567315, 5091.541761241432, 5094.5160209780015, 5101.8724531887, 436.1778048378829, 445.7904784751162, 448.2626080098285, 451.85540626999045, 457.79399270328486, 3583.480395342661, 3588.120910376922, 3610.1335679436747, 3624.0577449863226, 3703.2408356286896, 8482.194191551916, 8811.206991370807, 8825.779355516164, 8916.910830891738, 8940.240079593308, 8723.302135829246, 8742.956285218534, 8819.603117859711, 8823.647054117891, 8834.823303533893, 6546.18172728409, 6578.539502234893, 6602.636854973022, 6628.105205797252, 6674.299198584079, 5040.117979353672, 5079.796808127633, 5083.46623604531, 5121.615878809179, 5136.1268584340005, 7857.253560911704, 8115.837683246184, 8131.552764598004, 8145.144759800136, 8278.71024514139, 7893.092294386219, 8343.082260951413, 8358.414910956175, 8369.665213391396, 8437.0, 6065.302490213506, 6495.0906873036865, 6662.83342916431, 6689.09697190873, 6822.658867056726, 6935.133108361455, 7030.859382812213, 7087.0, 7106.893396598952, 7109.893351599833, 6307.180066591497, 6370.076338930737, 6458.838529036811, 6532.248791389051, 6541.803745887631, 6109.602875813058, 6131.294901086254, 6155.230596175478, 6208.844778880564, 6223.937760622336, 5825.970870145622, 5869.090291004901, 5930.851728706817, 5936.5844390892225, 5965.4929331005615, 4236.6187043166265, 4449.466064072332, 4458.910821783611, 4584.747838868894, 4652.488226295172, 4356.673249506236, 4381.40850985113, 4412.29403295484, 4557.202489564247, 4578.954210457853], "value": 3854.685546518008, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.48916841369675, 310.4195155060038, 314.7560640503609, 319.0587766090034, 319.54145800775905, 4618.538146185379, 4719.669623126379, 4736.52634736527, 4835.202191638376, 4850.63620228483, 4551.795169217385, 4710.505396933324, 4712.3638308828295, 4715.269133284346, 4715.962488252579, 3757.361248587733, 3787.7537960032646, 3789.8294576743974, 3795.1650636859845, 3803.1062700265416, 3614.024213462377, 3648.5986541480415, 3737.1965027519077, 3792.0, 3808.657220850123, 3734.906627334311, 3760.6427389397963, 3769.321522126016, 3782.073392018959, 3798.772073675588, 3781.6785573226307, 3782.978595779138, 3789.5263092113487, 3791.9810400948095, 3800.4869342638667, 3384.187794929224, 3391.1183092396154, 3391.2030672791875, 3394.949075763841, 3398.711109555666, 4479.395281637003, 4541.750203738826, 4560.452745670541, 4570.7257564546235, 4593.173228818811, 4236.894077648052, 4261.0, 4263.701540892139, 4279.422277992462, 4287.892802679958, 4911.16510193268, 4934.136526107916, 4936.086823937583, 4944.653874228806, 4956.405231372259, 3507.9824600877087, 3650.7992060436663, 3682.1346983458866, 3689.612590677967, 3700.4264339027495, 5142.580184177555, 5148.845534633967, 5177.37871455424, 5200.843974680765, 5213.635045546814, 3767.3030489359558, 3771.9434208486896, 3780.432935059763, 3783.6405541473514, 3785.280796648628, 3818.1981783825154, 3827.158025234444, 3829.8659546915724, 3841.2317536492815, 3878.7672739635714, 4082.6119119499513, 4262.829486820492, 4290.3993440917675, 4307.806148723315, 4309.827606895689, 4940.950590494121, 4961.5286547777905, 4966.404031516241, 4979.30289759434, 4988.900221995613, 1226.7853125703145, 1255.9058070644737, 1258.7985922252396, 1259.2066997791333, 1259.609521048478, 890.4612709310903, 906.954652267384, 909.4725059465494, 909.8498747706686, 913.5386629751932, 4182.013543566782, 4197.580241975778, 4214.768187749642, 4219.78901054946, 4229.915401691949, 4851.587615052689, 4874.95125048745, 4977.701337919736, 4979.402471703419, 4999.475055119233, 4170.582941705866, 4204.327307630764, 4208.305629571148, 4210.389493523422, 4211.873643790691, 2603.47930413918, 2608.2305719812703, 2623.0, 2623.8819253133656, 2624.8162628615814, 4334.263175260214, 4624.676272660949, 4651.418572678415, 4682.0, 4683.227267500824, 5034.345535080416, 5037.078494473197, 5038.294638750578, 5042.546170844642, 5053.898922021539, 4547.795349209294, 4610.561996610317, 4616.561426664462, 4653.418322709661, 4679.344891715163, 4723.669343145947, 4854.514548545118, 4862.756862156807, 4914.729689867092, 4924.064427758858, 4784.736839473723, 4833.824778849602, 4844.2007068834655, 4846.613814497885, 4865.0, 4635.629149668086, 4641.584316783414, 4654.720716757005, 4656.3946686930485, 4660.906781864412, 3667.2298817248675, 3669.4862719219864, 3670.7614005089586, 3675.5773086094373, 3683.9447408289434, 4694.34279200919, 4812.398450193726, 4820.324719780415, 4827.806887724451, 4877.244027175793, 4741.241401375763, 4769.759862435722, 4771.856844294677, 4779.689320194177, 4780.569748722632, 4691.765411729468, 4722.858314250578, 4735.739534325645, 4764.904701906012, 4779.617630589475, 4529.660275479287, 4623.332623372217, 4703.623710103252, 4904.94543673112, 4939.6542242042715, 4952.083864485082, 4974.925376119289, 4984.800607975641, 4987.451380348086, 4992.003198720396, 4855.36880205571, 4866.221404575251, 4880.780364883518, 4886.755662216804, 4887.0], "value": 3725.9026541845683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.8327059870331, 798.8082860113575, 812.8861959325692, 828.3331917806164, 829.7054545636303, 11073.72315692107, 11557.24877882938, 11649.825252621218, 11733.7653246935, 11748.41257937102, 12589.685257868536, 12626.558070467536, 12629.621111366674, 12640.0, 12642.241465512052, 657.6021506988275, 676.861243445095, 677.1603212017112, 848.8854004709362, 866.1295398124876, 685.5372623479157, 835.3692961813822, 859.621766422772, 864.844328020956, 868.3227082875368, 910.0671811393308, 915.1809130827905, 918.1277786103195, 918.9172974432299, 919.0120620333169, 909.627052908311, 909.8726178335071, 910.094456016268, 910.658503061352, 911.0616065452562, 514.072099859753, 529.4731741916818, 530.4748299183781, 654.4241067860253, 673.535260670136, 11806.468708908034, 11811.763764724657, 11813.881861181364, 11852.525898964032, 11862.466189021428, 11923.224990375684, 12467.812982805175, 12547.874521254762, 12808.10343275971, 12839.165454245443, 10786.191035672357, 10837.83743243852, 10983.450827458675, 10998.780024399468, 11007.852102176737, 3622.8913132606062, 3631.2918980798754, 3679.4848721179055, 3720.4977328060636, 3732.533433320835, 42713.35929961022, 42759.57240427618, 42866.0, 42895.92760180989, 43009.569904301185, 9727.9027209727, 10031.949840250752, 10184.134348580306, 10190.949045254727, 10700.839487407695, 18075.27698892056, 18076.638467230845, 18090.547736306697, 18137.455876323733, 18150.09249537518, 6632.237292711304, 6635.104260924713, 6714.462842972551, 6715.529912906148, 6862.656867156622, 3424.6746559076846, 3499.8775042873376, 3504.737144714157, 3575.4636804479014, 3606.13452771333, 2899.1157696902224, 2940.868915722644, 2990.9102726918227, 2996.5205567109156, 2997.6702562718083, 517.3403910014686, 523.2622002975786, 528.5428104689416, 535.4244187498377, 536.7450461030979, 486.9870669008454, 490.0077343379685, 505.6738403729574, 557.3117200257759, 623.8565130020121, 7328.193898671142, 7585.355244804254, 7621.504602200839, 7702.8844567331535, 7784.610769461504, 556.5186114011432, 568.4486048532999, 580.097947691344, 589.6138029590625, 593.2969431224013, 3295.307985323109, 3493.947590786089, 3501.9299614007577, 3534.720105531969, 3583.552055993001, 51487.48512514902, 52100.739496302274, 52324.0, 52761.0, 53325.0, 47664.0, 47875.0, 48283.0, 49119.754401227765, 49589.25616115761, 43422.34866476942, 43511.782441088224, 43856.3421548677, 44304.3354349685, 44427.777861111135, 6820.761273355409, 6833.145856767904, 6876.17485901695, 6883.070785443901, 6904.102466679299, 28424.57363139513, 29010.709892901647, 29974.0, 29990.55014174833, 30161.245968850955, 36035.63964360428, 37443.0, 38680.2263954725, 38799.418008730456, 39525.2094958105, 8950.194482496607, 9315.86026209594, 9326.253899688145, 9351.0, 9673.70978870635, 9311.674091406769, 9486.762830929007, 9590.520473976134, 9723.805523889341, 10228.539715712663, 8842.425242359226, 8975.461472311683, 9323.207527359978, 9458.763530911783, 9479.241660667269, 8819.426737262058, 8951.910480895107, 9063.229625481908, 9282.814343713222, 9366.344355895022, 8741.645045018033, 8798.208161265517, 8827.69103081389, 8880.422772519765, 9107.316951228551, 7088.184858741311, 7224.205337412775, 7376.4836461447185, 7420.962895185489, 7467.626618669154, 7730.0, 7843.098043725045, 7847.254510821463, 7965.123836378109, 8000.959995199987], "value": 5700.045090319355, "unit": "score"}], "name": "dromaeo_css", "value": 6160.3891161645715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 116.0, 116.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 137.0, 153.0, 219.0, 134.0, 156.0, 161.0, 136.0, 203.0, 130.0], "value": 159.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 145.0, 76.0, 77.0, 77.0, 76.0, 129.0, 76.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 146.0, 92.0, 94.0, 92.0, 125.0, 93.0, 92.0, 121.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 66.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 83.0, 82.0, 81.0, 88.0, 83.0, 82.0, 160.0, 87.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 150.0, 131.0, 132.0, 136.0, 139.0, 140.0, 148.0, 132.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 177.0, 177.0, 175.0, 177.0, 170.0, 175.0, 176.0, 174.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 67.0, 69.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1588.2, "alertThreshold": 2.0}]} 07:00:11 INFO - Return code: 0 07:00:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:00:11 ERROR - # TBPL SUCCESS # 07:00:11 INFO - Running post-action listener: _resource_record_post_action 07:00:11 INFO - ##### 07:00:11 INFO - ##### Finished run-tests step (success) 07:00:11 INFO - ##### 07:00:11 INFO - Running post-run listener: _resource_record_post_run 07:00:12 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533442560; Read time: 36; Write time: 599652 07:00:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234979328; Read time: 0; Write time: 285248 07:00:12 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294584320; Read time: 36; Write time: 313748 07:00:12 INFO - Running post-run listener: _upload_blobber_files 07:00:12 INFO - Blob upload gear active. 07:00:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:00:12 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 07:00:12 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'] 07:00:12 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 07:00:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:14 INFO - (blobuploader) - INFO - Done attempting. 07:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:14 INFO - (blobuploader) - INFO - Done attempting. 07:00:14 INFO - (blobuploader) - INFO - Iteration through files over. 07:00:14 INFO - Return code: 0 07:00:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:00:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:00:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d230fda5d2f18d377b77972ecdf485a470968aaf6a12cbd4fef121227fcaf2ba1133ba95d2158a93e3d3da531253e1c750c79fb847e2737525777eb455532275", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72962720b0e52586253fd30c060d00a95bfb306b471b30d6ce41f147ba1cf68a3b249bd3e9d77501b83f1bfc554de54bb6684d3dd7645e95e4ee954a80de9f0a"} 07:00:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:00:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:00:14 INFO - Contents: 07:00:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d230fda5d2f18d377b77972ecdf485a470968aaf6a12cbd4fef121227fcaf2ba1133ba95d2158a93e3d3da531253e1c750c79fb847e2737525777eb455532275", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72962720b0e52586253fd30c060d00a95bfb306b471b30d6ce41f147ba1cf68a3b249bd3e9d77501b83f1bfc554de54bb6684d3dd7645e95e4ee954a80de9f0a"} 07:00:14 INFO - Running post-run listener: copy_logs_to_upload_dir 07:00:14 INFO - Copying logs to upload dir... 07:00:14 INFO - mkdir: /builds/slave/test/build/upload/logs 07:00:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.554228 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-09 07:00:14.384384) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:00:14.387977) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579 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/d230fda5d2f18d377b77972ecdf485a470968aaf6a12cbd4fef121227fcaf2ba1133ba95d2158a93e3d3da531253e1c750c79fb847e2737525777eb455532275", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72962720b0e52586253fd30c060d00a95bfb306b471b30d6ce41f147ba1cf68a3b249bd3e9d77501b83f1bfc554de54bb6684d3dd7645e95e4ee954a80de9f0a"} build_url:https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/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/d230fda5d2f18d377b77972ecdf485a470968aaf6a12cbd4fef121227fcaf2ba1133ba95d2158a93e3d3da531253e1c750c79fb847e2737525777eb455532275", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72962720b0e52586253fd30c060d00a95bfb306b471b30d6ce41f147ba1cf68a3b249bd3e9d77501b83f1bfc554de54bb6684d3dd7645e95e4ee954a80de9f0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:00:14.413658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:00:14.414124) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462801174.668523-1505399579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:00:14.496410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:00:14.496733) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:00:14.497031) ========= ========= Total master_lag: 0.17 =========