builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1461683248.51 results: success (0) buildid: 20160426053023 builduid: 4a526f94997c4e24b8426c59657e9d0d revision: 38b63eafc2cad07afeb86f0349f8eddf370e829a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.509568) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.510147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.510483) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.527922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.528515) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 08:07:28-- 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% 225M=0s 2016-04-26 08:07:28 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.627441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.627766) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.677573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:28.677958) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 38b63eafc2cad07afeb86f0349f8eddf370e829a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 38b63eafc2cad07afeb86f0349f8eddf370e829a --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=5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 08:07:28,912 truncating revision to first 12 chars 2016-04-26 08:07:28,912 Setting DEBUG logging. 2016-04-26 08:07:28,912 attempt 1/10 2016-04-26 08:07:28,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/38b63eafc2ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 08:07:29,215 unpacking tar archive at: fx-team-38b63eafc2ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:29.298818) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:29.299199) ========= script_repo_revision: 38b63eafc2cad07afeb86f0349f8eddf370e829a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:29.299654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:29.299979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 08:07:29.307861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-26 08:07:29.308166) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:29 INFO - MultiFileLogger online at 20160426 08:07:29 in /builds/slave/test 08:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:29 INFO - {'append_to_log': False, 08:07:29 INFO - 'base_work_dir': '/builds/slave/test', 08:07:29 INFO - 'blob_upload_branch': 'Fx-Team', 08:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:29 INFO - 'branch': 'Fx-Team', 08:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:29 INFO - 'config_files': ('talos/linux_config.py',), 08:07:29 INFO - 'default_actions': ('clobber', 08:07:29 INFO - 'read-buildbot-config', 08:07:29 INFO - 'download-and-extract', 08:07:29 INFO - 'populate-webroot', 08:07:29 INFO - 'create-virtualenv', 08:07:29 INFO - 'install', 08:07:29 INFO - 'run-tests'), 08:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:29 INFO - 'download_minidump_stackwalk': True, 08:07:29 INFO - 'download_symbols': 'ondemand', 08:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:29 INFO - 'installer_path': 'installer.exe', 08:07:29 INFO - 'log_level': 'info', 08:07:29 INFO - 'log_name': 'talos', 08:07:29 INFO - 'log_to_console': True, 08:07:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:29 INFO - 'opt_config_files': (), 08:07:29 INFO - 'pip_index': False, 08:07:29 INFO - 'sps_profile': False, 08:07:29 INFO - 'sps_profile_interval': 0, 08:07:29 INFO - 'suite': 'dromaeojs-e10s', 08:07:29 INFO - 'system_bits': '32', 08:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:29 INFO - 'title': 'talos-linux64-ix-011', 08:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:29 INFO - 'use_talos_json': True, 08:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:29 INFO - 'work_dir': 'build'} 08:07:29 INFO - ##### 08:07:29 INFO - ##### Running clobber step. 08:07:29 INFO - ##### 08:07:29 INFO - Running pre-action listener: _resource_record_pre_action 08:07:29 INFO - Running main action method: clobber 08:07:29 INFO - rmtree: /builds/slave/test/build 08:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - ##### 08:07:30 INFO - ##### Running read-buildbot-config step. 08:07:30 INFO - ##### 08:07:30 INFO - Running pre-action listener: _resource_record_pre_action 08:07:30 INFO - Running main action method: read_buildbot_config 08:07:30 INFO - Using buildbot properties: 08:07:30 INFO - { 08:07:30 INFO - "project": "", 08:07:30 INFO - "product": "firefox", 08:07:30 INFO - "script_repo_revision": "production", 08:07:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:07:30 INFO - "repository": "", 08:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:07:30 INFO - "buildid": "20160426053023", 08:07:30 INFO - "pgo_build": "True", 08:07:30 INFO - "basedir": "/builds/slave/test", 08:07:30 INFO - "buildnumber": 694, 08:07:30 INFO - "slavename": "talos-linux64-ix-011", 08:07:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:07:30 INFO - "platform": "ubuntu64_hw", 08:07:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:07:30 INFO - "branch": "fx-team", 08:07:30 INFO - "repo_path": "integration/fx-team", 08:07:30 INFO - "revision": "38b63eafc2cad07afeb86f0349f8eddf370e829a", 08:07:30 INFO - "stage_platform": "linux64-pgo", 08:07:30 INFO - "builduid": "4a526f94997c4e24b8426c59657e9d0d", 08:07:30 INFO - "slavebuilddir": "test" 08:07:30 INFO - } 08:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - ##### 08:07:30 INFO - ##### Running download-and-extract step. 08:07:30 INFO - ##### 08:07:30 INFO - Running pre-action listener: _resource_record_pre_action 08:07:30 INFO - Running main action method: download_and_extract 08:07:30 INFO - mkdir: /builds/slave/test/build/tests 08:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:30 INFO - https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:31 INFO - Downloaded 1361 bytes. 08:07:31 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:07:31 INFO - Using the following test package requirements: 08:07:31 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:31 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:31 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:31 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'jsshell-linux-x86_64.zip'], 08:07:31 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:31 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:31 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:31 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:31 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:31 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:31 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')]} 08:07:31 INFO - https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:33 INFO - Downloaded 23863536 bytes. 08:07:33 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'] 08:07:33 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 08:07:34 INFO - Return code: 0 08:07:34 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 08:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:34 INFO - https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:46 INFO - Downloaded 23863536 bytes. 08:07:46 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'] 08:07:46 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 08:07:48 INFO - Return code: 0 08:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:48 INFO - https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:50 INFO - Downloaded 10840145 bytes. 08:07:50 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'] 08:07:50 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 08:07:51 INFO - Return code: 0 08:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:51 INFO - https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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 08:07:52 INFO - Downloaded 58359706 bytes. 08:07:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:52 INFO - mkdir: /builds/slave/test/properties 08:07:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:07:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:07:52 INFO - Contents: 08:07:52 INFO - build_url:https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:53 INFO - Running post-action listener: _resource_record_post_action 08:07:53 INFO - Running post-action listener: set_extra_try_arguments 08:07:53 INFO - ##### 08:07:53 INFO - ##### Running populate-webroot step. 08:07:53 INFO - ##### 08:07:53 INFO - Running pre-action listener: _resource_record_pre_action 08:07:53 INFO - Running main action method: populate_webroot 08:07:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:53 INFO - '--tppagecycles', 08:07:53 INFO - '7'], 08:07:53 INFO - 'tests': ['tsvgm']}}, 08:07:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:07:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:07:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:53 INFO - 'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:53 INFO - 'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['damp', 'tps']}, 08:07:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:53 INFO - 'tests': ['damp', 'tps']}, 08:07:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['dromaeo_dom']}, 08:07:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['a11yr', 08:07:53 INFO - 'ts_paint', 08:07:53 INFO - 'tpaint', 08:07:53 INFO - 'sessionrestore', 08:07:53 INFO - 'sessionrestore_no_auto_restore', 08:07:53 INFO - 'tabpaint']}, 08:07:53 INFO - 'other-e10s': {'tests': ['a11yr', 08:07:53 INFO - 'ts_paint', 08:07:53 INFO - 'tpaint', 08:07:53 INFO - 'sessionrestore', 08:07:53 INFO - 'sessionrestore_no_auto_restore', 08:07:53 INFO - 'tabpaint']}, 08:07:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:07:53 INFO - 'ts_paint', 08:07:53 INFO - 'tpaint', 08:07:53 INFO - 'sessionrestore', 08:07:53 INFO - 'sessionrestore_no_auto_restore', 08:07:53 INFO - 'tabpaint']}, 08:07:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:07:53 INFO - 'ts_paint', 08:07:53 INFO - 'tpaint', 08:07:53 INFO - 'sessionrestore', 08:07:53 INFO - 'sessionrestore_no_auto_restore', 08:07:53 INFO - 'tabpaint']}, 08:07:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['a11yr', 08:07:53 INFO - 'ts_paint', 08:07:53 INFO - 'tpaint', 08:07:53 INFO - 'sessionrestore', 08:07:53 INFO - 'sessionrestore_no_auto_restore', 08:07:53 INFO - 'tabpaint']}, 08:07:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['a11yr', 08:07:53 INFO - 'ts_paint', 08:07:53 INFO - 'tpaint', 08:07:53 INFO - 'sessionrestore', 08:07:53 INFO - 'sessionrestore_no_auto_restore', 08:07:53 INFO - 'tabpaint']}, 08:07:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['tsvgx', 08:07:53 INFO - 'tsvgr_opacity', 08:07:53 INFO - 'tart', 08:07:53 INFO - 'tscrollx', 08:07:53 INFO - 'cart']}, 08:07:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:07:53 INFO - 'tsvgr_opacity', 08:07:53 INFO - 'tart', 08:07:53 INFO - 'tscrollx', 08:07:53 INFO - 'cart']}, 08:07:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:53 INFO - 'talos_options': ['--disable-e10s'], 08:07:53 INFO - 'tests': ['tp5o']}, 08:07:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:53 INFO - 'tests': ['tp5o']}, 08:07:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:53 INFO - 'talos_options': ['--disable-e10s', 08:07:53 INFO - '--xperf_path', 08:07:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:53 INFO - 'tests': ['tp5n']}, 08:07:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:53 INFO - 'talos_options': ['--xperf_path', 08:07:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:53 INFO - 'tests': ['tp5n']}}, 08:07:53 INFO - 'talos.zip': {'path': '', 08:07:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:53 INFO - Running post-action listener: _resource_record_post_action 08:07:53 INFO - ##### 08:07:53 INFO - ##### Running create-virtualenv step. 08:07:53 INFO - ##### 08:07:53 INFO - Running pre-action listener: _resource_record_pre_action 08:07:53 INFO - Running main action method: create_virtualenv 08:07:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:53 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 08:07:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:53 INFO - Using real prefix '/usr' 08:07:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:07:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:56 INFO - Installing pip.................done. 08:07:56 INFO - Return code: 0 08:07:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07:56 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')]} 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:56 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')]} 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:56 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 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:07:56 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 08:07:56 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 08:07:56 INFO - Using env: {'DISPLAY': ':0', 08:07:56 INFO - 'HOME': '/home/cltbld', 08:07:56 INFO - 'LANG': 'en_US.UTF-8', 08:07:56 INFO - 'LANGUAGE': 'en_US:en', 08:07:56 INFO - 'LOGNAME': 'cltbld', 08:07:56 INFO - 'MAIL': '/var/mail/cltbld', 08:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:56 INFO - 'MOZ_NO_REMOTE': '1', 08:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:56 INFO - 'NO_EM_RESTART': '1', 08:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:56 INFO - 'PWD': '/builds/slave/test', 08:07:56 INFO - 'SHELL': '/bin/bash', 08:07:56 INFO - 'SHLVL': '1', 08:07:56 INFO - 'TERM': 'linux', 08:07:56 INFO - 'TMOUT': '86400', 08:07:56 INFO - 'USER': 'cltbld', 08:07:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:56 INFO - '_': '/tools/buildbot/bin/python'} 08:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:56 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 08:07:56 INFO - Cleaning up... 08:07:56 INFO - Return code: 0 08:07:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:07:56 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')]} 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:56 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')]} 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:56 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 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:07:56 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 08:07:56 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 08:07:56 INFO - Using env: {'DISPLAY': ':0', 08:07:56 INFO - 'HOME': '/home/cltbld', 08:07:56 INFO - 'LANG': 'en_US.UTF-8', 08:07:56 INFO - 'LANGUAGE': 'en_US:en', 08:07:56 INFO - 'LOGNAME': 'cltbld', 08:07:56 INFO - 'MAIL': '/var/mail/cltbld', 08:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:56 INFO - 'MOZ_NO_REMOTE': '1', 08:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:56 INFO - 'NO_EM_RESTART': '1', 08:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:56 INFO - 'PWD': '/builds/slave/test', 08:07:56 INFO - 'SHELL': '/bin/bash', 08:07:56 INFO - 'SHLVL': '1', 08:07:56 INFO - 'TERM': 'linux', 08:07:56 INFO - 'TMOUT': '86400', 08:07:56 INFO - 'USER': 'cltbld', 08:07:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:56 INFO - '_': '/tools/buildbot/bin/python'} 08:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:56 INFO - Downloading/unpacking psutil>=0.7.1 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:58 INFO - Installing collected packages: psutil 08:07:58 INFO - Running setup.py install for psutil 08:07:58 INFO - building 'psutil._psutil_linux' extension 08:07:58 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 08:07:58 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 08:07:58 INFO - building 'psutil._psutil_posix' extension 08:07:58 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 08:07:58 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 08:07:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:59 INFO - Successfully installed psutil 08:07:59 INFO - Cleaning up... 08:07:59 INFO - Return code: 0 08:07:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 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 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:07:59 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 08:07:59 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 08:07:59 INFO - Using env: {'DISPLAY': ':0', 08:07:59 INFO - 'HOME': '/home/cltbld', 08:07:59 INFO - 'LANG': 'en_US.UTF-8', 08:07:59 INFO - 'LANGUAGE': 'en_US:en', 08:07:59 INFO - 'LOGNAME': 'cltbld', 08:07:59 INFO - 'MAIL': '/var/mail/cltbld', 08:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:59 INFO - 'MOZ_NO_REMOTE': '1', 08:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:59 INFO - 'NO_EM_RESTART': '1', 08:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:59 INFO - 'PWD': '/builds/slave/test', 08:07:59 INFO - 'SHELL': '/bin/bash', 08:07:59 INFO - 'SHLVL': '1', 08:07:59 INFO - 'TERM': 'linux', 08:07:59 INFO - 'TMOUT': '86400', 08:07:59 INFO - 'USER': 'cltbld', 08:07:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:59 INFO - '_': '/tools/buildbot/bin/python'} 08:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:07:59 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 08:07:59 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 08:07:59 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 08:07:59 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 08:07:59 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 08:07:59 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 08:08:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:08:01 INFO - Installing collected packages: mozsystemmonitor 08:08:01 INFO - Running setup.py install for mozsystemmonitor 08:08:01 INFO - Successfully installed mozsystemmonitor 08:08:01 INFO - Cleaning up... 08:08:01 INFO - Return code: 0 08:08:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:01 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')]} 08:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:01 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')]} 08:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:01 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 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:08:01 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 08:08:01 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 08:08:01 INFO - Using env: {'DISPLAY': ':0', 08:08:01 INFO - 'HOME': '/home/cltbld', 08:08:01 INFO - 'LANG': 'en_US.UTF-8', 08:08:01 INFO - 'LANGUAGE': 'en_US:en', 08:08:01 INFO - 'LOGNAME': 'cltbld', 08:08:01 INFO - 'MAIL': '/var/mail/cltbld', 08:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:01 INFO - 'MOZ_NO_REMOTE': '1', 08:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:01 INFO - 'NO_EM_RESTART': '1', 08:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:01 INFO - 'PWD': '/builds/slave/test', 08:08:01 INFO - 'SHELL': '/bin/bash', 08:08:01 INFO - 'SHLVL': '1', 08:08:01 INFO - 'TERM': 'linux', 08:08:01 INFO - 'TMOUT': '86400', 08:08:01 INFO - 'USER': 'cltbld', 08:08:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:01 INFO - '_': '/tools/buildbot/bin/python'} 08:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:04 INFO - Downloading docopt-0.6.1.tar.gz 08:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:04 INFO - Running setup.py install for blobuploader 08:08:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:04 INFO - Running setup.py install for requests 08:08:04 INFO - Running setup.py install for docopt 08:08:04 INFO - Successfully installed blobuploader requests docopt 08:08:04 INFO - Cleaning up... 08:08:04 INFO - Return code: 0 08:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 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 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:08:04 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 08:08:04 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 08:08:04 INFO - Using env: {'DISPLAY': ':0', 08:08:04 INFO - 'HOME': '/home/cltbld', 08:08:04 INFO - 'LANG': 'en_US.UTF-8', 08:08:04 INFO - 'LANGUAGE': 'en_US:en', 08:08:04 INFO - 'LOGNAME': 'cltbld', 08:08:04 INFO - 'MAIL': '/var/mail/cltbld', 08:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:04 INFO - 'MOZ_NO_REMOTE': '1', 08:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:04 INFO - 'NO_EM_RESTART': '1', 08:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:04 INFO - 'PWD': '/builds/slave/test', 08:08:04 INFO - 'SHELL': '/bin/bash', 08:08:04 INFO - 'SHLVL': '1', 08:08:04 INFO - 'TERM': 'linux', 08:08:04 INFO - 'TMOUT': '86400', 08:08:04 INFO - 'USER': 'cltbld', 08:08:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:04 INFO - '_': '/tools/buildbot/bin/python'} 08:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:05 INFO - Running setup.py (path:/tmp/pip-KiYEcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:05 INFO - Running setup.py (path:/tmp/pip-Xie1QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:05 INFO - Running setup.py (path:/tmp/pip-TUK0XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:05 INFO - Running setup.py (path:/tmp/pip-5LslnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:05 INFO - Running setup.py (path:/tmp/pip-k0n_FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:05 INFO - Running setup.py (path:/tmp/pip-di_5_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:05 INFO - Running setup.py (path:/tmp/pip-3UP3Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:05 INFO - Running setup.py (path:/tmp/pip-mD_y_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:05 INFO - Running setup.py (path:/tmp/pip-vaWe8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:05 INFO - Running setup.py (path:/tmp/pip-62WP0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:05 INFO - Running setup.py (path:/tmp/pip-yuTREF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:05 INFO - Running setup.py (path:/tmp/pip-v1wdYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:05 INFO - Running setup.py (path:/tmp/pip-IR_Mn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:06 INFO - Running setup.py (path:/tmp/pip-tMIeZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:06 INFO - Running setup.py (path:/tmp/pip-eMqiiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:06 INFO - Running setup.py (path:/tmp/pip-SQGRAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:06 INFO - Running setup.py (path:/tmp/pip-BzpS__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:06 INFO - Running setup.py install for manifestparser 08:08:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:06 INFO - Running setup.py install for mozcrash 08:08:06 INFO - Running setup.py install for mozdebug 08:08:06 INFO - Running setup.py install for mozdevice 08:08:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:08:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:06 INFO - Running setup.py install for mozfile 08:08:06 INFO - Running setup.py install for mozhttpd 08:08:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:06 INFO - Running setup.py install for mozinfo 08:08:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Running setup.py install for mozInstall 08:08:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Running setup.py install for mozleak 08:08:07 INFO - Running setup.py install for mozlog 08:08:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Running setup.py install for moznetwork 08:08:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Running setup.py install for mozprocess 08:08:07 INFO - Running setup.py install for mozprofile 08:08:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Running setup.py install for mozrunner 08:08:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Running setup.py install for mozscreenshot 08:08:07 INFO - Running setup.py install for moztest 08:08:08 INFO - Running setup.py install for mozversion 08:08:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:08 INFO - Cleaning up... 08:08:08 INFO - Return code: 0 08:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:08 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 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:08:08 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 08:08:08 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 08:08:08 INFO - Using env: {'DISPLAY': ':0', 08:08:08 INFO - 'HOME': '/home/cltbld', 08:08:08 INFO - 'LANG': 'en_US.UTF-8', 08:08:08 INFO - 'LANGUAGE': 'en_US:en', 08:08:08 INFO - 'LOGNAME': 'cltbld', 08:08:08 INFO - 'MAIL': '/var/mail/cltbld', 08:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:08 INFO - 'MOZ_NO_REMOTE': '1', 08:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:08 INFO - 'NO_EM_RESTART': '1', 08:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:08 INFO - 'PWD': '/builds/slave/test', 08:08:08 INFO - 'SHELL': '/bin/bash', 08:08:08 INFO - 'SHLVL': '1', 08:08:08 INFO - 'TERM': 'linux', 08:08:08 INFO - 'TMOUT': '86400', 08:08:08 INFO - 'USER': 'cltbld', 08:08:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:08 INFO - '_': '/tools/buildbot/bin/python'} 08:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:08 INFO - Running setup.py (path:/tmp/pip-6Tg9oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:08 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)) 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:08 INFO - Running setup.py (path:/tmp/pip-ZeHR8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:08 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)) 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:08 INFO - Running setup.py (path:/tmp/pip-qHpB7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:08 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)) 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:08 INFO - Running setup.py (path:/tmp/pip-DVldw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:08 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)) 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:08 INFO - Running setup.py (path:/tmp/pip-lOIvdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:08 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)) 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:08 INFO - Running setup.py (path:/tmp/pip-_39qx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:08 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)) 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:08 INFO - Running setup.py (path:/tmp/pip-SMfcfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:08 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)) 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:08 INFO - Running setup.py (path:/tmp/pip-Moa6q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:09 INFO - Running setup.py (path:/tmp/pip-M9fCa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:09 INFO - Running setup.py (path:/tmp/pip-9Hdgsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:09 INFO - Running setup.py (path:/tmp/pip-fuM4JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:09 INFO - Running setup.py (path:/tmp/pip-4iLBha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:09 INFO - Running setup.py (path:/tmp/pip-dsCVev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:09 INFO - Running setup.py (path:/tmp/pip-B1yaAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:09 INFO - Running setup.py (path:/tmp/pip-fHGVAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:09 INFO - Running setup.py (path:/tmp/pip-mAV8Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:09 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)) 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:09 INFO - Running setup.py (path:/tmp/pip-GOAp8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:09 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)) 08:08:09 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)) 08:08:09 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)) 08:08:09 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)) 08:08:09 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)) 08:08:09 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)) 08:08:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:11 INFO - Downloading blessings-1.6.tar.gz 08:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:11 INFO - Installing collected packages: blessings 08:08:11 INFO - Running setup.py install for blessings 08:08:11 INFO - Successfully installed blessings 08:08:11 INFO - Cleaning up... 08:08:11 INFO - Return code: 0 08:08:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:12 INFO - Reading from file tmpfile_stdout 08:08:12 INFO - Current package versions: 08:08:12 INFO - argparse == 1.2.1 08:08:12 INFO - blessings == 1.6 08:08:12 INFO - blobuploader == 1.2.4 08:08:12 INFO - docopt == 0.6.1 08:08:12 INFO - manifestparser == 1.1 08:08:12 INFO - mozInstall == 1.12 08:08:12 INFO - mozcrash == 0.17 08:08:12 INFO - mozdebug == 0.1 08:08:12 INFO - mozdevice == 0.48 08:08:12 INFO - mozfile == 1.2 08:08:12 INFO - mozhttpd == 0.7 08:08:12 INFO - mozinfo == 0.9 08:08:12 INFO - mozleak == 0.1 08:08:12 INFO - mozlog == 3.1 08:08:12 INFO - moznetwork == 0.27 08:08:12 INFO - mozprocess == 0.22 08:08:12 INFO - mozprofile == 0.28 08:08:12 INFO - mozrunner == 6.11 08:08:12 INFO - mozscreenshot == 0.1 08:08:12 INFO - mozsystemmonitor == 0.0 08:08:12 INFO - moztest == 0.7 08:08:12 INFO - mozversion == 1.4 08:08:12 INFO - psutil == 3.1.1 08:08:12 INFO - requests == 1.2.3 08:08:12 INFO - wsgiref == 0.1.2 08:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:12 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')]} 08:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:12 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')]} 08:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:12 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 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:08:12 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 08:08:12 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 08:08:12 INFO - Using env: {'DISPLAY': ':0', 08:08:12 INFO - 'HOME': '/home/cltbld', 08:08:12 INFO - 'LANG': 'en_US.UTF-8', 08:08:12 INFO - 'LANGUAGE': 'en_US:en', 08:08:12 INFO - 'LOGNAME': 'cltbld', 08:08:12 INFO - 'MAIL': '/var/mail/cltbld', 08:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:12 INFO - 'MOZ_NO_REMOTE': '1', 08:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:12 INFO - 'NO_EM_RESTART': '1', 08:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:12 INFO - 'PWD': '/builds/slave/test', 08:08:12 INFO - 'SHELL': '/bin/bash', 08:08:12 INFO - 'SHLVL': '1', 08:08:12 INFO - 'TERM': 'linux', 08:08:12 INFO - 'TMOUT': '86400', 08:08:12 INFO - 'USER': 'cltbld', 08:08:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:12 INFO - '_': '/tools/buildbot/bin/python'} 08:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 INFO - Cleaning up... 08:08:12 INFO - Return code: 0 08:08:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:12 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')]} 08:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:12 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')]} 08:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:12 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 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:08:12 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 08:08:12 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 08:08:12 INFO - Using env: {'DISPLAY': ':0', 08:08:12 INFO - 'HOME': '/home/cltbld', 08:08:12 INFO - 'LANG': 'en_US.UTF-8', 08:08:12 INFO - 'LANGUAGE': 'en_US:en', 08:08:12 INFO - 'LOGNAME': 'cltbld', 08:08:12 INFO - 'MAIL': '/var/mail/cltbld', 08:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:12 INFO - 'MOZ_NO_REMOTE': '1', 08:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:12 INFO - 'NO_EM_RESTART': '1', 08:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:12 INFO - 'PWD': '/builds/slave/test', 08:08:12 INFO - 'SHELL': '/bin/bash', 08:08:12 INFO - 'SHLVL': '1', 08:08:12 INFO - 'TERM': 'linux', 08:08:12 INFO - 'TMOUT': '86400', 08:08:12 INFO - 'USER': 'cltbld', 08:08:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:12 INFO - '_': '/tools/buildbot/bin/python'} 08:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:12 INFO - Downloading/unpacking jsonschema 08:08:12 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 08:08:12 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 08:08:12 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 08:08:12 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 08:08:12 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 08:08:12 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 08:08:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:14 INFO - warning: no files found matching '*.txt' 08:08:14 INFO - no previously-included directories found matching 'build' 08:08:14 INFO - no previously-included directories found matching 'dist' 08:08:14 INFO - no previously-included directories found matching '.git*' 08:08:14 INFO - Installing collected packages: jsonschema, functools32 08:08:14 INFO - Running setup.py install for functools32 08:08:14 INFO - warning: no files found matching '*.txt' 08:08:14 INFO - no previously-included directories found matching 'build' 08:08:14 INFO - no previously-included directories found matching 'dist' 08:08:14 INFO - no previously-included directories found matching '.git*' 08:08:14 INFO - Successfully installed jsonschema functools32 08:08:14 INFO - Cleaning up... 08:08:14 INFO - Return code: 0 08:08:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29bdecdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', '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 08:08: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', 'flake8'] in /builds/slave/test/build 08:08: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 flake8 08:08:14 INFO - Using env: {'DISPLAY': ':0', 08:08:14 INFO - 'HOME': '/home/cltbld', 08:08:14 INFO - 'LANG': 'en_US.UTF-8', 08:08:14 INFO - 'LANGUAGE': 'en_US:en', 08:08:14 INFO - 'LOGNAME': 'cltbld', 08:08:14 INFO - 'MAIL': '/var/mail/cltbld', 08:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:14 INFO - 'MOZ_NO_REMOTE': '1', 08:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:14 INFO - 'NO_EM_RESTART': '1', 08:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:14 INFO - 'PWD': '/builds/slave/test', 08:08:14 INFO - 'SHELL': '/bin/bash', 08:08:14 INFO - 'SHLVL': '1', 08:08:14 INFO - 'TERM': 'linux', 08:08:14 INFO - 'TMOUT': '86400', 08:08:14 INFO - 'USER': 'cltbld', 08:08:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:14 INFO - '_': '/tools/buildbot/bin/python'} 08:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:15 INFO - Downloading/unpacking flake8 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 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 08:08:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:16 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 08:08:16 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 08:08:16 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 08:08:16 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 08:08:16 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 08:08:16 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 08:08:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:17 INFO - no previously-included directories found matching 'docs/_build' 08:08:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:17 INFO - Running setup.py install for pep8 08:08:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:17 INFO - no previously-included directories found matching 'docs/_build' 08:08:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:17 INFO - Cleaning up... 08:08:17 INFO - Return code: 0 08:08:17 INFO - Running post-action listener: _resource_record_post_action 08:08:17 INFO - Running post-action listener: _start_resource_monitoring 08:08:17 INFO - Starting resource monitoring. 08:08:17 INFO - ##### 08:08:17 INFO - ##### Running install step. 08:08:17 INFO - ##### 08:08:17 INFO - Running pre-action listener: _resource_record_pre_action 08:08:17 INFO - Running main action method: install 08:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:18 INFO - Reading from file tmpfile_stdout 08:08:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:18 INFO - Reading from file tmpfile_stdout 08:08:18 INFO - Output received: 08:08:18 INFO - Usage: mozinstall [options] installer 08:08:18 INFO - Options: 08:08:18 INFO - -h, --help show this help message and exit 08:08:18 INFO - -d DEST, --destination=DEST 08:08:18 INFO - Directory to install application into. [default: 08:08:18 INFO - "/builds/slave/test"] 08:08:18 INFO - --app=APP Application being installed. [default: firefox] 08:08:18 INFO - mkdir: /builds/slave/test/build/application 08:08:18 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'] 08:08:18 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 08:08:34 INFO - Reading from file tmpfile_stdout 08:08:34 INFO - Output received: 08:08:34 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:34 INFO - Running post-action listener: _resource_record_post_action 08:08:34 INFO - ##### 08:08:34 INFO - ##### Running run-tests step. 08:08:34 INFO - ##### 08:08:34 INFO - Running pre-action listener: _resource_record_pre_action 08:08:34 INFO - Running main action method: run_tests 08:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:34 INFO - Python 2.7.3 08:08:34 INFO - Return code: 0 08:08:34 INFO - grabbing minidump binary from tooltool 08:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:34 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 0x1266410>, '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 0x1267310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12677a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:34 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 08:08:34 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 08:08:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:34 INFO - Return code: 0 08:08:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:35 INFO - Return code: 0 08:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 08:08:35 INFO - Using env: {'DISPLAY': ':0', 08:08:35 INFO - 'HOME': '/home/cltbld', 08:08:35 INFO - 'LANG': 'en_US.UTF-8', 08:08:35 INFO - 'LANGUAGE': 'en_US:en', 08:08:35 INFO - 'LOGNAME': 'cltbld', 08:08:35 INFO - 'MAIL': '/var/mail/cltbld', 08:08:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:35 INFO - 'MOZ_NO_REMOTE': '1', 08:08:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:35 INFO - 'NO_EM_RESTART': '1', 08:08:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:35 INFO - 'PWD': '/builds/slave/test', 08:08:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:35 INFO - 'SHELL': '/bin/bash', 08:08:35 INFO - 'SHLVL': '1', 08:08:35 INFO - 'TERM': 'linux', 08:08:35 INFO - 'TMOUT': '86400', 08:08:35 INFO - 'USER': 'cltbld', 08:08:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743', 08:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:35 INFO - '_': '/tools/buildbot/bin/python'} 08:08:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:08:35 INFO - mozversion application_buildid: 20160426053023 08:08:35 INFO - mozversion application_changeset: 38b63eafc2cad07afeb86f0349f8eddf370e829a 08:08:35 INFO - mozversion application_display_name: Nightly 08:08:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:35 INFO - mozversion application_name: Firefox 08:08:35 INFO - mozversion application_remotingname: firefox 08:08:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:35 INFO - mozversion application_vendor: Mozilla 08:08:35 INFO - mozversion application_version: 49.0a1 08:08:35 INFO - mozversion platform_buildid: 20160426053023 08:08:35 INFO - mozversion platform_changeset: 38b63eafc2cad07afeb86f0349f8eddf370e829a 08:08:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:35 INFO - mozversion platform_version: 49.0a1 08:08:35 INFO - using testdate: 1461683315 08:08:35 INFO - actual date: 1461683315 08:08:35 INFO - starting webserver on 'localhost:57591' 08:08:35 INFO - SUITE-START | Running 2 tests 08:08:35 INFO - TEST-START | dromaeo_css 08:08:35 INFO - operating with platform_type : linux_ 08:08:35 INFO - Initialising browser for dromaeo_css test... 08:08:35 INFO - TEST-INFO | started process 27282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpguHrOx/profile http://localhost:57591/getInfo.html) 08:08:40 INFO - PROCESS | 27282 | 08:08:40 INFO - PROCESS | 27282 | (process:27347): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:08:41 INFO - PROCESS | 27282 | __metrics Screen width/height:1600/1200 08:08:41 INFO - PROCESS | 27282 | colorDepth:24 08:08:41 INFO - PROCESS | 27282 | Browser inner width/height: 1024/697 08:08:41 INFO - PROCESS | 27282 | __metrics 08:08:42 ERROR - PROCESS | 27282 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:08:43 INFO - TEST-INFO | 27282: exit 0 08:08:43 INFO - Browser initialized. 08:08:43 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:43 INFO - TEST-INFO | started process 27398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpguHrOx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:45 INFO - PROCESS | 27398 | 08:08:45 INFO - PROCESS | 27398 | (process:27459): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:08:55 INFO - PROCESS | 27398 | RSS: Main: 164667392 08:08:55 INFO - PROCESS | 27398 | 08:09:44 INFO - PROCESS | 27398 | 1461683384579 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] 08:11:52 INFO - PROCESS | 27398 | Cycle 1(1): loaded http://localhost:57591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57591/tests/dromaeo/cssquery-ext.html) 08:11:53 INFO - PROCESS | 27398 | RSS: Main: 167264256 08:11:53 INFO - PROCESS | 27398 | 08:14:55 INFO - PROCESS | 27398 | Cycle 1(1): loaded http://localhost:57591/tests/dromaeo/cssquery-ext.html (next: http://localhost:57591/tests/dromaeo/cssquery-jquery.html) 08:14:56 INFO - PROCESS | 27398 | RSS: Main: 166825984 08:14:56 INFO - PROCESS | 27398 | 08:17:58 INFO - PROCESS | 27398 | Cycle 1(1): loaded http://localhost:57591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57591/tests/dromaeo/cssquery-mootools.html) 08:17:58 INFO - PROCESS | 27398 | RSS: Main: 167575552 08:17:58 INFO - PROCESS | 27398 | 08:21:00 INFO - PROCESS | 27398 | Cycle 1(1): loaded http://localhost:57591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57591/tests/dromaeo/cssquery-prototype.html) 08:21:01 INFO - PROCESS | 27398 | RSS: Main: 165662720 08:21:01 INFO - PROCESS | 27398 | 08:24:03 INFO - PROCESS | 27398 | Cycle 1(1): loaded http://localhost:57591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57591/tests/dromaeo/cssquery-yui.html) 08:24:04 INFO - PROCESS | 27398 | RSS: Main: 166842368 08:24:04 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | Cycle 1(1): loaded http://localhost:57591/tests/dromaeo/cssquery-yui.html (next: http://localhost:57591/tests/dromaeo/cssquery-dojo.html) 08:27:06 INFO - PROCESS | 27398 | RSS: Main: 168751104 08:27:06 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | __start_tp_report 08:27:06 INFO - PROCESS | 27398 | _x_x_mozilla_page_load 08:27:06 INFO - PROCESS | 27398 | _x_x_mozilla_page_load_details 08:27:06 INFO - PROCESS | 27398 | |i|pagename|runs| 08:27:06 INFO - PROCESS | 27398 | |0;dojo.html;3132.2482604175;3182.458981973065;3182.8408579571014;3230.3054843208706;3237.838108094596;5466.863328416792;5468.644538105021;5468.972655136724;5479.232907392969;5534.28054352934;5416.9187462188;5426.375966763813;5476.123820188771;5543.805966791163;5556.305461817273;4916.065947469987;4942.382202224722;4998.250262460642;5017.071841709278;5086.31334769805;814.607656862536;4850.587700045483;4907.975460122712;4954.603631709455;4956.2565615157655;4943.826966056206;4965.106280869424;4979.10376132296;4979.8008079676765;5013.4234563025175;4985.451600323961;4998.125328067574;4999.575036121934;5015.724135172564;5055.140626093536;4832.855014349575;4898.53463920927;4930.950690493085;4944.9862778130755;4987.15218412867;5313.096773548467;5327.920081198785;5333.679979201261;5353.357597088374;5428.131498960148;5762.078067509178;5820.039693450575;5825.796097136622;5847.883042339172;5851.678157701324;5920.437558431942;5974.790882319098;5993.880122397528;5994.340622531518;6013.188219590343;5483.2049352844015;5593.440655934414;5599.972000140014;5606.719664016824;5608.495235428831;5821.708914554255;5822.272215973004;6106.236720409949;6115.602485838495;6128.662923539248;5781.855453613609;5784.971075144682;5785.652860828363;5797.159411885253;5831.475167234885;5849.941500585025;5857.502112320415;5859.882802343929;5861.560382971209;5870.765169393262;5691.715414229272;5736.4550367715;5808.186853840466;5813.651180929158;5895.086261629454;5786.218860453869;5796.94203057964;5820.796272130455;5826.82519524415;5851.356350801409;4397.934030989538;4414.249577571821;4417.160739459492;4425.09285596452;4459.487158976759;3850.3454412749898;3904.2386734586485;3970.920581588352;3973.165635216579;3995.9400608990886;5445.564354851682;5483;5513.117901135799;5542.085555883315;5583.3858275589655;5803.245578074823;5808.448197421323;5836.095405212199;5844.912326315109;5866.178734977107;5470.507654311131;5491.423400542965;5522.144067669517;5573.219749235111;5632.493075623213;4977.129002424561;4987.62592805541;4996.850094497171;4997.5002499749735;5042.798288068436;5978.701064946736;6008.819735407945;6035.909461358083;6039.456448919618;6050.546209034252;5738.799142030092;5796.188533605383;5883.382244864228;5910.586258961831;5945.137954996588;6076.756929722938;6081.847953801191;6083.574149809471;6084.148219249397;6096.1465394845645;5697.914531282117;5734.770609175753;5794.159846822272;5797.420257974338;5803.100519419497;5910.320313164041;5972.880542389041;5985.790497332572;6021.7591296347655;6024;5716.314042314949;5731.484166424875;5752;5752.050911599539;5762.279715035621;5539.944600553943;5609.607327487037;5736.110902810071;5739.655620662774;5753.05074662676;5621.409751975983;5640;5648.181013753065;5661.264035675335;5693.202951586698;5677.943220567741;5741.91387129185;5763.164341170591;5785.334686511105;5803.216565763737;5562.360328562106;5641.238432811518;5676.063449530946;5683.829485115453;5693.544516438592 08:27:06 INFO - PROCESS | 27398 | |1;ext.html;597.1580072098342;662.7812821768816;666.0409011024125;668.0680450771174;690.4579904774753;37210.81394593027;38169.23661526768;38263.42604860929;38459.42310865339;38469;38467.23065538688;38958.80520597393;39240.80379598098;39292.41061384082;39471.40792888109;8490.53302068386;8697.52163631;8706.434081784695;8709.34679899007;8714.215720585145;8590.098039705834;8591.914080859206;8616.698415555456;8665.826683466326;8714.302855771555;8645.69740059098;8722.86915696265;8724.171203735636;8732;8763.298936085097;8665.610047547843;8710.346723995694;8716.825663486758;8732;8742.256908162813;8526.275266602346;8622.3533235007;8636;8641.308695304424;8648.264897483721;30168.54747178794;36984;37511.43732844009;37526.62473375286;37605.62394376076;3287.088989741498;3309.172706823294;3407.539982102434;3413.9317213655836;3557.4130268505664;26990;27355.179344619693;27529.724702753116;27532.58701119485;28181.29546761327;4063.146739184745;4108.465899433055;4136.152088821785;4137.793110344501;4161.687873409506;186266;187860.12139878562;187862;188077;188157;32024.839875800473;32942.835285823414;33029.50455743166;34419.827900860335;34425.31149376999;33733.83133084319;33854.49218261728;34003.31993360119;34244;34283.314333713184;13859.168449893039;14133.646658833612;14134.434622615187;14149.71700565983;14169.78745318821;11053.723656908482;11271.774564508827;11325.716857078474;11348.262362946381;11386;8171.2237337454035;8235.341172706168;8244.587770611566;8264.504129752235;8290.626921788535;3282.950755738666;3290.6380298167182;3300.273939733255;3321.0202990117973;3339.782914110575;1123.1520202247414;1137.9146564007733;1157.9247348922293;1170.5317872850758;1193.2184419205435;31060.378792424024;31111.688883111332;31183.84408077945;31340.216494587363;31698.841505792323;1203.506562309449;1215.1068964311223;1229.1027549888631;1282.775514285015;1300.1678925487695;15890.81812102152;16554.917225413796;16585.50243492697;16660.16699165037;16677.828211424414;340197;343705;347837;347992;348475;54332.18501722477;55461.44538554644;55707.16439253414;55746;55755.442445575834;1388.0838646493266;1397.1407584335561;1419.0705088167267;1429.121090529317;1532.2185685300353;29588.704112958596;29796;30220.395592087596;30437;30913.536296955113;47525.28712069253;48363.75818120887;48650.756746217456;48974.75512622414;49231.50768492269;252237;256388;256768;256780;257798;41059.7947010263;41149.79425102855;41431.7928410356;41734;41757.58242417659;46013.76993115013;46732.53267467418;46811.76594117007;46973;47091.29363059488;39137.80431097826;39259.803700982455;39644.207115858095;40028.799856000536;40210;32874.17814554559;34047.48928766021;37092;37991.96064314903;38210.426843597925;35982.28035439329;36344.27311453809;37057.81471092627;37771.244575108896;38004;30457.695423045487;32197.51703724493;32228.35543289168;32341.191470212492;32700;26120.216393508224;26319.868400657873;26615.600765988915;26734.331641709112;28017.159485215478 08:27:06 INFO - PROCESS | 27398 | |2;jquery.html;398.3228511530399;404.4479285774917;404.88865561970454;407.1896925119012;407.8205589540604;16862.49412517625;17355.305787768473;17547.2103755331;17568.736468952975;19254.807451925477;18014.90992545039;18264.543386415346;18589.814101858978;18693.158807853644;18758.62482750344;5514.503694667479;5553.000459917213;5733.140028995663;5763.5101016413655;5768.134779783024;5626.578006649497;5631.774729010835;5653.406392328808;5682.886342273152;5685.374608793029;5413.945860541403;5552.222688823547;5563.332400111972;5637.548996080303;5664.490195882369;5595.272614560081;5622.100463925773;5628.718564071801;5642.971785141089;5663.943360566383;4834.371531700892;5023.372078490189;5104.259882317043;5113.130767769489;5124.92312615311;21170.470738231666;21177.364679059654;21289.787102128936;21926.89036554807;21988.560228795493;2264.207527365409;2361.9055237790467;2367.6093444581625;2437.171361737;2455.0670745116918;9009.909900900973;9505;9646.951765241129;9757.170640495566;11586.420678966102;1742.1550547984218;1857.8142185781448;1976.4268362175096;1987.175322241268;2119.13115622594;61021;61311;64519.67740161316;68572.31427685759;69979.30020699778;10065.4464004479;10229.590816367261;10286.434246116385;10567.682969510774;10588.15294776416;14289.42842286297;14319.427222910967;14329.57011289663;14418.279086045866;14450.421983120768;7598.278163574451;7811.80470488231;7936;8020.759377218693;8066.596670166468;7493.3256006958545;7522.736704215326;7622.428317876182;7626.885596716053;7692.923070769332;4426.136903303889;4550.249208880564;4593.448786145684;4617.515160908057;4807.086653535817;1971.9802801972085;1983.5735316906935;2000.6998950157592;2016.949576260576;2052.7434070741156;955.8900726416551;984.9113579777711;996.3473924579412;1113.8663360396642;1144.5593446522983;17053.066713150834;17531.824681753274;18063.819361806476;18186.27254909789;18255.087245637664;1008.6030847276428;1020.433659319085;1027.5870677818;1073.3988966178808;1152.0207823350254;10024.649137280307;10470.842937355947;10491.16070714341;10563.590724360525;10623.84064239037;498273;500616;513508;518071;519826;79581;80577.59711201406;81134;81326.59336703397;81739.5913020431;1063.4842101580728;1066.930649507764;1088.9183311251688;1106.419129956763;1122.0574717237396;15714.607134821721;15826.68346633084;15947.760783588488;16050.036997780171;16095.919520402324;35461.29077418386;36956.81521592375;37685.81157094197;38292.61707382891;38378.61621383862;49307.50692493029;51341.7432912848;51596.74201628968;52285.47714522806;53182.73408633087;8350.08149103586;8407.873881891654;8512.914870851213;8531.104234055583;8555.914440855511;10174.931632178515;12181.634550963485;12428.13003089775;12537.996960243341;12581.119321647762;11156.219064665396;11296.265742726697;11389.715257118307;11410.429478525875;11457;10987.450627468754;11319.717007074889;11364.204505684524;11546.19176657626;11551.133664974992;9055.68305109318;11248.887511124783;11422.600208992646;11483.368414736935;11602.825957610812;8352.248297653241;8597.699080532151;8634.09342019079;8656.26421754158;8783.956080219557;7965.322947549292;8040.638171282423;8089.2315230053055;8168.305694015838;8727.65089396417 08:27:06 INFO - PROCESS | 27398 | |3;mootools.html;1533.4939469974909;1540.5840423085767;1741.8258174182583;1797.5685835399509;1851.6296740651874;7641.2358764123555;8246.876296855544;8248.7937801555;8628.094050124733;8628.09405012474;8262.91737082629;8285.254327110559;8286.95856520718;8311.792205194874;8366.958165209166;2303.2053941390236;2372.406898275431;2375.5130198309307;2376.8930398132125;2380.0241900820665;2317.5249073939804;2349.3304408243566;2376.061455724988;2385.6183010718287;2387.7373488916205;2335.602947498929;2366.408397900525;2373.1219448803968;2382.1662418153683;2394.2338451695464;2302.689136966513;2307.123293148593;2310.9831674063444;2321.3268152235914;2332.300309907021;2309.5380923815137;2311.1448763957274;2312.595295823224;2317.8145748340094;2323.384303159664;8417.873731894026;8421.789455263668;8441.915580844174;8459.619317130682;8496.405251632388;4915.188993816016;5286.762095705702;5295.258663787073;5297.761600727977;5314.123169677037;3402;3483.285926385085;3498;3519.085037890167;3531.2407832315916;1105.6296140792845;1111.372074777756;1170.900473459757;1171.4786919820683;1190.458341454636;11765.764684706259;11796.410179491077;11797.82303265443;11800.46897889597;11889.524419023228;4571.497135315112;4624.5144259852905;4704.2473204287835;4715.669903106818;4743.525647435229;10077.899221007843;10084.49577521121;10095.747606309755;10107.69676909694;10113.747156321151;5303.151495760737;5367.087595108841;5381.0583147948955;5391.919121213185;5399.37907140676;4238.470191226097;4715.858524244278;4864.36763220779;4871.464138944713;4959.032988567267;3934.9803250984132;3958.782266975344;3995.2409042281874;4045.7167998239843;4045.716799824043;1312.5406107862364;1338.8928885689122;1341.336038660869;1341.745068436994;1352.4657760184673;879.8328317619632;990;995.382862625177;1000.2198285337448;1024.288119756762;5578.609497335228;5742.885142297214;5805.419458054161;5810.1865738796605;5867.589268751147;433.47982421094815;437.2151987183014;439.07574555560086;439.30151059815046;441.94696636403836;3971.1462035661893;4025.0742329264435;4025.255327764373;4029.6776257899296;4083.224187404384;9881.209503239723;10434.113100386401;10439.112675422673;10454.843177352346;10584.629537966135;9858.80282394348;10366.896331036593;10395.688129356131;10413.687589372332;10456.52945617449;7601.163871974079;7751.418643601753;7825.765227043198;7831.373490120776;7846.960765196138;5728.312602487728;5785.537157027512;5824.70876456167;5894.2926848778425;5939.376365481562;9588.952055239679;9712.17446517054;9745.951270243604;9803.117719405287;9899.406035637885;9535;9876.802463950824;10021.899781002097;10164.79670406573;10197.082262596401;6922.411595014481;7417.443691723251;7478.626068696434;7538.509996850187;7719.652615632423;8194.426390152632;8249.175082491944;8252.21603947624;8261.421700481149;8296.087430382773;7376.262373762581;7577.204393538599;7629.198934111839;7660;7661.540307581563;7270.382017528358;7402.3707984821895;7418;7534.284242996907;7541.396688265036;6769.120014398097;6918.7232510699005;6924.861502769816;6932.064171336805;6970.825729356807;4977.800887964441;5086.982603479393;5110.615504092053;5202.687838729688;5286.20706893969;5226.175665588455;5231.6890881913305;5306.495882891119;5309.415964243853;5320.866978325573 08:27:06 INFO - PROCESS | 27398 | |4;prototype.html;301.09520889726383;304.6800859097947;307.4343208496366;322.84342094084366;332.3386460942724;5601.80393686221;5668.858278543038;5684.175794509793;5688.947544704222;5725.166042808805;5597.496225339719;5612.242347283115;5618.353889302732;5622.91565626516;5645.294338207724;4085.407615895693;4107.999999999993;4215.009472773896;4330.220560299145;4339.349097635349;4219.156168766243;4248.787560621972;4250.107477429743;4280.250956082688;4294.162638285536;4222.767747773872;4230.7250028748185;4233.66130709544;4235.538739134993;4248.447701798762;3977.7016723745833;4225.450691410097;4225.598568136023;4229.429027081335;4246;3632.8183590820354;3637.94543081854;3643.8724644637578;3643.9453408198897;3646.5049329774665;5355.785768569292;5378.1663842104535;5410.56715462766;5413.675179489243;5433.701146436944;4612.3542704021465;4849.951500484985;4853.563179313879;4875.609951203895;4888.926666100011;5772.64342879423;5820.3888591698105;5828.300603927556;5835.416458354173;5853.1220316952795;4075.5313138988804;4083.591640835922;4096.73371230872;4101.405296232059;4108.424820525129;6003.309619393738;6041.124037014608;6075.149479072933;6122.142899994004;6125.5712100153005;4090.877273681794;4112.794360282034;4119.732217405859;4149.502059752788;4163.958360416417;4178.12259425518;4178.6657067434535;4189.099343641071;4197.979010104991;4206.957930420656;4673.158831410379;4789.257665061921;4821.373221481185;4875.634327425457;4888.437829649564;5808.912866307009;5891.440313170242;5896.528277737771;5899.67551784656;5908.320543137508;1499.9025063370846;1505.3215664533966;1516.3403919295142;1516.385863725193;1519.688463864905;975.9121679048919;1005.7686732051669;1016.537475448669;1027.0551092994463;1046.3512622174148;6029.638221706624;6034.668093254913;6039.54703397247;6051.213342265477;6092.573519853568;6425.164728585254;6468.094466774655;6468.935310646833;6501.902471462932;6534.542582019213;5875.441833025856;6018.2176317079375;6047.334793172748;6055.909161362583;6074.3925607438905;3418.9145271368416;3446.70748469324;3456.75802693809;3460.5155278261063;3476.6001909780193;6512.185976752906;6587.242467116247;6695.46436285096;6698.129243198353;6707;6439.552969871419;6487.7080531376205;6532.6733663316645;6558.475321974326;6565.967170164118;6536.8365790855605;6665.866682666319;6668.099806526154;6692;6736.8989465158065;6312.621242725451;6377.330380310001;6415.711292991733;6446.355364463516;6471.514636402195;5786.363500014911;6321.336259692666;6354.841128971812;6373.298937117006;6398.840028999126;6360.713767880549;6364.299927007933;6374.4900407966325;6389.361063893573;6397.6481293529305;4208.22147902639;4271.893202669959;4278.251306021371;4290.3993440917675;4293.95706042948;5831.475167234969;5968.224130863134;6124.601900876429;6167.414095660905;6167.691615419121;5940.514871282179;5965.254343207099;5974.492168165754;5982.7008649568215;6041.516678665608;5951.583389162717;5955.285365756137;5962.970185149046;5984.1323008164445;5990.281166260077;5588.636738611977;5819;5827.825165245049;5838.32859221195;5842.5325973921135;5943.375945525658;5964;5971.820845374646;5977.521798256216;6020.729067192075;5699.230603868425;5845.503132233808;5855;5879.9710050741805;5909.793157239476 08:27:06 INFO - PROCESS | 27398 | |5;yui.html;660.7885476647473;696.4532841719251;704.0249254782127;719.4999475364617;730.7953772943574;13140.408681609326;13151.408186631601;13408;13476.59570212894;13496.865031349684;13851.445942162327;13907.443702251923;13916.095453795522;13947.302634868267;14032.64918377041;810.5055915891302;824.1264259884512;825.471698113208;825.84721826462;826.3884725303293;831.0567505880839;831.4346244553701;835.2107258640588;835.2566216067704;840.4369072721291;874.6588830356167;878.3412440669498;879.226280872831;881.3081730841291;883.6332921837429;869.1135042256894;873.0309356614154;875.7197696737047;876.0582373948031;876.8947726272825;638.1225814505055;641.3234038089813;641.8523739539885;643.0193954219806;645.2966266769245;13602.115862468909;13633.659158521017;13689.931550342284;13693.082968384435;13704.725905481835;13299.268540230283;13434.798478022838;13457.125286856322;13546.864531354659;13619.25094119823;11350;11551.249168804;11615.535378584931;11736.589219377367;11752.23610465317;3821.5987321331136;3840.423936409561;3847.480590120354;3866.903327416809;3880.631340022693;59282.40717592855;59749.7012514939;59806.40193598052;59849.40150598482;60442.093368599504;10515.94742026285;10584;10585.735356615993;10814.567417303377;10884.346939183675;17570.472885813448;17779.822201778075;17863.73204401935;17902.373416930346;18139.18373673188;7732.729354472679;7938.563379014095;8274.710385136492;8297.502149871027;8388.412811103164;4729.101470720552;4751.83368582098;4779.569838714532;4859.489753575895;4874.683145595525;3101.2712012677002;3196.5844440222622;3199.472087105648;3201.535777312277;3203.9839800800846;565.366789196103;584.7573257098342;590.1560768101571;592.9555283353766;598.1685457214476;528.4424931697097;536.7423636654428;542.815442749467;621.0621960839165;655.275920108283;9425.340226184102;9497.762555936157;9506.857397139049;9580.616775329048;9603;668.1781408867121;670.4368330602317;671.278375746075;673.9090222819857;675.1864003875319;4088.7342322749523;4152.896177595584;4156.771377574202;4240.448741663564;4337.584112753348;64842.35157648457;65386.346136538974;67150.66424667845;67189.66405167943;67360;54812;55641;56516.717416412655;56913.71543142341;59806.40193598095;48217.75891120522;48240;50989;51272.48727512752;51404.22893656598;8851.645934162561;8951.32865035138;9009.54952252398;9168.954155229181;9232.169104780332;32804;32994.98728078767;33065.17337066496;33302.66697332996;33461.49807752837;40537.1892562153;41309.58690413057;41447.58552414437;41451.7927410361;44510;11386.259893106922;11436.542538298707;11545.942270288931;11610.303381797119;11875.049996000473;12255.509779608716;12480.625581232578;12543.686407839878;12871.22772633645;13021.739565208452;11705.356205408785;11728.70678233051;11770.411479426166;11837.289762614271;12180.695482612651;11370.886291136983;11924.523019079139;12265.976113941457;12270.570530031406;12410.441530131346;11769.117316201147;11800.468978896142;11935.820962685393;12024.639260822189;12081.75836483283;9694;9707.951460242653;9775.413475191512;9963.202943764627;10443.321184123008;9382.437053776795;9707.854382184414;10186.236032297458;10232.53953572106;10290.3825770454 08:27:06 INFO - PROCESS | 27398 | __end_tp_report 08:27:06 INFO - PROCESS | 27398 | __start_cc_report 08:27:06 INFO - PROCESS | 27398 | _x_x_mozilla_cycle_collect,342 08:27:06 INFO - PROCESS | 27398 | __end_cc_report 08:27:06 INFO - PROCESS | 27398 | __startTimestamp1461684426798__endTimestamp 08:27:06 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | ------- Summary: start ------- 08:27:06 INFO - PROCESS | 27398 | Number of tests: 6 08:27:06 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | [#0] dojo.html Cycles:165 Average:5411.49 Median:5676.06 stddev:722.66 (12.7%) stddev-sans-first:702.41 08:27:06 INFO - PROCESS | 27398 | Values: 3132.2 3182.5 3182.8 3230.3 3237.8 5466.9 5468.6 5469.0 5479.2 5534.3 5416.9 5426.4 5476.1 5543.8 5556.3 4916.1 4942.4 4998.3 5017.1 5086.3 814.6 4850.6 4908.0 4954.6 4956.3 4943.8 4965.1 4979.1 4979.8 5013.4 4985.5 4998.1 4999.6 5015.7 5055.1 4832.9 4898.5 4931.0 4945.0 4987.2 5313.1 5327.9 5333.7 5353.4 5428.1 5762.1 5820.0 5825.8 5847.9 5851.7 5920.4 5974.8 5993.9 5994.3 6013.2 5483.2 5593.4 5600.0 5606.7 5608.5 5821.7 5822.3 6106.2 6115.6 6128.7 5781.9 5785.0 5785.7 5797.2 5831.5 5849.9 5857.5 5859.9 5861.6 5870.8 5691.7 5736.5 5808.2 5813.7 5895.1 5786.2 5796.9 5820.8 5826.8 5851.4 4397.9 4414.2 4417.2 4425.1 4459.5 3850.3 3904.2 3970.9 3973.2 3995.9 5445.6 5483.0 5513.1 5542.1 5583.4 5803.2 5808.4 5836.1 5844.9 5866.2 5470.5 5491.4 5522.1 5573.2 5632.5 4977.1 4987.6 4996.9 4997.5 5042.8 5978.7 6008.8 6035.9 6039.5 6050.5 5738.8 5796.2 5883.4 5910.6 5945.1 6076.8 6081.8 6083.6 6084.1 6096.1 5697.9 5734.8 5794.2 5797.4 5803.1 5910.3 5972.9 5985.8 6021.8 6024.0 5716.3 5731.5 5752.0 5752.1 5762.3 5539.9 5609.6 5736.1 5739.7 5753.1 5621.4 5640.0 5648.2 5661.3 5693.2 5677.9 5741.9 5763.2 5785.3 5803.2 5562.4 5641.2 5676.1 5683.8 5693.5 08:27:06 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | [#1] ext.html Cycles:180 Average:42531.69 Median:348233.50 stddev:71046.98 (20.4%) stddev-sans-first:71176.51 08:27:06 INFO - PROCESS | 27398 | Values: 597.2 662.8 666.0 668.1 690.5 37210.8 38169.2 38263.4 38459.4 38469.0 38467.2 38958.8 39240.8 39292.4 39471.4 8490.5 8697.5 8706.4 8709.3 8714.2 8590.1 8591.9 8616.7 8665.8 8714.3 8645.7 8722.9 8724.2 8732.0 8763.3 8665.6 8710.3 8716.8 8732.0 8742.3 8526.3 8622.4 8636.0 8641.3 8648.3 30168.5 36984.0 37511.4 37526.6 37605.6 3287.1 3309.2 3407.5 3413.9 3557.4 26990.0 27355.2 27529.7 27532.6 28181.3 4063.1 4108.5 4136.2 4137.8 4161.7 186266.0 187860.1 187862.0 188077.0 188157.0 32024.8 32942.8 33029.5 34419.8 34425.3 33733.8 33854.5 34003.3 34244.0 34283.3 13859.2 14133.6 14134.4 14149.7 14169.8 11053.7 11271.8 11325.7 11348.3 11386.0 8171.2 8235.3 8244.6 8264.5 8290.6 3283.0 3290.6 3300.3 3321.0 3339.8 1123.2 1137.9 1157.9 1170.5 1193.2 31060.4 31111.7 31183.8 31340.2 31698.8 1203.5 1215.1 1229.1 1282.8 1300.2 15890.8 16554.9 16585.5 16660.2 16677.8 340197.0 343705.0 347837.0 347992.0 348475.0 54332.2 55461.4 55707.2 55746.0 55755.4 1388.1 1397.1 1419.1 1429.1 1532.2 29588.7 29796.0 30220.4 30437.0 30913.5 47525.3 48363.8 48650.8 48974.8 49231.5 252237.0 256388.0 256768.0 256780.0 257798.0 41059.8 41149.8 41431.8 41734.0 41757.6 46013.8 46732.5 46811.8 46973.0 47091.3 39137.8 39259.8 39644.2 40028.8 40210.0 32874.2 34047.5 37092.0 37992.0 38210.4 35982.3 36344.3 37057.8 37771.2 38004.0 30457.7 32197.5 32228.4 32341.2 32700.0 26120.2 26319.9 26615.6 26734.3 28017.2 08:27:06 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | [#2] jquery.html Cycles:180 Average:28051.40 Median:38335.62 stddev:83568.15 (218.0%) stddev-sans-first:83776.78 08:27:06 INFO - PROCESS | 27398 | Values: 398.3 404.4 404.9 407.2 407.8 16862.5 17355.3 17547.2 17568.7 19254.8 18014.9 18264.5 18589.8 18693.2 18758.6 5514.5 5553.0 5733.1 5763.5 5768.1 5626.6 5631.8 5653.4 5682.9 5685.4 5413.9 5552.2 5563.3 5637.5 5664.5 5595.3 5622.1 5628.7 5643.0 5663.9 4834.4 5023.4 5104.3 5113.1 5124.9 21170.5 21177.4 21289.8 21926.9 21988.6 2264.2 2361.9 2367.6 2437.2 2455.1 9009.9 9505.0 9647.0 9757.2 11586.4 1742.2 1857.8 1976.4 1987.2 2119.1 61021.0 61311.0 64519.7 68572.3 69979.3 10065.4 10229.6 10286.4 10567.7 10588.2 14289.4 14319.4 14329.6 14418.3 14450.4 7598.3 7811.8 7936.0 8020.8 8066.6 7493.3 7522.7 7622.4 7626.9 7692.9 4426.1 4550.2 4593.4 4617.5 4807.1 1972.0 1983.6 2000.7 2016.9 2052.7 955.9 984.9 996.3 1113.9 1144.6 17053.1 17531.8 18063.8 18186.3 18255.1 1008.6 1020.4 1027.6 1073.4 1152.0 10024.6 10470.8 10491.2 10563.6 10623.8 498273.0 500616.0 513508.0 518071.0 519826.0 79581.0 80577.6 81134.0 81326.6 81739.6 1063.5 1066.9 1088.9 1106.4 1122.1 15714.6 15826.7 15947.8 16050.0 16095.9 35461.3 36956.8 37685.8 38292.6 38378.6 49307.5 51341.7 51596.7 52285.5 53182.7 8350.1 8407.9 8512.9 8531.1 8555.9 10174.9 12181.6 12428.1 12538.0 12581.1 11156.2 11296.3 11389.7 11410.4 11457.0 10987.5 11319.7 11364.2 11546.2 11551.1 9055.7 11248.9 11422.6 11483.4 11602.8 8352.2 8597.7 8634.1 8656.3 8784.0 7965.3 8040.6 8089.2 8168.3 8727.7 08:27:06 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | [#3] mootools.html Cycles:180 Average:5652.39 Median:4867.92 stddev:3139.02 (64.5%) stddev-sans-first:3132.57 08:27:06 INFO - PROCESS | 27398 | Values: 1533.5 1540.6 1741.8 1797.6 1851.6 7641.2 8246.9 8248.8 8628.1 8628.1 8262.9 8285.3 8287.0 8311.8 8367.0 2303.2 2372.4 2375.5 2376.9 2380.0 2317.5 2349.3 2376.1 2385.6 2387.7 2335.6 2366.4 2373.1 2382.2 2394.2 2302.7 2307.1 2311.0 2321.3 2332.3 2309.5 2311.1 2312.6 2317.8 2323.4 8417.9 8421.8 8441.9 8459.6 8496.4 4915.2 5286.8 5295.3 5297.8 5314.1 3402.0 3483.3 3498.0 3519.1 3531.2 1105.6 1111.4 1170.9 1171.5 1190.5 11765.8 11796.4 11797.8 11800.5 11889.5 4571.5 4624.5 4704.2 4715.7 4743.5 10077.9 10084.5 10095.7 10107.7 10113.7 5303.2 5367.1 5381.1 5391.9 5399.4 4238.5 4715.9 4864.4 4871.5 4959.0 3935.0 3958.8 3995.2 4045.7 4045.7 1312.5 1338.9 1341.3 1341.7 1352.5 879.8 990.0 995.4 1000.2 1024.3 5578.6 5742.9 5805.4 5810.2 5867.6 433.5 437.2 439.1 439.3 441.9 3971.1 4025.1 4025.3 4029.7 4083.2 9881.2 10434.1 10439.1 10454.8 10584.6 9858.8 10366.9 10395.7 10413.7 10456.5 7601.2 7751.4 7825.8 7831.4 7847.0 5728.3 5785.5 5824.7 5894.3 5939.4 9589.0 9712.2 9746.0 9803.1 9899.4 9535.0 9876.8 10021.9 10164.8 10197.1 6922.4 7417.4 7478.6 7538.5 7719.7 8194.4 8249.2 8252.2 8261.4 8296.1 7376.3 7577.2 7629.2 7660.0 7661.5 7270.4 7402.4 7418.0 7534.3 7541.4 6769.1 6918.7 6924.9 6932.1 6970.8 4977.8 5087.0 5110.6 5202.7 5286.2 5226.2 5231.7 5306.5 5309.4 5320.9 08:27:06 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | [#4] prototype.html Cycles:180 Average:5016.16 Median:5748.90 stddev:1550.31 (27.0%) stddev-sans-first:1513.72 08:27:06 INFO - PROCESS | 27398 | Values: 301.1 304.7 307.4 322.8 332.3 5601.8 5668.9 5684.2 5688.9 5725.2 5597.5 5612.2 5618.4 5622.9 5645.3 4085.4 4108.0 4215.0 4330.2 4339.3 4219.2 4248.8 4250.1 4280.3 4294.2 4222.8 4230.7 4233.7 4235.5 4248.4 3977.7 4225.5 4225.6 4229.4 4246.0 3632.8 3637.9 3643.9 3643.9 3646.5 5355.8 5378.2 5410.6 5413.7 5433.7 4612.4 4850.0 4853.6 4875.6 4888.9 5772.6 5820.4 5828.3 5835.4 5853.1 4075.5 4083.6 4096.7 4101.4 4108.4 6003.3 6041.1 6075.1 6122.1 6125.6 4090.9 4112.8 4119.7 4149.5 4164.0 4178.1 4178.7 4189.1 4198.0 4207.0 4673.2 4789.3 4821.4 4875.6 4888.4 5808.9 5891.4 5896.5 5899.7 5908.3 1499.9 1505.3 1516.3 1516.4 1519.7 975.9 1005.8 1016.5 1027.1 1046.4 6029.6 6034.7 6039.5 6051.2 6092.6 6425.2 6468.1 6468.9 6501.9 6534.5 5875.4 6018.2 6047.3 6055.9 6074.4 3418.9 3446.7 3456.8 3460.5 3476.6 6512.2 6587.2 6695.5 6698.1 6707.0 6439.6 6487.7 6532.7 6558.5 6566.0 6536.8 6665.9 6668.1 6692.0 6736.9 6312.6 6377.3 6415.7 6446.4 6471.5 5786.4 6321.3 6354.8 6373.3 6398.8 6360.7 6364.3 6374.5 6389.4 6397.6 4208.2 4271.9 4278.3 4290.4 4294.0 5831.5 5968.2 6124.6 6167.4 6167.7 5940.5 5965.3 5974.5 5982.7 6041.5 5951.6 5955.3 5963.0 5984.1 5990.3 5588.6 5819.0 5827.8 5838.3 5842.5 5943.4 5964.0 5971.8 5977.5 6020.7 5699.2 5845.5 5855.0 5880.0 5909.8 08:27:06 INFO - PROCESS | 27398 | 08:27:06 INFO - PROCESS | 27398 | [#5] yui.html Cycles:180 Average:14769.10 Median:4765.70 stddev:17725.51 (371.9%) stddev-sans-first:17743.57 08:27:06 INFO - PROCESS | 27398 | Values: 660.8 696.5 704.0 719.5 730.8 13140.4 13151.4 13408.0 13476.6 13496.9 13851.4 13907.4 13916.1 13947.3 14032.6 810.5 824.1 825.5 825.8 826.4 831.1 831.4 835.2 835.3 840.4 874.7 878.3 879.2 881.3 883.6 869.1 873.0 875.7 876.1 876.9 638.1 641.3 641.9 643.0 645.3 13602.1 13633.7 13689.9 13693.1 13704.7 13299.3 13434.8 13457.1 13546.9 13619.3 11350.0 11551.2 11615.5 11736.6 11752.2 3821.6 3840.4 3847.5 3866.9 3880.6 59282.4 59749.7 59806.4 59849.4 60442.1 10515.9 10584.0 10585.7 10814.6 10884.3 17570.5 17779.8 17863.7 17902.4 18139.2 7732.7 7938.6 8274.7 8297.5 8388.4 4729.1 4751.8 4779.6 4859.5 4874.7 3101.3 3196.6 3199.5 3201.5 3204.0 565.4 584.8 590.2 593.0 598.2 528.4 536.7 542.8 621.1 655.3 9425.3 9497.8 9506.9 9580.6 9603.0 668.2 670.4 671.3 673.9 675.2 4088.7 4152.9 4156.8 4240.4 4337.6 64842.4 65386.3 67150.7 67189.7 67360.0 54812.0 55641.0 56516.7 56913.7 59806.4 48217.8 48240.0 50989.0 51272.5 51404.2 8851.6 8951.3 9009.5 9169.0 9232.2 32804.0 32995.0 33065.2 33302.7 33461.5 40537.2 41309.6 41447.6 41451.8 44510.0 11386.3 11436.5 11545.9 11610.3 11875.0 12255.5 12480.6 12543.7 12871.2 13021.7 11705.4 11728.7 11770.4 11837.3 12180.7 11370.9 11924.5 12266.0 12270.6 12410.4 11769.1 11800.5 11935.8 12024.6 12081.8 9694.0 9708.0 9775.4 9963.2 10443.3 9382.4 9707.9 10186.2 10232.5 10290.4 08:27:06 INFO - PROCESS | 27398 | -------- Summary: end -------- 08:27:06 INFO - PROCESS | 27398 | 08:27:07 INFO - TEST-INFO | 27398: exit 0 08:27:07 INFO - TEST-OK | dromaeo_css | took 1111531ms 08:27:07 INFO - TEST-START | kraken 08:27:07 INFO - operating with platform_type : linux_ 08:27:07 INFO - Initialising browser for kraken test... 08:27:07 INFO - TEST-INFO | started process 27634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9URHU/profile http://localhost:57591/getInfo.html) 08:27:11 INFO - PROCESS | 27634 | 08:27:11 INFO - PROCESS | 27634 | (process:27701): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:27:13 INFO - PROCESS | 27634 | __metrics Screen width/height:1600/1200 08:27:13 INFO - PROCESS | 27634 | colorDepth:24 08:27:13 INFO - PROCESS | 27634 | Browser inner width/height: 1024/697 08:27:13 INFO - PROCESS | 27634 | __metrics 08:27:14 ERROR - PROCESS | 27634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:27:14 INFO - TEST-INFO | 27634: exit 0 08:27:14 INFO - Browser initialized. 08:27:14 INFO - Running cycle 1/1 for kraken test... 08:27:14 INFO - TEST-INFO | started process 27752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9URHU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:16 INFO - PROCESS | 27752 | 08:27:16 INFO - PROCESS | 27752 | (process:27814): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:27:26 INFO - PROCESS | 27752 | RSS: Main: 165007360 08:27:26 INFO - PROCESS | 27752 | 08:27:29 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57591/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:30 INFO - PROCESS | 27752 | RSS: Main: 169508864 08:27:30 INFO - PROCESS | 27752 | 08:27:32 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57591/tests/kraken/driver.html?testName=audio-dft) 08:27:33 INFO - PROCESS | 27752 | RSS: Main: 173162496 08:27:33 INFO - PROCESS | 27752 | 08:27:36 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57591/tests/kraken/driver.html?testName=audio-fft) 08:27:36 INFO - PROCESS | 27752 | RSS: Main: 163303424 08:27:36 INFO - PROCESS | 27752 | 08:27:39 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57591/tests/kraken/driver.html?testName=audio-oscillator) 08:27:39 INFO - PROCESS | 27752 | RSS: Main: 163737600 08:27:39 INFO - PROCESS | 27752 | 08:27:41 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:42 INFO - PROCESS | 27752 | RSS: Main: 165040128 08:27:42 INFO - PROCESS | 27752 | 08:27:45 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57591/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:46 INFO - PROCESS | 27752 | RSS: Main: 165539840 08:27:46 INFO - PROCESS | 27752 | 08:27:49 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57591/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:50 INFO - PROCESS | 27752 | RSS: Main: 167710720 08:27:50 INFO - PROCESS | 27752 | 08:27:53 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57591/tests/kraken/driver.html?testName=json-parse-financial) 08:27:53 INFO - PROCESS | 27752 | RSS: Main: 167972864 08:27:53 INFO - PROCESS | 27752 | 08:27:55 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:55 INFO - PROCESS | 27752 | RSS: Main: 167895040 08:27:55 INFO - PROCESS | 27752 | 08:27:57 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57591/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:58 INFO - PROCESS | 27752 | RSS: Main: 168251392 08:27:58 INFO - PROCESS | 27752 | 08:28:00 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:01 INFO - PROCESS | 27752 | RSS: Main: 168562688 08:28:01 INFO - PROCESS | 27752 | 08:28:03 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:04 INFO - PROCESS | 27752 | RSS: Main: 168730624 08:28:04 INFO - PROCESS | 27752 | 08:28:07 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:08 INFO - PROCESS | 27752 | RSS: Main: 169230336 08:28:08 INFO - PROCESS | 27752 | 08:28:09 INFO - PROCESS | 27752 | Cycle 1(1): loaded http://localhost:57591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57591/tests/kraken/driver.html?testName=ai-astar) 08:28:10 INFO - PROCESS | 27752 | RSS: Main: 169885696 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | __start_tp_report 08:28:10 INFO - PROCESS | 27752 | _x_x_mozilla_page_load 08:28:10 INFO - PROCESS | 27752 | _x_x_mozilla_page_load_details 08:28:10 INFO - PROCESS | 27752 | |i|pagename|runs| 08:28:10 INFO - PROCESS | 27752 | |0;ai-astar;111;107;114;111;111;124;112;112;112;113 08:28:10 INFO - PROCESS | 27752 | |1;audio-beat-detection;160;130;160;181;130;160;157;129;196;128 08:28:10 INFO - PROCESS | 27752 | |2;audio-dft;162;163;161;162;162;165;175;164;166;162 08:28:10 INFO - PROCESS | 27752 | |3;audio-fft;75;74;76;158;74;76;75;80;165;77 08:28:10 INFO - PROCESS | 27752 | |4;audio-oscillator;93;93;153;93;93;92;152;92;92;147 08:28:10 INFO - PROCESS | 27752 | |5;imaging-gaussian-blur;116;117;117;118;117;118;118;118;117;117 08:28:10 INFO - PROCESS | 27752 | |6;imaging-darkroom;146;145;146;147;145;147;150;147;147;146 08:28:10 INFO - PROCESS | 27752 | |7;imaging-desaturate;95;96;95;95;95;97;95;95;95;95 08:28:10 INFO - PROCESS | 27752 | |8;json-parse-financial;59;59;59;58;59;59;58;85;56;56 08:28:10 INFO - PROCESS | 27752 | |9;json-stringify-tinderbox;60;60;62;61;61;61;60;60;63;61 08:28:10 INFO - PROCESS | 27752 | |10;stanford-crypto-aes;79;77;87;79;79;77;85;78;79;78 08:28:10 INFO - PROCESS | 27752 | |11;stanford-crypto-ccm;135;144;126;131;140;126;130;127;159;131 08:28:10 INFO - PROCESS | 27752 | |12;stanford-crypto-pbkdf2;205;205;203;208;206;211;208;208;207;216 08:28:10 INFO - PROCESS | 27752 | |13;stanford-crypto-sha256-iterative;72;72;73;71;71;70;72;69;69;78 08:28:10 INFO - PROCESS | 27752 | __end_tp_report 08:28:10 INFO - PROCESS | 27752 | __start_cc_report 08:28:10 INFO - PROCESS | 27752 | _x_x_mozilla_cycle_collect,867 08:28:10 INFO - PROCESS | 27752 | __end_cc_report 08:28:10 INFO - PROCESS | 27752 | __startTimestamp1461684490197__endTimestamp 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | ------- Summary: start ------- 08:28:10 INFO - PROCESS | 27752 | Number of tests: 14 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:4.37 (3.9%) stddev-sans-first:4.59 08:28:10 INFO - PROCESS | 27752 | Values: 111.0 107.0 114.0 111.0 111.0 124.0 112.0 112.0 112.0 113.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:160.00 stddev:23.70 (14.8%) stddev-sans-first:25.00 08:28:10 INFO - PROCESS | 27752 | Values: 160.0 130.0 160.0 181.0 130.0 160.0 157.0 129.0 196.0 128.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:4.10 (2.5%) stddev-sans-first:4.28 08:28:10 INFO - PROCESS | 27752 | Values: 162.0 163.0 161.0 162.0 162.0 165.0 175.0 164.0 166.0 162.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.50 stddev:36.18 (47.9%) stddev-sans-first:37.79 08:28:10 INFO - PROCESS | 27752 | Values: 75.0 74.0 76.0 158.0 74.0 76.0 75.0 80.0 165.0 77.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.50 stddev:28.11 (30.4%) stddev-sans-first:29.13 08:28:10 INFO - PROCESS | 27752 | Values: 93.0 93.0 153.0 93.0 93.0 92.0 152.0 92.0 92.0 147.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 08:28:10 INFO - PROCESS | 27752 | Values: 116.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.43 (1.0%) stddev-sans-first:1.50 08:28:10 INFO - PROCESS | 27752 | Values: 146.0 145.0 146.0 147.0 145.0 147.0 150.0 147.0 147.0 146.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:28:10 INFO - PROCESS | 27752 | Values: 95.0 96.0 95.0 95.0 95.0 97.0 95.0 95.0 95.0 95.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:59.00 stddev:8.59 (14.6%) stddev-sans-first:9.08 08:28:10 INFO - PROCESS | 27752 | Values: 59.0 59.0 59.0 58.0 59.0 59.0 58.0 85.0 56.0 56.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 08:28:10 INFO - PROCESS | 27752 | Values: 60.0 60.0 62.0 61.0 61.0 61.0 60.0 60.0 63.0 61.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:3.39 (4.3%) stddev-sans-first:3.59 08:28:10 INFO - PROCESS | 27752 | Values: 79.0 77.0 87.0 79.0 79.0 77.0 85.0 78.0 79.0 78.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:133.00 stddev:10.35 (7.8%) stddev-sans-first:10.98 08:28:10 INFO - PROCESS | 27752 | Values: 135.0 144.0 126.0 131.0 140.0 126.0 130.0 127.0 159.0 131.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.70 Median:208.00 stddev:3.65 (1.8%) stddev-sans-first:3.74 08:28:10 INFO - PROCESS | 27752 | Values: 205.0 205.0 203.0 208.0 206.0 211.0 208.0 208.0 207.0 216.0 08:28:10 INFO - PROCESS | 27752 | 08:28:10 INFO - PROCESS | 27752 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:2.58 (3.6%) stddev-sans-first:2.74 08:28:10 INFO - PROCESS | 27752 | Values: 72.0 72.0 73.0 71.0 71.0 70.0 72.0 69.0 69.0 78.0 08:28:10 INFO - PROCESS | 27752 | -------- Summary: end -------- 08:28:10 INFO - PROCESS | 27752 | 08:28:11 INFO - TEST-INFO | 27752: exit 0 08:28:11 INFO - TEST-OK | kraken | took 63696ms 08:28:11 INFO - SUITE-END | took 1175s 08:28:11 INFO - Completed test suite (00:19:35) 08:28:11 INFO - javascript benchmark 08:28:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.2482604175, 3182.458981973065, 3182.8408579571014, 3230.3054843208706, 3237.838108094596, 5466.863328416792, 5468.644538105021, 5468.972655136724, 5479.232907392969, 5534.28054352934, 5416.9187462188, 5426.375966763813, 5476.123820188771, 5543.805966791163, 5556.305461817273, 4916.065947469987, 4942.382202224722, 4998.250262460642, 5017.071841709278, 5086.31334769805, 814.607656862536, 4850.587700045483, 4907.975460122712, 4954.603631709455, 4956.2565615157655, 4943.826966056206, 4965.106280869424, 4979.10376132296, 4979.8008079676765, 5013.4234563025175, 4985.451600323961, 4998.125328067574, 4999.575036121934, 5015.724135172564, 5055.140626093536, 4832.855014349575, 4898.53463920927, 4930.950690493085, 4944.9862778130755, 4987.15218412867, 5313.096773548467, 5327.920081198785, 5333.679979201261, 5353.357597088374, 5428.131498960148, 5762.078067509178, 5820.039693450575, 5825.796097136622, 5847.883042339172, 5851.678157701324, 5920.437558431942, 5974.790882319098, 5993.880122397528, 5994.340622531518, 6013.188219590343, 5483.2049352844015, 5593.440655934414, 5599.972000140014, 5606.719664016824, 5608.495235428831, 5821.708914554255, 5822.272215973004, 6106.236720409949, 6115.602485838495, 6128.662923539248, 5781.855453613609, 5784.971075144682, 5785.652860828363, 5797.159411885253, 5831.475167234885, 5849.941500585025, 5857.502112320415, 5859.882802343929, 5861.560382971209, 5870.765169393262, 5691.715414229272, 5736.4550367715, 5808.186853840466, 5813.651180929158, 5895.086261629454, 5786.218860453869, 5796.94203057964, 5820.796272130455, 5826.82519524415, 5851.356350801409, 4397.934030989538, 4414.249577571821, 4417.160739459492, 4425.09285596452, 4459.487158976759, 3850.3454412749898, 3904.2386734586485, 3970.920581588352, 3973.165635216579, 3995.9400608990886, 5445.564354851682, 5483.0, 5513.117901135799, 5542.085555883315, 5583.3858275589655, 5803.245578074823, 5808.448197421323, 5836.095405212199, 5844.912326315109, 5866.178734977107, 5470.507654311131, 5491.423400542965, 5522.144067669517, 5573.219749235111, 5632.493075623213, 4977.129002424561, 4987.62592805541, 4996.850094497171, 4997.5002499749735, 5042.798288068436, 5978.701064946736, 6008.819735407945, 6035.909461358083, 6039.456448919618, 6050.546209034252, 5738.799142030092, 5796.188533605383, 5883.382244864228, 5910.586258961831, 5945.137954996588, 6076.756929722938, 6081.847953801191, 6083.574149809471, 6084.148219249397, 6096.1465394845645, 5697.914531282117, 5734.770609175753, 5794.159846822272, 5797.420257974338, 5803.100519419497, 5910.320313164041, 5972.880542389041, 5985.790497332572, 6021.7591296347655, 6024.0, 5716.314042314949, 5731.484166424875, 5752.0, 5752.050911599539, 5762.279715035621, 5539.944600553943, 5609.607327487037, 5736.110902810071, 5739.655620662774, 5753.05074662676, 5621.409751975983, 5640.0, 5648.181013753065, 5661.264035675335, 5693.202951586698, 5677.943220567741, 5741.91387129185, 5763.164341170591, 5785.334686511105, 5803.216565763737, 5562.360328562106, 5641.238432811518, 5676.063449530946, 5683.829485115453, 5693.544516438592], "value": 5363.691248019298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1580072098342, 662.7812821768816, 666.0409011024125, 668.0680450771174, 690.4579904774753, 37210.81394593027, 38169.23661526768, 38263.42604860929, 38459.42310865339, 38469.0, 38467.23065538688, 38958.80520597393, 39240.80379598098, 39292.41061384082, 39471.40792888109, 8490.53302068386, 8697.52163631, 8706.434081784695, 8709.34679899007, 8714.215720585145, 8590.098039705834, 8591.914080859206, 8616.698415555456, 8665.826683466326, 8714.302855771555, 8645.69740059098, 8722.86915696265, 8724.171203735636, 8732.0, 8763.298936085097, 8665.610047547843, 8710.346723995694, 8716.825663486758, 8732.0, 8742.256908162813, 8526.275266602346, 8622.3533235007, 8636.0, 8641.308695304424, 8648.264897483721, 30168.54747178794, 36984.0, 37511.43732844009, 37526.62473375286, 37605.62394376076, 3287.088989741498, 3309.172706823294, 3407.539982102434, 3413.9317213655836, 3557.4130268505664, 26990.0, 27355.179344619693, 27529.724702753116, 27532.58701119485, 28181.29546761327, 4063.146739184745, 4108.465899433055, 4136.152088821785, 4137.793110344501, 4161.687873409506, 186266.0, 187860.12139878562, 187862.0, 188077.0, 188157.0, 32024.839875800473, 32942.835285823414, 33029.50455743166, 34419.827900860335, 34425.31149376999, 33733.83133084319, 33854.49218261728, 34003.31993360119, 34244.0, 34283.314333713184, 13859.168449893039, 14133.646658833612, 14134.434622615187, 14149.71700565983, 14169.78745318821, 11053.723656908482, 11271.774564508827, 11325.716857078474, 11348.262362946381, 11386.0, 8171.2237337454035, 8235.341172706168, 8244.587770611566, 8264.504129752235, 8290.626921788535, 3282.950755738666, 3290.6380298167182, 3300.273939733255, 3321.0202990117973, 3339.782914110575, 1123.1520202247414, 1137.9146564007733, 1157.9247348922293, 1170.5317872850758, 1193.2184419205435, 31060.378792424024, 31111.688883111332, 31183.84408077945, 31340.216494587363, 31698.841505792323, 1203.506562309449, 1215.1068964311223, 1229.1027549888631, 1282.775514285015, 1300.1678925487695, 15890.81812102152, 16554.917225413796, 16585.50243492697, 16660.16699165037, 16677.828211424414, 340197.0, 343705.0, 347837.0, 347992.0, 348475.0, 54332.18501722477, 55461.44538554644, 55707.16439253414, 55746.0, 55755.442445575834, 1388.0838646493266, 1397.1407584335561, 1419.0705088167267, 1429.121090529317, 1532.2185685300353, 29588.704112958596, 29796.0, 30220.395592087596, 30437.0, 30913.536296955113, 47525.28712069253, 48363.75818120887, 48650.756746217456, 48974.75512622414, 49231.50768492269, 252237.0, 256388.0, 256768.0, 256780.0, 257798.0, 41059.7947010263, 41149.79425102855, 41431.7928410356, 41734.0, 41757.58242417659, 46013.76993115013, 46732.53267467418, 46811.76594117007, 46973.0, 47091.29363059488, 39137.80431097826, 39259.803700982455, 39644.207115858095, 40028.799856000536, 40210.0, 32874.17814554559, 34047.48928766021, 37092.0, 37991.96064314903, 38210.426843597925, 35982.28035439329, 36344.27311453809, 37057.81471092627, 37771.244575108896, 38004.0, 30457.695423045487, 32197.51703724493, 32228.35543289168, 32341.191470212492, 32700.0, 26120.216393508224, 26319.868400657873, 26615.600765988915, 26734.331641709112, 28017.159485215478], "value": 17350.201340079468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.3228511530399, 404.4479285774917, 404.88865561970454, 407.1896925119012, 407.8205589540604, 16862.49412517625, 17355.305787768473, 17547.2103755331, 17568.736468952975, 19254.807451925477, 18014.90992545039, 18264.543386415346, 18589.814101858978, 18693.158807853644, 18758.62482750344, 5514.503694667479, 5553.000459917213, 5733.140028995663, 5763.5101016413655, 5768.134779783024, 5626.578006649497, 5631.774729010835, 5653.406392328808, 5682.886342273152, 5685.374608793029, 5413.945860541403, 5552.222688823547, 5563.332400111972, 5637.548996080303, 5664.490195882369, 5595.272614560081, 5622.100463925773, 5628.718564071801, 5642.971785141089, 5663.943360566383, 4834.371531700892, 5023.372078490189, 5104.259882317043, 5113.130767769489, 5124.92312615311, 21170.470738231666, 21177.364679059654, 21289.787102128936, 21926.89036554807, 21988.560228795493, 2264.207527365409, 2361.9055237790467, 2367.6093444581625, 2437.171361737, 2455.0670745116918, 9009.909900900973, 9505.0, 9646.951765241129, 9757.170640495566, 11586.420678966102, 1742.1550547984218, 1857.8142185781448, 1976.4268362175096, 1987.175322241268, 2119.13115622594, 61021.0, 61311.0, 64519.67740161316, 68572.31427685759, 69979.30020699778, 10065.4464004479, 10229.590816367261, 10286.434246116385, 10567.682969510774, 10588.15294776416, 14289.42842286297, 14319.427222910967, 14329.57011289663, 14418.279086045866, 14450.421983120768, 7598.278163574451, 7811.80470488231, 7936.0, 8020.759377218693, 8066.596670166468, 7493.3256006958545, 7522.736704215326, 7622.428317876182, 7626.885596716053, 7692.923070769332, 4426.136903303889, 4550.249208880564, 4593.448786145684, 4617.515160908057, 4807.086653535817, 1971.9802801972085, 1983.5735316906935, 2000.6998950157592, 2016.949576260576, 2052.7434070741156, 955.8900726416551, 984.9113579777711, 996.3473924579412, 1113.8663360396642, 1144.5593446522983, 17053.066713150834, 17531.824681753274, 18063.819361806476, 18186.27254909789, 18255.087245637664, 1008.6030847276428, 1020.433659319085, 1027.5870677818, 1073.3988966178808, 1152.0207823350254, 10024.649137280307, 10470.842937355947, 10491.16070714341, 10563.590724360525, 10623.84064239037, 498273.0, 500616.0, 513508.0, 518071.0, 519826.0, 79581.0, 80577.59711201406, 81134.0, 81326.59336703397, 81739.5913020431, 1063.4842101580728, 1066.930649507764, 1088.9183311251688, 1106.419129956763, 1122.0574717237396, 15714.607134821721, 15826.68346633084, 15947.760783588488, 16050.036997780171, 16095.919520402324, 35461.29077418386, 36956.81521592375, 37685.81157094197, 38292.61707382891, 38378.61621383862, 49307.50692493029, 51341.7432912848, 51596.74201628968, 52285.47714522806, 53182.73408633087, 8350.08149103586, 8407.873881891654, 8512.914870851213, 8531.104234055583, 8555.914440855511, 10174.931632178515, 12181.634550963485, 12428.13003089775, 12537.996960243341, 12581.119321647762, 11156.219064665396, 11296.265742726697, 11389.715257118307, 11410.429478525875, 11457.0, 10987.450627468754, 11319.717007074889, 11364.204505684524, 11546.19176657626, 11551.133664974992, 9055.68305109318, 11248.887511124783, 11422.600208992646, 11483.368414736935, 11602.825957610812, 8352.248297653241, 8597.699080532151, 8634.09342019079, 8656.26421754158, 8783.956080219557, 7965.322947549292, 8040.638171282423, 8089.2315230053055, 8168.305694015838, 8727.65089396417], "value": 8799.899459418712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.4939469974909, 1540.5840423085767, 1741.8258174182583, 1797.5685835399509, 1851.6296740651874, 7641.2358764123555, 8246.876296855544, 8248.7937801555, 8628.094050124733, 8628.09405012474, 8262.91737082629, 8285.254327110559, 8286.95856520718, 8311.792205194874, 8366.958165209166, 2303.2053941390236, 2372.406898275431, 2375.5130198309307, 2376.8930398132125, 2380.0241900820665, 2317.5249073939804, 2349.3304408243566, 2376.061455724988, 2385.6183010718287, 2387.7373488916205, 2335.602947498929, 2366.408397900525, 2373.1219448803968, 2382.1662418153683, 2394.2338451695464, 2302.689136966513, 2307.123293148593, 2310.9831674063444, 2321.3268152235914, 2332.300309907021, 2309.5380923815137, 2311.1448763957274, 2312.595295823224, 2317.8145748340094, 2323.384303159664, 8417.873731894026, 8421.789455263668, 8441.915580844174, 8459.619317130682, 8496.405251632388, 4915.188993816016, 5286.762095705702, 5295.258663787073, 5297.761600727977, 5314.123169677037, 3402.0, 3483.285926385085, 3498.0, 3519.085037890167, 3531.2407832315916, 1105.6296140792845, 1111.372074777756, 1170.900473459757, 1171.4786919820683, 1190.458341454636, 11765.764684706259, 11796.410179491077, 11797.82303265443, 11800.46897889597, 11889.524419023228, 4571.497135315112, 4624.5144259852905, 4704.2473204287835, 4715.669903106818, 4743.525647435229, 10077.899221007843, 10084.49577521121, 10095.747606309755, 10107.69676909694, 10113.747156321151, 5303.151495760737, 5367.087595108841, 5381.0583147948955, 5391.919121213185, 5399.37907140676, 4238.470191226097, 4715.858524244278, 4864.36763220779, 4871.464138944713, 4959.032988567267, 3934.9803250984132, 3958.782266975344, 3995.2409042281874, 4045.7167998239843, 4045.716799824043, 1312.5406107862364, 1338.8928885689122, 1341.336038660869, 1341.745068436994, 1352.4657760184673, 879.8328317619632, 990.0, 995.382862625177, 1000.2198285337448, 1024.288119756762, 5578.609497335228, 5742.885142297214, 5805.419458054161, 5810.1865738796605, 5867.589268751147, 433.47982421094815, 437.2151987183014, 439.07574555560086, 439.30151059815046, 441.94696636403836, 3971.1462035661893, 4025.0742329264435, 4025.255327764373, 4029.6776257899296, 4083.224187404384, 9881.209503239723, 10434.113100386401, 10439.112675422673, 10454.843177352346, 10584.629537966135, 9858.80282394348, 10366.896331036593, 10395.688129356131, 10413.687589372332, 10456.52945617449, 7601.163871974079, 7751.418643601753, 7825.765227043198, 7831.373490120776, 7846.960765196138, 5728.312602487728, 5785.537157027512, 5824.70876456167, 5894.2926848778425, 5939.376365481562, 9588.952055239679, 9712.17446517054, 9745.951270243604, 9803.117719405287, 9899.406035637885, 9535.0, 9876.802463950824, 10021.899781002097, 10164.79670406573, 10197.082262596401, 6922.411595014481, 7417.443691723251, 7478.626068696434, 7538.509996850187, 7719.652615632423, 8194.426390152632, 8249.175082491944, 8252.21603947624, 8261.421700481149, 8296.087430382773, 7376.262373762581, 7577.204393538599, 7629.198934111839, 7660.0, 7661.540307581563, 7270.382017528358, 7402.3707984821895, 7418.0, 7534.284242996907, 7541.396688265036, 6769.120014398097, 6918.7232510699005, 6924.861502769816, 6932.064171336805, 6970.825729356807, 4977.800887964441, 5086.982603479393, 5110.615504092053, 5202.687838729688, 5286.20706893969, 5226.175665588455, 5231.6890881913305, 5306.495882891119, 5309.415964243853, 5320.866978325573], "value": 4502.082444729653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.09520889726383, 304.6800859097947, 307.4343208496366, 322.84342094084366, 332.3386460942724, 5601.80393686221, 5668.858278543038, 5684.175794509793, 5688.947544704222, 5725.166042808805, 5597.496225339719, 5612.242347283115, 5618.353889302732, 5622.91565626516, 5645.294338207724, 4085.407615895693, 4107.999999999993, 4215.009472773896, 4330.220560299145, 4339.349097635349, 4219.156168766243, 4248.787560621972, 4250.107477429743, 4280.250956082688, 4294.162638285536, 4222.767747773872, 4230.7250028748185, 4233.66130709544, 4235.538739134993, 4248.447701798762, 3977.7016723745833, 4225.450691410097, 4225.598568136023, 4229.429027081335, 4246.0, 3632.8183590820354, 3637.94543081854, 3643.8724644637578, 3643.9453408198897, 3646.5049329774665, 5355.785768569292, 5378.1663842104535, 5410.56715462766, 5413.675179489243, 5433.701146436944, 4612.3542704021465, 4849.951500484985, 4853.563179313879, 4875.609951203895, 4888.926666100011, 5772.64342879423, 5820.3888591698105, 5828.300603927556, 5835.416458354173, 5853.1220316952795, 4075.5313138988804, 4083.591640835922, 4096.73371230872, 4101.405296232059, 4108.424820525129, 6003.309619393738, 6041.124037014608, 6075.149479072933, 6122.142899994004, 6125.5712100153005, 4090.877273681794, 4112.794360282034, 4119.732217405859, 4149.502059752788, 4163.958360416417, 4178.12259425518, 4178.6657067434535, 4189.099343641071, 4197.979010104991, 4206.957930420656, 4673.158831410379, 4789.257665061921, 4821.373221481185, 4875.634327425457, 4888.437829649564, 5808.912866307009, 5891.440313170242, 5896.528277737771, 5899.67551784656, 5908.320543137508, 1499.9025063370846, 1505.3215664533966, 1516.3403919295142, 1516.385863725193, 1519.688463864905, 975.9121679048919, 1005.7686732051669, 1016.537475448669, 1027.0551092994463, 1046.3512622174148, 6029.638221706624, 6034.668093254913, 6039.54703397247, 6051.213342265477, 6092.573519853568, 6425.164728585254, 6468.094466774655, 6468.935310646833, 6501.902471462932, 6534.542582019213, 5875.441833025856, 6018.2176317079375, 6047.334793172748, 6055.909161362583, 6074.3925607438905, 3418.9145271368416, 3446.70748469324, 3456.75802693809, 3460.5155278261063, 3476.6001909780193, 6512.185976752906, 6587.242467116247, 6695.46436285096, 6698.129243198353, 6707.0, 6439.552969871419, 6487.7080531376205, 6532.6733663316645, 6558.475321974326, 6565.967170164118, 6536.8365790855605, 6665.866682666319, 6668.099806526154, 6692.0, 6736.8989465158065, 6312.621242725451, 6377.330380310001, 6415.711292991733, 6446.355364463516, 6471.514636402195, 5786.363500014911, 6321.336259692666, 6354.841128971812, 6373.298937117006, 6398.840028999126, 6360.713767880549, 6364.299927007933, 6374.4900407966325, 6389.361063893573, 6397.6481293529305, 4208.22147902639, 4271.893202669959, 4278.251306021371, 4290.3993440917675, 4293.95706042948, 5831.475167234969, 5968.224130863134, 6124.601900876429, 6167.414095660905, 6167.691615419121, 5940.514871282179, 5965.254343207099, 5974.492168165754, 5982.7008649568215, 6041.516678665608, 5951.583389162717, 5955.285365756137, 5962.970185149046, 5984.1323008164445, 5990.281166260077, 5588.636738611977, 5819.0, 5827.825165245049, 5838.32859221195, 5842.5325973921135, 5943.375945525658, 5964.0, 5971.820845374646, 5977.521798256216, 6020.729067192075, 5699.230603868425, 5845.503132233808, 5855.0, 5879.9710050741805, 5909.793157239476], "value": 4513.363351717592, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.7885476647473, 696.4532841719251, 704.0249254782127, 719.4999475364617, 730.7953772943574, 13140.408681609326, 13151.408186631601, 13408.0, 13476.59570212894, 13496.865031349684, 13851.445942162327, 13907.443702251923, 13916.095453795522, 13947.302634868267, 14032.64918377041, 810.5055915891302, 824.1264259884512, 825.471698113208, 825.84721826462, 826.3884725303293, 831.0567505880839, 831.4346244553701, 835.2107258640588, 835.2566216067704, 840.4369072721291, 874.6588830356167, 878.3412440669498, 879.226280872831, 881.3081730841291, 883.6332921837429, 869.1135042256894, 873.0309356614154, 875.7197696737047, 876.0582373948031, 876.8947726272825, 638.1225814505055, 641.3234038089813, 641.8523739539885, 643.0193954219806, 645.2966266769245, 13602.115862468909, 13633.659158521017, 13689.931550342284, 13693.082968384435, 13704.725905481835, 13299.268540230283, 13434.798478022838, 13457.125286856322, 13546.864531354659, 13619.25094119823, 11350.0, 11551.249168804, 11615.535378584931, 11736.589219377367, 11752.23610465317, 3821.5987321331136, 3840.423936409561, 3847.480590120354, 3866.903327416809, 3880.631340022693, 59282.40717592855, 59749.7012514939, 59806.40193598052, 59849.40150598482, 60442.093368599504, 10515.94742026285, 10584.0, 10585.735356615993, 10814.567417303377, 10884.346939183675, 17570.472885813448, 17779.822201778075, 17863.73204401935, 17902.373416930346, 18139.18373673188, 7732.729354472679, 7938.563379014095, 8274.710385136492, 8297.502149871027, 8388.412811103164, 4729.101470720552, 4751.83368582098, 4779.569838714532, 4859.489753575895, 4874.683145595525, 3101.2712012677002, 3196.5844440222622, 3199.472087105648, 3201.535777312277, 3203.9839800800846, 565.366789196103, 584.7573257098342, 590.1560768101571, 592.9555283353766, 598.1685457214476, 528.4424931697097, 536.7423636654428, 542.815442749467, 621.0621960839165, 655.275920108283, 9425.340226184102, 9497.762555936157, 9506.857397139049, 9580.616775329048, 9603.0, 668.1781408867121, 670.4368330602317, 671.278375746075, 673.9090222819857, 675.1864003875319, 4088.7342322749523, 4152.896177595584, 4156.771377574202, 4240.448741663564, 4337.584112753348, 64842.35157648457, 65386.346136538974, 67150.66424667845, 67189.66405167943, 67360.0, 54812.0, 55641.0, 56516.717416412655, 56913.71543142341, 59806.40193598095, 48217.75891120522, 48240.0, 50989.0, 51272.48727512752, 51404.22893656598, 8851.645934162561, 8951.32865035138, 9009.54952252398, 9168.954155229181, 9232.169104780332, 32804.0, 32994.98728078767, 33065.17337066496, 33302.66697332996, 33461.49807752837, 40537.1892562153, 41309.58690413057, 41447.58552414437, 41451.7927410361, 44510.0, 11386.259893106922, 11436.542538298707, 11545.942270288931, 11610.303381797119, 11875.049996000473, 12255.509779608716, 12480.625581232578, 12543.686407839878, 12871.22772633645, 13021.739565208452, 11705.356205408785, 11728.70678233051, 11770.411479426166, 11837.289762614271, 12180.695482612651, 11370.886291136983, 11924.523019079139, 12265.976113941457, 12270.570530031406, 12410.441530131346, 11769.117316201147, 11800.468978896142, 11935.820962685393, 12024.639260822189, 12081.75836483283, 9694.0, 9707.951460242653, 9775.413475191512, 9963.202943764627, 10443.321184123008, 9382.437053776795, 9707.854382184414, 10186.236032297458, 10232.53953572106, 10290.3825770454], "value": 6571.92636362555, "unit": "score"}], "name": "dromaeo_css", "value": 6915.362589074544, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 114.0, 111.0, 111.0, 124.0, 112.0, 112.0, 112.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 160.0, 181.0, 130.0, 160.0, 157.0, 129.0, 196.0, 128.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 162.0, 165.0, 175.0, 164.0, 166.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 158.0, 74.0, 76.0, 75.0, 80.0, 165.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 153.0, 93.0, 93.0, 92.0, 152.0, 92.0, 92.0, 147.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 145.0, 147.0, 150.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 58.0, 85.0, 56.0, 56.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 62.0, 61.0, 61.0, 61.0, 60.0, 60.0, 63.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 87.0, 79.0, 79.0, 77.0, 85.0, 78.0, 79.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 144.0, 126.0, 131.0, 140.0, 126.0, 130.0, 127.0, 159.0, 131.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 205.0, 203.0, 208.0, 206.0, 211.0, 208.0, 208.0, 207.0, 216.0], "value": 207.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 71.0, 71.0, 70.0, 72.0, 69.0, 69.0, 78.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1608.0000000000002, "alertThreshold": 2.0}]} 08:28:11 INFO - Return code: 0 08:28:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:28:11 ERROR - # TBPL SUCCESS # 08:28:11 INFO - Running post-action listener: _resource_record_post_action 08:28:11 INFO - Running post-run listener: _resource_record_post_run 08:28:12 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534462464; Read time: 12; Write time: 1045308 08:28:12 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 202764288; Read time: 0; Write time: 521972 08:28:12 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289746944; Read time: 12; Write time: 514892 08:28:12 INFO - Running post-run listener: _upload_blobber_files 08:28:12 INFO - Blob upload gear active. 08:28:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:28:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:28:12 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:28:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:13 INFO - (blobuploader) - INFO - Done attempting. 08:28:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:28:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:28:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:14 INFO - (blobuploader) - INFO - Done attempting. 08:28:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:14 INFO - Return code: 0 08:28:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cff64f6102d2687994bd6eea121a42ef55fa028e096a2e0e9265863475f393c45723aa5f371eadc3b52002470f5ab939f6c2b069a59821c875dd45ef592d56a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/155aa95efb9f4a0c56e93e27fbcc43379ce99ea986b8e83582eead78a69f3867d62a4e58e20d16750d9b589b0871b51de961cc78cdcf5804f1331b74e775a5ef"} 08:28:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:14 INFO - Contents: 08:28:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cff64f6102d2687994bd6eea121a42ef55fa028e096a2e0e9265863475f393c45723aa5f371eadc3b52002470f5ab939f6c2b069a59821c875dd45ef592d56a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/155aa95efb9f4a0c56e93e27fbcc43379ce99ea986b8e83582eead78a69f3867d62a4e58e20d16750d9b589b0871b51de961cc78cdcf5804f1331b74e775a5ef"} 08:28:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:14 INFO - Copying logs to upload dir... 08:28:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.156896 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-26 08:28:14.485041) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 08:28:14.488201) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743 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/Fx-Team/sha512/1cff64f6102d2687994bd6eea121a42ef55fa028e096a2e0e9265863475f393c45723aa5f371eadc3b52002470f5ab939f6c2b069a59821c875dd45ef592d56a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/155aa95efb9f4a0c56e93e27fbcc43379ce99ea986b8e83582eead78a69f3867d62a4e58e20d16750d9b589b0871b51de961cc78cdcf5804f1331b74e775a5ef"} build_url:https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/AhqvJsVZRiyl-9wq0zV56Q/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/Fx-Team/sha512/1cff64f6102d2687994bd6eea121a42ef55fa028e096a2e0e9265863475f393c45723aa5f371eadc3b52002470f5ab939f6c2b069a59821c875dd45ef592d56a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/155aa95efb9f4a0c56e93e27fbcc43379ce99ea986b8e83582eead78a69f3867d62a4e58e20d16750d9b589b0871b51de961cc78cdcf5804f1331b74e775a5ef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 08:28:14.512699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:28:14.513019) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461682802.418291-750277743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:28:14.596097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 08:28:14.596405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 08:28:14.596696) ========= ========= Total master_lag: 0.17 =========