builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1462793315.39 results: success (0) buildid: 20160509024751 builduid: 991189a231734b41ad920f1637f0b2f5 revision: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:35.390625) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:35.391070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:35.391344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:35.447155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:35.447589) ========= 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=52faae308a556c440401f8e5000001e8-1462793314.799158-274072716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 04:28:38-- 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% 46.0M=0s 2016-05-09 04:28:38 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:35.630172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:35.630503) ========= 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=52faae308a556c440401f8e5000001e8-1462793314.799158-274072716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020567 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:35.681124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 04:28:35.681606) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce --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 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce --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=52faae308a556c440401f8e5000001e8-1462793314.799158-274072716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 04:28:38,564 truncating revision to first 12 chars 2016-05-09 04:28:38,564 Setting DEBUG logging. 2016-05-09 04:28:38,564 attempt 1/10 2016-05-09 04:28:38,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7adbdf0fce9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 04:28:39,154 unpacking tar archive at: mozilla-central-7adbdf0fce9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.125786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 04:28:36.821462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:36.821800) ========= script_repo_revision: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:36.822183) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:36.822445) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:28:36.832089) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-09 04:28:36.832472) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=52faae308a556c440401f8e5000001e8-1462793314.799158-274072716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:28:39 INFO - MultiFileLogger online at 20160509 04:28:39 in /builds/slave/test 04:28:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 04:28:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:28:39 INFO - {'append_to_log': False, 04:28:39 INFO - 'base_work_dir': '/builds/slave/test', 04:28:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:28:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:28:39 INFO - 'branch': 'Firefox-Non-PGO', 04:28:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:28:39 INFO - 'config_files': ('talos/linux_config.py',), 04:28:39 INFO - 'default_actions': ('clobber', 04:28:39 INFO - 'read-buildbot-config', 04:28:39 INFO - 'download-and-extract', 04:28:39 INFO - 'populate-webroot', 04:28:39 INFO - 'create-virtualenv', 04:28:39 INFO - 'install', 04:28:39 INFO - 'run-tests'), 04:28:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:28:39 INFO - 'download_minidump_stackwalk': True, 04:28:39 INFO - 'download_symbols': 'ondemand', 04:28:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:28:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:28:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:28:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:28:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:28:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:28:39 INFO - 'installer_path': 'installer.exe', 04:28:39 INFO - 'log_level': 'info', 04:28:39 INFO - 'log_name': 'talos', 04:28:39 INFO - 'log_to_console': True, 04:28:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:28:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:28:39 INFO - 'opt_config_files': (), 04:28:39 INFO - 'pip_index': False, 04:28:39 INFO - 'sps_profile': False, 04:28:39 INFO - 'sps_profile_interval': 0, 04:28:39 INFO - 'suite': 'dromaeojs-e10s', 04:28:39 INFO - 'system_bits': '32', 04:28:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:28:39 INFO - 'title': 'talos-linux64-ix-056', 04:28:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:28:39 INFO - 'use_talos_json': True, 04:28:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:28:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:28:39 INFO - 'work_dir': 'build'} 04:28:39 INFO - ##### 04:28:39 INFO - ##### Running clobber step. 04:28:39 INFO - ##### 04:28:39 INFO - Running pre-action listener: _resource_record_pre_action 04:28:39 INFO - Running main action method: clobber 04:28:39 INFO - rmtree: /builds/slave/test/build 04:28:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:28:40 INFO - Running post-action listener: _resource_record_post_action 04:28:40 INFO - ##### 04:28:40 INFO - ##### Finished clobber step (success) 04:28:40 INFO - ##### 04:28:40 INFO - ##### 04:28:40 INFO - ##### Running read-buildbot-config step. 04:28:40 INFO - ##### 04:28:40 INFO - Running pre-action listener: _resource_record_pre_action 04:28:40 INFO - Running main action method: read_buildbot_config 04:28:40 INFO - Using buildbot properties: 04:28:40 INFO - { 04:28:40 INFO - "project": "", 04:28:40 INFO - "product": "firefox", 04:28:40 INFO - "script_repo_revision": "production", 04:28:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:28:40 INFO - "repository": "", 04:28:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:28:40 INFO - "buildid": "20160509024751", 04:28:40 INFO - "pgo_build": "False", 04:28:40 INFO - "basedir": "/builds/slave/test", 04:28:40 INFO - "buildnumber": 306, 04:28:40 INFO - "slavename": "talos-linux64-ix-056", 04:28:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:28:40 INFO - "platform": "ubuntu64_hw", 04:28:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:28:40 INFO - "branch": "mozilla-central", 04:28:40 INFO - "repo_path": "mozilla-central", 04:28:40 INFO - "revision": "7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce", 04:28:40 INFO - "stage_platform": "linux64", 04:28:40 INFO - "builduid": "991189a231734b41ad920f1637f0b2f5", 04:28:40 INFO - "slavebuilddir": "test" 04:28:40 INFO - } 04:28:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:28:40 INFO - Running post-action listener: _resource_record_post_action 04:28:40 INFO - ##### 04:28:40 INFO - ##### Finished read-buildbot-config step (success) 04:28:40 INFO - ##### 04:28:40 INFO - ##### 04:28:40 INFO - ##### Running download-and-extract step. 04:28:40 INFO - ##### 04:28:40 INFO - Running pre-action listener: _resource_record_pre_action 04:28:40 INFO - Running main action method: download_and_extract 04:28:40 INFO - mkdir: /builds/slave/test/build/tests 04:28: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')]} 04:28:40 INFO - https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:28:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:28:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:28:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:28:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:28:41 INFO - Downloaded 1361 bytes. 04:28:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:28:41 INFO - Using the following test package requirements: 04:28:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:28:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:28:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:28:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:41 INFO - u'jsshell-linux-x86_64.zip'], 04:28:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:28:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:28:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:28:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:28:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:28:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:28:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:41 INFO - https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:28:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:28:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:28:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:28:54 INFO - Downloaded 22322613 bytes. 04:28:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:28:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:28:55 INFO - Return code: 0 04:28:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:55 INFO - https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:28:58 INFO - Downloaded 22322613 bytes. 04:28:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:28:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:28:59 INFO - Return code: 0 04:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:59 INFO - https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:28:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:28:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:28:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:28:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:29:01 INFO - Downloaded 10840152 bytes. 04:29:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:29:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:29:02 INFO - Return code: 0 04:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:02 INFO - https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:29:07 INFO - Downloaded 54855947 bytes. 04:29:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:29:07 INFO - mkdir: /builds/slave/test/properties 04:29:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:29:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:29:07 INFO - Contents: 04:29:07 INFO - build_url:https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:29:08 INFO - Running post-action listener: _resource_record_post_action 04:29:08 INFO - Running post-action listener: set_extra_try_arguments 04:29:08 INFO - ##### 04:29:08 INFO - ##### Finished download-and-extract step (success) 04:29:08 INFO - ##### 04:29:08 INFO - ##### 04:29:08 INFO - ##### Running populate-webroot step. 04:29:08 INFO - ##### 04:29:08 INFO - Running pre-action listener: _resource_record_pre_action 04:29:08 INFO - Running main action method: populate_webroot 04:29:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:29:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:29:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:29:08 INFO - '--tppagecycles', 04:29:08 INFO - '7'], 04:29:08 INFO - 'tests': ['tsvgm']}}, 04:29:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:29:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:29:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:29:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:29:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:08 INFO - 'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:08 INFO - 'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['damp', 'tps']}, 04:29:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:08 INFO - 'tests': ['damp', 'tps']}, 04:29:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['dromaeo_dom']}, 04:29:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:29:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['a11yr', 04:29:08 INFO - 'ts_paint', 04:29:08 INFO - 'tpaint', 04:29:08 INFO - 'sessionrestore', 04:29:08 INFO - 'sessionrestore_no_auto_restore', 04:29:08 INFO - 'tabpaint']}, 04:29:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:29:08 INFO - 'ts_paint', 04:29:08 INFO - 'tpaint', 04:29:08 INFO - 'sessionrestore', 04:29:08 INFO - 'sessionrestore_no_auto_restore', 04:29:08 INFO - 'tabpaint']}, 04:29:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:29:08 INFO - 'ts_paint', 04:29:08 INFO - 'tpaint', 04:29:08 INFO - 'sessionrestore', 04:29:08 INFO - 'sessionrestore_no_auto_restore', 04:29:08 INFO - 'tabpaint']}, 04:29:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:29:08 INFO - 'ts_paint', 04:29:08 INFO - 'tpaint', 04:29:08 INFO - 'sessionrestore', 04:29:08 INFO - 'sessionrestore_no_auto_restore', 04:29:08 INFO - 'tabpaint']}, 04:29:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['a11yr', 04:29:08 INFO - 'ts_paint', 04:29:08 INFO - 'tpaint', 04:29:08 INFO - 'sessionrestore', 04:29:08 INFO - 'sessionrestore_no_auto_restore', 04:29:08 INFO - 'tabpaint']}, 04:29:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['a11yr', 04:29:08 INFO - 'ts_paint', 04:29:08 INFO - 'tpaint', 04:29:08 INFO - 'sessionrestore', 04:29:08 INFO - 'sessionrestore_no_auto_restore', 04:29:08 INFO - 'tabpaint']}, 04:29:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['tsvgx', 04:29:08 INFO - 'tsvgr_opacity', 04:29:08 INFO - 'tart', 04:29:08 INFO - 'tscrollx', 04:29:08 INFO - 'cart']}, 04:29:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:29:08 INFO - 'tsvgr_opacity', 04:29:08 INFO - 'tart', 04:29:08 INFO - 'tscrollx', 04:29:08 INFO - 'cart']}, 04:29:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:08 INFO - 'talos_options': ['--disable-e10s'], 04:29:08 INFO - 'tests': ['tp5o']}, 04:29:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:08 INFO - 'tests': ['tp5o']}, 04:29:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:08 INFO - 'talos_options': ['--disable-e10s', 04:29:08 INFO - '--xperf_path', 04:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:08 INFO - 'tests': ['tp5n']}, 04:29:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:08 INFO - 'talos_options': ['--xperf_path', 04:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:08 INFO - 'tests': ['tp5n']}}, 04:29:08 INFO - 'talos.zip': {'path': '', 04:29:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:29:08 INFO - Running post-action listener: _resource_record_post_action 04:29:08 INFO - ##### 04:29:08 INFO - ##### Finished populate-webroot step (success) 04:29:08 INFO - ##### 04:29:08 INFO - ##### 04:29:08 INFO - ##### Running create-virtualenv step. 04:29:08 INFO - ##### 04:29:08 INFO - Running pre-action listener: _resource_record_pre_action 04:29:08 INFO - Running main action method: create_virtualenv 04:29:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:29:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:29:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:29:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:29:08 INFO - Using real prefix '/usr' 04:29:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:29:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:29:10 INFO - Installing pip.................done. 04:29:10 INFO - Return code: 0 04:29:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:29:10 INFO - Using env: {'DISPLAY': ':0', 04:29:10 INFO - 'HOME': '/home/cltbld', 04:29:10 INFO - 'LANG': 'en_US.UTF-8', 04:29:10 INFO - 'LANGUAGE': 'en_US:en', 04:29:10 INFO - 'LOGNAME': 'cltbld', 04:29:10 INFO - 'MAIL': '/var/mail/cltbld', 04:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:10 INFO - 'MOZ_NO_REMOTE': '1', 04:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:10 INFO - 'NO_EM_RESTART': '1', 04:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:10 INFO - 'PWD': '/builds/slave/test', 04:29:10 INFO - 'SHELL': '/bin/bash', 04:29:10 INFO - 'SHLVL': '1', 04:29:10 INFO - 'TERM': 'linux', 04:29:10 INFO - 'TMOUT': '86400', 04:29:10 INFO - 'USER': 'cltbld', 04:29:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:10 INFO - '_': '/tools/buildbot/bin/python'} 04:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:29:11 INFO - Cleaning up... 04:29:11 INFO - Return code: 0 04:29:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:11 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 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:29:11 INFO - Using env: {'DISPLAY': ':0', 04:29:11 INFO - 'HOME': '/home/cltbld', 04:29:11 INFO - 'LANG': 'en_US.UTF-8', 04:29:11 INFO - 'LANGUAGE': 'en_US:en', 04:29:11 INFO - 'LOGNAME': 'cltbld', 04:29:11 INFO - 'MAIL': '/var/mail/cltbld', 04:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:11 INFO - 'MOZ_NO_REMOTE': '1', 04:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:11 INFO - 'NO_EM_RESTART': '1', 04:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:11 INFO - 'PWD': '/builds/slave/test', 04:29:11 INFO - 'SHELL': '/bin/bash', 04:29:11 INFO - 'SHLVL': '1', 04:29:11 INFO - 'TERM': 'linux', 04:29:11 INFO - 'TMOUT': '86400', 04:29:11 INFO - 'USER': 'cltbld', 04:29:11 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:11 INFO - '_': '/tools/buildbot/bin/python'} 04:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:11 INFO - Downloading/unpacking psutil>=0.7.1 04:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:29:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:14 INFO - Installing collected packages: psutil 04:29:14 INFO - Running setup.py install for psutil 04:29:14 INFO - building 'psutil._psutil_linux' extension 04:29:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:29:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:29:14 INFO - building 'psutil._psutil_posix' extension 04:29:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:29:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:29:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:14 INFO - Successfully installed psutil 04:29:14 INFO - Cleaning up... 04:29:14 INFO - Return code: 0 04:29:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:14 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 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:29:14 INFO - Using env: {'DISPLAY': ':0', 04:29:14 INFO - 'HOME': '/home/cltbld', 04:29:14 INFO - 'LANG': 'en_US.UTF-8', 04:29:14 INFO - 'LANGUAGE': 'en_US:en', 04:29:14 INFO - 'LOGNAME': 'cltbld', 04:29:14 INFO - 'MAIL': '/var/mail/cltbld', 04:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:14 INFO - 'MOZ_NO_REMOTE': '1', 04:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:14 INFO - 'NO_EM_RESTART': '1', 04:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:14 INFO - 'PWD': '/builds/slave/test', 04:29:14 INFO - 'SHELL': '/bin/bash', 04:29:14 INFO - 'SHLVL': '1', 04:29:14 INFO - 'TERM': 'linux', 04:29:14 INFO - 'TMOUT': '86400', 04:29:14 INFO - 'USER': 'cltbld', 04:29:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:14 INFO - '_': '/tools/buildbot/bin/python'} 04:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:29:17 INFO - Installing collected packages: mozsystemmonitor 04:29:17 INFO - Running setup.py install for mozsystemmonitor 04:29:17 INFO - Successfully installed mozsystemmonitor 04:29:17 INFO - Cleaning up... 04:29:17 INFO - Return code: 0 04:29:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:17 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 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:29:17 INFO - Using env: {'DISPLAY': ':0', 04:29:17 INFO - 'HOME': '/home/cltbld', 04:29:17 INFO - 'LANG': 'en_US.UTF-8', 04:29:17 INFO - 'LANGUAGE': 'en_US:en', 04:29:17 INFO - 'LOGNAME': 'cltbld', 04:29:17 INFO - 'MAIL': '/var/mail/cltbld', 04:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:17 INFO - 'MOZ_NO_REMOTE': '1', 04:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:17 INFO - 'NO_EM_RESTART': '1', 04:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:17 INFO - 'PWD': '/builds/slave/test', 04:29:17 INFO - 'SHELL': '/bin/bash', 04:29:17 INFO - 'SHLVL': '1', 04:29:17 INFO - 'TERM': 'linux', 04:29:17 INFO - 'TMOUT': '86400', 04:29:17 INFO - 'USER': 'cltbld', 04:29:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:17 INFO - '_': '/tools/buildbot/bin/python'} 04:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:17 INFO - Downloading/unpacking blobuploader==1.2.4 04:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:29:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:29:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:21 INFO - Downloading docopt-0.6.1.tar.gz 04:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:29:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:29:21 INFO - Running setup.py install for blobuploader 04:29:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:29:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:29:21 INFO - Running setup.py install for requests 04:29:22 INFO - Running setup.py install for docopt 04:29:22 INFO - Successfully installed blobuploader requests docopt 04:29:22 INFO - Cleaning up... 04:29:22 INFO - Return code: 0 04:29:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:22 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 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:22 INFO - Using env: {'DISPLAY': ':0', 04:29:22 INFO - 'HOME': '/home/cltbld', 04:29:22 INFO - 'LANG': 'en_US.UTF-8', 04:29:22 INFO - 'LANGUAGE': 'en_US:en', 04:29:22 INFO - 'LOGNAME': 'cltbld', 04:29:22 INFO - 'MAIL': '/var/mail/cltbld', 04:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:22 INFO - 'MOZ_NO_REMOTE': '1', 04:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:22 INFO - 'NO_EM_RESTART': '1', 04:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:22 INFO - 'PWD': '/builds/slave/test', 04:29:22 INFO - 'SHELL': '/bin/bash', 04:29:22 INFO - 'SHLVL': '1', 04:29:22 INFO - 'TERM': 'linux', 04:29:22 INFO - 'TMOUT': '86400', 04:29:22 INFO - 'USER': 'cltbld', 04:29:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:22 INFO - '_': '/tools/buildbot/bin/python'} 04:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:22 INFO - Running setup.py (path:/tmp/pip-_xGrYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:22 INFO - Running setup.py (path:/tmp/pip-uHz8px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:22 INFO - Running setup.py (path:/tmp/pip-KMavsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:22 INFO - Running setup.py (path:/tmp/pip-TnoWXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:22 INFO - Running setup.py (path:/tmp/pip-goPgSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:23 INFO - Running setup.py (path:/tmp/pip-gG74da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:23 INFO - Running setup.py (path:/tmp/pip-W91Il6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:23 INFO - Running setup.py (path:/tmp/pip-V0Fh13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:23 INFO - Running setup.py (path:/tmp/pip-nkqzpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:23 INFO - Running setup.py (path:/tmp/pip-RBuvso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:23 INFO - Running setup.py (path:/tmp/pip-tpdTuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:23 INFO - Running setup.py (path:/tmp/pip-IPNe8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:23 INFO - Running setup.py (path:/tmp/pip-evntt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:23 INFO - Running setup.py (path:/tmp/pip-sZofJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:23 INFO - Running setup.py (path:/tmp/pip-ZZWx6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:23 INFO - Running setup.py (path:/tmp/pip-juU_AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:23 INFO - Running setup.py (path:/tmp/pip-nfuJbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:29:23 INFO - Running setup.py install for manifestparser 04:29:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Running setup.py install for mozcrash 04:29:24 INFO - Running setup.py install for mozdebug 04:29:24 INFO - Running setup.py install for mozdevice 04:29:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Running setup.py install for mozfile 04:29:24 INFO - Running setup.py install for mozhttpd 04:29:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Running setup.py install for mozinfo 04:29:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Running setup.py install for mozInstall 04:29:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Running setup.py install for mozleak 04:29:24 INFO - Running setup.py install for mozlog 04:29:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Running setup.py install for moznetwork 04:29:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:29:25 INFO - Running setup.py install for mozprocess 04:29:25 INFO - Running setup.py install for mozprofile 04:29:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:29:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:29:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:29:25 INFO - Running setup.py install for mozrunner 04:29:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:29:25 INFO - Running setup.py install for mozscreenshot 04:29:25 INFO - Running setup.py install for moztest 04:29:25 INFO - Running setup.py install for mozversion 04:29:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:29:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:29:25 INFO - Cleaning up... 04:29:25 INFO - Return code: 0 04:29:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:25 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 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:25 INFO - Using env: {'DISPLAY': ':0', 04:29:25 INFO - 'HOME': '/home/cltbld', 04:29:25 INFO - 'LANG': 'en_US.UTF-8', 04:29:25 INFO - 'LANGUAGE': 'en_US:en', 04:29:25 INFO - 'LOGNAME': 'cltbld', 04:29:25 INFO - 'MAIL': '/var/mail/cltbld', 04:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:25 INFO - 'MOZ_NO_REMOTE': '1', 04:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:25 INFO - 'NO_EM_RESTART': '1', 04:29:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:25 INFO - 'PWD': '/builds/slave/test', 04:29:25 INFO - 'SHELL': '/bin/bash', 04:29:25 INFO - 'SHLVL': '1', 04:29:25 INFO - 'TERM': 'linux', 04:29:25 INFO - 'TMOUT': '86400', 04:29:25 INFO - 'USER': 'cltbld', 04:29:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:25 INFO - '_': '/tools/buildbot/bin/python'} 04:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:25 INFO - Running setup.py (path:/tmp/pip-_3qM5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:26 INFO - Running setup.py (path:/tmp/pip-w7FI4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:26 INFO - Running setup.py (path:/tmp/pip-NSKkgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:26 INFO - Running setup.py (path:/tmp/pip-PVmm_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:26 INFO - Running setup.py (path:/tmp/pip-aX6TqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:26 INFO - Running setup.py (path:/tmp/pip-HcGdBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:26 INFO - Running setup.py (path:/tmp/pip-HlBMR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:26 INFO - Running setup.py (path:/tmp/pip-MxwD7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:26 INFO - Running setup.py (path:/tmp/pip-q6RJHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:26 INFO - Running setup.py (path:/tmp/pip-khk5LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:26 INFO - Running setup.py (path:/tmp/pip-_RyliF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:26 INFO - Running setup.py (path:/tmp/pip-xSfykD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:26 INFO - Running setup.py (path:/tmp/pip-Grm1MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:26 INFO - Running setup.py (path:/tmp/pip-JNylCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:26 INFO - Running setup.py (path:/tmp/pip-wZHSxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:27 INFO - Running setup.py (path:/tmp/pip-tRRhpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:27 INFO - Running setup.py (path:/tmp/pip-fUosaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:29 INFO - Downloading blessings-1.6.tar.gz 04:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:29:29 INFO - Installing collected packages: blessings 04:29:29 INFO - Running setup.py install for blessings 04:29:29 INFO - Successfully installed blessings 04:29:29 INFO - Cleaning up... 04:29:29 INFO - Return code: 0 04:29:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:29:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:29 INFO - Reading from file tmpfile_stdout 04:29:29 INFO - Current package versions: 04:29:29 INFO - argparse == 1.2.1 04:29:29 INFO - blessings == 1.6 04:29:29 INFO - blobuploader == 1.2.4 04:29:29 INFO - docopt == 0.6.1 04:29:29 INFO - manifestparser == 1.1 04:29:29 INFO - mozInstall == 1.12 04:29:29 INFO - mozcrash == 0.17 04:29:29 INFO - mozdebug == 0.1 04:29:29 INFO - mozdevice == 0.48 04:29:29 INFO - mozfile == 1.2 04:29:29 INFO - mozhttpd == 0.7 04:29:29 INFO - mozinfo == 0.9 04:29:29 INFO - mozleak == 0.1 04:29:29 INFO - mozlog == 3.1 04:29:29 INFO - moznetwork == 0.27 04:29:29 INFO - mozprocess == 0.22 04:29:29 INFO - mozprofile == 0.28 04:29:29 INFO - mozrunner == 6.11 04:29:29 INFO - mozscreenshot == 0.1 04:29:29 INFO - mozsystemmonitor == 0.0 04:29:29 INFO - moztest == 0.7 04:29:29 INFO - mozversion == 1.4 04:29:29 INFO - psutil == 3.1.1 04:29:29 INFO - requests == 1.2.3 04:29:29 INFO - wsgiref == 0.1.2 04:29:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:29 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 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:29 INFO - Using env: {'DISPLAY': ':0', 04:29:29 INFO - 'HOME': '/home/cltbld', 04:29:29 INFO - 'LANG': 'en_US.UTF-8', 04:29:29 INFO - 'LANGUAGE': 'en_US:en', 04:29:29 INFO - 'LOGNAME': 'cltbld', 04:29:29 INFO - 'MAIL': '/var/mail/cltbld', 04:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:29 INFO - 'MOZ_NO_REMOTE': '1', 04:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:29 INFO - 'NO_EM_RESTART': '1', 04:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:29 INFO - 'PWD': '/builds/slave/test', 04:29:29 INFO - 'SHELL': '/bin/bash', 04:29:29 INFO - 'SHLVL': '1', 04:29:29 INFO - 'TERM': 'linux', 04:29:29 INFO - 'TMOUT': '86400', 04:29:29 INFO - 'USER': 'cltbld', 04:29:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:29 INFO - '_': '/tools/buildbot/bin/python'} 04:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:29:29 INFO - Cleaning up... 04:29:29 INFO - Return code: 0 04:29:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:29:29 INFO - Using env: {'DISPLAY': ':0', 04:29:29 INFO - 'HOME': '/home/cltbld', 04:29:29 INFO - 'LANG': 'en_US.UTF-8', 04:29:29 INFO - 'LANGUAGE': 'en_US:en', 04:29:29 INFO - 'LOGNAME': 'cltbld', 04:29:29 INFO - 'MAIL': '/var/mail/cltbld', 04:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:29 INFO - 'MOZ_NO_REMOTE': '1', 04:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:29 INFO - 'NO_EM_RESTART': '1', 04:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:29 INFO - 'PWD': '/builds/slave/test', 04:29:29 INFO - 'SHELL': '/bin/bash', 04:29:29 INFO - 'SHLVL': '1', 04:29:29 INFO - 'TERM': 'linux', 04:29:29 INFO - 'TMOUT': '86400', 04:29:29 INFO - 'USER': 'cltbld', 04:29:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:29 INFO - '_': '/tools/buildbot/bin/python'} 04:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:30 INFO - Downloading/unpacking jsonschema 04:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:29:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:29:32 INFO - warning: no files found matching '*.txt' 04:29:32 INFO - no previously-included directories found matching 'build' 04:29:32 INFO - no previously-included directories found matching 'dist' 04:29:32 INFO - no previously-included directories found matching '.git*' 04:29:32 INFO - Installing collected packages: jsonschema, functools32 04:29:32 INFO - Running setup.py install for functools32 04:29:32 INFO - warning: no files found matching '*.txt' 04:29:32 INFO - no previously-included directories found matching 'build' 04:29:32 INFO - no previously-included directories found matching 'dist' 04:29:32 INFO - no previously-included directories found matching '.git*' 04:29:32 INFO - Successfully installed jsonschema functools32 04:29:32 INFO - Cleaning up... 04:29:32 INFO - Return code: 0 04:29:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ec0a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, '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': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:29:32 INFO - Using env: {'DISPLAY': ':0', 04:29:32 INFO - 'HOME': '/home/cltbld', 04:29:32 INFO - 'LANG': 'en_US.UTF-8', 04:29:32 INFO - 'LANGUAGE': 'en_US:en', 04:29:32 INFO - 'LOGNAME': 'cltbld', 04:29:32 INFO - 'MAIL': '/var/mail/cltbld', 04:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:32 INFO - 'MOZ_NO_REMOTE': '1', 04:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:32 INFO - 'NO_EM_RESTART': '1', 04:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:32 INFO - 'PWD': '/builds/slave/test', 04:29:32 INFO - 'SHELL': '/bin/bash', 04:29:32 INFO - 'SHLVL': '1', 04:29:32 INFO - 'TERM': 'linux', 04:29:32 INFO - 'TMOUT': '86400', 04:29:32 INFO - 'USER': 'cltbld', 04:29:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:32 INFO - '_': '/tools/buildbot/bin/python'} 04:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:33 INFO - Downloading/unpacking flake8 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:29:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:29:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:29:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:29:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:29:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:29:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:29:36 INFO - no previously-included directories found matching 'docs/_build' 04:29:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:29:36 INFO - Running setup.py install for pep8 04:29:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:29:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:29:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:29:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:29:36 INFO - no previously-included directories found matching 'docs/_build' 04:29:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:29:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:29:36 INFO - Cleaning up... 04:29:37 INFO - Return code: 0 04:29:37 INFO - Running post-action listener: _resource_record_post_action 04:29:37 INFO - Running post-action listener: _start_resource_monitoring 04:29:37 INFO - Starting resource monitoring. 04:29:37 INFO - ##### 04:29:37 INFO - ##### Finished create-virtualenv step (success) 04:29:37 INFO - ##### 04:29:37 INFO - ##### 04:29:37 INFO - ##### Running install step. 04:29:37 INFO - ##### 04:29:37 INFO - Running pre-action listener: _resource_record_pre_action 04:29:37 INFO - Running main action method: install 04:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:37 INFO - Reading from file tmpfile_stdout 04:29:37 INFO - Detecting whether we're running mozinstall >=1.0... 04:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:29:37 INFO - Reading from file tmpfile_stdout 04:29:37 INFO - Output received: 04:29:37 INFO - Usage: mozinstall [options] installer 04:29:37 INFO - Options: 04:29:37 INFO - -h, --help show this help message and exit 04:29:37 INFO - -d DEST, --destination=DEST 04:29:37 INFO - Directory to install application into. [default: 04:29:37 INFO - "/builds/slave/test"] 04:29:37 INFO - --app=APP Application being installed. [default: firefox] 04:29:37 INFO - mkdir: /builds/slave/test/build/application 04:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:29:53 INFO - Reading from file tmpfile_stdout 04:29:53 INFO - Output received: 04:29:53 INFO - /builds/slave/test/build/application/firefox/firefox 04:29:53 INFO - Running post-action listener: _resource_record_post_action 04:29:53 INFO - ##### 04:29:53 INFO - ##### Finished install step (success) 04:29:53 INFO - ##### 04:29:53 INFO - ##### 04:29:53 INFO - ##### Running run-tests step. 04:29:53 INFO - ##### 04:29:53 INFO - Running pre-action listener: _resource_record_pre_action 04:29:53 INFO - Running main action method: run_tests 04:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:29:53 INFO - Python 2.7.3 04:29:53 INFO - Return code: 0 04:29:53 INFO - grabbing minidump binary from tooltool 04:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:53 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 0x17779c0>, '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 0x17788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1778d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:29:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:29:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:29:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:29:53 INFO - Return code: 0 04:29:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:29:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:29:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:29:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:29:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:29:54 INFO - Return code: 0 04:29:54 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:29:54 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:29:54 INFO - Using env: {'DISPLAY': ':0', 04:29:54 INFO - 'HOME': '/home/cltbld', 04:29:54 INFO - 'LANG': 'en_US.UTF-8', 04:29:54 INFO - 'LANGUAGE': 'en_US:en', 04:29:54 INFO - 'LOGNAME': 'cltbld', 04:29:54 INFO - 'MAIL': '/var/mail/cltbld', 04:29:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:29:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:54 INFO - 'MOZ_NO_REMOTE': '1', 04:29:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:54 INFO - 'NO_EM_RESTART': '1', 04:29:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:54 INFO - 'PWD': '/builds/slave/test', 04:29:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:29:54 INFO - 'SHELL': '/bin/bash', 04:29:54 INFO - 'SHLVL': '1', 04:29:54 INFO - 'TERM': 'linux', 04:29:54 INFO - 'TMOUT': '86400', 04:29:54 INFO - 'USER': 'cltbld', 04:29:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462793314.799158-274072716', 04:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:54 INFO - '_': '/tools/buildbot/bin/python'} 04:29:54 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:29:54 INFO - mozversion application_buildid: 20160509024751 04:29:54 INFO - mozversion application_changeset: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce 04:29:54 INFO - mozversion application_display_name: Nightly 04:29:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:29:54 INFO - mozversion application_name: Firefox 04:29:54 INFO - mozversion application_remotingname: firefox 04:29:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:29:54 INFO - mozversion application_vendor: Mozilla 04:29:54 INFO - mozversion application_version: 49.0a1 04:29:54 INFO - mozversion platform_buildid: 20160509024751 04:29:54 INFO - mozversion platform_changeset: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce 04:29:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:29:54 INFO - mozversion platform_version: 49.0a1 04:29:54 INFO - using testdate: 1462793394 04:29:54 INFO - actual date: 1462793394 04:29:54 INFO - starting webserver on 'localhost:40049' 04:29:54 INFO - SUITE-START | Running 2 tests 04:29:54 INFO - TEST-START | dromaeo_css 04:29:54 INFO - operating with platform_type : linux_ 04:29:54 INFO - Initialising browser for dromaeo_css test... 04:29:54 INFO - TEST-INFO | started process 27379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpktxyWp/profile http://localhost:40049/getInfo.html) 04:29:59 INFO - PROCESS | 27379 | 04:29:59 INFO - PROCESS | 27379 | (process:27448): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:29:59 INFO - PROCESS | 27379 | __metrics Screen width/height:1600/1200 04:29:59 INFO - PROCESS | 27379 | colorDepth:24 04:29:59 INFO - PROCESS | 27379 | Browser inner width/height: 1024/697 04:29:59 INFO - PROCESS | 27379 | __metrics 04:30:00 ERROR - PROCESS | 27379 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:30:01 INFO - TEST-INFO | 27379: exit 0 04:30:01 INFO - Browser initialized. 04:30:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:30:01 INFO - TEST-INFO | started process 27499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpktxyWp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:03 INFO - PROCESS | 27499 | 04:30:03 INFO - PROCESS | 27499 | (process:27561): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:30:13 INFO - PROCESS | 27499 | RSS: Main: 164524032 04:30:13 INFO - PROCESS | 27499 | 04:31:03 INFO - PROCESS | 27499 | 1462793463142 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:33:15 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:40049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40049/tests/dromaeo/cssquery-ext.html) 04:33:16 INFO - PROCESS | 27499 | RSS: Main: 166244352 04:33:16 INFO - PROCESS | 27499 | 04:36:18 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:40049/tests/dromaeo/cssquery-ext.html (next: http://localhost:40049/tests/dromaeo/cssquery-jquery.html) 04:36:19 INFO - PROCESS | 27499 | RSS: Main: 166498304 04:36:19 INFO - PROCESS | 27499 | 04:39:21 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:40049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40049/tests/dromaeo/cssquery-mootools.html) 04:39:21 INFO - PROCESS | 27499 | RSS: Main: 167510016 04:39:21 INFO - PROCESS | 27499 | 04:42:23 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:40049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40049/tests/dromaeo/cssquery-prototype.html) 04:42:24 INFO - PROCESS | 27499 | RSS: Main: 165801984 04:42:24 INFO - PROCESS | 27499 | 04:45:26 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:40049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40049/tests/dromaeo/cssquery-yui.html) 04:45:27 INFO - PROCESS | 27499 | RSS: Main: 166977536 04:45:27 INFO - PROCESS | 27499 | 04:48:29 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:40049/tests/dromaeo/cssquery-yui.html (next: http://localhost:40049/tests/dromaeo/cssquery-dojo.html) 04:48:30 INFO - PROCESS | 27499 | RSS: Main: 169107456 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - PROCESS | 27499 | __start_tp_report 04:48:30 INFO - PROCESS | 27499 | _x_x_mozilla_page_load 04:48:30 INFO - PROCESS | 27499 | _x_x_mozilla_page_load_details 04:48:30 INFO - PROCESS | 27499 | |i|pagename|runs| 04:48:30 INFO - PROCESS | 27499 | |0;dojo.html;2649.0728245114215;2695.609136675183;2719.9048033318827;2736.0834120569607;2745.327394788277;4681.8127274909;4776.90446191076;4816.686915350504;4879.3656824612835;4946.035523073002;4716;4770.499097594746;4806.495317991613;4811.13399588074;4898.853034408973;4438.5561443855595;4496.842610508633;4610.147122782279;4610.792514336863;4649.093426781762;589.4669152124568;4308.870733877989;4420.40324556184;4449.354843547683;4451.087527056946;4454.042380888109;4477.283634618478;4489.528599497038;4499.415076040126;4519.954800451987;4444.888877778049;4498.775061246957;4509.301058335963;4509.368688383629;4516.683832131752;4328.112736888962;4334.154839806239;4350.456192975878;4362.323839804835;4389.517153113155;4629.097326021427;4710.646701497401;4742.905141897143;4755.857324280242;4771.928421073687;5099.796008159669;5188.403333616645;5208.791648334062;5211.088059589594;5237.711925844077;5144.717040562768;5179.249008893727;5179.300794392747;5200.219967004941;5227.60792940531;4769.66612337133;4801.399825021872;4826.300186472942;4843.951560484421;4871.732054736953;5293.7353132344;5376.838694839161;5387.649802762808;5398.91901621476;5439.592030597721;5085.059264036091;5105.33630628016;5118.513741194581;5124.5131712487255;5127.179651255781;5191.117510023305;5191.870203244949;5222.164453687392;5227.032998895216;5237.135872581058;4975.701457912537;5088.618353623493;5092.745362731923;5113.565346945476;5137.229415587692;5111.897762044739;5117.053345131163;5123.205903085028;5154.072266991902;5181.896362072737;4317.913641727211;4382.364557139197;4383.276759334738;4407.338899165151;4451.599356057905;3815.4849095372324;3837.9232415352094;3858.7298889077497;3884.6309600587897;3891.3579259422445;4326.58897404746;4402.229609818269;4465.508794032654;4499.1451624191295;4507.639388848885;5242.108841496878;5258.316418865599;5258.710770907637;5259.316288882497;5307.867303317448;4331.7834108294455;4475.328700694922;4495.3032279996;4497.977510112429;4521.683482156218;4723.527647235249;4725.267583524559;4734.384530011145;4735.83424580138;4752.453467851172;4893.779779909913;4966.975165124151;4980.103581355318;4981.128302547112;5037.773300201573;5109.386873575046;5213.947860521498;5218.347706536683;5246.160614301693;5290.232916227049;4863.051704917507;4907.337509436323;4924.261360795909;4925.359703238556;4963.429205641398;4939.802407903644;5090.796368145381;5094.363204599425;5106.719130447861;5111.769970351269;5256.605754568499;5270.8155214567305;5315.893682126413;5322.281491998686;5331.253624492651;5114.4374118847645;5147.176451767699;5148.099082660594;5159.922601160911;5217.713025783618;4904.509549045067;5006.324146240357;5114.744262786771;5127.53852153308;5128.1794912813775;4933.457319694759;4939.259111133359;4992.2511623256805;5025.0452414042675;5084.440711521804;5070.163423035158;5131.153359695609;5132.563732082815;5141.974290128525;5187.740612969412;4878.804847806048;4945.2582112683385;5001.899962000667;5004.974975125101;5007.37407824022 04:48:30 INFO - PROCESS | 27499 | |1;ext.html;546.2052713302146;598.8472939400453;607.3228350389318;613.4938675592635;630.2657404124195;35289;39817.40273895894;39884.80057599711;39947.40078898812;39963;40181;40771.59228407715;40793.38809917853;40898;40953.18093638133;7727.574983375926;7777.611119444034;7837.8824317635;7925.207479252086;7953.761387158365;7741.5355078695175;7782.727604533842;7786.961065194666;7821.37429005681;7893.486923349992;7797.610119494031;7810.0627924649125;7817.6091195440285;7842.803929901769;7896.763097107096;7715.074191097048;7758.922410775876;7874.212578742137;7883.7240696575345;7909.802254943644;7819.648115834744;7841.9215807841765;7844.294013538752;7859.685612575548;7922.049354077548;30208.24479388011;37767.24465510674;37957.810210948766;37970.81014594937;38084.23831523354;3189.5534625152495;3233;3354.295597924439;3409.7783644063056;3437.656234376542;27142.32144196391;27430.862845685842;28453.146405607866;29296.50979666731;30482.390352192833;3264.7061764441078;3271.263965607743;3304.9173770655925;3309.851056702454;3333.6499667535045;248708;254282;254818;256077;256422.71788641124;35143;36295.4555681665;58780.41219587835;59888.40111598915;60218.39781602128;36437.08907277286;36464.81767591145;36597.634023659426;36791.26417471636;36806.815965919996;12682.746345073047;12768.489260429664;12853.93573032129;12869.549565765341;12900.161489503153;9777.46223957675;9783.706488805346;9862.802743945082;9881;9989.150922171697;8439.57802109892;8487.830243395098;8549.529775862264;8580;8657.264132548804;3320.675527131018;3423.9828800855835;3441.2429265561536;3457.4122399192197;3471.7396195285455;968.1093394077466;975.5561219645044;994.5922171909627;1017.6489111256604;1047.9468134524755;29024.129276121752;29203.73377431991;29264.853675731913;29312.26719332034;29514;1008.5713571732131;1031.1441503552035;1038.6053299746047;1046.895310468947;1122.9719257018476;15559.377624894878;15600.14199219031;15646;15789.684206316038;15971.201439927958;386339;387296;390381;390437;391267;51995.74002130041;52253;52499.21251181235;52607;52791;1231.6612931443924;1258.9999999999816;1270.707737220426;1272.923624582528;1282.4036822877406;26625.467490650466;28060.438791223653;28101.297467563476;28680.856595716887;28720.71279287264;43695.34456983084;43844.78077609592;44114.55885441104;44195.77902110469;44220.33669494896;314525;315056;315093;315682;315887;26603.467930641666;26628.866855665598;27122;27167.04915327954;27231.59152612673;43279.567204328814;43364.78317608392;43391.34912976371;43534.129317412844;44649.33026004677;36495.27009459743;36502.45246321254;36529.63470365262;36707.63292367042;37319.25361492809;36579.634203657624;36595.359568775704;36620.26759464849;36651.816740916125;37011.259774804894;32033.839830800698;36765.08087297732;37086.44370334393;37600.81199593985;37665;31273.530897037017;33535.83232083824;33567.83216083904;33778.15554611056;34126;25534.489310214063;25712.485750285265;25733.742662573884;25753.227403177934;26304.8684756575 04:48:30 INFO - PROCESS | 27499 | |2;jquery.html;364.94525821126837;373.67676959430094;376.12926076133766;389.1186462662069;390.62109753539073;16072.51782446527;17178.5705357366;17730.82269177308;17963;18021.819781802194;10524.315919465229;11045.668629941094;11057.06014988725;11390.886091139086;11416.600418985337;4578.702384345007;4740.525947405258;5330.040592693314;5337.546308563777;5341.1187154119525;5292.523672869441;5299.443558426367;5307.150855863063;5312.654677445954;5342.98483288174;4845.394325709286;4857.34425852509;4873.342098816667;4891.388576427947;5338.252644629755;4792.7124372537755;4803.615710743132;4841.515848415148;4855.5872750816225;4866.562009419152;4541.72749635023;4746.644001699852;4751.7624118794265;4772.498887616785;4775.856724298276;12469.438875250635;12503.812442813365;12539.184952978027;12554.874451255462;18116.365927192484;1939.360011196302;1990.5322249271555;2003.2387692676834;2036.470517665403;2052.7434070741156;8905.465672059632;9277.35058545902;9325.44047357154;9628.889650956444;9790.657326993522;1748.0997286397514;1762.647470505904;1769.78762548495;1828.3874901907743;1872.906354682274;67553;70874;71668.28331716669;72956.63521682358;73125.63437182833;9481.857772133424;9484.90515094854;9520.952395237979;9695.369800962915;9804.705858824247;13122.737545249041;13148;13180;13272.668183295302;13308.667283317995;6931.896021559681;6957.199922009034;7010.404115650125;7011.684474198673;7105.715771369088;6457.709403076873;6594.307597702268;6741.8651626967185;6786.117804685458;6799.796006119825;3923.92152156961;4033.7983100845427;4046.846648705105;4086.7139300248696;4521.598304525608;1712.5547357686842;1720;1819.581496255842;1880.4922670878786;1963.5385684364162;888.4846788862444;901.8421776189141;958.8945216026232;973.99026009739;975.1175186456269;16484.6703065938;17121.82878171202;17130.914345428195;17146.82853171477;17388.82611173872;899.581694512055;914.2046419614844;917.655879045358;934.1125930366179;964.2864280432569;8856.114388561222;9395;9535.2371810255;9553.283503737248;9600.56585258944;357756;366156;394384;396700;409455;82064.17935820685;82701.58649206716;83155;83678.58160709158;84385.57807211047;1015.8019186258756;1034.5448002878559;1048.2033654422542;1071.8017166824163;1073;14829.555113346616;15155;15226.923865380602;15270.083794972337;15431;34298.82850585731;34562.82718586492;34741.82629086838;35571.11072223215;36433;51373.48626513687;52072.73963630309;52232.21651675152;52270.73864630653;52599;7677;7720.845583088195;7912.762617121495;7944.245296696805;8020.278174964281;8494.872576911228;9033.96109447422;11558.479868405773;11881.22772019816;12017.579384721494;10461.476926153815;10501.579936802747;10561.155107591221;10562.788744225227;11017.504212310625;10036.19710423179;10111.090001899864;10296;10354.948225258826;10414.583416663552;10290.536925838205;10444.477776111316;10635.840462392916;10921.344719316867;11018.669439916815;7762.88355674654;7805.297523222937;7982;8171.264586187272;8260.669573217005;9509.619615215313;10230.386176829117;10273.537690804082;10405.011523905217;10434 04:48:30 INFO - PROCESS | 27499 | |3;mootools.html;1500.6623509710314;1503.0530765617661;1684.6209602839363;1832.8533717302616;1846.1415441819552;6373.968130159355;7207.711691532339;7234.674439650215;7674.079110506733;7674.769756907288;7306.159791623965;7465.850682986337;7537.397008239342;7539.472236943416;7550.169481357047;2224.232639739287;2247.7302723673183;2261.8869056547187;2263.219189379661;2267.9092836286527;2144.0887622760342;2155.795199456049;2193.0898677049086;2245.6631505274177;2265.0939624150305;2218.811401030914;2225.877576733279;2234.709487766588;2237.1163390460756;2270.9780598730554;2129.446343950584;2132;2134.935951921445;2142.667886477591;2149.312220089572;2123.161351266241;2137.326742076241;2142.8607140535814;2146.7638559758416;2158.4711745622267;7523.134839493474;7566.319031287156;7597.050368703912;7601.467897247195;7621.504602200839;4409.536998615164;4510.774461276923;4516.41286632739;4531.977340113312;4540;2813.366992426688;2950.542665886791;2959.422912532057;2960;2960.437516871809;902.1609902790402;924.6809850601531;929.1916033051222;977.1498796047413;981.6073570571757;9945.85081223775;10004.849927251023;10036.046575575381;10044.598216071348;10068.748281292954;4132.834686612502;4186.6859985501205;4235.915281694349;4256.084941737541;4278.764667943293;8615.052344242129;8673.089325620718;8683.696070637498;8710.172533609297;8784.736457906272;4479.574440428154;4491.30384790358;4501.369808226851;4520;4527.886802829889;3515.191505953645;3869.671077958405;3957.2876882160913;4086.366613174963;4150.1284730207;3576.3741345264475;3590.425531914881;3679.1354031802507;3699.7040236780995;3701.9444708329397;1187.7565099154654;1210.2919791921825;1217.7260116473722;1218.5186851193905;1226.47874653272;859.7592674051276;870.4429165334191;882.5278476015301;893.5398269891011;912.0970239463016;5268.394134674485;5397.082495975615;5517.337919449692;5556.77772889088;5608.242887210256;843.9071702112763;878.8022694893598;910.886139232596;925.3430064654171;954.3319676226669;3568.7858728476376;3577.4276115821344;3619.3485172668647;3673.571250311954;3757.3988161893967;8852.114788521225;9191.816163676824;9242.953785231031;9266;9321.021292764297;9061.13919177677;9064.637414503346;9073.45559266433;9103.863442048374;9164.358494905426;7071.8939215911805;7153.4992550522;7210.819729506699;7217.530860494051;7227.674754636054;4925.16272233714;5094.108531006985;5117.74411279442;5221.791128354976;5230.764615592231;8473.110323415953;8486.618102185294;8503.107173746668;8565.27195188416;8661.696840610548;8199.795005124919;8464.746057618282;8469.491830490191;8693.434926729742;8707.129287071242;6300.306966233802;6781.6270105144695;7019.613921234177;7094.858102838018;7155.248698886542;6955.304469553206;6968.65156742171;7029.613371264425;7060.964695176492;7065.858682826212;6332.715027823667;6630.46956243509;6686.531942764154;6792.524523283323;6826.453883689393;6520.902186467112;6564.310747371648;6623.900641490478;6644.671065786765;6692.230393504809;6248.625082495065;6316.652584107918;6340.873182536416;6355.777547785805;6361.8727625448155;4355.803988820448;4360.9345859812765;4469.128519938581;4597.7011494252765;4657.115148121846;4740.502247263988;4745.810167593258;4758.738269395078;4762.380890484214;4809.326694262736 04:48:30 INFO - PROCESS | 27499 | |4;prototype.html;306.6534815658307;313.9811611303322;319.52231414036015;319.61646024770255;319.9360127974406;4791.712497250168;4822.276658501227;4929.162042452783;4968.378952630921;4972.7265000425;4812.566868981791;4886.804527818883;4908.263760435936;4918.434380046296;4937.061958227943;3919.157381163049;3931.862384816532;3939.4681717968137;3948.4669569608095;3951.664108550762;3708.9443658345144;3926.725129240954;3927.0967677434205;3944.7435916665468;3956.8417263309434;3829.9084760843166;3831.7126215533945;3865.4781604483314;3875.8643447479344;3887.319719049169;3880.6223790554227;3881.5536213335404;3882.0007696036564;3932.4494570760116;3933.2920074386598;3491.8428670709877;3500.6499350065046;3515.964840351615;3524.207053412987;3526.7531272810916;4565.863024109282;4689.320048592969;4695.131400690849;4759.50025247351;4775.474697783241;4385.188740083095;4405.3612226227015;4423.208600516796;4433;4435.334699795024;5117.48825117489;5125.436202017812;5131.563817075553;5132.794688212467;5184.274201611777;3709.5516958807057;3724.255148970217;3765.1340191755776;3781.3760729479604;3789.829457674411;5386.218998245272;5398.6220964532495;5413.593980451443;5452.945470545284;5462.371827239839;3886.902827429337;3889.1638297766117;3906.003968987947;3907.159960608426;3915.373540233606;3934.468846705658;3939.940900886489;3941.881743547698;3943.3493473577114;3959.48526691534;4246.395806028809;4372.540883207281;4375.628071613948;4407.986163182486;4430.556944305544;5091.694498330112;5141.203113517411;5177.4822517747925;5181.455947125498;5206.791728330824;1246.2335663566842;1284.5504073574175;1314.6327819068063;1322.2529270961875;1324.1591589340837;921.9124183202586;925.6019911438146;929.7629104578424;931.1852129386787;940.6049459227141;4305.182015417061;4351.586599273064;4352.107817897323;4368.868933931987;4382.868513944587;5127.9230811537855;5138.177891537336;5142.794288228429;5147;5148.716820574904;4310.590493903074;4359.7111516454115;4377.277749171415;4383.7808109595035;4406.1187762447635;2598.7126285249174;2798.902038428686;2804.8920676332737;2812.521871281846;2813.0998080614418;4926.807570631035;4944.975275123673;4951.183054795918;4972.179590367549;4975.651704380731;5185.585153187736;5331.694349503333;5349.646155691484;5373.731313434391;5407.782809048272;4861.80552777892;4903.705777653352;4904.485029071968;4939.3084968104495;4939.703617782944;5231.843044708665;5244;5256.186615617606;5275.920861187008;5293.708846013352;5048.3941926969;5061.367329083864;5163.561097306771;5199.050356116456;5232.738363081907;4884.145274576864;4919.975400122977;4941.629377796751;4949.752512374439;4964.230544265644;3633.3278343506536;3644.781313121221;3645.2478378823816;3662.5238718966366;3695.9260814783015;5018.573421259088;5223.7910483580235;5242.344706911636;5269;5317.973410132925;4989.426215985063;5038.974805125951;5053.29253904461;5084;5125.461826508312;5000.699958002531;5037.672551284155;5053.797848086182;5059.974700126476;5067.670601410897;4811.591014763784;4920.901581968269;4965.92112889996;4970.8757281068265;5137.845864624067;5218.946916054151;5243.060067774948;5251.4245726282725;5253.947460525345;5273.841784746463;5100.948990510047;5116.107040394929;5137.944822071052;5146.974265128651;5147.536721694915 04:48:30 INFO - PROCESS | 27499 | |5;yui.html;784.6312233250372;807.6688557691348;809.2554849538424;811.6063709101088;826.4586695714307;11015.724606884822;11549.191556591042;11561.190716649839;11624.070074394049;11649.301041937479;12169.087318451107;12172.878271217285;12207.450664720087;12228.93885530571;12247;660.5640277416906;840.5209030852417;849.4096602860999;861.2033868671485;862.5773371048203;858.7681326041965;858.9269912057482;859.3554833874595;860.4493124400389;861.8621020636699;904.1726819959729;908.2915326045662;908.4276905549494;909.727081875438;913.0914739833875;890.7060669978891;898.1018981018981;899.6491368366343;905.5653286422554;907.0022974727813;661.7749965011919;663.5222639699409;663.598522893652;663.8937769956832;664.8504086580481;11487.483063262172;11550.480228389742;11580.363080030595;11590.942045289805;11618.128640352008;10995.175361847814;11042.116630669527;11427.828582571268;11452.198346115776;11885.40572971348;9598.616055357847;9600.66397676078;9812.46031468269;9840.11438970496;9973.102420782165;4172.269852775752;4175.603317684815;4193.622573968327;4196.349565817303;4395.252807022814;40524.59475405267;40652;40957;44637.43768968071;44949.775251123865;9189.862152067724;9221.631134754669;9756.317057805885;9883.357581757164;9919.057689519484;16730.4144354947;16756.748648770033;16778.328866845433;16786.244618992176;16825.91587042057;6479;6489.545731798823;6503.544751867324;6610.0745895574655;6682.331766823376;3253.8861139860464;3282.5404443377947;3291.901242962715;3360.3615313090436;3420.9144771380916;2843.6871944086133;2884.3798583304692;2890.7976441649303;2917.5331946888396;2924.9122526324245;528.0811388184532;531.3889027618193;531.5720844720038;542.6310109125753;545.9454054594509;399.2872722190875;443.0253442426674;521.1999580643694;530.6100016487878;535.9866003349947;7124.786256412316;7229.783106506813;7246.347828695337;7346.96326518364;7528.096628404626;568.6559631423012;581.4360070731468;593.0896074525582;600.540586451365;636.6053047110821;3442.6557344265375;3475.2354482013916;3569.5181150544345;3572.5534308211472;3637.136978713279;48824.75587622039;49460;49467;50627.48117556479;51355.74322128366;46000.539994599625;47109.76445117821;47707;48095.75952120217;48198.5180148201;40877;41563;41763.58236417597;42127.789361053;42802.57197427986;6776.6950487227205;6800.421964133104;6851.9657401712675;6892.448604111559;7057.294270572902;27129;27669.723302766713;28447.28881777972;28733.856330718212;28750.568741468476;34284.48573271353;34376.421768367974;36989.445158323186;37186.62813371832;37482.812585936896;8749.737507874774;8856.734297971072;9214.078592140731;9259.166674999282;9332.673356432493;8753.255973242345;8829.867551986854;8832.867506987528;8853.955730221307;9539.332246742939;8588.828223435621;8809.251213646912;8818.86771698438;8991.55042247898;9122.087791220825;8601.741947741577;8728;8734.475931444134;8870.112988701077;8969.686060987835;8546.316294696286;8596.78508037304;8635.136486351315;8660.566971651519;8734.47593144388;7332.853342933005;7517;7556.433267505069;7600.125985511516;7716.884246736416;7537.434692398202;7541.5475071495885;7704.499207551491;7813.726519571787;7942.8085787132395 04:48:30 INFO - PROCESS | 27499 | __end_tp_report 04:48:30 INFO - PROCESS | 27499 | __start_cc_report 04:48:30 INFO - PROCESS | 27499 | _x_x_mozilla_cycle_collect,379 04:48:30 INFO - PROCESS | 27499 | __end_cc_report 04:48:30 INFO - PROCESS | 27499 | __startTimestamp1462794510097__endTimestamp 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - PROCESS | 27499 | ------- Summary: start ------- 04:48:30 INFO - PROCESS | 27499 | Number of tests: 6 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - PROCESS | 27499 | [#0] dojo.html Cycles:165 Average:4777.21 Median:4939.80 stddev:606.89 (12.3%) stddev-sans-first:585.34 04:48:30 INFO - PROCESS | 27499 | Values: 2649.1 2695.6 2719.9 2736.1 2745.3 4681.8 4776.9 4816.7 4879.4 4946.0 4716.0 4770.5 4806.5 4811.1 4898.9 4438.6 4496.8 4610.1 4610.8 4649.1 589.5 4308.9 4420.4 4449.4 4451.1 4454.0 4477.3 4489.5 4499.4 4520.0 4444.9 4498.8 4509.3 4509.4 4516.7 4328.1 4334.2 4350.5 4362.3 4389.5 4629.1 4710.6 4742.9 4755.9 4771.9 5099.8 5188.4 5208.8 5211.1 5237.7 5144.7 5179.2 5179.3 5200.2 5227.6 4769.7 4801.4 4826.3 4844.0 4871.7 5293.7 5376.8 5387.6 5398.9 5439.6 5085.1 5105.3 5118.5 5124.5 5127.2 5191.1 5191.9 5222.2 5227.0 5237.1 4975.7 5088.6 5092.7 5113.6 5137.2 5111.9 5117.1 5123.2 5154.1 5181.9 4317.9 4382.4 4383.3 4407.3 4451.6 3815.5 3837.9 3858.7 3884.6 3891.4 4326.6 4402.2 4465.5 4499.1 4507.6 5242.1 5258.3 5258.7 5259.3 5307.9 4331.8 4475.3 4495.3 4498.0 4521.7 4723.5 4725.3 4734.4 4735.8 4752.5 4893.8 4967.0 4980.1 4981.1 5037.8 5109.4 5213.9 5218.3 5246.2 5290.2 4863.1 4907.3 4924.3 4925.4 4963.4 4939.8 5090.8 5094.4 5106.7 5111.8 5256.6 5270.8 5315.9 5322.3 5331.3 5114.4 5147.2 5148.1 5159.9 5217.7 4904.5 5006.3 5114.7 5127.5 5128.2 4933.5 4939.3 4992.3 5025.0 5084.4 5070.2 5131.2 5132.6 5142.0 5187.7 4878.8 4945.3 5001.9 5005.0 5007.4 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - PROCESS | 27499 | [#1] ext.html Cycles:180 Average:46746.93 Median:36636.04 stddev:85497.66 (233.4%) stddev-sans-first:85667.13 04:48:30 INFO - PROCESS | 27499 | Values: 546.2 598.8 607.3 613.5 630.3 35289.0 39817.4 39884.8 39947.4 39963.0 40181.0 40771.6 40793.4 40898.0 40953.2 7727.6 7777.6 7837.9 7925.2 7953.8 7741.5 7782.7 7787.0 7821.4 7893.5 7797.6 7810.1 7817.6 7842.8 7896.8 7715.1 7758.9 7874.2 7883.7 7909.8 7819.6 7841.9 7844.3 7859.7 7922.0 30208.2 37767.2 37957.8 37970.8 38084.2 3189.6 3233.0 3354.3 3409.8 3437.7 27142.3 27430.9 28453.1 29296.5 30482.4 3264.7 3271.3 3304.9 3309.9 3333.6 248708.0 254282.0 254818.0 256077.0 256422.7 35143.0 36295.5 58780.4 59888.4 60218.4 36437.1 36464.8 36597.6 36791.3 36806.8 12682.7 12768.5 12853.9 12869.5 12900.2 9777.5 9783.7 9862.8 9881.0 9989.2 8439.6 8487.8 8549.5 8580.0 8657.3 3320.7 3424.0 3441.2 3457.4 3471.7 968.1 975.6 994.6 1017.6 1047.9 29024.1 29203.7 29264.9 29312.3 29514.0 1008.6 1031.1 1038.6 1046.9 1123.0 15559.4 15600.1 15646.0 15789.7 15971.2 386339.0 387296.0 390381.0 390437.0 391267.0 51995.7 52253.0 52499.2 52607.0 52791.0 1231.7 1259.0 1270.7 1272.9 1282.4 26625.5 28060.4 28101.3 28680.9 28720.7 43695.3 43844.8 44114.6 44195.8 44220.3 314525.0 315056.0 315093.0 315682.0 315887.0 26603.5 26628.9 27122.0 27167.0 27231.6 43279.6 43364.8 43391.3 43534.1 44649.3 36495.3 36502.5 36529.6 36707.6 37319.3 36579.6 36595.4 36620.3 36651.8 37011.3 32033.8 36765.1 37086.4 37600.8 37665.0 31273.5 33535.8 33567.8 33778.2 34126.0 25534.5 25712.5 25733.7 25753.2 26304.9 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - PROCESS | 27499 | [#2] jquery.html Cycles:180 Average:23950.91 Median:206988.30 stddev:63932.85 (30.9%) stddev-sans-first:64087.67 04:48:30 INFO - PROCESS | 27499 | Values: 364.9 373.7 376.1 389.1 390.6 16072.5 17178.6 17730.8 17963.0 18021.8 10524.3 11045.7 11057.1 11390.9 11416.6 4578.7 4740.5 5330.0 5337.5 5341.1 5292.5 5299.4 5307.2 5312.7 5343.0 4845.4 4857.3 4873.3 4891.4 5338.3 4792.7 4803.6 4841.5 4855.6 4866.6 4541.7 4746.6 4751.8 4772.5 4775.9 12469.4 12503.8 12539.2 12554.9 18116.4 1939.4 1990.5 2003.2 2036.5 2052.7 8905.5 9277.4 9325.4 9628.9 9790.7 1748.1 1762.6 1769.8 1828.4 1872.9 67553.0 70874.0 71668.3 72956.6 73125.6 9481.9 9484.9 9521.0 9695.4 9804.7 13122.7 13148.0 13180.0 13272.7 13308.7 6931.9 6957.2 7010.4 7011.7 7105.7 6457.7 6594.3 6741.9 6786.1 6799.8 3923.9 4033.8 4046.8 4086.7 4521.6 1712.6 1720.0 1819.6 1880.5 1963.5 888.5 901.8 958.9 974.0 975.1 16484.7 17121.8 17130.9 17146.8 17388.8 899.6 914.2 917.7 934.1 964.3 8856.1 9395.0 9535.2 9553.3 9600.6 357756.0 366156.0 394384.0 396700.0 409455.0 82064.2 82701.6 83155.0 83678.6 84385.6 1015.8 1034.5 1048.2 1071.8 1073.0 14829.6 15155.0 15226.9 15270.1 15431.0 34298.8 34562.8 34741.8 35571.1 36433.0 51373.5 52072.7 52232.2 52270.7 52599.0 7677.0 7720.8 7912.8 7944.2 8020.3 8494.9 9034.0 11558.5 11881.2 12017.6 10461.5 10501.6 10561.2 10562.8 11017.5 10036.2 10111.1 10296.0 10354.9 10414.6 10290.5 10444.5 10635.8 10921.3 11018.7 7762.9 7805.3 7982.0 8171.3 8260.7 9509.6 10230.4 10273.5 10405.0 10434.0 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - PROCESS | 27499 | [#3] mootools.html Cycles:180 Average:5020.92 Median:5457.21 stddev:2702.02 (49.5%) stddev-sans-first:2696.65 04:48:30 INFO - PROCESS | 27499 | Values: 1500.7 1503.1 1684.6 1832.9 1846.1 6374.0 7207.7 7234.7 7674.1 7674.8 7306.2 7465.9 7537.4 7539.5 7550.2 2224.2 2247.7 2261.9 2263.2 2267.9 2144.1 2155.8 2193.1 2245.7 2265.1 2218.8 2225.9 2234.7 2237.1 2271.0 2129.4 2132.0 2134.9 2142.7 2149.3 2123.2 2137.3 2142.9 2146.8 2158.5 7523.1 7566.3 7597.1 7601.5 7621.5 4409.5 4510.8 4516.4 4532.0 4540.0 2813.4 2950.5 2959.4 2960.0 2960.4 902.2 924.7 929.2 977.1 981.6 9945.9 10004.8 10036.0 10044.6 10068.7 4132.8 4186.7 4235.9 4256.1 4278.8 8615.1 8673.1 8683.7 8710.2 8784.7 4479.6 4491.3 4501.4 4520.0 4527.9 3515.2 3869.7 3957.3 4086.4 4150.1 3576.4 3590.4 3679.1 3699.7 3701.9 1187.8 1210.3 1217.7 1218.5 1226.5 859.8 870.4 882.5 893.5 912.1 5268.4 5397.1 5517.3 5556.8 5608.2 843.9 878.8 910.9 925.3 954.3 3568.8 3577.4 3619.3 3673.6 3757.4 8852.1 9191.8 9243.0 9266.0 9321.0 9061.1 9064.6 9073.5 9103.9 9164.4 7071.9 7153.5 7210.8 7217.5 7227.7 4925.2 5094.1 5117.7 5221.8 5230.8 8473.1 8486.6 8503.1 8565.3 8661.7 8199.8 8464.7 8469.5 8693.4 8707.1 6300.3 6781.6 7019.6 7094.9 7155.2 6955.3 6968.7 7029.6 7061.0 7065.9 6332.7 6630.5 6686.5 6792.5 6826.5 6520.9 6564.3 6623.9 6644.7 6692.2 6248.6 6316.7 6340.9 6355.8 6361.9 4355.8 4360.9 4469.1 4597.7 4657.1 4740.5 4745.8 4758.7 4762.4 4809.3 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - PROCESS | 27499 | [#4] prototype.html Cycles:180 Average:4269.49 Median:4885.47 stddev:1217.78 (24.9%) stddev-sans-first:1184.31 04:48:30 INFO - PROCESS | 27499 | Values: 306.7 314.0 319.5 319.6 319.9 4791.7 4822.3 4929.2 4968.4 4972.7 4812.6 4886.8 4908.3 4918.4 4937.1 3919.2 3931.9 3939.5 3948.5 3951.7 3708.9 3926.7 3927.1 3944.7 3956.8 3829.9 3831.7 3865.5 3875.9 3887.3 3880.6 3881.6 3882.0 3932.4 3933.3 3491.8 3500.6 3516.0 3524.2 3526.8 4565.9 4689.3 4695.1 4759.5 4775.5 4385.2 4405.4 4423.2 4433.0 4435.3 5117.5 5125.4 5131.6 5132.8 5184.3 3709.6 3724.3 3765.1 3781.4 3789.8 5386.2 5398.6 5413.6 5452.9 5462.4 3886.9 3889.2 3906.0 3907.2 3915.4 3934.5 3939.9 3941.9 3943.3 3959.5 4246.4 4372.5 4375.6 4408.0 4430.6 5091.7 5141.2 5177.5 5181.5 5206.8 1246.2 1284.6 1314.6 1322.3 1324.2 921.9 925.6 929.8 931.2 940.6 4305.2 4351.6 4352.1 4368.9 4382.9 5127.9 5138.2 5142.8 5147.0 5148.7 4310.6 4359.7 4377.3 4383.8 4406.1 2598.7 2798.9 2804.9 2812.5 2813.1 4926.8 4945.0 4951.2 4972.2 4975.7 5185.6 5331.7 5349.6 5373.7 5407.8 4861.8 4903.7 4904.5 4939.3 4939.7 5231.8 5244.0 5256.2 5275.9 5293.7 5048.4 5061.4 5163.6 5199.1 5232.7 4884.1 4920.0 4941.6 4949.8 4964.2 3633.3 3644.8 3645.2 3662.5 3695.9 5018.6 5223.8 5242.3 5269.0 5318.0 4989.4 5039.0 5053.3 5084.0 5125.5 5000.7 5037.7 5053.8 5060.0 5067.7 4811.6 4920.9 4965.9 4970.9 5137.8 5218.9 5243.1 5251.4 5253.9 5273.8 5100.9 5116.1 5137.9 5147.0 5147.5 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - PROCESS | 27499 | [#5] yui.html Cycles:180 Average:11926.43 Median:6484.27 stddev:13970.49 (215.5%) stddev-sans-first:13984.62 04:48:30 INFO - PROCESS | 27499 | Values: 784.6 807.7 809.3 811.6 826.5 11015.7 11549.2 11561.2 11624.1 11649.3 12169.1 12172.9 12207.5 12228.9 12247.0 660.6 840.5 849.4 861.2 862.6 858.8 858.9 859.4 860.4 861.9 904.2 908.3 908.4 909.7 913.1 890.7 898.1 899.6 905.6 907.0 661.8 663.5 663.6 663.9 664.9 11487.5 11550.5 11580.4 11590.9 11618.1 10995.2 11042.1 11427.8 11452.2 11885.4 9598.6 9600.7 9812.5 9840.1 9973.1 4172.3 4175.6 4193.6 4196.3 4395.3 40524.6 40652.0 40957.0 44637.4 44949.8 9189.9 9221.6 9756.3 9883.4 9919.1 16730.4 16756.7 16778.3 16786.2 16825.9 6479.0 6489.5 6503.5 6610.1 6682.3 3253.9 3282.5 3291.9 3360.4 3420.9 2843.7 2884.4 2890.8 2917.5 2924.9 528.1 531.4 531.6 542.6 545.9 399.3 443.0 521.2 530.6 536.0 7124.8 7229.8 7246.3 7347.0 7528.1 568.7 581.4 593.1 600.5 636.6 3442.7 3475.2 3569.5 3572.6 3637.1 48824.8 49460.0 49467.0 50627.5 51355.7 46000.5 47109.8 47707.0 48095.8 48198.5 40877.0 41563.0 41763.6 42127.8 42802.6 6776.7 6800.4 6852.0 6892.4 7057.3 27129.0 27669.7 28447.3 28733.9 28750.6 34284.5 34376.4 36989.4 37186.6 37482.8 8749.7 8856.7 9214.1 9259.2 9332.7 8753.3 8829.9 8832.9 8854.0 9539.3 8588.8 8809.3 8818.9 8991.6 9122.1 8601.7 8728.0 8734.5 8870.1 8969.7 8546.3 8596.8 8635.1 8660.6 8734.5 7332.9 7517.0 7556.4 7600.1 7716.9 7537.4 7541.5 7704.5 7813.7 7942.8 04:48:30 INFO - PROCESS | 27499 | -------- Summary: end -------- 04:48:30 INFO - PROCESS | 27499 | 04:48:30 INFO - TEST-INFO | 27499: exit 0 04:48:30 INFO - TEST-OK | dromaeo_css | took 1116079ms 04:48:30 INFO - TEST-START | kraken 04:48:30 INFO - operating with platform_type : linux_ 04:48:30 INFO - Initialising browser for kraken test... 04:48:30 INFO - TEST-INFO | started process 27736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAJ9_e/profile http://localhost:40049/getInfo.html) 04:48:35 INFO - PROCESS | 27736 | 04:48:35 INFO - PROCESS | 27736 | (process:27803): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:48:35 INFO - PROCESS | 27736 | __metrics Screen width/height:1600/1200 04:48:35 INFO - PROCESS | 27736 | colorDepth:24 04:48:35 INFO - PROCESS | 27736 | Browser inner width/height: 1024/697 04:48:35 INFO - PROCESS | 27736 | __metrics 04:48:36 ERROR - PROCESS | 27736 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:48:37 INFO - TEST-INFO | 27736: exit 0 04:48:37 INFO - Browser initialized. 04:48:37 INFO - Running cycle 1/1 for kraken test... 04:48:37 INFO - TEST-INFO | started process 27854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAJ9_e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:39 INFO - PROCESS | 27854 | 04:48:39 INFO - PROCESS | 27854 | (process:27917): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:48:49 INFO - PROCESS | 27854 | RSS: Main: 163909632 04:48:49 INFO - PROCESS | 27854 | 04:48:52 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40049/tests/kraken/driver.html?testName=audio-beat-detection) 04:48:53 INFO - PROCESS | 27854 | RSS: Main: 167464960 04:48:53 INFO - PROCESS | 27854 | 04:48:56 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40049/tests/kraken/driver.html?testName=audio-dft) 04:48:56 INFO - PROCESS | 27854 | RSS: Main: 167739392 04:48:56 INFO - PROCESS | 27854 | 04:48:59 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40049/tests/kraken/driver.html?testName=audio-fft) 04:49:00 INFO - PROCESS | 27854 | RSS: Main: 164323328 04:49:00 INFO - PROCESS | 27854 | 04:49:02 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40049/tests/kraken/driver.html?testName=audio-oscillator) 04:49:03 INFO - PROCESS | 27854 | RSS: Main: 164171776 04:49:03 INFO - PROCESS | 27854 | 04:49:05 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:49:06 INFO - PROCESS | 27854 | RSS: Main: 164421632 04:49:06 INFO - PROCESS | 27854 | 04:49:09 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40049/tests/kraken/driver.html?testName=imaging-darkroom) 04:49:10 INFO - PROCESS | 27854 | RSS: Main: 164270080 04:49:10 INFO - PROCESS | 27854 | 04:49:13 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40049/tests/kraken/driver.html?testName=imaging-desaturate) 04:49:14 INFO - PROCESS | 27854 | RSS: Main: 163520512 04:49:14 INFO - PROCESS | 27854 | 04:49:17 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40049/tests/kraken/driver.html?testName=json-parse-financial) 04:49:18 INFO - PROCESS | 27854 | RSS: Main: 163491840 04:49:18 INFO - PROCESS | 27854 | 04:49:19 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:20 INFO - PROCESS | 27854 | RSS: Main: 163889152 04:49:20 INFO - PROCESS | 27854 | 04:49:22 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40049/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:49:23 INFO - PROCESS | 27854 | RSS: Main: 164859904 04:49:23 INFO - PROCESS | 27854 | 04:49:25 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:49:26 INFO - PROCESS | 27854 | RSS: Main: 164749312 04:49:26 INFO - PROCESS | 27854 | 04:49:29 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:49:29 INFO - PROCESS | 27854 | RSS: Main: 164941824 04:49:29 INFO - PROCESS | 27854 | 04:49:32 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:49:33 INFO - PROCESS | 27854 | RSS: Main: 164691968 04:49:33 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | Cycle 1(1): loaded http://localhost:40049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40049/tests/kraken/driver.html?testName=ai-astar) 04:49:35 INFO - PROCESS | 27854 | RSS: Main: 167202816 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | __start_tp_report 04:49:35 INFO - PROCESS | 27854 | _x_x_mozilla_page_load 04:49:35 INFO - PROCESS | 27854 | _x_x_mozilla_page_load_details 04:49:35 INFO - PROCESS | 27854 | |i|pagename|runs| 04:49:35 INFO - PROCESS | 27854 | |0;ai-astar;112;116;107;116;116;116;109;116;116;116 04:49:35 INFO - PROCESS | 27854 | |1;audio-beat-detection;171;133;161;219;140;157;153;139;180;136 04:49:35 INFO - PROCESS | 27854 | |2;audio-dft;162;166;186;168;167;167;165;166;165;165 04:49:35 INFO - PROCESS | 27854 | |3;audio-fft;77;78;78;171;78;77;77;77;157;79 04:49:35 INFO - PROCESS | 27854 | |4;audio-oscillator;94;93;173;94;93;94;149;95;95;148 04:49:35 INFO - PROCESS | 27854 | |5;imaging-gaussian-blur;118;117;118;118;118;118;118;117;120;118 04:49:35 INFO - PROCESS | 27854 | |6;imaging-darkroom;148;148;148;148;148;148;148;147;148;148 04:49:35 INFO - PROCESS | 27854 | |7;imaging-desaturate;95;95;95;96;95;96;96;96;96;96 04:49:35 INFO - PROCESS | 27854 | |8;json-parse-financial;68;70;69;69;72;70;68;68;68;69 04:49:35 INFO - PROCESS | 27854 | |9;json-stringify-tinderbox;65;66;65;67;65;66;66;66;65;65 04:49:35 INFO - PROCESS | 27854 | |10;stanford-crypto-aes;83;87;86;82;83;83;86;83;144;83 04:49:35 INFO - PROCESS | 27854 | |11;stanford-crypto-ccm;139;136;136;133;134;134;144;145;150;139 04:49:35 INFO - PROCESS | 27854 | |12;stanford-crypto-pbkdf2;179;172;174;173;172;174;178;171;175;182 04:49:35 INFO - PROCESS | 27854 | |13;stanford-crypto-sha256-iterative;69;71;70;69;71;69;70;67;69;67 04:49:35 INFO - PROCESS | 27854 | __end_tp_report 04:49:35 INFO - PROCESS | 27854 | __start_cc_report 04:49:35 INFO - PROCESS | 27854 | _x_x_mozilla_cycle_collect,933 04:49:35 INFO - PROCESS | 27854 | __end_cc_report 04:49:35 INFO - PROCESS | 27854 | __startTimestamp1462794575334__endTimestamp 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | ------- Summary: start ------- 04:49:35 INFO - PROCESS | 27854 | Number of tests: 14 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#0] ai-astar Cycles:10 Average:114.00 Median:116.00 stddev:3.43 (3.0%) stddev-sans-first:3.56 04:49:35 INFO - PROCESS | 27854 | Values: 112.0 116.0 107.0 116.0 116.0 116.0 109.0 116.0 116.0 116.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#1] audio-beat-detection Cycles:10 Average:158.90 Median:159.00 stddev:26.24 (16.5%) stddev-sans-first:27.46 04:49:35 INFO - PROCESS | 27854 | Values: 171.0 133.0 161.0 219.0 140.0 157.0 153.0 139.0 180.0 136.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#2] audio-dft Cycles:10 Average:167.70 Median:166.50 stddev:6.63 (4.0%) stddev-sans-first:6.71 04:49:35 INFO - PROCESS | 27854 | Values: 162.0 166.0 186.0 168.0 167.0 167.0 165.0 166.0 165.0 165.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#3] audio-fft Cycles:10 Average:94.90 Median:77.50 stddev:36.57 (47.2%) stddev-sans-first:38.21 04:49:35 INFO - PROCESS | 27854 | Values: 77.0 78.0 78.0 171.0 78.0 77.0 77.0 77.0 157.0 79.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:94.00 stddev:31.00 (33.0%) stddev-sans-first:32.13 04:49:35 INFO - PROCESS | 27854 | Values: 94.0 93.0 173.0 94.0 93.0 94.0 149.0 95.0 95.0 148.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 04:49:35 INFO - PROCESS | 27854 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 120.0 118.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:49:35 INFO - PROCESS | 27854 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 148.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:49:35 INFO - PROCESS | 27854 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 04:49:35 INFO - PROCESS | 27854 | Values: 68.0 70.0 69.0 69.0 72.0 70.0 68.0 68.0 68.0 69.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 04:49:35 INFO - PROCESS | 27854 | Values: 65.0 66.0 65.0 67.0 65.0 66.0 66.0 66.0 65.0 65.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:83.00 stddev:19.05 (23.0%) stddev-sans-first:20.04 04:49:35 INFO - PROCESS | 27854 | Values: 83.0 87.0 86.0 82.0 83.0 83.0 86.0 83.0 144.0 83.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:139.00 stddev:5.64 (4.1%) stddev-sans-first:5.98 04:49:35 INFO - PROCESS | 27854 | Values: 139.0 136.0 136.0 133.0 134.0 134.0 144.0 145.0 150.0 139.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:174.50 stddev:3.56 (2.0%) stddev-sans-first:3.47 04:49:35 INFO - PROCESS | 27854 | Values: 179.0 172.0 174.0 173.0 172.0 174.0 178.0 171.0 175.0 182.0 04:49:35 INFO - PROCESS | 27854 | 04:49:35 INFO - PROCESS | 27854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.40 (2.0%) stddev-sans-first:1.48 04:49:35 INFO - PROCESS | 27854 | Values: 69.0 71.0 70.0 69.0 71.0 69.0 70.0 67.0 69.0 67.0 04:49:35 INFO - PROCESS | 27854 | -------- Summary: end -------- 04:49:35 INFO - PROCESS | 27854 | 04:49:36 INFO - TEST-INFO | 27854: exit 0 04:49:36 INFO - TEST-OK | kraken | took 65493ms 04:49:36 INFO - SUITE-END | took 1181s 04:49:36 INFO - Completed test suite (00:19:41) 04:49:36 INFO - javascript benchmark 04:49:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.0728245114215, 2695.609136675183, 2719.9048033318827, 2736.0834120569607, 2745.327394788277, 4681.8127274909, 4776.90446191076, 4816.686915350504, 4879.3656824612835, 4946.035523073002, 4716.0, 4770.499097594746, 4806.495317991613, 4811.13399588074, 4898.853034408973, 4438.5561443855595, 4496.842610508633, 4610.147122782279, 4610.792514336863, 4649.093426781762, 589.4669152124568, 4308.870733877989, 4420.40324556184, 4449.354843547683, 4451.087527056946, 4454.042380888109, 4477.283634618478, 4489.528599497038, 4499.415076040126, 4519.954800451987, 4444.888877778049, 4498.775061246957, 4509.301058335963, 4509.368688383629, 4516.683832131752, 4328.112736888962, 4334.154839806239, 4350.456192975878, 4362.323839804835, 4389.517153113155, 4629.097326021427, 4710.646701497401, 4742.905141897143, 4755.857324280242, 4771.928421073687, 5099.796008159669, 5188.403333616645, 5208.791648334062, 5211.088059589594, 5237.711925844077, 5144.717040562768, 5179.249008893727, 5179.300794392747, 5200.219967004941, 5227.60792940531, 4769.66612337133, 4801.399825021872, 4826.300186472942, 4843.951560484421, 4871.732054736953, 5293.7353132344, 5376.838694839161, 5387.649802762808, 5398.91901621476, 5439.592030597721, 5085.059264036091, 5105.33630628016, 5118.513741194581, 5124.5131712487255, 5127.179651255781, 5191.117510023305, 5191.870203244949, 5222.164453687392, 5227.032998895216, 5237.135872581058, 4975.701457912537, 5088.618353623493, 5092.745362731923, 5113.565346945476, 5137.229415587692, 5111.897762044739, 5117.053345131163, 5123.205903085028, 5154.072266991902, 5181.896362072737, 4317.913641727211, 4382.364557139197, 4383.276759334738, 4407.338899165151, 4451.599356057905, 3815.4849095372324, 3837.9232415352094, 3858.7298889077497, 3884.6309600587897, 3891.3579259422445, 4326.58897404746, 4402.229609818269, 4465.508794032654, 4499.1451624191295, 4507.639388848885, 5242.108841496878, 5258.316418865599, 5258.710770907637, 5259.316288882497, 5307.867303317448, 4331.7834108294455, 4475.328700694922, 4495.3032279996, 4497.977510112429, 4521.683482156218, 4723.527647235249, 4725.267583524559, 4734.384530011145, 4735.83424580138, 4752.453467851172, 4893.779779909913, 4966.975165124151, 4980.103581355318, 4981.128302547112, 5037.773300201573, 5109.386873575046, 5213.947860521498, 5218.347706536683, 5246.160614301693, 5290.232916227049, 4863.051704917507, 4907.337509436323, 4924.261360795909, 4925.359703238556, 4963.429205641398, 4939.802407903644, 5090.796368145381, 5094.363204599425, 5106.719130447861, 5111.769970351269, 5256.605754568499, 5270.8155214567305, 5315.893682126413, 5322.281491998686, 5331.253624492651, 5114.4374118847645, 5147.176451767699, 5148.099082660594, 5159.922601160911, 5217.713025783618, 4904.509549045067, 5006.324146240357, 5114.744262786771, 5127.53852153308, 5128.1794912813775, 4933.457319694759, 4939.259111133359, 4992.2511623256805, 5025.0452414042675, 5084.440711521804, 5070.163423035158, 5131.153359695609, 5132.563732082815, 5141.974290128525, 5187.740612969412, 4878.804847806048, 4945.2582112683385, 5001.899962000667, 5004.974975125101, 5007.37407824022], "value": 4739.942431781074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.2052713302146, 598.8472939400453, 607.3228350389318, 613.4938675592635, 630.2657404124195, 35289.0, 39817.40273895894, 39884.80057599711, 39947.40078898812, 39963.0, 40181.0, 40771.59228407715, 40793.38809917853, 40898.0, 40953.18093638133, 7727.574983375926, 7777.611119444034, 7837.8824317635, 7925.207479252086, 7953.761387158365, 7741.5355078695175, 7782.727604533842, 7786.961065194666, 7821.37429005681, 7893.486923349992, 7797.610119494031, 7810.0627924649125, 7817.6091195440285, 7842.803929901769, 7896.763097107096, 7715.074191097048, 7758.922410775876, 7874.212578742137, 7883.7240696575345, 7909.802254943644, 7819.648115834744, 7841.9215807841765, 7844.294013538752, 7859.685612575548, 7922.049354077548, 30208.24479388011, 37767.24465510674, 37957.810210948766, 37970.81014594937, 38084.23831523354, 3189.5534625152495, 3233.0, 3354.295597924439, 3409.7783644063056, 3437.656234376542, 27142.32144196391, 27430.862845685842, 28453.146405607866, 29296.50979666731, 30482.390352192833, 3264.7061764441078, 3271.263965607743, 3304.9173770655925, 3309.851056702454, 3333.6499667535045, 248708.0, 254282.0, 254818.0, 256077.0, 256422.71788641124, 35143.0, 36295.4555681665, 58780.41219587835, 59888.40111598915, 60218.39781602128, 36437.08907277286, 36464.81767591145, 36597.634023659426, 36791.26417471636, 36806.815965919996, 12682.746345073047, 12768.489260429664, 12853.93573032129, 12869.549565765341, 12900.161489503153, 9777.46223957675, 9783.706488805346, 9862.802743945082, 9881.0, 9989.150922171697, 8439.57802109892, 8487.830243395098, 8549.529775862264, 8580.0, 8657.264132548804, 3320.675527131018, 3423.9828800855835, 3441.2429265561536, 3457.4122399192197, 3471.7396195285455, 968.1093394077466, 975.5561219645044, 994.5922171909627, 1017.6489111256604, 1047.9468134524755, 29024.129276121752, 29203.73377431991, 29264.853675731913, 29312.26719332034, 29514.0, 1008.5713571732131, 1031.1441503552035, 1038.6053299746047, 1046.895310468947, 1122.9719257018476, 15559.377624894878, 15600.14199219031, 15646.0, 15789.684206316038, 15971.201439927958, 386339.0, 387296.0, 390381.0, 390437.0, 391267.0, 51995.74002130041, 52253.0, 52499.21251181235, 52607.0, 52791.0, 1231.6612931443924, 1258.9999999999816, 1270.707737220426, 1272.923624582528, 1282.4036822877406, 26625.467490650466, 28060.438791223653, 28101.297467563476, 28680.856595716887, 28720.71279287264, 43695.34456983084, 43844.78077609592, 44114.55885441104, 44195.77902110469, 44220.33669494896, 314525.0, 315056.0, 315093.0, 315682.0, 315887.0, 26603.467930641666, 26628.866855665598, 27122.0, 27167.04915327954, 27231.59152612673, 43279.567204328814, 43364.78317608392, 43391.34912976371, 43534.129317412844, 44649.33026004677, 36495.27009459743, 36502.45246321254, 36529.63470365262, 36707.63292367042, 37319.25361492809, 36579.634203657624, 36595.359568775704, 36620.26759464849, 36651.816740916125, 37011.259774804894, 32033.839830800698, 36765.08087297732, 37086.44370334393, 37600.81199593985, 37665.0, 31273.530897037017, 33535.83232083824, 33567.83216083904, 33778.15554611056, 34126.0, 25534.489310214063, 25712.485750285265, 25733.742662573884, 25753.227403177934, 26304.8684756575], "value": 16809.81231284644, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.94525821126837, 373.67676959430094, 376.12926076133766, 389.1186462662069, 390.62109753539073, 16072.51782446527, 17178.5705357366, 17730.82269177308, 17963.0, 18021.819781802194, 10524.315919465229, 11045.668629941094, 11057.06014988725, 11390.886091139086, 11416.600418985337, 4578.702384345007, 4740.525947405258, 5330.040592693314, 5337.546308563777, 5341.1187154119525, 5292.523672869441, 5299.443558426367, 5307.150855863063, 5312.654677445954, 5342.98483288174, 4845.394325709286, 4857.34425852509, 4873.342098816667, 4891.388576427947, 5338.252644629755, 4792.7124372537755, 4803.615710743132, 4841.515848415148, 4855.5872750816225, 4866.562009419152, 4541.72749635023, 4746.644001699852, 4751.7624118794265, 4772.498887616785, 4775.856724298276, 12469.438875250635, 12503.812442813365, 12539.184952978027, 12554.874451255462, 18116.365927192484, 1939.360011196302, 1990.5322249271555, 2003.2387692676834, 2036.470517665403, 2052.7434070741156, 8905.465672059632, 9277.35058545902, 9325.44047357154, 9628.889650956444, 9790.657326993522, 1748.0997286397514, 1762.647470505904, 1769.78762548495, 1828.3874901907743, 1872.906354682274, 67553.0, 70874.0, 71668.28331716669, 72956.63521682358, 73125.63437182833, 9481.857772133424, 9484.90515094854, 9520.952395237979, 9695.369800962915, 9804.705858824247, 13122.737545249041, 13148.0, 13180.0, 13272.668183295302, 13308.667283317995, 6931.896021559681, 6957.199922009034, 7010.404115650125, 7011.684474198673, 7105.715771369088, 6457.709403076873, 6594.307597702268, 6741.8651626967185, 6786.117804685458, 6799.796006119825, 3923.92152156961, 4033.7983100845427, 4046.846648705105, 4086.7139300248696, 4521.598304525608, 1712.5547357686842, 1720.0, 1819.581496255842, 1880.4922670878786, 1963.5385684364162, 888.4846788862444, 901.8421776189141, 958.8945216026232, 973.99026009739, 975.1175186456269, 16484.6703065938, 17121.82878171202, 17130.914345428195, 17146.82853171477, 17388.82611173872, 899.581694512055, 914.2046419614844, 917.655879045358, 934.1125930366179, 964.2864280432569, 8856.114388561222, 9395.0, 9535.2371810255, 9553.283503737248, 9600.56585258944, 357756.0, 366156.0, 394384.0, 396700.0, 409455.0, 82064.17935820685, 82701.58649206716, 83155.0, 83678.58160709158, 84385.57807211047, 1015.8019186258756, 1034.5448002878559, 1048.2033654422542, 1071.8017166824163, 1073.0, 14829.555113346616, 15155.0, 15226.923865380602, 15270.083794972337, 15431.0, 34298.82850585731, 34562.82718586492, 34741.82629086838, 35571.11072223215, 36433.0, 51373.48626513687, 52072.73963630309, 52232.21651675152, 52270.73864630653, 52599.0, 7677.0, 7720.845583088195, 7912.762617121495, 7944.245296696805, 8020.278174964281, 8494.872576911228, 9033.96109447422, 11558.479868405773, 11881.22772019816, 12017.579384721494, 10461.476926153815, 10501.579936802747, 10561.155107591221, 10562.788744225227, 11017.504212310625, 10036.19710423179, 10111.090001899864, 10296.0, 10354.948225258826, 10414.583416663552, 10290.536925838205, 10444.477776111316, 10635.840462392916, 10921.344719316867, 11018.669439916815, 7762.88355674654, 7805.297523222937, 7982.0, 8171.264586187272, 8260.669573217005, 9509.619615215313, 10230.386176829117, 10273.537690804082, 10405.011523905217, 10434.0], "value": 8005.771676236356, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.6623509710314, 1503.0530765617661, 1684.6209602839363, 1832.8533717302616, 1846.1415441819552, 6373.968130159355, 7207.711691532339, 7234.674439650215, 7674.079110506733, 7674.769756907288, 7306.159791623965, 7465.850682986337, 7537.397008239342, 7539.472236943416, 7550.169481357047, 2224.232639739287, 2247.7302723673183, 2261.8869056547187, 2263.219189379661, 2267.9092836286527, 2144.0887622760342, 2155.795199456049, 2193.0898677049086, 2245.6631505274177, 2265.0939624150305, 2218.811401030914, 2225.877576733279, 2234.709487766588, 2237.1163390460756, 2270.9780598730554, 2129.446343950584, 2132.0, 2134.935951921445, 2142.667886477591, 2149.312220089572, 2123.161351266241, 2137.326742076241, 2142.8607140535814, 2146.7638559758416, 2158.4711745622267, 7523.134839493474, 7566.319031287156, 7597.050368703912, 7601.467897247195, 7621.504602200839, 4409.536998615164, 4510.774461276923, 4516.41286632739, 4531.977340113312, 4540.0, 2813.366992426688, 2950.542665886791, 2959.422912532057, 2960.0, 2960.437516871809, 902.1609902790402, 924.6809850601531, 929.1916033051222, 977.1498796047413, 981.6073570571757, 9945.85081223775, 10004.849927251023, 10036.046575575381, 10044.598216071348, 10068.748281292954, 4132.834686612502, 4186.6859985501205, 4235.915281694349, 4256.084941737541, 4278.764667943293, 8615.052344242129, 8673.089325620718, 8683.696070637498, 8710.172533609297, 8784.736457906272, 4479.574440428154, 4491.30384790358, 4501.369808226851, 4520.0, 4527.886802829889, 3515.191505953645, 3869.671077958405, 3957.2876882160913, 4086.366613174963, 4150.1284730207, 3576.3741345264475, 3590.425531914881, 3679.1354031802507, 3699.7040236780995, 3701.9444708329397, 1187.7565099154654, 1210.2919791921825, 1217.7260116473722, 1218.5186851193905, 1226.47874653272, 859.7592674051276, 870.4429165334191, 882.5278476015301, 893.5398269891011, 912.0970239463016, 5268.394134674485, 5397.082495975615, 5517.337919449692, 5556.77772889088, 5608.242887210256, 843.9071702112763, 878.8022694893598, 910.886139232596, 925.3430064654171, 954.3319676226669, 3568.7858728476376, 3577.4276115821344, 3619.3485172668647, 3673.571250311954, 3757.3988161893967, 8852.114788521225, 9191.816163676824, 9242.953785231031, 9266.0, 9321.021292764297, 9061.13919177677, 9064.637414503346, 9073.45559266433, 9103.863442048374, 9164.358494905426, 7071.8939215911805, 7153.4992550522, 7210.819729506699, 7217.530860494051, 7227.674754636054, 4925.16272233714, 5094.108531006985, 5117.74411279442, 5221.791128354976, 5230.764615592231, 8473.110323415953, 8486.618102185294, 8503.107173746668, 8565.27195188416, 8661.696840610548, 8199.795005124919, 8464.746057618282, 8469.491830490191, 8693.434926729742, 8707.129287071242, 6300.306966233802, 6781.6270105144695, 7019.613921234177, 7094.858102838018, 7155.248698886542, 6955.304469553206, 6968.65156742171, 7029.613371264425, 7060.964695176492, 7065.858682826212, 6332.715027823667, 6630.46956243509, 6686.531942764154, 6792.524523283323, 6826.453883689393, 6520.902186467112, 6564.310747371648, 6623.900641490478, 6644.671065786765, 6692.230393504809, 6248.625082495065, 6316.652584107918, 6340.873182536416, 6355.777547785805, 6361.8727625448155, 4355.803988820448, 4360.9345859812765, 4469.128519938581, 4597.7011494252765, 4657.115148121846, 4740.502247263988, 4745.810167593258, 4758.738269395078, 4762.380890484214, 4809.326694262736], "value": 4110.7363657767655, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.6534815658307, 313.9811611303322, 319.52231414036015, 319.61646024770255, 319.9360127974406, 4791.712497250168, 4822.276658501227, 4929.162042452783, 4968.378952630921, 4972.7265000425, 4812.566868981791, 4886.804527818883, 4908.263760435936, 4918.434380046296, 4937.061958227943, 3919.157381163049, 3931.862384816532, 3939.4681717968137, 3948.4669569608095, 3951.664108550762, 3708.9443658345144, 3926.725129240954, 3927.0967677434205, 3944.7435916665468, 3956.8417263309434, 3829.9084760843166, 3831.7126215533945, 3865.4781604483314, 3875.8643447479344, 3887.319719049169, 3880.6223790554227, 3881.5536213335404, 3882.0007696036564, 3932.4494570760116, 3933.2920074386598, 3491.8428670709877, 3500.6499350065046, 3515.964840351615, 3524.207053412987, 3526.7531272810916, 4565.863024109282, 4689.320048592969, 4695.131400690849, 4759.50025247351, 4775.474697783241, 4385.188740083095, 4405.3612226227015, 4423.208600516796, 4433.0, 4435.334699795024, 5117.48825117489, 5125.436202017812, 5131.563817075553, 5132.794688212467, 5184.274201611777, 3709.5516958807057, 3724.255148970217, 3765.1340191755776, 3781.3760729479604, 3789.829457674411, 5386.218998245272, 5398.6220964532495, 5413.593980451443, 5452.945470545284, 5462.371827239839, 3886.902827429337, 3889.1638297766117, 3906.003968987947, 3907.159960608426, 3915.373540233606, 3934.468846705658, 3939.940900886489, 3941.881743547698, 3943.3493473577114, 3959.48526691534, 4246.395806028809, 4372.540883207281, 4375.628071613948, 4407.986163182486, 4430.556944305544, 5091.694498330112, 5141.203113517411, 5177.4822517747925, 5181.455947125498, 5206.791728330824, 1246.2335663566842, 1284.5504073574175, 1314.6327819068063, 1322.2529270961875, 1324.1591589340837, 921.9124183202586, 925.6019911438146, 929.7629104578424, 931.1852129386787, 940.6049459227141, 4305.182015417061, 4351.586599273064, 4352.107817897323, 4368.868933931987, 4382.868513944587, 5127.9230811537855, 5138.177891537336, 5142.794288228429, 5147.0, 5148.716820574904, 4310.590493903074, 4359.7111516454115, 4377.277749171415, 4383.7808109595035, 4406.1187762447635, 2598.7126285249174, 2798.902038428686, 2804.8920676332737, 2812.521871281846, 2813.0998080614418, 4926.807570631035, 4944.975275123673, 4951.183054795918, 4972.179590367549, 4975.651704380731, 5185.585153187736, 5331.694349503333, 5349.646155691484, 5373.731313434391, 5407.782809048272, 4861.80552777892, 4903.705777653352, 4904.485029071968, 4939.3084968104495, 4939.703617782944, 5231.843044708665, 5244.0, 5256.186615617606, 5275.920861187008, 5293.708846013352, 5048.3941926969, 5061.367329083864, 5163.561097306771, 5199.050356116456, 5232.738363081907, 4884.145274576864, 4919.975400122977, 4941.629377796751, 4949.752512374439, 4964.230544265644, 3633.3278343506536, 3644.781313121221, 3645.2478378823816, 3662.5238718966366, 3695.9260814783015, 5018.573421259088, 5223.7910483580235, 5242.344706911636, 5269.0, 5317.973410132925, 4989.426215985063, 5038.974805125951, 5053.29253904461, 5084.0, 5125.461826508312, 5000.699958002531, 5037.672551284155, 5053.797848086182, 5059.974700126476, 5067.670601410897, 4811.591014763784, 4920.901581968269, 4965.92112889996, 4970.8757281068265, 5137.845864624067, 5218.946916054151, 5243.060067774948, 5251.4245726282725, 5253.947460525345, 5273.841784746463, 5100.948990510047, 5116.107040394929, 5137.944822071052, 5146.974265128651, 5147.536721694915], "value": 3887.8630216068054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.6312233250372, 807.6688557691348, 809.2554849538424, 811.6063709101088, 826.4586695714307, 11015.724606884822, 11549.191556591042, 11561.190716649839, 11624.070074394049, 11649.301041937479, 12169.087318451107, 12172.878271217285, 12207.450664720087, 12228.93885530571, 12247.0, 660.5640277416906, 840.5209030852417, 849.4096602860999, 861.2033868671485, 862.5773371048203, 858.7681326041965, 858.9269912057482, 859.3554833874595, 860.4493124400389, 861.8621020636699, 904.1726819959729, 908.2915326045662, 908.4276905549494, 909.727081875438, 913.0914739833875, 890.7060669978891, 898.1018981018981, 899.6491368366343, 905.5653286422554, 907.0022974727813, 661.7749965011919, 663.5222639699409, 663.598522893652, 663.8937769956832, 664.8504086580481, 11487.483063262172, 11550.480228389742, 11580.363080030595, 11590.942045289805, 11618.128640352008, 10995.175361847814, 11042.116630669527, 11427.828582571268, 11452.198346115776, 11885.40572971348, 9598.616055357847, 9600.66397676078, 9812.46031468269, 9840.11438970496, 9973.102420782165, 4172.269852775752, 4175.603317684815, 4193.622573968327, 4196.349565817303, 4395.252807022814, 40524.59475405267, 40652.0, 40957.0, 44637.43768968071, 44949.775251123865, 9189.862152067724, 9221.631134754669, 9756.317057805885, 9883.357581757164, 9919.057689519484, 16730.4144354947, 16756.748648770033, 16778.328866845433, 16786.244618992176, 16825.91587042057, 6479.0, 6489.545731798823, 6503.544751867324, 6610.0745895574655, 6682.331766823376, 3253.8861139860464, 3282.5404443377947, 3291.901242962715, 3360.3615313090436, 3420.9144771380916, 2843.6871944086133, 2884.3798583304692, 2890.7976441649303, 2917.5331946888396, 2924.9122526324245, 528.0811388184532, 531.3889027618193, 531.5720844720038, 542.6310109125753, 545.9454054594509, 399.2872722190875, 443.0253442426674, 521.1999580643694, 530.6100016487878, 535.9866003349947, 7124.786256412316, 7229.783106506813, 7246.347828695337, 7346.96326518364, 7528.096628404626, 568.6559631423012, 581.4360070731468, 593.0896074525582, 600.540586451365, 636.6053047110821, 3442.6557344265375, 3475.2354482013916, 3569.5181150544345, 3572.5534308211472, 3637.136978713279, 48824.75587622039, 49460.0, 49467.0, 50627.48117556479, 51355.74322128366, 46000.539994599625, 47109.76445117821, 47707.0, 48095.75952120217, 48198.5180148201, 40877.0, 41563.0, 41763.58236417597, 42127.789361053, 42802.57197427986, 6776.6950487227205, 6800.421964133104, 6851.9657401712675, 6892.448604111559, 7057.294270572902, 27129.0, 27669.723302766713, 28447.28881777972, 28733.856330718212, 28750.568741468476, 34284.48573271353, 34376.421768367974, 36989.445158323186, 37186.62813371832, 37482.812585936896, 8749.737507874774, 8856.734297971072, 9214.078592140731, 9259.166674999282, 9332.673356432493, 8753.255973242345, 8829.867551986854, 8832.867506987528, 8853.955730221307, 9539.332246742939, 8588.828223435621, 8809.251213646912, 8818.86771698438, 8991.55042247898, 9122.087791220825, 8601.741947741577, 8728.0, 8734.475931444134, 8870.112988701077, 8969.686060987835, 8546.316294696286, 8596.78508037304, 8635.136486351315, 8660.566971651519, 8734.47593144388, 7332.853342933005, 7517.0, 7556.433267505069, 7600.125985511516, 7716.884246736416, 7537.434692398202, 7541.5475071495885, 7704.499207551491, 7813.726519571787, 7942.8085787132395], "value": 5605.621799648409, "unit": "score"}], "name": "dromaeo_css", "value": 6206.40381769118, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 107.0, 116.0, 116.0, 116.0, 109.0, 116.0, 116.0, 116.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 133.0, 161.0, 219.0, 140.0, 157.0, 153.0, 139.0, 180.0, 136.0], "value": 158.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 186.0, 168.0, 167.0, 167.0, 165.0, 166.0, 165.0, 165.0], "value": 167.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 171.0, 78.0, 77.0, 77.0, 77.0, 157.0, 79.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 173.0, 94.0, 93.0, 94.0, 149.0, 95.0, 95.0, 148.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 120.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 69.0, 72.0, 70.0, 68.0, 68.0, 68.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 67.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 86.0, 82.0, 83.0, 83.0, 86.0, 83.0, 144.0, 83.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 136.0, 133.0, 134.0, 134.0, 144.0, 145.0, 150.0, 139.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 172.0, 174.0, 173.0, 172.0, 174.0, 178.0, 171.0, 175.0, 182.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 70.0, 69.0, 71.0, 69.0, 70.0, 67.0, 69.0, 67.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1617.6999999999998, "alertThreshold": 2.0}]} 04:49:36 INFO - Return code: 0 04:49:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:49:36 ERROR - # TBPL SUCCESS # 04:49:36 INFO - Running post-action listener: _resource_record_post_action 04:49:36 INFO - ##### 04:49:36 INFO - ##### Finished run-tests step (success) 04:49:36 INFO - ##### 04:49:36 INFO - Running post-run listener: _resource_record_post_run 04:49:37 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 309198848; Read time: 8; Write time: 300408 04:49:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20381696; Read time: 0; Write time: 10408 04:49:37 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 288817152; Read time: 8; Write time: 290000 04:49:37 INFO - Running post-run listener: _upload_blobber_files 04:49:37 INFO - Blob upload gear active. 04:49:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:49:37 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 04:49:37 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'] 04:49:37 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 04:49:38 INFO - (blobuploader) - INFO - Open directory for files ... 04:49:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:49:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:49:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:40 INFO - (blobuploader) - INFO - Done attempting. 04:49:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:49:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:49:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:42 INFO - (blobuploader) - INFO - Done attempting. 04:49:42 INFO - (blobuploader) - INFO - Iteration through files over. 04:49:42 INFO - Return code: 0 04:49:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:49:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:49:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbad7e6df56cacc85395dffa6f39aa130a34617acfe19d99e26ea23550b443226cb2d91f2e5256bcc8cac4efd31ec9eacecfdefc0a42886c011787a306fc76ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a46af442f4ee9444dc08c036009f2771ed92c2a8d8749ed70208630a163b2c42d067e37c1b74f6932bff9d8dc94596a1a02d9bfd21dcc12f5e0bc5c761dbb5e0"} 04:49:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:49:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:49:42 INFO - Contents: 04:49:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbad7e6df56cacc85395dffa6f39aa130a34617acfe19d99e26ea23550b443226cb2d91f2e5256bcc8cac4efd31ec9eacecfdefc0a42886c011787a306fc76ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a46af442f4ee9444dc08c036009f2771ed92c2a8d8749ed70208630a163b2c42d067e37c1b74f6932bff9d8dc94596a1a02d9bfd21dcc12f5e0bc5c761dbb5e0"} 04:49:42 INFO - Running post-run listener: copy_logs_to_upload_dir 04:49:42 INFO - Copying logs to upload dir... 04:49:42 INFO - mkdir: /builds/slave/test/build/upload/logs 04:49:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.490193 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-09 04:49:39.315549) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:49:39.318960) ========= 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=52faae308a556c440401f8e5000001e8-1462793314.799158-274072716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbad7e6df56cacc85395dffa6f39aa130a34617acfe19d99e26ea23550b443226cb2d91f2e5256bcc8cac4efd31ec9eacecfdefc0a42886c011787a306fc76ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a46af442f4ee9444dc08c036009f2771ed92c2a8d8749ed70208630a163b2c42d067e37c1b74f6932bff9d8dc94596a1a02d9bfd21dcc12f5e0bc5c761dbb5e0"} build_url:https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/RafteCDxS_q8BVNucrrx3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbad7e6df56cacc85395dffa6f39aa130a34617acfe19d99e26ea23550b443226cb2d91f2e5256bcc8cac4efd31ec9eacecfdefc0a42886c011787a306fc76ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a46af442f4ee9444dc08c036009f2771ed92c2a8d8749ed70208630a163b2c42d067e37c1b74f6932bff9d8dc94596a1a02d9bfd21dcc12f5e0bc5c761dbb5e0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:49:39.343858) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:49:39.344167) ========= 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=52faae308a556c440401f8e5000001e8-1462793314.799158-274072716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:49:39.426252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:49:39.426572) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:49:39.426862) ========= ========= Total master_lag: 0.14 =========