builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1462795453.16 results: success (0) buildid: 20160509033554 builduid: 463766b0613f4db6af6a837af1cfc271 revision: 043082cb7bd8490c60815f67fbd1f33323ad7663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.160837) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.161995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.162769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.311382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.311719) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 05:04:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.1M=0s 2016-05-09 05:04:13 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105013 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.434815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.435363) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019005 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.488035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:13.488826) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8490c60815f67fbd1f33323ad7663 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8490c60815f67fbd1f33323ad7663 --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=aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 05:04:13,988 truncating revision to first 12 chars 2016-05-09 05:04:13,988 Setting DEBUG logging. 2016-05-09 05:04:13,988 attempt 1/10 2016-05-09 05:04:13,988 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/043082cb7bd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:04:14,347 unpacking tar archive at: mozilla-central-043082cb7bd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650003 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:14.157991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:14.158766) ========= script_repo_revision: 043082cb7bd8490c60815f67fbd1f33323ad7663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:14.159759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:14.160459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:04:14.171878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-09 05:04:14.172208) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:04:14 INFO - MultiFileLogger online at 20160509 05:04:14 in /builds/slave/test 05:04:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:04:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:14 INFO - {'append_to_log': False, 05:04:14 INFO - 'base_work_dir': '/builds/slave/test', 05:04:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:04:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:14 INFO - 'branch': 'Firefox-Non-PGO', 05:04:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:14 INFO - 'config_files': ('talos/linux_config.py',), 05:04:14 INFO - 'default_actions': ('clobber', 05:04:14 INFO - 'read-buildbot-config', 05:04:14 INFO - 'download-and-extract', 05:04:14 INFO - 'populate-webroot', 05:04:14 INFO - 'create-virtualenv', 05:04:14 INFO - 'install', 05:04:14 INFO - 'run-tests'), 05:04:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:14 INFO - 'download_minidump_stackwalk': True, 05:04:14 INFO - 'download_symbols': 'ondemand', 05:04:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:14 INFO - 'installer_path': 'installer.exe', 05:04:14 INFO - 'log_level': 'info', 05:04:14 INFO - 'log_name': 'talos', 05:04:14 INFO - 'log_to_console': True, 05:04:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:04:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:04:14 INFO - 'opt_config_files': (), 05:04:14 INFO - 'pip_index': False, 05:04:14 INFO - 'sps_profile': False, 05:04:14 INFO - 'sps_profile_interval': 0, 05:04:14 INFO - 'suite': 'dromaeojs', 05:04:14 INFO - 'system_bits': '32', 05:04:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:14 INFO - 'title': 'talos-linux64-ix-037', 05:04:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:14 INFO - 'use_talos_json': True, 05:04:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:14 INFO - 'work_dir': 'build'} 05:04:14 INFO - ##### 05:04:14 INFO - ##### Running clobber step. 05:04:14 INFO - ##### 05:04:14 INFO - Running pre-action listener: _resource_record_pre_action 05:04:14 INFO - Running main action method: clobber 05:04:14 INFO - rmtree: /builds/slave/test/build 05:04:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:15 INFO - Running post-action listener: _resource_record_post_action 05:04:15 INFO - ##### 05:04:15 INFO - ##### Finished clobber step (success) 05:04:15 INFO - ##### 05:04:15 INFO - ##### 05:04:15 INFO - ##### Running read-buildbot-config step. 05:04:15 INFO - ##### 05:04:15 INFO - Running pre-action listener: _resource_record_pre_action 05:04:15 INFO - Running main action method: read_buildbot_config 05:04:15 INFO - Using buildbot properties: 05:04:15 INFO - { 05:04:15 INFO - "project": "", 05:04:15 INFO - "product": "firefox", 05:04:15 INFO - "script_repo_revision": "production", 05:04:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:04:15 INFO - "repository": "", 05:04:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:04:15 INFO - "buildid": "20160509033554", 05:04:15 INFO - "pgo_build": "False", 05:04:15 INFO - "basedir": "/builds/slave/test", 05:04:15 INFO - "buildnumber": 503, 05:04:15 INFO - "slavename": "talos-linux64-ix-037", 05:04:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:04:15 INFO - "platform": "ubuntu64_hw", 05:04:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:04:15 INFO - "branch": "mozilla-central", 05:04:15 INFO - "repo_path": "mozilla-central", 05:04:15 INFO - "revision": "043082cb7bd8490c60815f67fbd1f33323ad7663", 05:04:15 INFO - "stage_platform": "linux64", 05:04:15 INFO - "builduid": "463766b0613f4db6af6a837af1cfc271", 05:04:15 INFO - "slavebuilddir": "test" 05:04:15 INFO - } 05:04:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:04:15 INFO - Running post-action listener: _resource_record_post_action 05:04:15 INFO - ##### 05:04:15 INFO - ##### Finished read-buildbot-config step (success) 05:04:15 INFO - ##### 05:04:15 INFO - ##### 05:04:15 INFO - ##### Running download-and-extract step. 05:04:15 INFO - ##### 05:04:15 INFO - Running pre-action listener: _resource_record_pre_action 05:04:15 INFO - Running main action method: download_and_extract 05:04:15 INFO - mkdir: /builds/slave/test/build/tests 05:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:15 INFO - https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:04:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:04:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:04:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:16 INFO - Downloaded 1361 bytes. 05:04:16 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:04:16 INFO - Using the following test package requirements: 05:04:16 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:16 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:04:16 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:04:16 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:16 INFO - u'jsshell-linux-x86_64.zip'], 05:04:16 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:04:16 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:16 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:04:16 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:04:16 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:04:16 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:04:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:16 INFO - https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:17 INFO - Downloaded 22322613 bytes. 05:04:17 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'] 05:04:17 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 05:04:19 INFO - Return code: 0 05:04:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:19 INFO - https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:04:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:04:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:04:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:20 INFO - Downloaded 22322613 bytes. 05:04:20 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'] 05:04:20 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 05:04:22 INFO - Return code: 0 05:04:22 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')]} 05:04:22 INFO - https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:04:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:23 INFO - Downloaded 10840152 bytes. 05:04:23 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'] 05:04:23 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 05:04:23 INFO - Return code: 0 05:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:23 INFO - https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ay_BQ99_QdCPuINK1STp5w/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 05:04:24 INFO - Downloaded 54857373 bytes. 05:04:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:04:24 INFO - mkdir: /builds/slave/test/properties 05:04:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:04:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:04:24 INFO - Contents: 05:04:24 INFO - build_url:https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:04:25 INFO - Running post-action listener: _resource_record_post_action 05:04:25 INFO - Running post-action listener: set_extra_try_arguments 05:04:25 INFO - ##### 05:04:25 INFO - ##### Finished download-and-extract step (success) 05:04:25 INFO - ##### 05:04:25 INFO - ##### 05:04:25 INFO - ##### Running populate-webroot step. 05:04:25 INFO - ##### 05:04:25 INFO - Running pre-action listener: _resource_record_pre_action 05:04:25 INFO - Running main action method: populate_webroot 05:04:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:25 INFO - '--tppagecycles', 05:04:25 INFO - '7'], 05:04:25 INFO - 'tests': ['tsvgm']}}, 05:04:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:04:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:04:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:04:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:25 INFO - 'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:25 INFO - 'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['damp', 'tps']}, 05:04:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:25 INFO - 'tests': ['damp', 'tps']}, 05:04:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['dromaeo_dom']}, 05:04:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['a11yr', 05:04:25 INFO - 'ts_paint', 05:04:25 INFO - 'tpaint', 05:04:25 INFO - 'sessionrestore', 05:04:25 INFO - 'sessionrestore_no_auto_restore', 05:04:25 INFO - 'tabpaint']}, 05:04:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:04:25 INFO - 'ts_paint', 05:04:25 INFO - 'tpaint', 05:04:25 INFO - 'sessionrestore', 05:04:25 INFO - 'sessionrestore_no_auto_restore', 05:04:25 INFO - 'tabpaint']}, 05:04:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:04:25 INFO - 'ts_paint', 05:04:25 INFO - 'tpaint', 05:04:25 INFO - 'sessionrestore', 05:04:25 INFO - 'sessionrestore_no_auto_restore', 05:04:25 INFO - 'tabpaint']}, 05:04:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:04:25 INFO - 'ts_paint', 05:04:25 INFO - 'tpaint', 05:04:25 INFO - 'sessionrestore', 05:04:25 INFO - 'sessionrestore_no_auto_restore', 05:04:25 INFO - 'tabpaint']}, 05:04:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['a11yr', 05:04:25 INFO - 'ts_paint', 05:04:25 INFO - 'tpaint', 05:04:25 INFO - 'sessionrestore', 05:04:25 INFO - 'sessionrestore_no_auto_restore', 05:04:25 INFO - 'tabpaint']}, 05:04:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['a11yr', 05:04:25 INFO - 'ts_paint', 05:04:25 INFO - 'tpaint', 05:04:25 INFO - 'sessionrestore', 05:04:25 INFO - 'sessionrestore_no_auto_restore', 05:04:25 INFO - 'tabpaint']}, 05:04:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['tsvgx', 05:04:25 INFO - 'tsvgr_opacity', 05:04:25 INFO - 'tart', 05:04:25 INFO - 'tscrollx', 05:04:25 INFO - 'cart']}, 05:04:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:04:25 INFO - 'tsvgr_opacity', 05:04:25 INFO - 'tart', 05:04:25 INFO - 'tscrollx', 05:04:25 INFO - 'cart']}, 05:04:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:25 INFO - 'talos_options': ['--disable-e10s'], 05:04:25 INFO - 'tests': ['tp5o']}, 05:04:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:25 INFO - 'tests': ['tp5o']}, 05:04:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:25 INFO - 'talos_options': ['--disable-e10s', 05:04:25 INFO - '--xperf_path', 05:04:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:25 INFO - 'tests': ['tp5n']}, 05:04:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:25 INFO - 'talos_options': ['--xperf_path', 05:04:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:25 INFO - 'tests': ['tp5n']}}, 05:04:25 INFO - 'talos.zip': {'path': '', 05:04:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:25 INFO - Running post-action listener: _resource_record_post_action 05:04:25 INFO - ##### 05:04:25 INFO - ##### Finished populate-webroot step (success) 05:04:25 INFO - ##### 05:04:25 INFO - ##### 05:04:25 INFO - ##### Running create-virtualenv step. 05:04:25 INFO - ##### 05:04:25 INFO - Running pre-action listener: _resource_record_pre_action 05:04:25 INFO - Running main action method: create_virtualenv 05:04:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:04:25 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 05:04:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:04:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:25 INFO - Using real prefix '/usr' 05:04:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:04:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:27 INFO - Installing pip.................done. 05:04:27 INFO - Return code: 0 05:04:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:04:27 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')]} 05:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:27 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')]} 05:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:27 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:27 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 05:04:27 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 05:04:27 INFO - Using env: {'DISPLAY': ':0', 05:04:27 INFO - 'HOME': '/home/cltbld', 05:04:27 INFO - 'LANG': 'en_US.UTF-8', 05:04:27 INFO - 'LANGUAGE': 'en_US:en', 05:04:27 INFO - 'LOGNAME': 'cltbld', 05:04:27 INFO - 'MAIL': '/var/mail/cltbld', 05:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:27 INFO - 'MOZ_NO_REMOTE': '1', 05:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:27 INFO - 'NO_EM_RESTART': '1', 05:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:27 INFO - 'PWD': '/builds/slave/test', 05:04:27 INFO - 'SHELL': '/bin/bash', 05:04:27 INFO - 'SHLVL': '1', 05:04:27 INFO - 'TERM': 'linux', 05:04:27 INFO - 'TMOUT': '86400', 05:04:27 INFO - 'USER': 'cltbld', 05:04:27 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:27 INFO - '_': '/tools/buildbot/bin/python'} 05:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:28 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 05:04:28 INFO - Cleaning up... 05:04:28 INFO - Return code: 0 05:04:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:04:28 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')]} 05:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:28 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')]} 05:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:28 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:28 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 05:04:28 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 05:04:28 INFO - Using env: {'DISPLAY': ':0', 05:04:28 INFO - 'HOME': '/home/cltbld', 05:04:28 INFO - 'LANG': 'en_US.UTF-8', 05:04:28 INFO - 'LANGUAGE': 'en_US:en', 05:04:28 INFO - 'LOGNAME': 'cltbld', 05:04:28 INFO - 'MAIL': '/var/mail/cltbld', 05:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:28 INFO - 'MOZ_NO_REMOTE': '1', 05:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:28 INFO - 'NO_EM_RESTART': '1', 05:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:28 INFO - 'PWD': '/builds/slave/test', 05:04:28 INFO - 'SHELL': '/bin/bash', 05:04:28 INFO - 'SHLVL': '1', 05:04:28 INFO - 'TERM': 'linux', 05:04:28 INFO - 'TMOUT': '86400', 05:04:28 INFO - 'USER': 'cltbld', 05:04:28 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:28 INFO - '_': '/tools/buildbot/bin/python'} 05:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:28 INFO - Downloading/unpacking psutil>=0.7.1 05:04:28 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 05:04:28 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 05:04:28 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 05:04:28 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 05:04:28 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 05:04:28 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 05:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:30 INFO - Installing collected packages: psutil 05:04:30 INFO - Running setup.py install for psutil 05:04:30 INFO - building 'psutil._psutil_linux' extension 05:04:30 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 05:04:30 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 05:04:30 INFO - building 'psutil._psutil_posix' extension 05:04:30 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 05:04:30 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 05:04:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:30 INFO - Successfully installed psutil 05:04:30 INFO - Cleaning up... 05:04:30 INFO - Return code: 0 05:04:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:04:30 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')]} 05:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:30 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')]} 05:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:30 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:30 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 05:04:30 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 05:04:30 INFO - Using env: {'DISPLAY': ':0', 05:04:30 INFO - 'HOME': '/home/cltbld', 05:04:30 INFO - 'LANG': 'en_US.UTF-8', 05:04:30 INFO - 'LANGUAGE': 'en_US:en', 05:04:30 INFO - 'LOGNAME': 'cltbld', 05:04:30 INFO - 'MAIL': '/var/mail/cltbld', 05:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:30 INFO - 'MOZ_NO_REMOTE': '1', 05:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:30 INFO - 'NO_EM_RESTART': '1', 05:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:30 INFO - 'PWD': '/builds/slave/test', 05:04:30 INFO - 'SHELL': '/bin/bash', 05:04:30 INFO - 'SHLVL': '1', 05:04:30 INFO - 'TERM': 'linux', 05:04:30 INFO - 'TMOUT': '86400', 05:04:30 INFO - 'USER': 'cltbld', 05:04:30 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:30 INFO - '_': '/tools/buildbot/bin/python'} 05:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:04:31 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 05:04:31 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 05:04:31 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 05:04:31 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 05:04:31 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 05:04:31 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 05:04:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:04:33 INFO - Installing collected packages: mozsystemmonitor 05:04:33 INFO - Running setup.py install for mozsystemmonitor 05:04:33 INFO - Successfully installed mozsystemmonitor 05:04:33 INFO - Cleaning up... 05:04:33 INFO - Return code: 0 05:04:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:04:33 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')]} 05:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:33 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')]} 05:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:33 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:33 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 05:04:33 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 05:04:33 INFO - Using env: {'DISPLAY': ':0', 05:04:33 INFO - 'HOME': '/home/cltbld', 05:04:33 INFO - 'LANG': 'en_US.UTF-8', 05:04:33 INFO - 'LANGUAGE': 'en_US:en', 05:04:33 INFO - 'LOGNAME': 'cltbld', 05:04:33 INFO - 'MAIL': '/var/mail/cltbld', 05:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:33 INFO - 'MOZ_NO_REMOTE': '1', 05:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:33 INFO - 'NO_EM_RESTART': '1', 05:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:33 INFO - 'PWD': '/builds/slave/test', 05:04:33 INFO - 'SHELL': '/bin/bash', 05:04:33 INFO - 'SHLVL': '1', 05:04:33 INFO - 'TERM': 'linux', 05:04:33 INFO - 'TMOUT': '86400', 05:04:33 INFO - 'USER': 'cltbld', 05:04:33 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:33 INFO - '_': '/tools/buildbot/bin/python'} 05:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:33 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 05:04:33 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 05:04:33 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 05:04:33 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 05:04:33 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 05:04:33 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 05:04:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:04:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:36 INFO - Downloading docopt-0.6.1.tar.gz 05:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:36 INFO - Running setup.py install for blobuploader 05:04:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:04:36 INFO - Running setup.py install for requests 05:04:36 INFO - Running setup.py install for docopt 05:04:36 INFO - Successfully installed blobuploader requests docopt 05:04:36 INFO - Cleaning up... 05:04:36 INFO - Return code: 0 05:04:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:36 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:36 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 05:04:36 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 05:04:36 INFO - Using env: {'DISPLAY': ':0', 05:04:36 INFO - 'HOME': '/home/cltbld', 05:04:36 INFO - 'LANG': 'en_US.UTF-8', 05:04:36 INFO - 'LANGUAGE': 'en_US:en', 05:04:36 INFO - 'LOGNAME': 'cltbld', 05:04:36 INFO - 'MAIL': '/var/mail/cltbld', 05:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:36 INFO - 'MOZ_NO_REMOTE': '1', 05:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:36 INFO - 'NO_EM_RESTART': '1', 05:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:36 INFO - 'PWD': '/builds/slave/test', 05:04:36 INFO - 'SHELL': '/bin/bash', 05:04:36 INFO - 'SHLVL': '1', 05:04:36 INFO - 'TERM': 'linux', 05:04:36 INFO - 'TMOUT': '86400', 05:04:36 INFO - 'USER': 'cltbld', 05:04:36 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:36 INFO - '_': '/tools/buildbot/bin/python'} 05:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:37 INFO - Running setup.py (path:/tmp/pip-HjFZ0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:37 INFO - Running setup.py (path:/tmp/pip-Ub1k53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:37 INFO - Running setup.py (path:/tmp/pip-eC3s0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:37 INFO - Running setup.py (path:/tmp/pip-Sa8HuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:37 INFO - Running setup.py (path:/tmp/pip-HHJ0O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:37 INFO - Running setup.py (path:/tmp/pip-Ea7bA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:37 INFO - Running setup.py (path:/tmp/pip-08bJTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:37 INFO - Running setup.py (path:/tmp/pip-TmoYD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:37 INFO - Running setup.py (path:/tmp/pip-ITLJmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:37 INFO - Running setup.py (path:/tmp/pip-WcKR4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:37 INFO - Running setup.py (path:/tmp/pip-46goZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:37 INFO - Running setup.py (path:/tmp/pip-HjEXQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:37 INFO - Running setup.py (path:/tmp/pip-IEAEWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:37 INFO - Running setup.py (path:/tmp/pip-Kfjzcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:38 INFO - Running setup.py (path:/tmp/pip-G_v_7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:38 INFO - Running setup.py (path:/tmp/pip-_5Lnmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:38 INFO - Running setup.py (path:/tmp/pip-M6zyWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:38 INFO - Running setup.py install for manifestparser 05:04:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:04:38 INFO - Running setup.py install for mozcrash 05:04:38 INFO - Running setup.py install for mozdebug 05:04:38 INFO - Running setup.py install for mozdevice 05:04:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:04:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:04:38 INFO - Running setup.py install for mozfile 05:04:38 INFO - Running setup.py install for mozhttpd 05:04:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:04:38 INFO - Running setup.py install for mozinfo 05:04:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:04:38 INFO - Running setup.py install for mozInstall 05:04:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Running setup.py install for mozleak 05:04:39 INFO - Running setup.py install for mozlog 05:04:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Running setup.py install for moznetwork 05:04:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Running setup.py install for mozprocess 05:04:39 INFO - Running setup.py install for mozprofile 05:04:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Running setup.py install for mozrunner 05:04:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:04:39 INFO - Running setup.py install for mozscreenshot 05:04:39 INFO - Running setup.py install for moztest 05:04:39 INFO - Running setup.py install for mozversion 05:04:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:04:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:40 INFO - Cleaning up... 05:04:40 INFO - Return code: 0 05:04:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:40 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')]} 05:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:40 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')]} 05:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:40 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:40 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 05:04:40 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 05:04:40 INFO - Using env: {'DISPLAY': ':0', 05:04:40 INFO - 'HOME': '/home/cltbld', 05:04:40 INFO - 'LANG': 'en_US.UTF-8', 05:04:40 INFO - 'LANGUAGE': 'en_US:en', 05:04:40 INFO - 'LOGNAME': 'cltbld', 05:04:40 INFO - 'MAIL': '/var/mail/cltbld', 05:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:40 INFO - 'MOZ_NO_REMOTE': '1', 05:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:40 INFO - 'NO_EM_RESTART': '1', 05:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:40 INFO - 'PWD': '/builds/slave/test', 05:04:40 INFO - 'SHELL': '/bin/bash', 05:04:40 INFO - 'SHLVL': '1', 05:04:40 INFO - 'TERM': 'linux', 05:04:40 INFO - 'TMOUT': '86400', 05:04:40 INFO - 'USER': 'cltbld', 05:04:40 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:40 INFO - '_': '/tools/buildbot/bin/python'} 05:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:40 INFO - Running setup.py (path:/tmp/pip-gihdSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:40 INFO - Running setup.py (path:/tmp/pip-dK0f5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:40 INFO - Running setup.py (path:/tmp/pip-i8GeP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:40 INFO - Running setup.py (path:/tmp/pip-F6LGwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:40 INFO - Running setup.py (path:/tmp/pip-tlUCMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:40 INFO - Running setup.py (path:/tmp/pip-oNuZcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:40 INFO - Running setup.py (path:/tmp/pip-Fa8MQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:40 INFO - Running setup.py (path:/tmp/pip-nZWWxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:40 INFO - Running setup.py (path:/tmp/pip-MnqA7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:40 INFO - Running setup.py (path:/tmp/pip-WEzf0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:40 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)) 05:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:40 INFO - Running setup.py (path:/tmp/pip-COAtEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:41 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)) 05:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:41 INFO - Running setup.py (path:/tmp/pip-mWYm23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:41 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)) 05:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:41 INFO - Running setup.py (path:/tmp/pip-5ypm_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:41 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)) 05:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:41 INFO - Running setup.py (path:/tmp/pip-TBZ0J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:41 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)) 05:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:41 INFO - Running setup.py (path:/tmp/pip-wsp0is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:41 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)) 05:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:41 INFO - Running setup.py (path:/tmp/pip-_t0rp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:41 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)) 05:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:41 INFO - Running setup.py (path:/tmp/pip-XC_ZwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:41 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)) 05:04:41 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)) 05:04:41 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)) 05:04:41 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)) 05:04:41 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)) 05:04:41 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)) 05:04:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:43 INFO - Downloading blessings-1.6.tar.gz 05:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:43 INFO - Installing collected packages: blessings 05:04:43 INFO - Running setup.py install for blessings 05:04:43 INFO - Successfully installed blessings 05:04:43 INFO - Cleaning up... 05:04:43 INFO - Return code: 0 05:04:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:04:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:43 INFO - Reading from file tmpfile_stdout 05:04:43 INFO - Current package versions: 05:04:43 INFO - argparse == 1.2.1 05:04:43 INFO - blessings == 1.6 05:04:43 INFO - blobuploader == 1.2.4 05:04:43 INFO - docopt == 0.6.1 05:04:43 INFO - manifestparser == 1.1 05:04:43 INFO - mozInstall == 1.12 05:04:43 INFO - mozcrash == 0.17 05:04:43 INFO - mozdebug == 0.1 05:04:43 INFO - mozdevice == 0.48 05:04:43 INFO - mozfile == 1.2 05:04:43 INFO - mozhttpd == 0.7 05:04:43 INFO - mozinfo == 0.9 05:04:43 INFO - mozleak == 0.1 05:04:43 INFO - mozlog == 3.1 05:04:43 INFO - moznetwork == 0.27 05:04:43 INFO - mozprocess == 0.22 05:04:43 INFO - mozprofile == 0.28 05:04:43 INFO - mozrunner == 6.11 05:04:43 INFO - mozscreenshot == 0.1 05:04:43 INFO - mozsystemmonitor == 0.0 05:04:43 INFO - moztest == 0.7 05:04:43 INFO - mozversion == 1.4 05:04:43 INFO - psutil == 3.1.1 05:04:43 INFO - requests == 1.2.3 05:04:43 INFO - wsgiref == 0.1.2 05:04:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:43 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:43 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 05:04:43 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 05:04:43 INFO - Using env: {'DISPLAY': ':0', 05:04:43 INFO - 'HOME': '/home/cltbld', 05:04:43 INFO - 'LANG': 'en_US.UTF-8', 05:04:43 INFO - 'LANGUAGE': 'en_US:en', 05:04:43 INFO - 'LOGNAME': 'cltbld', 05:04:43 INFO - 'MAIL': '/var/mail/cltbld', 05:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:43 INFO - 'MOZ_NO_REMOTE': '1', 05:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:43 INFO - 'NO_EM_RESTART': '1', 05:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:43 INFO - 'PWD': '/builds/slave/test', 05:04:43 INFO - 'SHELL': '/bin/bash', 05:04:43 INFO - 'SHLVL': '1', 05:04:43 INFO - 'TERM': 'linux', 05:04:43 INFO - 'TMOUT': '86400', 05:04:43 INFO - 'USER': 'cltbld', 05:04:43 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:43 INFO - '_': '/tools/buildbot/bin/python'} 05:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 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)) 05:04:44 INFO - Cleaning up... 05:04:44 INFO - Return code: 0 05:04:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:44 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:44 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 05:04:44 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 05:04:44 INFO - Using env: {'DISPLAY': ':0', 05:04:44 INFO - 'HOME': '/home/cltbld', 05:04:44 INFO - 'LANG': 'en_US.UTF-8', 05:04:44 INFO - 'LANGUAGE': 'en_US:en', 05:04:44 INFO - 'LOGNAME': 'cltbld', 05:04:44 INFO - 'MAIL': '/var/mail/cltbld', 05:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:44 INFO - 'MOZ_NO_REMOTE': '1', 05:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:44 INFO - 'NO_EM_RESTART': '1', 05:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:44 INFO - 'PWD': '/builds/slave/test', 05:04:44 INFO - 'SHELL': '/bin/bash', 05:04:44 INFO - 'SHLVL': '1', 05:04:44 INFO - 'TERM': 'linux', 05:04:44 INFO - 'TMOUT': '86400', 05:04:44 INFO - 'USER': 'cltbld', 05:04:44 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:44 INFO - '_': '/tools/buildbot/bin/python'} 05:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:44 INFO - Downloading/unpacking jsonschema 05:04:44 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 05:04:44 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 05:04:44 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 05:04:44 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 05:04:44 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 05:04:44 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 05:04:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:46 INFO - Downloading/unpacking functools32 (from jsonschema) 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:46 INFO - warning: no files found matching '*.txt' 05:04:46 INFO - no previously-included directories found matching 'build' 05:04:46 INFO - no previously-included directories found matching 'dist' 05:04:46 INFO - no previously-included directories found matching '.git*' 05:04:46 INFO - Installing collected packages: jsonschema, functools32 05:04:46 INFO - Running setup.py install for functools32 05:04:46 INFO - warning: no files found matching '*.txt' 05:04:46 INFO - no previously-included directories found matching 'build' 05:04:46 INFO - no previously-included directories found matching 'dist' 05:04:46 INFO - no previously-included directories found matching '.git*' 05:04:46 INFO - Successfully installed jsonschema functools32 05:04:46 INFO - Cleaning up... 05:04:46 INFO - Return code: 0 05:04:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:04:46 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')]} 05:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:46 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')]} 05:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:46 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 0x7f7956efef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', '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 05:04:46 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 05:04:46 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 05:04:46 INFO - Using env: {'DISPLAY': ':0', 05:04:46 INFO - 'HOME': '/home/cltbld', 05:04:46 INFO - 'LANG': 'en_US.UTF-8', 05:04:46 INFO - 'LANGUAGE': 'en_US:en', 05:04:46 INFO - 'LOGNAME': 'cltbld', 05:04:46 INFO - 'MAIL': '/var/mail/cltbld', 05:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:46 INFO - 'MOZ_NO_REMOTE': '1', 05:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:46 INFO - 'NO_EM_RESTART': '1', 05:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:46 INFO - 'PWD': '/builds/slave/test', 05:04:46 INFO - 'SHELL': '/bin/bash', 05:04:46 INFO - 'SHLVL': '1', 05:04:46 INFO - 'TERM': 'linux', 05:04:46 INFO - 'TMOUT': '86400', 05:04:46 INFO - 'USER': 'cltbld', 05:04:46 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:46 INFO - '_': '/tools/buildbot/bin/python'} 05:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:46 INFO - Downloading/unpacking flake8 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:04:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:04:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:04:49 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 05:04:49 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 05:04:49 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 05:04:49 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 05:04:49 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 05:04:49 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 05:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:04:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:49 INFO - no previously-included directories found matching 'docs/_build' 05:04:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:04:49 INFO - Running setup.py install for pep8 05:04:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:49 INFO - no previously-included directories found matching 'docs/_build' 05:04:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:04:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:04:49 INFO - Cleaning up... 05:04:49 INFO - Return code: 0 05:04:49 INFO - Running post-action listener: _resource_record_post_action 05:04:49 INFO - Running post-action listener: _start_resource_monitoring 05:04:49 INFO - Starting resource monitoring. 05:04:49 INFO - ##### 05:04:49 INFO - ##### Finished create-virtualenv step (success) 05:04:49 INFO - ##### 05:04:49 INFO - ##### 05:04:49 INFO - ##### Running install step. 05:04:49 INFO - ##### 05:04:49 INFO - Running pre-action listener: _resource_record_pre_action 05:04:49 INFO - Running main action method: install 05:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:49 INFO - Reading from file tmpfile_stdout 05:04:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:04:50 INFO - Reading from file tmpfile_stdout 05:04:50 INFO - Output received: 05:04:50 INFO - Usage: mozinstall [options] installer 05:04:50 INFO - Options: 05:04:50 INFO - -h, --help show this help message and exit 05:04:50 INFO - -d DEST, --destination=DEST 05:04:50 INFO - Directory to install application into. [default: 05:04:50 INFO - "/builds/slave/test"] 05:04:50 INFO - --app=APP Application being installed. [default: firefox] 05:04:50 INFO - mkdir: /builds/slave/test/build/application 05:04:50 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'] 05:04:50 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 05:05:05 INFO - Reading from file tmpfile_stdout 05:05:05 INFO - Output received: 05:05:05 INFO - /builds/slave/test/build/application/firefox/firefox 05:05:05 INFO - Running post-action listener: _resource_record_post_action 05:05:05 INFO - ##### 05:05:05 INFO - ##### Finished install step (success) 05:05:05 INFO - ##### 05:05:05 INFO - ##### 05:05:05 INFO - ##### Running run-tests step. 05:05:05 INFO - ##### 05:05:05 INFO - Running pre-action listener: _resource_record_pre_action 05:05:05 INFO - Running main action method: run_tests 05:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:05 INFO - Python 2.7.3 05:05:05 INFO - Return code: 0 05:05:05 INFO - grabbing minidump binary from tooltool 05:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:05 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 0xf3e9c0>, '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 0xf3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:05 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 05:05:05 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 05:05:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:05 INFO - Return code: 0 05:05:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:05:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:05:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:05:06 INFO - Return code: 0 05:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 05:05:06 INFO - Using env: {'DISPLAY': ':0', 05:05:06 INFO - 'HOME': '/home/cltbld', 05:05:06 INFO - 'LANG': 'en_US.UTF-8', 05:05:06 INFO - 'LANGUAGE': 'en_US:en', 05:05:06 INFO - 'LOGNAME': 'cltbld', 05:05:06 INFO - 'MAIL': '/var/mail/cltbld', 05:05:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:06 INFO - 'MOZ_NO_REMOTE': '1', 05:05:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:06 INFO - 'NO_EM_RESTART': '1', 05:05:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:06 INFO - 'PWD': '/builds/slave/test', 05:05:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:06 INFO - 'SHELL': '/bin/bash', 05:05:06 INFO - 'SHLVL': '1', 05:05:06 INFO - 'TERM': 'linux', 05:05:06 INFO - 'TMOUT': '86400', 05:05:06 INFO - 'USER': 'cltbld', 05:05:06 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159', 05:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:06 INFO - '_': '/tools/buildbot/bin/python'} 05:05:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:05:06 INFO - mozversion application_buildid: 20160509033554 05:05:06 INFO - mozversion application_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 05:05:06 INFO - mozversion application_display_name: Nightly 05:05:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:06 INFO - mozversion application_name: Firefox 05:05:06 INFO - mozversion application_remotingname: firefox 05:05:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:05:06 INFO - mozversion application_vendor: Mozilla 05:05:06 INFO - mozversion application_version: 49.0a1 05:05:06 INFO - mozversion platform_buildid: 20160509033554 05:05:06 INFO - mozversion platform_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 05:05:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:05:06 INFO - mozversion platform_version: 49.0a1 05:05:06 INFO - using testdate: 1462795506 05:05:06 INFO - actual date: 1462795506 05:05:06 INFO - starting webserver on 'localhost:45028' 05:05:06 INFO - SUITE-START | Running 2 tests 05:05:06 INFO - TEST-START | dromaeo_css 05:05:06 INFO - operating with platform_type : linux_ 05:05:06 INFO - Initialising browser for dromaeo_css test... 05:05:06 INFO - TEST-INFO | started process 19669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjxDKh9/profile http://localhost:45028/getInfo.html) 05:05:11 INFO - PROCESS | 19669 | __metrics Screen width/height:1600/1200 05:05:11 INFO - PROCESS | 19669 | colorDepth:24 05:05:11 INFO - PROCESS | 19669 | Browser inner width/height: 1024/697 05:05:11 INFO - PROCESS | 19669 | __metrics 05:05:12 ERROR - PROCESS | 19669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:05:13 INFO - TEST-INFO | 19669: exit 0 05:05:13 INFO - Browser initialized. 05:05:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:13 INFO - TEST-INFO | started process 19750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjxDKh9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:25 INFO - PROCESS | 19750 | RSS: Main: 153640960 05:05:25 INFO - PROCESS | 19750 | 05:06:16 INFO - PROCESS | 19750 | 1462795576954 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] 05:08:28 INFO - PROCESS | 19750 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45028/tests/dromaeo/cssquery-ext.html) 05:08:29 INFO - PROCESS | 19750 | RSS: Main: 250851328 05:08:29 INFO - PROCESS | 19750 | 05:11:32 INFO - PROCESS | 19750 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-ext.html (next: http://localhost:45028/tests/dromaeo/cssquery-jquery.html) 05:11:32 INFO - PROCESS | 19750 | RSS: Main: 237174784 05:11:32 INFO - PROCESS | 19750 | 05:14:35 INFO - PROCESS | 19750 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45028/tests/dromaeo/cssquery-mootools.html) 05:14:35 INFO - PROCESS | 19750 | RSS: Main: 237948928 05:14:35 INFO - PROCESS | 19750 | 05:17:37 INFO - PROCESS | 19750 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45028/tests/dromaeo/cssquery-prototype.html) 05:17:38 INFO - PROCESS | 19750 | RSS: Main: 223588352 05:17:38 INFO - PROCESS | 19750 | 05:20:41 INFO - PROCESS | 19750 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45028/tests/dromaeo/cssquery-yui.html) 05:20:41 INFO - PROCESS | 19750 | RSS: Main: 204496896 05:20:41 INFO - PROCESS | 19750 | 05:23:44 INFO - PROCESS | 19750 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-yui.html (next: http://localhost:45028/tests/dromaeo/cssquery-dojo.html) 05:23:45 INFO - PROCESS | 19750 | RSS: Main: 279150592 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - PROCESS | 19750 | __start_tp_report 05:23:45 INFO - PROCESS | 19750 | _x_x_mozilla_page_load 05:23:45 INFO - PROCESS | 19750 | _x_x_mozilla_page_load_details 05:23:45 INFO - PROCESS | 19750 | |i|pagename|runs| 05:23:45 INFO - PROCESS | 19750 | |0;dojo.html;2659.2819938616576;2664.6402735630686;2683.919482415527;2697.6358191644135;2698.6626671666036;4596.770161491929;4661.4872364039975;4666.090112428078;4750.809967601296;4788.0663270662235;4712.505186955372;4781.235002399617;4832.202686556714;4836.540528649782;4899.608031357492;4304.548022457644;4324.870253892388;4364.694471387004;4432.889177770549;4546.022605139894;4497.415336006315;4507.864764057083;4508.053308805155;4512.842050528232;4537.750423726694;4225.04936389313;4243.342281946272;4270.338097594847;4352.390665306843;4354.542773008852;4313.245182093121;4319.33050377192;4324.200022995725;4325.41606883073;4372.191144638252;4327.199468098412;4341.565843415665;4343.239933011742;4378.365137055109;4382.101669157815;4515.232410490192;4651;4651.348811166439;4716.9292460613115;4722.905541889143;5124.4106927703415;5198.194279886624;5203.8178663746585;5205.245239440298;5215.921761173586;5128.871778205537;5178.4562620924635;5189.403218629868;5231.372235331746;5237.947620523784;4595.678302518859;4784.497627749106;4821.517848215186;4827.61379089679;4873.463918968911;5279.155335146358;5333.706646134422;5350.946490535122;5355.946440535545;5357.678539287577;5093.2105523643895;5093.668911520739;5119.0273847968765;5143.151380022329;5148.742562871841;4872.9512704873205;5118.3090282811345;5160.0969830279555;5162.793488260428;5170.1727723564045;5131.61512886535;5147.047796157723;5148;5153.123968925292;5157.4584668610005;5152.407473140562;5153.2785410042625;5155.61332900034;5156.767945442464;5196.870078248074;4173.373993900878;4202.243596152661;4203.957960420418;4255.702100852973;4258;3740.401535754321;3765.134019175605;3767.8869633911027;3784.905377365533;3793.5827059023486;4376.7811609419405;4404.4494438195225;4443.955560444419;4445.822167113344;4456.064226512469;5169.741512924339;5174.9482505174465;5176.8964620707375;5177.637565370388;5227.895442091137;4208.326667733148;4317.136572685476;4389.978050109729;4404.66964977628;4445.977770111129;4557.498675145731;4573.451185857718;4586.205700295915;4596.8161273548685;4639.211334073216;4801.5438533339275;4807.735574543363;4810.230363141881;4849.563539281482;4860.854174374775;4808.302796094476;5025.547700706954;5060.342155519759;5084.949150508448;5087.821926232564;4773.618110551078;4807.399075115611;4810.59109975656;4837.661363704648;4855.465898751064;4999.77501012448;5002.224655178453;5004.974975125101;5009.4489606144025;5053.090443720165;4905.705657660552;5074.67014644047;5082.237664350377;5117.513836185556;5126.2054381570915;4965.155923492943;4983.925241121458;4990.051890140861;4995.450500445021;5029.798808047637;4958.5041495851565;4977.477364876636;4979.128652485728;4994.900101997867;5024.271480635361;4770.069836382011;4855.927161092657;4908.288298196813;4918.2376731606655;4955.380577427822;5023.522765337287;5028.044671512547;5033.245013248042;5049.722265275445;5057.7724002419245;4906.435759887659;4917.0903382874285;4920.360353154067;4933.013397320478;4960.528749768766 05:23:45 INFO - PROCESS | 19750 | |1;ext.html;580.6835274775248;605.3311091244178;605.6729366142281;617.1483352972897;620.4478014567035;26969.865150674243;27577.310567235803;29968.850155749245;29990.700092999065;30000.54999175014;30053.849730751317;43805.78097109518;44172;44202.33696494555;49482.75258623702;7931.960340198305;8068.112507624157;8068.515889046646;8069.112397636255;8069.7175598854055;7907.130215676271;7981.241782030698;8000.719974800883;8000.799980000488;8005.11943686197;8055.113937466874;8080.353571714249;8087.919120808805;8089.635966381527;8098.959505202495;7946;7970.60146992651;8003.879941800848;8019.478733882337;8020.238077382639;7847.882281765778;7876.094249161362;7929.762107136795;7932.444728868982;7935.127136015034;39621.80189099036;40000.19999600021;40050.79974600137;40075;40076.799616001736;3159.1470303018286;3225.3710526447353;3335.449650807614;3438.673326034023;3552.626974167701;29254.26864328409;29532.114036578936;29886.252843678863;29952.101436956928;30007;3243.0919342584116;3252.7235185009304;3264.820434876081;3405.404054290514;3413.2149605590853;246691;246800;248814;249136;249163;35335.11662208414;36276.455853162224;36428.45357319642;55450.72274638601;55590.72204638951;35998.46002309967;36072.45891311632;36079.098022549646;36108.63891361053;36133;13309.73380532384;13367.732645347232;13434.126781759154;13449.731005379837;13459.394327255297;10731.785364292671;10804.729881753019;10832;10832.837507437394;10834.620788272372;8381;8392.622331994953;8396.832063358699;8462.915370846213;8483.618237179342;3282.917927051843;3286.244163842282;3320.6513316101946;3337.7162941150273;3374.4938259261307;939.5865819039601;946.2146418472652;952.4187074459172;987.2398253344884;1025.1337619711333;28433.715662843522;28695.56956645652;28854.567181492293;29059.273518162216;29323.706762932525;988.9901100989042;1029.459533744775;1035.6012935019921;1056.6777132974362;1095.4960718069617;15051.548453546411;15433.151176685165;15449.768253476206;15723.135227562594;15805;374257;374897;375001;375080;375862;50614.746926265136;51199.74400127975;51222.74388628033;51237.48762512327;51248.74375628098;1146.1060372909144;1270.9491620335084;1276.6233960981533;1282.5446966327006;1289.5615490733196;28570.714292856806;28810;29161.56257656179;29599.336059754725;29644.851775740983;42955.78522107495;43211.56788432076;43234;43503.56496434995;43623.34564981464;293606;293885;294524;294941;296062;23071.307860764206;25761.484770304112;26087.478250435266;26830;27030.594541082293;42539.36190957076;42662.78668606637;42777.57222427861;43702;44195;36356.27287454289;36788.26423471462;36963.81518092392;37584.62415375921;37630.98952083772;36313.45529817108;36376.63623363733;36454.27091458103;36503;37101.628983709816;36448.63551364453;36816;37022.44466333061;38265;38492.23015539617;32222.677773222906;33471.49792753159;33718.49422258619;33867.830660847525;33987.32025359529;26262.86868565645;26266.212013639622;26535.60196597014;26644;26876.865615671795 05:23:45 INFO - PROCESS | 19750 | |2;jquery.html;365.7823594960998;383.7639851491333;384.6999340514398;385.71842554934915;394.1742050404402;16695.749563756537;16707.248173832177;17516.73724894126;17560.209790559424;17617.999999999985;16979.91510042451;17085.487435376926;17332.393366232183;17479.82520174801;17548.385806496775;5091.312672789172;5177.818776342829;5222.451642577532;5240;5273.472652734715;3677.5770786359644;3918.04008018036;5421.361283287973;5951.2858456985;6042.667653279068;5967.731452084667;5972.552058595623;5974.6713930733795;6007.128966299884;6014.6391216527145;5874.7943821966455;5911.054231322989;5932.2584676915385;5943.4056594340655;5976.432238937294;3325.567676202078;4934.111859865223;5191.844244672666;5235.345581802275;5300.390455097675;20189.8990505048;20735;20809.271675491284;20953.790462095338;21031.369058928256;1990.6715391960308;2059.073416962373;2269.6482045283005;2371.4901296221396;2565.3330134165253;12820.80768788469;13290.534831280955;13419.865801342057;13684.52104176359;13769.105008174436;1714.5113642611796;1795.7755280589927;1799.2982736732686;1805.1696219738935;1805.2057094878212;50224.748876255384;54130;64805.67597162031;68263.31736682619;69991.65004174998;9554.808903821884;9676.612935482643;9750.122488976027;9816.116549510578;9915;13308.800367994489;13334.26661533625;13400.597982060553;13409.396577153857;13436.664083397993;7245.963770181115;7337.523061001018;7545.622718864144;7613.467057305936;7640;7305.3790427813165;7350.595717235603;7389.187189409161;7451.85096298071;7489.962550187214;6062.363451837582;6155.692215389213;6191.5665903387235;6284.685765711696;6302.810915672537;1713.9914300428418;1749.5013921032444;1757.5621555572027;1785.544686105035;1799;418.57932777558966;897.9326550508738;912.2884150362595;998.2962011781676;1012.8278192707257;10348.948255258676;10915;10920.399378034126;10947.397893115796;11104.61133860311;869.6086760957594;913.7578541686458;926.4487629860357;987.7283746969641;1000.2648053680539;9025.684101056431;9303.906960930439;9591.472469014132;9663.516824158763;9699.806003879883;407796;415488;416340;419472;426633;77886;78347.60826195833;78492.21507784963;78581.60709196418;78708.60645696735;962.9855552166723;971.5870754929127;983.4541829284816;983.5426526665135;1001.7345403468087;12665;16092.114933678291;16216.756748648544;16228.432004879773;16507.58731031734;34442.12789037111;34538.82730586331;35484.46773298351;35514.467282990256;35888.64111358853;46169;47727.28409073797;47735.28397074116;48044;48404.75797620989;4989.35138432016;5325.174597937326;7843.176466470938;7951.403644726553;7984.081830589556;11229.157813163882;11929.224600400947;12023.75952480928;12099.81850272229;12296.20074695142;9636.903630963601;10080.445575493124;10356.844647330447;10595.94702026485;10707.946460267649;9934.304598678023;10054.748631284276;10353.585856565653;10642.73393165146;10779.67660970172;9734.853977190489;10320.741981450223;10468.790624187626;10552;10775;7398.519096258726;7447;7534.869769534614;7618.504797188165;7640.617969101411;9500.61997520119;10122.645707400206;10342.793144136924;10482.580696772044;10526.736831579272 05:23:45 INFO - PROCESS | 19750 | |3;mootools.html;1219.6889793102757;1417.3692706745499;1458.125124925045;1597.456864666014;1824.607709342491;6911.412529934955;7208.783736487907;7241.927580724185;7371.483996120273;7377.336039756421;7124.643767811614;7231.385332246766;7265.164506081802;7271;7284.599347035911;2077.4598604362823;2115.471132216946;2116.3968269043326;2116.47088227943;2122.8726276423386;2055.1368425261426;2078.896055197242;2085.363963990982;2092.1526781653456;2101.569178318449;2090.8118269355755;2112.2923820520145;2114.2071723103836;2126.723525941625;2134.3170185540635;2006.027076867718;2007.6787713965696;2007.7088822120784;2013.7583489981223;2014.8589598728095;2002.3392280547384;2022.7067075274003;2059.4439501334705;2059.835213182942;2064.6799746039387;7235.457340699469;7272.345488905971;7277.490575659706;7461.216572259943;7737.148913619498;4522.751248681321;4607.884802879921;4626.537346265381;4630.004549021976;4640.419947506562;2916.737493625563;2927.443785680714;2991.4316279906748;3010.292581243406;3010.3377257003426;936.3164889630608;945.2768631996528;961.038961038961;966.7438128895848;979.5053497983544;9957.402555846673;9958.80082398348;10017.549210285555;10094.091531762104;10178.134858537032;3883.262180185756;3984.2629113614075;4031.415444760552;4047.0489434982755;4061.593840615915;7999.280064794197;8050.315723163597;8105.51366917975;8109.878351824727;8132.837343253102;4390.736555806662;4457.754823484739;4463.308187230984;4473.753943533137;4495.056038231943;3650.926981460356;3972.82122304497;4119.340905455113;4129.834806607702;4135;3353.8826141085433;3368.79787212768;3410.556627638391;3422.57217847769;3569.196930690626;1013.4628646817199;1017.5573625472942;1018.1956254558816;1024.4775164665925;1029.4029462911494;853.117023880281;876.250805561236;886.8448021596195;901.256463417683;904.1817155474306;4991.900161996739;5154.14956532168;5225.790968361299;5250.553702935294;5285.63000589955;839.7942504086537;880.8678698195322;910.8041771019131;924.2051835421532;934.5654270764128;3551.8224088795973;3594.694450971697;3645.234500754871;3651.835667394974;3736.663700266989;9137.543122843832;9489.145976862115;9511.143997040299;9567.186789123003;9596.520173991272;9281.767955801159;9448.90551094494;9490.810183796286;9515.809683806423;9517.381370211053;6788.49086318528;7128.394086502705;7147.1780745214965;7231.69829430697;7291.453141014339;5213;5316.096263635114;5415.458454154553;5463.562914966714;5578.86052848682;8093.19068093186;8365.832683346178;8370.121137280497;8626.5255410953;8772.692955746517;8595.484270943763;8602.483850968962;8608.956955215184;8609.526476043628;8641.740747777576;5906.291245050621;6083.178770865877;6091.116788065617;6474.676266186578;6833.931660683528;6662.200535935719;6927.480438966997;7174.820629484305;7207.099112610924;7406.444516661164;6539.182602174728;6591.274959754327;6658.833529161616;6778.339306869849;6783.084283621845;6399.712012959335;6430.710618022106;6603.438707709898;6630.569013014138;6662.233843108104;6110.663913484801;6142.6314421134875;6154.507639388748;6170.352113028068;6173.9691301545;4415.116976604756;4470.480036787508;4500.842470513517;4568.337591049213;4586.72479651222;4479.283314669638;4516.412866327357;4556.2937744649635;4559.270516717309;4562.88592785183 05:23:45 INFO - PROCESS | 19750 | |4;prototype.html;309.39204463229754;315.4668610049017;317.028308235259;317.66962359146476;319.4792488244162;4828.444728856178;4834.782434790434;4838.298446725223;4861.468637379223;4882.170031094709;4718.740469274188;4744.383230180072;4746.90506189876;4756.976215118928;4782.426108866932;3574.624664410232;3686.668199862012;3688.7417880748358;3697.131174174067;3706.22169344438;3620.2216523447455;3694.6120657331;3736.140687641844;3778.4521244419543;3791.2796568652006;3708.9072773180615;3724.664780169784;3731.9440208396895;3745.1386181178345;3754.2679177560385;3599.280143971216;3721.7208709346637;3754;3763.849446022156;3781.2626537825136;3305.7190138838228;3311.65227651098;3314.635390107086;3318.4192766265805;3331.916702082443;4562.749048802315;4570.360149579062;4573.977130114361;4576.427946506687;4612.7924243409125;4252.4046633471335;4253.532111467736;4262.25410553152;4284.892877678052;4287.627959053104;4704.952950470486;4894.535019173209;4960.479149689267;4992.301077849104;5018.322526458955;3581.462780582933;3583.4557464200448;3594.586622538415;3608.440691692792;3608.7293452990866;5231.790728370861;5272.894542109175;5277;5284.815031473919;5288.312519372457;3565.5008298838184;3649.8540058397366;3654.488371627974;3659.87190448333;3676.246369494247;3683.3922402803773;3687.9262414751556;3707.7404581679025;3718.7025037996896;3725.4598083277774;4172.603602657743;4190.182914331676;4207.179599978036;4208.716341515806;4241.2365774160335;4968.701877887338;4977.825776097891;4997.475265097185;5006.699598024057;5026.974865125724;1194.4326444938586;1240.6774238698004;1242.8322176506238;1251.7371352015996;1252.768237875996;853.5561508015921;854.2653318146389;856.6530555125184;859.6991053131354;865.2774932931073;4202.8739137825305;4288.48538175421;4384.934225986613;4397.890052748707;4417.779111044435;5142.408623008327;5169.932027189079;5170.97414512925;5189.844304670866;5197.194434862602;4334.349847522833;4349.499807522112;4351.325544540601;4362.323839804835;4362.76004819738;2592.403747138131;2636.248669129289;2649.86685717995;2665.4935562243113;2704.851233182194;4747.738874361874;4753.215719406328;4754.595859351994;4774.856754297307;4777.474477807438;5081.23781432788;5095.821646242363;5126.615503837227;5130.050940576006;5134.666246694028;4473.555362370957;4704.623630109583;4716.339712440261;4765.7140571565815;4787.832425865078;5007.674501157559;5031.195008798574;5044.268581055653;5049.2173713074535;5060.51925067118;4944.381952255968;4949.208126699855;4954.851354459372;4965.851024469127;4996.300517927566;4578.793954272132;4920.179533572458;4922.1140194765285;4923.040007198562;4928.162212423968;3627.0207044098474;3648.543932008499;3654.5614526255954;3661.5789184244154;3678.356287649704;5199.4020687621405;5205.817796377109;5207.661502002357;5208.9739551302;5218.895622087461;4905.950940490549;5035.974820125876;5050.84847454577;5051.62112841531;5054.444011158696;5004.424491183415;5027.497250274943;5035.60096934575;5046.1673823818655;5048.040872234411;4961.925571116509;4965.4289756678445;4972.229304457815;4981.950180498294;5002.474740152377;4807.95192048075;4864.8054077837905;4899.608031357554;5049.192129259448;5061.544460998528;4926.802927882844;4954.653174277766;4968.701877887338;4979.253112033224;4998.4251811042195 05:23:45 INFO - PROCESS | 19750 | |5;yui.html;691.4433880726017;719.4532155561778;750.4934169435633;771.8533478639059;816.3061397811858;11102.777944441117;11824.172307938448;11824.40877956103;11843.46704398302;11850.644480665573;12369.072319576022;12803.871961280407;13217.801732974012;13251.734965300688;13523.391447384867;858.7681326041965;865.9826803463927;869.5999840073542;870.2950610005915;870.6212797433137;684.6884667476286;853.6030745703247;888.1429420609111;890.4790697441972;891.3671293381707;914.7941713114529;917.9770505737376;918.9264858811279;919.0533750237266;919.7608621758358;705.3052743048094;911.1935936696005;911.726482055384;911.867779172023;911.9954400228023;659.7262136213466;678.694587435651;678.6979793991676;680.7991642465485;681.7511608262998;12256.264624122581;12257.509699612005;12260.325682087481;12277.938610306981;12283.324417157053;10912.50893709785;11310.37792921389;11416.372099534523;11598.420078996101;12144.089193310538;11207.551697932155;11323.433828308634;11339.603113891057;11450.083993280601;12010.099242556844;4081.7959102045074;4109.856155034559;4146.751194928283;4157.376393540962;4162.313218318974;42877;43376.78311608453;43610.12779744387;43897.78051109756;44712.3293150603;9102.31732620043;9126.041765614647;9259;9366.90633093674;9565;16142.919285403497;16143.497757847317;16174;16176.838231617769;16181.838181618268;6131.448169664752;6422.614643121427;6454.903176452357;6462.935370646327;6467.191601049869;3665.3035923175044;3673.5959044505084;3687.723420743455;3696.77819330841;3761.3793724035777;2795;2894.421115776853;2906;2906.157214407798;2908.0403466855887;538.3485981961792;564.9915251271234;575.10571061999;579.5740131003708;585.2216551985848;521.0958986159011;618.8947878860514;636.3318515558645;637.5377851058039;658.8188248231775;7865.370770338359;7991.640376183086;8029.156938521488;8071.273585377344;8099.352051835839;547.6631871399061;552.9281193444826;620.1813606039984;639.7536948274948;643.9420452159328;3813.904652383713;3832.7125465590193;3843.7693738375788;3993.4409182714444;4012.398140278923;41878;44779.55220447819;44984.100317993456;46970;47578.76210618925;44281.557184427744;44457.555424445345;44508;44712.3293150603;46241.5375846244;41718.79140604277;41808.58191418047;42033.78983105065;42357;42415.7879210602;8125.349972002344;8226.177382261725;8342.332613390792;8343.624536895733;8413.116622754767;28110;28915.277118071375;29206.853965730035;29463.55804662889;29885.103446896628;38387;38868;38946;39388.60611393964;39570.60429395669;10973.122150227802;10976.780464390828;11020.559177632806;11148.442577871236;11365.886341136484;11763.294202347886;12060.457279422622;12146.210496317712;12196;12488.188267762567;11115.666530004113;11216.607418740305;11324.6036388726;11377.4880130396;11857.703557411134;10595.470226488798;11353.318800871974;11660.416979151178;11899.702507437383;12040.277583345027;11206;11404.94297528507;11506.424678765861;11803.704907377385;11868.406579671155;9026.503542305236;9134.862977055482;9524.523773811421;9662.178714809039;9716.174125199437;9217.677381291622;9319.720408387759;9638.662646807328;9679.274054445805;9682.41905485645 05:23:45 INFO - PROCESS | 19750 | __end_tp_report 05:23:45 INFO - PROCESS | 19750 | __start_cc_report 05:23:45 INFO - PROCESS | 19750 | _x_x_mozilla_cycle_collect,916 05:23:45 INFO - PROCESS | 19750 | __end_cc_report 05:23:45 INFO - PROCESS | 19750 | __startTimestamp1462796625010__endTimestamp 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - PROCESS | 19750 | ------- Summary: start ------- 05:23:45 INFO - PROCESS | 19750 | Number of tests: 6 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - PROCESS | 19750 | [#0] dojo.html Cycles:165 Average:4722.65 Median:4849.56 stddev:512.66 (10.6%) stddev-sans-first:488.01 05:23:45 INFO - PROCESS | 19750 | Values: 2659.3 2664.6 2683.9 2697.6 2698.7 4596.8 4661.5 4666.1 4750.8 4788.1 4712.5 4781.2 4832.2 4836.5 4899.6 4304.5 4324.9 4364.7 4432.9 4546.0 4497.4 4507.9 4508.1 4512.8 4537.8 4225.0 4243.3 4270.3 4352.4 4354.5 4313.2 4319.3 4324.2 4325.4 4372.2 4327.2 4341.6 4343.2 4378.4 4382.1 4515.2 4651.0 4651.3 4716.9 4722.9 5124.4 5198.2 5203.8 5205.2 5215.9 5128.9 5178.5 5189.4 5231.4 5237.9 4595.7 4784.5 4821.5 4827.6 4873.5 5279.2 5333.7 5350.9 5355.9 5357.7 5093.2 5093.7 5119.0 5143.2 5148.7 4873.0 5118.3 5160.1 5162.8 5170.2 5131.6 5147.0 5148.0 5153.1 5157.5 5152.4 5153.3 5155.6 5156.8 5196.9 4173.4 4202.2 4204.0 4255.7 4258.0 3740.4 3765.1 3767.9 3784.9 3793.6 4376.8 4404.4 4444.0 4445.8 4456.1 5169.7 5174.9 5176.9 5177.6 5227.9 4208.3 4317.1 4390.0 4404.7 4446.0 4557.5 4573.5 4586.2 4596.8 4639.2 4801.5 4807.7 4810.2 4849.6 4860.9 4808.3 5025.5 5060.3 5084.9 5087.8 4773.6 4807.4 4810.6 4837.7 4855.5 4999.8 5002.2 5005.0 5009.4 5053.1 4905.7 5074.7 5082.2 5117.5 5126.2 4965.2 4983.9 4990.1 4995.5 5029.8 4958.5 4977.5 4979.1 4994.9 5024.3 4770.1 4855.9 4908.3 4918.2 4955.4 5023.5 5028.0 5033.2 5049.7 5057.8 4906.4 4917.1 4920.4 4933.0 4960.5 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - PROCESS | 19750 | [#1] ext.html Cycles:180 Average:45358.79 Median:36120.82 stddev:81705.79 (226.2%) stddev-sans-first:81865.82 05:23:45 INFO - PROCESS | 19750 | Values: 580.7 605.3 605.7 617.1 620.4 26969.9 27577.3 29968.9 29990.7 30000.5 30053.8 43805.8 44172.0 44202.3 49482.8 7932.0 8068.1 8068.5 8069.1 8069.7 7907.1 7981.2 8000.7 8000.8 8005.1 8055.1 8080.4 8087.9 8089.6 8099.0 7946.0 7970.6 8003.9 8019.5 8020.2 7847.9 7876.1 7929.8 7932.4 7935.1 39621.8 40000.2 40050.8 40075.0 40076.8 3159.1 3225.4 3335.4 3438.7 3552.6 29254.3 29532.1 29886.3 29952.1 30007.0 3243.1 3252.7 3264.8 3405.4 3413.2 246691.0 246800.0 248814.0 249136.0 249163.0 35335.1 36276.5 36428.5 55450.7 55590.7 35998.5 36072.5 36079.1 36108.6 36133.0 13309.7 13367.7 13434.1 13449.7 13459.4 10731.8 10804.7 10832.0 10832.8 10834.6 8381.0 8392.6 8396.8 8462.9 8483.6 3282.9 3286.2 3320.7 3337.7 3374.5 939.6 946.2 952.4 987.2 1025.1 28433.7 28695.6 28854.6 29059.3 29323.7 989.0 1029.5 1035.6 1056.7 1095.5 15051.5 15433.2 15449.8 15723.1 15805.0 374257.0 374897.0 375001.0 375080.0 375862.0 50614.7 51199.7 51222.7 51237.5 51248.7 1146.1 1270.9 1276.6 1282.5 1289.6 28570.7 28810.0 29161.6 29599.3 29644.9 42955.8 43211.6 43234.0 43503.6 43623.3 293606.0 293885.0 294524.0 294941.0 296062.0 23071.3 25761.5 26087.5 26830.0 27030.6 42539.4 42662.8 42777.6 43702.0 44195.0 36356.3 36788.3 36963.8 37584.6 37631.0 36313.5 36376.6 36454.3 36503.0 37101.6 36448.6 36816.0 37022.4 38265.0 38492.2 32222.7 33471.5 33718.5 33867.8 33987.3 26262.9 26266.2 26535.6 26644.0 26876.9 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - PROCESS | 19750 | [#2] jquery.html Cycles:180 Average:24772.96 Median:209945.29 stddev:68577.43 (32.7%) stddev-sans-first:68745.32 05:23:45 INFO - PROCESS | 19750 | Values: 365.8 383.8 384.7 385.7 394.2 16695.7 16707.2 17516.7 17560.2 17618.0 16979.9 17085.5 17332.4 17479.8 17548.4 5091.3 5177.8 5222.5 5240.0 5273.5 3677.6 3918.0 5421.4 5951.3 6042.7 5967.7 5972.6 5974.7 6007.1 6014.6 5874.8 5911.1 5932.3 5943.4 5976.4 3325.6 4934.1 5191.8 5235.3 5300.4 20189.9 20735.0 20809.3 20953.8 21031.4 1990.7 2059.1 2269.6 2371.5 2565.3 12820.8 13290.5 13419.9 13684.5 13769.1 1714.5 1795.8 1799.3 1805.2 1805.2 50224.7 54130.0 64805.7 68263.3 69991.7 9554.8 9676.6 9750.1 9816.1 9915.0 13308.8 13334.3 13400.6 13409.4 13436.7 7246.0 7337.5 7545.6 7613.5 7640.0 7305.4 7350.6 7389.2 7451.9 7490.0 6062.4 6155.7 6191.6 6284.7 6302.8 1714.0 1749.5 1757.6 1785.5 1799.0 418.6 897.9 912.3 998.3 1012.8 10348.9 10915.0 10920.4 10947.4 11104.6 869.6 913.8 926.4 987.7 1000.3 9025.7 9303.9 9591.5 9663.5 9699.8 407796.0 415488.0 416340.0 419472.0 426633.0 77886.0 78347.6 78492.2 78581.6 78708.6 963.0 971.6 983.5 983.5 1001.7 12665.0 16092.1 16216.8 16228.4 16507.6 34442.1 34538.8 35484.5 35514.5 35888.6 46169.0 47727.3 47735.3 48044.0 48404.8 4989.4 5325.2 7843.2 7951.4 7984.1 11229.2 11929.2 12023.8 12099.8 12296.2 9636.9 10080.4 10356.8 10595.9 10707.9 9934.3 10054.7 10353.6 10642.7 10779.7 9734.9 10320.7 10468.8 10552.0 10775.0 7398.5 7447.0 7534.9 7618.5 7640.6 9500.6 10122.6 10342.8 10482.6 10526.7 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - PROCESS | 19750 | [#3] mootools.html Cycles:180 Average:4947.88 Median:5439.51 stddev:2721.44 (50.0%) stddev-sans-first:2714.65 05:23:45 INFO - PROCESS | 19750 | Values: 1219.7 1417.4 1458.1 1597.5 1824.6 6911.4 7208.8 7241.9 7371.5 7377.3 7124.6 7231.4 7265.2 7271.0 7284.6 2077.5 2115.5 2116.4 2116.5 2122.9 2055.1 2078.9 2085.4 2092.2 2101.6 2090.8 2112.3 2114.2 2126.7 2134.3 2006.0 2007.7 2007.7 2013.8 2014.9 2002.3 2022.7 2059.4 2059.8 2064.7 7235.5 7272.3 7277.5 7461.2 7737.1 4522.8 4607.9 4626.5 4630.0 4640.4 2916.7 2927.4 2991.4 3010.3 3010.3 936.3 945.3 961.0 966.7 979.5 9957.4 9958.8 10017.5 10094.1 10178.1 3883.3 3984.3 4031.4 4047.0 4061.6 7999.3 8050.3 8105.5 8109.9 8132.8 4390.7 4457.8 4463.3 4473.8 4495.1 3650.9 3972.8 4119.3 4129.8 4135.0 3353.9 3368.8 3410.6 3422.6 3569.2 1013.5 1017.6 1018.2 1024.5 1029.4 853.1 876.3 886.8 901.3 904.2 4991.9 5154.1 5225.8 5250.6 5285.6 839.8 880.9 910.8 924.2 934.6 3551.8 3594.7 3645.2 3651.8 3736.7 9137.5 9489.1 9511.1 9567.2 9596.5 9281.8 9448.9 9490.8 9515.8 9517.4 6788.5 7128.4 7147.2 7231.7 7291.5 5213.0 5316.1 5415.5 5463.6 5578.9 8093.2 8365.8 8370.1 8626.5 8772.7 8595.5 8602.5 8609.0 8609.5 8641.7 5906.3 6083.2 6091.1 6474.7 6833.9 6662.2 6927.5 7174.8 7207.1 7406.4 6539.2 6591.3 6658.8 6778.3 6783.1 6399.7 6430.7 6603.4 6630.6 6662.2 6110.7 6142.6 6154.5 6170.4 6174.0 4415.1 4470.5 4500.8 4568.3 4586.7 4479.3 4516.4 4556.3 4559.3 4562.9 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - PROCESS | 19750 | [#4] prototype.html Cycles:180 Average:4141.06 Median:4731.56 stddev:1202.00 (25.4%) stddev-sans-first:1170.46 05:23:45 INFO - PROCESS | 19750 | Values: 309.4 315.5 317.0 317.7 319.5 4828.4 4834.8 4838.3 4861.5 4882.2 4718.7 4744.4 4746.9 4757.0 4782.4 3574.6 3686.7 3688.7 3697.1 3706.2 3620.2 3694.6 3736.1 3778.5 3791.3 3708.9 3724.7 3731.9 3745.1 3754.3 3599.3 3721.7 3754.0 3763.8 3781.3 3305.7 3311.7 3314.6 3318.4 3331.9 4562.7 4570.4 4574.0 4576.4 4612.8 4252.4 4253.5 4262.3 4284.9 4287.6 4705.0 4894.5 4960.5 4992.3 5018.3 3581.5 3583.5 3594.6 3608.4 3608.7 5231.8 5272.9 5277.0 5284.8 5288.3 3565.5 3649.9 3654.5 3659.9 3676.2 3683.4 3687.9 3707.7 3718.7 3725.5 4172.6 4190.2 4207.2 4208.7 4241.2 4968.7 4977.8 4997.5 5006.7 5027.0 1194.4 1240.7 1242.8 1251.7 1252.8 853.6 854.3 856.7 859.7 865.3 4202.9 4288.5 4384.9 4397.9 4417.8 5142.4 5169.9 5171.0 5189.8 5197.2 4334.3 4349.5 4351.3 4362.3 4362.8 2592.4 2636.2 2649.9 2665.5 2704.9 4747.7 4753.2 4754.6 4774.9 4777.5 5081.2 5095.8 5126.6 5130.1 5134.7 4473.6 4704.6 4716.3 4765.7 4787.8 5007.7 5031.2 5044.3 5049.2 5060.5 4944.4 4949.2 4954.9 4965.9 4996.3 4578.8 4920.2 4922.1 4923.0 4928.2 3627.0 3648.5 3654.6 3661.6 3678.4 5199.4 5205.8 5207.7 5209.0 5218.9 4906.0 5036.0 5050.8 5051.6 5054.4 5004.4 5027.5 5035.6 5046.2 5048.0 4961.9 4965.4 4972.2 4982.0 5002.5 4808.0 4864.8 4899.6 5049.2 5061.5 4926.8 4954.7 4968.7 4979.3 4998.4 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - PROCESS | 19750 | [#5] yui.html Cycles:180 Average:12499.11 Median:42646.39 stddev:13614.03 (31.9%) stddev-sans-first:13623.34 05:23:45 INFO - PROCESS | 19750 | Values: 691.4 719.5 750.5 771.9 816.3 11102.8 11824.2 11824.4 11843.5 11850.6 12369.1 12803.9 13217.8 13251.7 13523.4 858.8 866.0 869.6 870.3 870.6 684.7 853.6 888.1 890.5 891.4 914.8 918.0 918.9 919.1 919.8 705.3 911.2 911.7 911.9 912.0 659.7 678.7 678.7 680.8 681.8 12256.3 12257.5 12260.3 12277.9 12283.3 10912.5 11310.4 11416.4 11598.4 12144.1 11207.6 11323.4 11339.6 11450.1 12010.1 4081.8 4109.9 4146.8 4157.4 4162.3 42877.0 43376.8 43610.1 43897.8 44712.3 9102.3 9126.0 9259.0 9366.9 9565.0 16142.9 16143.5 16174.0 16176.8 16181.8 6131.4 6422.6 6454.9 6462.9 6467.2 3665.3 3673.6 3687.7 3696.8 3761.4 2795.0 2894.4 2906.0 2906.2 2908.0 538.3 565.0 575.1 579.6 585.2 521.1 618.9 636.3 637.5 658.8 7865.4 7991.6 8029.2 8071.3 8099.4 547.7 552.9 620.2 639.8 643.9 3813.9 3832.7 3843.8 3993.4 4012.4 41878.0 44779.6 44984.1 46970.0 47578.8 44281.6 44457.6 44508.0 44712.3 46241.5 41718.8 41808.6 42033.8 42357.0 42415.8 8125.3 8226.2 8342.3 8343.6 8413.1 28110.0 28915.3 29206.9 29463.6 29885.1 38387.0 38868.0 38946.0 39388.6 39570.6 10973.1 10976.8 11020.6 11148.4 11365.9 11763.3 12060.5 12146.2 12196.0 12488.2 11115.7 11216.6 11324.6 11377.5 11857.7 10595.5 11353.3 11660.4 11899.7 12040.3 11206.0 11404.9 11506.4 11803.7 11868.4 9026.5 9134.9 9524.5 9662.2 9716.2 9217.7 9319.7 9638.7 9679.3 9682.4 05:23:45 INFO - PROCESS | 19750 | -------- Summary: end -------- 05:23:45 INFO - PROCESS | 19750 | 05:23:45 INFO - TEST-INFO | 19750: exit 0 05:23:45 INFO - TEST-OK | dromaeo_css | took 1118799ms 05:23:45 INFO - TEST-START | kraken 05:23:45 INFO - operating with platform_type : linux_ 05:23:45 INFO - Initialising browser for kraken test... 05:23:45 INFO - TEST-INFO | started process 19933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpis4A0F/profile http://localhost:45028/getInfo.html) 05:23:50 INFO - PROCESS | 19933 | __metrics Screen width/height:1600/1200 05:23:50 INFO - PROCESS | 19933 | colorDepth:24 05:23:50 INFO - PROCESS | 19933 | Browser inner width/height: 1024/697 05:23:50 INFO - PROCESS | 19933 | __metrics 05:23:51 ERROR - PROCESS | 19933 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:23:52 INFO - TEST-INFO | 19933: exit 0 05:23:52 INFO - Browser initialized. 05:23:52 INFO - Running cycle 1/1 for kraken test... 05:23:52 INFO - TEST-INFO | started process 20012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpis4A0F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:04 INFO - PROCESS | 20012 | RSS: Main: 154255360 05:24:04 INFO - PROCESS | 20012 | 05:24:06 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45028/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:07 INFO - PROCESS | 20012 | RSS: Main: 209055744 05:24:07 INFO - PROCESS | 20012 | 05:24:10 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45028/tests/kraken/driver.html?testName=audio-dft) 05:24:11 INFO - PROCESS | 20012 | RSS: Main: 197734400 05:24:11 INFO - PROCESS | 20012 | 05:24:14 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45028/tests/kraken/driver.html?testName=audio-fft) 05:24:15 INFO - PROCESS | 20012 | RSS: Main: 266792960 05:24:15 INFO - PROCESS | 20012 | 05:24:17 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45028/tests/kraken/driver.html?testName=audio-oscillator) 05:24:17 INFO - PROCESS | 20012 | RSS: Main: 175435776 05:24:17 INFO - PROCESS | 20012 | 05:24:20 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45028/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:20 INFO - PROCESS | 20012 | RSS: Main: 180064256 05:24:20 INFO - PROCESS | 20012 | 05:24:24 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45028/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:24 INFO - PROCESS | 20012 | RSS: Main: 215494656 05:24:24 INFO - PROCESS | 20012 | 05:24:28 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45028/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:29 INFO - PROCESS | 20012 | RSS: Main: 214491136 05:24:29 INFO - PROCESS | 20012 | 05:24:32 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45028/tests/kraken/driver.html?testName=json-parse-financial) 05:24:32 INFO - PROCESS | 20012 | RSS: Main: 215040000 05:24:32 INFO - PROCESS | 20012 | 05:24:34 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45028/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:35 INFO - PROCESS | 20012 | RSS: Main: 207147008 05:24:35 INFO - PROCESS | 20012 | 05:24:37 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:37 INFO - PROCESS | 20012 | RSS: Main: 212422656 05:24:37 INFO - PROCESS | 20012 | 05:24:40 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:40 INFO - PROCESS | 20012 | RSS: Main: 218451968 05:24:40 INFO - PROCESS | 20012 | 05:24:43 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:44 INFO - PROCESS | 20012 | RSS: Main: 220504064 05:24:44 INFO - PROCESS | 20012 | 05:24:47 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:47 INFO - PROCESS | 20012 | RSS: Main: 219156480 05:24:47 INFO - PROCESS | 20012 | 05:24:49 INFO - PROCESS | 20012 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45028/tests/kraken/driver.html?testName=ai-astar) 05:24:50 INFO - PROCESS | 20012 | RSS: Main: 264667136 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | __start_tp_report 05:24:50 INFO - PROCESS | 20012 | _x_x_mozilla_page_load 05:24:50 INFO - PROCESS | 20012 | _x_x_mozilla_page_load_details 05:24:50 INFO - PROCESS | 20012 | |i|pagename|runs| 05:24:50 INFO - PROCESS | 20012 | |0;ai-astar;114;108;114;115;116;113;114;116;115;114 05:24:50 INFO - PROCESS | 20012 | |1;audio-beat-detection;163;132;160;220;136;160;158;133;190;135 05:24:50 INFO - PROCESS | 20012 | |2;audio-dft;162;161;161;162;161;161;162;160;162;160 05:24:50 INFO - PROCESS | 20012 | |3;audio-fft;78;77;77;155;75;74;76;76;134;76 05:24:50 INFO - PROCESS | 20012 | |4;audio-oscillator;94;92;155;92;92;93;127;93;92;128 05:24:50 INFO - PROCESS | 20012 | |5;imaging-gaussian-blur;116;117;116;117;116;116;117;116;116;116 05:24:50 INFO - PROCESS | 20012 | |6;imaging-darkroom;146;147;146;146;145;146;146;146;146;147 05:24:50 INFO - PROCESS | 20012 | |7;imaging-desaturate;94;94;94;95;95;94;95;95;94;95 05:24:50 INFO - PROCESS | 20012 | |8;json-parse-financial;67;67;67;66;67;66;67;120;65;65 05:24:50 INFO - PROCESS | 20012 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;64;64;65 05:24:50 INFO - PROCESS | 20012 | |10;stanford-crypto-aes;89;82;82;81;83;88;83;82;84;83 05:24:50 INFO - PROCESS | 20012 | |11;stanford-crypto-ccm;137;135;136;130;138;131;129;130;255;144 05:24:50 INFO - PROCESS | 20012 | |12;stanford-crypto-pbkdf2;175;176;176;173;173;175;172;173;174;170 05:24:50 INFO - PROCESS | 20012 | |13;stanford-crypto-sha256-iterative;68;69;69;68;66;67;68;68;66;67 05:24:50 INFO - PROCESS | 20012 | __end_tp_report 05:24:50 INFO - PROCESS | 20012 | __start_cc_report 05:24:50 INFO - PROCESS | 20012 | _x_x_mozilla_cycle_collect,2069 05:24:50 INFO - PROCESS | 20012 | __end_cc_report 05:24:50 INFO - PROCESS | 20012 | __startTimestamp1462796690030__endTimestamp 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | ------- Summary: start ------- 05:24:50 INFO - PROCESS | 20012 | Number of tests: 14 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:2.28 (2.0%) stddev-sans-first:2.42 05:24:50 INFO - PROCESS | 20012 | Values: 114.0 108.0 114.0 115.0 116.0 113.0 114.0 116.0 115.0 114.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#1] audio-beat-detection Cycles:10 Average:158.70 Median:160.00 stddev:28.30 (17.7%) stddev-sans-first:29.98 05:24:50 INFO - PROCESS | 20012 | Values: 163.0 132.0 160.0 220.0 136.0 160.0 158.0 133.0 190.0 135.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 05:24:50 INFO - PROCESS | 20012 | Values: 162.0 161.0 161.0 162.0 161.0 161.0 162.0 160.0 162.0 160.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#3] audio-fft Cycles:10 Average:89.80 Median:76.00 stddev:29.27 (38.5%) stddev-sans-first:30.73 05:24:50 INFO - PROCESS | 20012 | Values: 78.0 77.0 77.0 155.0 75.0 74.0 76.0 76.0 134.0 76.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:92.00 stddev:22.59 (24.6%) stddev-sans-first:23.55 05:24:50 INFO - PROCESS | 20012 | Values: 94.0 92.0 155.0 92.0 92.0 93.0 127.0 93.0 92.0 128.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:24:50 INFO - PROCESS | 20012 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 116.0 116.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:24:50 INFO - PROCESS | 20012 | Values: 146.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 147.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:24:50 INFO - PROCESS | 20012 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:67.00 stddev:16.99 (25.4%) stddev-sans-first:17.94 05:24:50 INFO - PROCESS | 20012 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 67.0 120.0 65.0 65.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 05:24:50 INFO - PROCESS | 20012 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.67 (3.2%) stddev-sans-first:2.03 05:24:50 INFO - PROCESS | 20012 | Values: 89.0 82.0 82.0 81.0 83.0 88.0 83.0 82.0 84.0 83.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:136.50 stddev:38.41 (28.1%) stddev-sans-first:40.58 05:24:50 INFO - PROCESS | 20012 | Values: 137.0 135.0 136.0 130.0 138.0 131.0 129.0 130.0 255.0 144.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.50 stddev:1.89 (1.1%) stddev-sans-first:1.94 05:24:50 INFO - PROCESS | 20012 | Values: 175.0 176.0 176.0 173.0 173.0 175.0 172.0 173.0 174.0 170.0 05:24:50 INFO - PROCESS | 20012 | 05:24:50 INFO - PROCESS | 20012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 05:24:50 INFO - PROCESS | 20012 | Values: 68.0 69.0 69.0 68.0 66.0 67.0 68.0 68.0 66.0 67.0 05:24:50 INFO - PROCESS | 20012 | -------- Summary: end -------- 05:24:50 INFO - PROCESS | 20012 | 05:24:51 INFO - TEST-INFO | 20012: exit 0 05:24:51 INFO - TEST-OK | kraken | took 65349ms 05:24:51 INFO - SUITE-END | took 1184s 05:24:51 INFO - Completed test suite (00:19:44) 05:24:51 INFO - javascript benchmark 05:24:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.2819938616576, 2664.6402735630686, 2683.919482415527, 2697.6358191644135, 2698.6626671666036, 4596.770161491929, 4661.4872364039975, 4666.090112428078, 4750.809967601296, 4788.0663270662235, 4712.505186955372, 4781.235002399617, 4832.202686556714, 4836.540528649782, 4899.608031357492, 4304.548022457644, 4324.870253892388, 4364.694471387004, 4432.889177770549, 4546.022605139894, 4497.415336006315, 4507.864764057083, 4508.053308805155, 4512.842050528232, 4537.750423726694, 4225.04936389313, 4243.342281946272, 4270.338097594847, 4352.390665306843, 4354.542773008852, 4313.245182093121, 4319.33050377192, 4324.200022995725, 4325.41606883073, 4372.191144638252, 4327.199468098412, 4341.565843415665, 4343.239933011742, 4378.365137055109, 4382.101669157815, 4515.232410490192, 4651.0, 4651.348811166439, 4716.9292460613115, 4722.905541889143, 5124.4106927703415, 5198.194279886624, 5203.8178663746585, 5205.245239440298, 5215.921761173586, 5128.871778205537, 5178.4562620924635, 5189.403218629868, 5231.372235331746, 5237.947620523784, 4595.678302518859, 4784.497627749106, 4821.517848215186, 4827.61379089679, 4873.463918968911, 5279.155335146358, 5333.706646134422, 5350.946490535122, 5355.946440535545, 5357.678539287577, 5093.2105523643895, 5093.668911520739, 5119.0273847968765, 5143.151380022329, 5148.742562871841, 4872.9512704873205, 5118.3090282811345, 5160.0969830279555, 5162.793488260428, 5170.1727723564045, 5131.61512886535, 5147.047796157723, 5148.0, 5153.123968925292, 5157.4584668610005, 5152.407473140562, 5153.2785410042625, 5155.61332900034, 5156.767945442464, 5196.870078248074, 4173.373993900878, 4202.243596152661, 4203.957960420418, 4255.702100852973, 4258.0, 3740.401535754321, 3765.134019175605, 3767.8869633911027, 3784.905377365533, 3793.5827059023486, 4376.7811609419405, 4404.4494438195225, 4443.955560444419, 4445.822167113344, 4456.064226512469, 5169.741512924339, 5174.9482505174465, 5176.8964620707375, 5177.637565370388, 5227.895442091137, 4208.326667733148, 4317.136572685476, 4389.978050109729, 4404.66964977628, 4445.977770111129, 4557.498675145731, 4573.451185857718, 4586.205700295915, 4596.8161273548685, 4639.211334073216, 4801.5438533339275, 4807.735574543363, 4810.230363141881, 4849.563539281482, 4860.854174374775, 4808.302796094476, 5025.547700706954, 5060.342155519759, 5084.949150508448, 5087.821926232564, 4773.618110551078, 4807.399075115611, 4810.59109975656, 4837.661363704648, 4855.465898751064, 4999.77501012448, 5002.224655178453, 5004.974975125101, 5009.4489606144025, 5053.090443720165, 4905.705657660552, 5074.67014644047, 5082.237664350377, 5117.513836185556, 5126.2054381570915, 4965.155923492943, 4983.925241121458, 4990.051890140861, 4995.450500445021, 5029.798808047637, 4958.5041495851565, 4977.477364876636, 4979.128652485728, 4994.900101997867, 5024.271480635361, 4770.069836382011, 4855.927161092657, 4908.288298196813, 4918.2376731606655, 4955.380577427822, 5023.522765337287, 5028.044671512547, 5033.245013248042, 5049.722265275445, 5057.7724002419245, 4906.435759887659, 4917.0903382874285, 4920.360353154067, 4933.013397320478, 4960.528749768766], "value": 4689.353318878253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6835274775248, 605.3311091244178, 605.6729366142281, 617.1483352972897, 620.4478014567035, 26969.865150674243, 27577.310567235803, 29968.850155749245, 29990.700092999065, 30000.54999175014, 30053.849730751317, 43805.78097109518, 44172.0, 44202.33696494555, 49482.75258623702, 7931.960340198305, 8068.112507624157, 8068.515889046646, 8069.112397636255, 8069.7175598854055, 7907.130215676271, 7981.241782030698, 8000.719974800883, 8000.799980000488, 8005.11943686197, 8055.113937466874, 8080.353571714249, 8087.919120808805, 8089.635966381527, 8098.959505202495, 7946.0, 7970.60146992651, 8003.879941800848, 8019.478733882337, 8020.238077382639, 7847.882281765778, 7876.094249161362, 7929.762107136795, 7932.444728868982, 7935.127136015034, 39621.80189099036, 40000.19999600021, 40050.79974600137, 40075.0, 40076.799616001736, 3159.1470303018286, 3225.3710526447353, 3335.449650807614, 3438.673326034023, 3552.626974167701, 29254.26864328409, 29532.114036578936, 29886.252843678863, 29952.101436956928, 30007.0, 3243.0919342584116, 3252.7235185009304, 3264.820434876081, 3405.404054290514, 3413.2149605590853, 246691.0, 246800.0, 248814.0, 249136.0, 249163.0, 35335.11662208414, 36276.455853162224, 36428.45357319642, 55450.72274638601, 55590.72204638951, 35998.46002309967, 36072.45891311632, 36079.098022549646, 36108.63891361053, 36133.0, 13309.73380532384, 13367.732645347232, 13434.126781759154, 13449.731005379837, 13459.394327255297, 10731.785364292671, 10804.729881753019, 10832.0, 10832.837507437394, 10834.620788272372, 8381.0, 8392.622331994953, 8396.832063358699, 8462.915370846213, 8483.618237179342, 3282.917927051843, 3286.244163842282, 3320.6513316101946, 3337.7162941150273, 3374.4938259261307, 939.5865819039601, 946.2146418472652, 952.4187074459172, 987.2398253344884, 1025.1337619711333, 28433.715662843522, 28695.56956645652, 28854.567181492293, 29059.273518162216, 29323.706762932525, 988.9901100989042, 1029.459533744775, 1035.6012935019921, 1056.6777132974362, 1095.4960718069617, 15051.548453546411, 15433.151176685165, 15449.768253476206, 15723.135227562594, 15805.0, 374257.0, 374897.0, 375001.0, 375080.0, 375862.0, 50614.746926265136, 51199.74400127975, 51222.74388628033, 51237.48762512327, 51248.74375628098, 1146.1060372909144, 1270.9491620335084, 1276.6233960981533, 1282.5446966327006, 1289.5615490733196, 28570.714292856806, 28810.0, 29161.56257656179, 29599.336059754725, 29644.851775740983, 42955.78522107495, 43211.56788432076, 43234.0, 43503.56496434995, 43623.34564981464, 293606.0, 293885.0, 294524.0, 294941.0, 296062.0, 23071.307860764206, 25761.484770304112, 26087.478250435266, 26830.0, 27030.594541082293, 42539.36190957076, 42662.78668606637, 42777.57222427861, 43702.0, 44195.0, 36356.27287454289, 36788.26423471462, 36963.81518092392, 37584.62415375921, 37630.98952083772, 36313.45529817108, 36376.63623363733, 36454.27091458103, 36503.0, 37101.628983709816, 36448.63551364453, 36816.0, 37022.44466333061, 38265.0, 38492.23015539617, 32222.677773222906, 33471.49792753159, 33718.49422258619, 33867.830660847525, 33987.32025359529, 26262.86868565645, 26266.212013639622, 26535.60196597014, 26644.0, 26876.865615671795], "value": 16694.908944374445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7823594960998, 383.7639851491333, 384.6999340514398, 385.71842554934915, 394.1742050404402, 16695.749563756537, 16707.248173832177, 17516.73724894126, 17560.209790559424, 17617.999999999985, 16979.91510042451, 17085.487435376926, 17332.393366232183, 17479.82520174801, 17548.385806496775, 5091.312672789172, 5177.818776342829, 5222.451642577532, 5240.0, 5273.472652734715, 3677.5770786359644, 3918.04008018036, 5421.361283287973, 5951.2858456985, 6042.667653279068, 5967.731452084667, 5972.552058595623, 5974.6713930733795, 6007.128966299884, 6014.6391216527145, 5874.7943821966455, 5911.054231322989, 5932.2584676915385, 5943.4056594340655, 5976.432238937294, 3325.567676202078, 4934.111859865223, 5191.844244672666, 5235.345581802275, 5300.390455097675, 20189.8990505048, 20735.0, 20809.271675491284, 20953.790462095338, 21031.369058928256, 1990.6715391960308, 2059.073416962373, 2269.6482045283005, 2371.4901296221396, 2565.3330134165253, 12820.80768788469, 13290.534831280955, 13419.865801342057, 13684.52104176359, 13769.105008174436, 1714.5113642611796, 1795.7755280589927, 1799.2982736732686, 1805.1696219738935, 1805.2057094878212, 50224.748876255384, 54130.0, 64805.67597162031, 68263.31736682619, 69991.65004174998, 9554.808903821884, 9676.612935482643, 9750.122488976027, 9816.116549510578, 9915.0, 13308.800367994489, 13334.26661533625, 13400.597982060553, 13409.396577153857, 13436.664083397993, 7245.963770181115, 7337.523061001018, 7545.622718864144, 7613.467057305936, 7640.0, 7305.3790427813165, 7350.595717235603, 7389.187189409161, 7451.85096298071, 7489.962550187214, 6062.363451837582, 6155.692215389213, 6191.5665903387235, 6284.685765711696, 6302.810915672537, 1713.9914300428418, 1749.5013921032444, 1757.5621555572027, 1785.544686105035, 1799.0, 418.57932777558966, 897.9326550508738, 912.2884150362595, 998.2962011781676, 1012.8278192707257, 10348.948255258676, 10915.0, 10920.399378034126, 10947.397893115796, 11104.61133860311, 869.6086760957594, 913.7578541686458, 926.4487629860357, 987.7283746969641, 1000.2648053680539, 9025.684101056431, 9303.906960930439, 9591.472469014132, 9663.516824158763, 9699.806003879883, 407796.0, 415488.0, 416340.0, 419472.0, 426633.0, 77886.0, 78347.60826195833, 78492.21507784963, 78581.60709196418, 78708.60645696735, 962.9855552166723, 971.5870754929127, 983.4541829284816, 983.5426526665135, 1001.7345403468087, 12665.0, 16092.114933678291, 16216.756748648544, 16228.432004879773, 16507.58731031734, 34442.12789037111, 34538.82730586331, 35484.46773298351, 35514.467282990256, 35888.64111358853, 46169.0, 47727.28409073797, 47735.28397074116, 48044.0, 48404.75797620989, 4989.35138432016, 5325.174597937326, 7843.176466470938, 7951.403644726553, 7984.081830589556, 11229.157813163882, 11929.224600400947, 12023.75952480928, 12099.81850272229, 12296.20074695142, 9636.903630963601, 10080.445575493124, 10356.844647330447, 10595.94702026485, 10707.946460267649, 9934.304598678023, 10054.748631284276, 10353.585856565653, 10642.73393165146, 10779.67660970172, 9734.853977190489, 10320.741981450223, 10468.790624187626, 10552.0, 10775.0, 7398.519096258726, 7447.0, 7534.869769534614, 7618.504797188165, 7640.617969101411, 9500.61997520119, 10122.645707400206, 10342.793144136924, 10482.580696772044, 10526.736831579272], "value": 8312.140349560628, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.6889793102757, 1417.3692706745499, 1458.125124925045, 1597.456864666014, 1824.607709342491, 6911.412529934955, 7208.783736487907, 7241.927580724185, 7371.483996120273, 7377.336039756421, 7124.643767811614, 7231.385332246766, 7265.164506081802, 7271.0, 7284.599347035911, 2077.4598604362823, 2115.471132216946, 2116.3968269043326, 2116.47088227943, 2122.8726276423386, 2055.1368425261426, 2078.896055197242, 2085.363963990982, 2092.1526781653456, 2101.569178318449, 2090.8118269355755, 2112.2923820520145, 2114.2071723103836, 2126.723525941625, 2134.3170185540635, 2006.027076867718, 2007.6787713965696, 2007.7088822120784, 2013.7583489981223, 2014.8589598728095, 2002.3392280547384, 2022.7067075274003, 2059.4439501334705, 2059.835213182942, 2064.6799746039387, 7235.457340699469, 7272.345488905971, 7277.490575659706, 7461.216572259943, 7737.148913619498, 4522.751248681321, 4607.884802879921, 4626.537346265381, 4630.004549021976, 4640.419947506562, 2916.737493625563, 2927.443785680714, 2991.4316279906748, 3010.292581243406, 3010.3377257003426, 936.3164889630608, 945.2768631996528, 961.038961038961, 966.7438128895848, 979.5053497983544, 9957.402555846673, 9958.80082398348, 10017.549210285555, 10094.091531762104, 10178.134858537032, 3883.262180185756, 3984.2629113614075, 4031.415444760552, 4047.0489434982755, 4061.593840615915, 7999.280064794197, 8050.315723163597, 8105.51366917975, 8109.878351824727, 8132.837343253102, 4390.736555806662, 4457.754823484739, 4463.308187230984, 4473.753943533137, 4495.056038231943, 3650.926981460356, 3972.82122304497, 4119.340905455113, 4129.834806607702, 4135.0, 3353.8826141085433, 3368.79787212768, 3410.556627638391, 3422.57217847769, 3569.196930690626, 1013.4628646817199, 1017.5573625472942, 1018.1956254558816, 1024.4775164665925, 1029.4029462911494, 853.117023880281, 876.250805561236, 886.8448021596195, 901.256463417683, 904.1817155474306, 4991.900161996739, 5154.14956532168, 5225.790968361299, 5250.553702935294, 5285.63000589955, 839.7942504086537, 880.8678698195322, 910.8041771019131, 924.2051835421532, 934.5654270764128, 3551.8224088795973, 3594.694450971697, 3645.234500754871, 3651.835667394974, 3736.663700266989, 9137.543122843832, 9489.145976862115, 9511.143997040299, 9567.186789123003, 9596.520173991272, 9281.767955801159, 9448.90551094494, 9490.810183796286, 9515.809683806423, 9517.381370211053, 6788.49086318528, 7128.394086502705, 7147.1780745214965, 7231.69829430697, 7291.453141014339, 5213.0, 5316.096263635114, 5415.458454154553, 5463.562914966714, 5578.86052848682, 8093.19068093186, 8365.832683346178, 8370.121137280497, 8626.5255410953, 8772.692955746517, 8595.484270943763, 8602.483850968962, 8608.956955215184, 8609.526476043628, 8641.740747777576, 5906.291245050621, 6083.178770865877, 6091.116788065617, 6474.676266186578, 6833.931660683528, 6662.200535935719, 6927.480438966997, 7174.820629484305, 7207.099112610924, 7406.444516661164, 6539.182602174728, 6591.274959754327, 6658.833529161616, 6778.339306869849, 6783.084283621845, 6399.712012959335, 6430.710618022106, 6603.438707709898, 6630.569013014138, 6662.233843108104, 6110.663913484801, 6142.6314421134875, 6154.507639388748, 6170.352113028068, 6173.9691301545, 4415.116976604756, 4470.480036787508, 4500.842470513517, 4568.337591049213, 4586.72479651222, 4479.283314669638, 4516.412866327357, 4556.2937744649635, 4559.270516717309, 4562.88592785183], "value": 4014.4147143330297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.39204463229754, 315.4668610049017, 317.028308235259, 317.66962359146476, 319.4792488244162, 4828.444728856178, 4834.782434790434, 4838.298446725223, 4861.468637379223, 4882.170031094709, 4718.740469274188, 4744.383230180072, 4746.90506189876, 4756.976215118928, 4782.426108866932, 3574.624664410232, 3686.668199862012, 3688.7417880748358, 3697.131174174067, 3706.22169344438, 3620.2216523447455, 3694.6120657331, 3736.140687641844, 3778.4521244419543, 3791.2796568652006, 3708.9072773180615, 3724.664780169784, 3731.9440208396895, 3745.1386181178345, 3754.2679177560385, 3599.280143971216, 3721.7208709346637, 3754.0, 3763.849446022156, 3781.2626537825136, 3305.7190138838228, 3311.65227651098, 3314.635390107086, 3318.4192766265805, 3331.916702082443, 4562.749048802315, 4570.360149579062, 4573.977130114361, 4576.427946506687, 4612.7924243409125, 4252.4046633471335, 4253.532111467736, 4262.25410553152, 4284.892877678052, 4287.627959053104, 4704.952950470486, 4894.535019173209, 4960.479149689267, 4992.301077849104, 5018.322526458955, 3581.462780582933, 3583.4557464200448, 3594.586622538415, 3608.440691692792, 3608.7293452990866, 5231.790728370861, 5272.894542109175, 5277.0, 5284.815031473919, 5288.312519372457, 3565.5008298838184, 3649.8540058397366, 3654.488371627974, 3659.87190448333, 3676.246369494247, 3683.3922402803773, 3687.9262414751556, 3707.7404581679025, 3718.7025037996896, 3725.4598083277774, 4172.603602657743, 4190.182914331676, 4207.179599978036, 4208.716341515806, 4241.2365774160335, 4968.701877887338, 4977.825776097891, 4997.475265097185, 5006.699598024057, 5026.974865125724, 1194.4326444938586, 1240.6774238698004, 1242.8322176506238, 1251.7371352015996, 1252.768237875996, 853.5561508015921, 854.2653318146389, 856.6530555125184, 859.6991053131354, 865.2774932931073, 4202.8739137825305, 4288.48538175421, 4384.934225986613, 4397.890052748707, 4417.779111044435, 5142.408623008327, 5169.932027189079, 5170.97414512925, 5189.844304670866, 5197.194434862602, 4334.349847522833, 4349.499807522112, 4351.325544540601, 4362.323839804835, 4362.76004819738, 2592.403747138131, 2636.248669129289, 2649.86685717995, 2665.4935562243113, 2704.851233182194, 4747.738874361874, 4753.215719406328, 4754.595859351994, 4774.856754297307, 4777.474477807438, 5081.23781432788, 5095.821646242363, 5126.615503837227, 5130.050940576006, 5134.666246694028, 4473.555362370957, 4704.623630109583, 4716.339712440261, 4765.7140571565815, 4787.832425865078, 5007.674501157559, 5031.195008798574, 5044.268581055653, 5049.2173713074535, 5060.51925067118, 4944.381952255968, 4949.208126699855, 4954.851354459372, 4965.851024469127, 4996.300517927566, 4578.793954272132, 4920.179533572458, 4922.1140194765285, 4923.040007198562, 4928.162212423968, 3627.0207044098474, 3648.543932008499, 3654.5614526255954, 3661.5789184244154, 3678.356287649704, 5199.4020687621405, 5205.817796377109, 5207.661502002357, 5208.9739551302, 5218.895622087461, 4905.950940490549, 5035.974820125876, 5050.84847454577, 5051.62112841531, 5054.444011158696, 5004.424491183415, 5027.497250274943, 5035.60096934575, 5046.1673823818655, 5048.040872234411, 4961.925571116509, 4965.4289756678445, 4972.229304457815, 4981.950180498294, 5002.474740152377, 4807.95192048075, 4864.8054077837905, 4899.608031357554, 5049.192129259448, 5061.544460998528, 4926.802927882844, 4954.653174277766, 4968.701877887338, 4979.253112033224, 4998.4251811042195], "value": 3764.072604561913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.4433880726017, 719.4532155561778, 750.4934169435633, 771.8533478639059, 816.3061397811858, 11102.777944441117, 11824.172307938448, 11824.40877956103, 11843.46704398302, 11850.644480665573, 12369.072319576022, 12803.871961280407, 13217.801732974012, 13251.734965300688, 13523.391447384867, 858.7681326041965, 865.9826803463927, 869.5999840073542, 870.2950610005915, 870.6212797433137, 684.6884667476286, 853.6030745703247, 888.1429420609111, 890.4790697441972, 891.3671293381707, 914.7941713114529, 917.9770505737376, 918.9264858811279, 919.0533750237266, 919.7608621758358, 705.3052743048094, 911.1935936696005, 911.726482055384, 911.867779172023, 911.9954400228023, 659.7262136213466, 678.694587435651, 678.6979793991676, 680.7991642465485, 681.7511608262998, 12256.264624122581, 12257.509699612005, 12260.325682087481, 12277.938610306981, 12283.324417157053, 10912.50893709785, 11310.37792921389, 11416.372099534523, 11598.420078996101, 12144.089193310538, 11207.551697932155, 11323.433828308634, 11339.603113891057, 11450.083993280601, 12010.099242556844, 4081.7959102045074, 4109.856155034559, 4146.751194928283, 4157.376393540962, 4162.313218318974, 42877.0, 43376.78311608453, 43610.12779744387, 43897.78051109756, 44712.3293150603, 9102.31732620043, 9126.041765614647, 9259.0, 9366.90633093674, 9565.0, 16142.919285403497, 16143.497757847317, 16174.0, 16176.838231617769, 16181.838181618268, 6131.448169664752, 6422.614643121427, 6454.903176452357, 6462.935370646327, 6467.191601049869, 3665.3035923175044, 3673.5959044505084, 3687.723420743455, 3696.77819330841, 3761.3793724035777, 2795.0, 2894.421115776853, 2906.0, 2906.157214407798, 2908.0403466855887, 538.3485981961792, 564.9915251271234, 575.10571061999, 579.5740131003708, 585.2216551985848, 521.0958986159011, 618.8947878860514, 636.3318515558645, 637.5377851058039, 658.8188248231775, 7865.370770338359, 7991.640376183086, 8029.156938521488, 8071.273585377344, 8099.352051835839, 547.6631871399061, 552.9281193444826, 620.1813606039984, 639.7536948274948, 643.9420452159328, 3813.904652383713, 3832.7125465590193, 3843.7693738375788, 3993.4409182714444, 4012.398140278923, 41878.0, 44779.55220447819, 44984.100317993456, 46970.0, 47578.76210618925, 44281.557184427744, 44457.555424445345, 44508.0, 44712.3293150603, 46241.5375846244, 41718.79140604277, 41808.58191418047, 42033.78983105065, 42357.0, 42415.7879210602, 8125.349972002344, 8226.177382261725, 8342.332613390792, 8343.624536895733, 8413.116622754767, 28110.0, 28915.277118071375, 29206.853965730035, 29463.55804662889, 29885.103446896628, 38387.0, 38868.0, 38946.0, 39388.60611393964, 39570.60429395669, 10973.122150227802, 10976.780464390828, 11020.559177632806, 11148.442577871236, 11365.886341136484, 11763.294202347886, 12060.457279422622, 12146.210496317712, 12196.0, 12488.188267762567, 11115.666530004113, 11216.607418740305, 11324.6036388726, 11377.4880130396, 11857.703557411134, 10595.470226488798, 11353.318800871974, 11660.416979151178, 11899.702507437383, 12040.277583345027, 11206.0, 11404.94297528507, 11506.424678765861, 11803.704907377385, 11868.406579671155, 9026.503542305236, 9134.862977055482, 9524.523773811421, 9662.178714809039, 9716.174125199437, 9217.677381291622, 9319.720408387759, 9638.662646807328, 9679.274054445805, 9682.41905485645], "value": 6038.827957520469, "unit": "score"}], "name": "dromaeo_css", "value": 6246.191872030104, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 115.0, 116.0, 113.0, 114.0, 116.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 160.0, 220.0, 136.0, 160.0, 158.0, 133.0, 190.0, 135.0], "value": 158.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 160.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 155.0, 75.0, 74.0, 76.0, 76.0, 134.0, 76.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 155.0, 92.0, 92.0, 93.0, 127.0, 93.0, 92.0, 128.0], "value": 105.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 120.0, 65.0, 65.0], "value": 71.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 82.0, 81.0, 83.0, 88.0, 83.0, 82.0, 84.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 136.0, 130.0, 138.0, 131.0, 129.0, 130.0, 255.0, 144.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 176.0, 173.0, 173.0, 175.0, 172.0, 173.0, 174.0, 170.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 66.0, 67.0, 68.0, 68.0, 66.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1593.6, "alertThreshold": 2.0}]} 05:24:51 INFO - Return code: 0 05:24:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:24:51 ERROR - # TBPL SUCCESS # 05:24:51 INFO - Running post-action listener: _resource_record_post_action 05:24:51 INFO - ##### 05:24:51 INFO - ##### Finished run-tests step (success) 05:24:51 INFO - ##### 05:24:51 INFO - Running post-run listener: _resource_record_post_run 05:24:52 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 536170496; Read time: 0; Write time: 449644 05:24:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242438144; Read time: 0; Write time: 245704 05:24:52 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293732352; Read time: 0; Write time: 203940 05:24:52 INFO - Running post-run listener: _upload_blobber_files 05:24:52 INFO - Blob upload gear active. 05:24:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:24:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:24:52 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:24:52 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:24:52 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:24:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:24:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:53 INFO - (blobuploader) - INFO - Done attempting. 05:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:54 INFO - (blobuploader) - INFO - Done attempting. 05:24:54 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:54 INFO - Return code: 0 05:24:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fa6989e27f8baa72fdcdc8eb9611e65c3c679920730d7af8fa08375f6a4d9e0b2a407b7ebadc7d1bf155143de0b1ff80de664cd33563d8616d5d91553e85851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89143ca47f9450a196788dd26e859ee051568b212aae051e4c60ab5947590f6e11e50172067010cfb8a8f9498b3dded95d3db6304f5124e47ae908ed96fd37d3"} 05:24:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:54 INFO - Contents: 05:24:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fa6989e27f8baa72fdcdc8eb9611e65c3c679920730d7af8fa08375f6a4d9e0b2a407b7ebadc7d1bf155143de0b1ff80de664cd33563d8616d5d91553e85851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89143ca47f9450a196788dd26e859ee051568b212aae051e4c60ab5947590f6e11e50172067010cfb8a8f9498b3dded95d3db6304f5124e47ae908ed96fd37d3"} 05:24:54 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:54 INFO - Copying logs to upload dir... 05:24:54 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.804463 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-09 05:24:53.997191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:24:54.000831) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fa6989e27f8baa72fdcdc8eb9611e65c3c679920730d7af8fa08375f6a4d9e0b2a407b7ebadc7d1bf155143de0b1ff80de664cd33563d8616d5d91553e85851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89143ca47f9450a196788dd26e859ee051568b212aae051e4c60ab5947590f6e11e50172067010cfb8a8f9498b3dded95d3db6304f5124e47ae908ed96fd37d3"} build_url:https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/ay_BQ99_QdCPuINK1STp5w/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/Firefox-Non-PGO/sha512/9fa6989e27f8baa72fdcdc8eb9611e65c3c679920730d7af8fa08375f6a4d9e0b2a407b7ebadc7d1bf155143de0b1ff80de664cd33563d8616d5d91553e85851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89143ca47f9450a196788dd26e859ee051568b212aae051e4c60ab5947590f6e11e50172067010cfb8a8f9498b3dded95d3db6304f5124e47ae908ed96fd37d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:24:54.026968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:24:54.027279) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462795347.913049-1127484159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:24:54.112249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:24:54.112567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:24:54.112842) ========= ========= Total master_lag: 0.19 =========