builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1461978157.69 results: success (0) buildid: 20160429172135 builduid: fafd1f9ae6544e29a465af53fdf4d328 revision: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.685500) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.686777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.687474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.708675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.709026) ========= 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=eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 18:02:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.3M=0s 2016-04-29 18:02:39 (66.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.806420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.806885) ========= 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=eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020796 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.865797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.866151) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b7b5c87cf2b319aa751a5903f42ee2e5883749a --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 3b7b5c87cf2b319aa751a5903f42ee2e5883749a --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=eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 18:02:39,186 truncating revision to first 12 chars 2016-04-29 18:02:39,186 Setting DEBUG logging. 2016-04-29 18:02:39,186 attempt 1/10 2016-04-29 18:02:39,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b7b5c87cf2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 18:02:39,440 unpacking tar archive at: fx-team-3b7b5c87cf2b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:38.398557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:38.398935) ========= script_repo_revision: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:38.399373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:38.399690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:38.408558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-29 18:02:38.409299) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:02:39 INFO - MultiFileLogger online at 20160429 18:02:39 in /builds/slave/test 18:02:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:02:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:02:39 INFO - {'append_to_log': False, 18:02:39 INFO - 'base_work_dir': '/builds/slave/test', 18:02:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:02:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:02:39 INFO - 'branch': 'Fx-Team-Non-PGO', 18:02:39 INFO - 'buildbot_json_path': 'buildprops.json', 18:02:39 INFO - 'config_files': ('talos/linux_config.py',), 18:02:39 INFO - 'default_actions': ('clobber', 18:02:39 INFO - 'read-buildbot-config', 18:02:39 INFO - 'download-and-extract', 18:02:39 INFO - 'populate-webroot', 18:02:39 INFO - 'create-virtualenv', 18:02:39 INFO - 'install', 18:02:39 INFO - 'run-tests'), 18:02:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:02:39 INFO - 'download_minidump_stackwalk': True, 18:02:39 INFO - 'download_symbols': 'ondemand', 18:02:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:02:39 INFO - 'tooltool.py': '/tools/tooltool.py', 18:02:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:02:39 INFO - '/tools/misc-python/virtualenv.py')}, 18:02:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:02:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:02:39 INFO - 'installer_path': 'installer.exe', 18:02:39 INFO - 'log_level': 'info', 18:02:39 INFO - 'log_name': 'talos', 18:02:39 INFO - 'log_to_console': True, 18:02:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:02:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:02:39 INFO - 'opt_config_files': (), 18:02:39 INFO - 'pip_index': False, 18:02:39 INFO - 'sps_profile': False, 18:02:39 INFO - 'sps_profile_interval': 0, 18:02:39 INFO - 'suite': 'dromaeojs', 18:02:39 INFO - 'system_bits': '32', 18:02:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:02:39 INFO - 'title': 'talos-linux64-ix-010', 18:02:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:02:39 INFO - 'use_talos_json': True, 18:02:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:02:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:02:39 INFO - 'work_dir': 'build'} 18:02:39 INFO - ##### 18:02:39 INFO - ##### Running clobber step. 18:02:39 INFO - ##### 18:02:39 INFO - Running pre-action listener: _resource_record_pre_action 18:02:39 INFO - Running main action method: clobber 18:02:39 INFO - rmtree: /builds/slave/test/build 18:02:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:02:40 INFO - Running post-action listener: _resource_record_post_action 18:02:40 INFO - ##### 18:02:40 INFO - ##### Running read-buildbot-config step. 18:02:40 INFO - ##### 18:02:40 INFO - Running pre-action listener: _resource_record_pre_action 18:02:40 INFO - Running main action method: read_buildbot_config 18:02:40 INFO - Using buildbot properties: 18:02:40 INFO - { 18:02:40 INFO - "project": "", 18:02:40 INFO - "product": "firefox", 18:02:40 INFO - "script_repo_revision": "production", 18:02:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:02:40 INFO - "repository": "", 18:02:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:02:40 INFO - "buildid": "20160429172135", 18:02:40 INFO - "pgo_build": "False", 18:02:40 INFO - "basedir": "/builds/slave/test", 18:02:40 INFO - "buildnumber": 1721, 18:02:40 INFO - "slavename": "talos-linux64-ix-010", 18:02:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:02:40 INFO - "platform": "ubuntu64_hw", 18:02:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:02:40 INFO - "branch": "fx-team", 18:02:40 INFO - "repo_path": "integration/fx-team", 18:02:40 INFO - "revision": "3b7b5c87cf2b319aa751a5903f42ee2e5883749a", 18:02:40 INFO - "stage_platform": "linux64", 18:02:40 INFO - "builduid": "fafd1f9ae6544e29a465af53fdf4d328", 18:02:40 INFO - "slavebuilddir": "test" 18:02:40 INFO - } 18:02:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:02:40 INFO - Running post-action listener: _resource_record_post_action 18:02:40 INFO - ##### 18:02:40 INFO - ##### Running download-and-extract step. 18:02:40 INFO - ##### 18:02:40 INFO - Running pre-action listener: _resource_record_pre_action 18:02:40 INFO - Running main action method: download_and_extract 18:02:40 INFO - mkdir: /builds/slave/test/build/tests 18:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:40 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:41 INFO - Downloaded 1361 bytes. 18:02:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:02:41 INFO - Using the following test package requirements: 18:02:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:02:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:02:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:02:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:41 INFO - u'jsshell-linux-x86_64.zip'], 18:02:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:02:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:02:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:02:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:02:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:02:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:02:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:41 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:42 INFO - Downloaded 22304506 bytes. 18:02:42 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'] 18:02:42 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 18:02:43 INFO - Return code: 0 18:02:43 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 18:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:43 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:47 INFO - Downloaded 22304506 bytes. 18:02:47 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'] 18:02:47 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 18:02:49 INFO - Return code: 0 18:02:49 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')]} 18:02:49 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:50 INFO - Downloaded 10840152 bytes. 18:02: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'] 18:02: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 18:02:50 INFO - Return code: 0 18:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:50 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:02:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:02:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:02:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:52 INFO - Downloaded 54918257 bytes. 18:02:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:02:52 INFO - mkdir: /builds/slave/test/properties 18:02:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:02:52 INFO - Writing to file /builds/slave/test/properties/build_url 18:02:52 INFO - Contents: 18:02:52 INFO - build_url:https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:02:54 INFO - Running post-action listener: _resource_record_post_action 18:02:54 INFO - Running post-action listener: set_extra_try_arguments 18:02:54 INFO - ##### 18:02:54 INFO - ##### Running populate-webroot step. 18:02:54 INFO - ##### 18:02:54 INFO - Running pre-action listener: _resource_record_pre_action 18:02:54 INFO - Running main action method: populate_webroot 18:02:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:02:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:02:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:02:54 INFO - '--tppagecycles', 18:02:54 INFO - '7'], 18:02:54 INFO - 'tests': ['tsvgm']}}, 18:02:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:02:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:02:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:02:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:02:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:54 INFO - 'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:02:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:02:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:54 INFO - 'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['damp', 'tps']}, 18:02:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:54 INFO - 'tests': ['damp', 'tps']}, 18:02:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['dromaeo_dom']}, 18:02:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:02:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['a11yr', 18:02:54 INFO - 'ts_paint', 18:02:54 INFO - 'tpaint', 18:02:54 INFO - 'sessionrestore', 18:02:54 INFO - 'sessionrestore_no_auto_restore', 18:02:54 INFO - 'tabpaint']}, 18:02:54 INFO - 'other-e10s': {'tests': ['a11yr', 18:02:54 INFO - 'ts_paint', 18:02:54 INFO - 'tpaint', 18:02:54 INFO - 'sessionrestore', 18:02:54 INFO - 'sessionrestore_no_auto_restore', 18:02:54 INFO - 'tabpaint']}, 18:02:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:02:54 INFO - 'ts_paint', 18:02:54 INFO - 'tpaint', 18:02:54 INFO - 'sessionrestore', 18:02:54 INFO - 'sessionrestore_no_auto_restore', 18:02:54 INFO - 'tabpaint']}, 18:02:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:02:54 INFO - 'ts_paint', 18:02:54 INFO - 'tpaint', 18:02:54 INFO - 'sessionrestore', 18:02:54 INFO - 'sessionrestore_no_auto_restore', 18:02:54 INFO - 'tabpaint']}, 18:02:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['a11yr', 18:02:54 INFO - 'ts_paint', 18:02:54 INFO - 'tpaint', 18:02:54 INFO - 'sessionrestore', 18:02:54 INFO - 'sessionrestore_no_auto_restore', 18:02:54 INFO - 'tabpaint']}, 18:02:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['a11yr', 18:02:54 INFO - 'ts_paint', 18:02:54 INFO - 'tpaint', 18:02:54 INFO - 'sessionrestore', 18:02:54 INFO - 'sessionrestore_no_auto_restore', 18:02:54 INFO - 'tabpaint']}, 18:02:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['tsvgx', 18:02:54 INFO - 'tsvgr_opacity', 18:02:54 INFO - 'tart', 18:02:54 INFO - 'tscrollx', 18:02:54 INFO - 'cart']}, 18:02:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:02:54 INFO - 'tsvgr_opacity', 18:02:54 INFO - 'tart', 18:02:54 INFO - 'tscrollx', 18:02:54 INFO - 'cart']}, 18:02:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:54 INFO - 'talos_options': ['--disable-e10s'], 18:02:54 INFO - 'tests': ['tp5o']}, 18:02:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:54 INFO - 'tests': ['tp5o']}, 18:02:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:54 INFO - 'talos_options': ['--disable-e10s', 18:02:54 INFO - '--xperf_path', 18:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:02:54 INFO - 'tests': ['tp5n']}, 18:02:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:54 INFO - 'talos_options': ['--xperf_path', 18:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:02:54 INFO - 'tests': ['tp5n']}}, 18:02:54 INFO - 'talos.zip': {'path': '', 18:02:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:02:54 INFO - Running post-action listener: _resource_record_post_action 18:02:54 INFO - ##### 18:02:54 INFO - ##### Running create-virtualenv step. 18:02:54 INFO - ##### 18:02:54 INFO - Running pre-action listener: _resource_record_pre_action 18:02:54 INFO - Running main action method: create_virtualenv 18:02:54 INFO - Creating virtualenv /builds/slave/test/build/venv 18:02:54 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 18:02:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:02:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:02:54 INFO - Using real prefix '/usr' 18:02:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:02:55 INFO - Installing distribute.............................................................................................................................................................................................done. 18:02:57 INFO - Installing pip.................done. 18:02:57 INFO - Return code: 0 18:02:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:57 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:02:57 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 18:02:57 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 18:02:57 INFO - Using env: {'DISPLAY': ':0', 18:02:57 INFO - 'HOME': '/home/cltbld', 18:02:57 INFO - 'LANG': 'en_US.UTF-8', 18:02:57 INFO - 'LANGUAGE': 'en_US:en', 18:02:57 INFO - 'LOGNAME': 'cltbld', 18:02:57 INFO - 'MAIL': '/var/mail/cltbld', 18:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:57 INFO - 'MOZ_NO_REMOTE': '1', 18:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:02:57 INFO - 'NO_EM_RESTART': '1', 18:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:57 INFO - 'PWD': '/builds/slave/test', 18:02:57 INFO - 'SHELL': '/bin/bash', 18:02:57 INFO - 'SHLVL': '1', 18:02:57 INFO - 'TERM': 'linux', 18:02:57 INFO - 'TMOUT': '86400', 18:02:57 INFO - 'USER': 'cltbld', 18:02:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:57 INFO - '_': '/tools/buildbot/bin/python'} 18:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:57 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 18:02:57 INFO - Cleaning up... 18:02:57 INFO - Return code: 0 18:02:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:57 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:02:57 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 18:02:57 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 18:02:57 INFO - Using env: {'DISPLAY': ':0', 18:02:57 INFO - 'HOME': '/home/cltbld', 18:02:57 INFO - 'LANG': 'en_US.UTF-8', 18:02:57 INFO - 'LANGUAGE': 'en_US:en', 18:02:57 INFO - 'LOGNAME': 'cltbld', 18:02:57 INFO - 'MAIL': '/var/mail/cltbld', 18:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:57 INFO - 'MOZ_NO_REMOTE': '1', 18:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:02:57 INFO - 'NO_EM_RESTART': '1', 18:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:57 INFO - 'PWD': '/builds/slave/test', 18:02:57 INFO - 'SHELL': '/bin/bash', 18:02:57 INFO - 'SHLVL': '1', 18:02:57 INFO - 'TERM': 'linux', 18:02:57 INFO - 'TMOUT': '86400', 18:02:57 INFO - 'USER': 'cltbld', 18:02:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:57 INFO - '_': '/tools/buildbot/bin/python'} 18:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:57 INFO - Downloading/unpacking psutil>=0.7.1 18:02:57 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 18:02:57 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 18:02:57 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 18:02:57 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 18:02:57 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 18:02:57 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 18:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:02:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:02:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:02:59 INFO - Installing collected packages: psutil 18:02:59 INFO - Running setup.py install for psutil 18:02:59 INFO - building 'psutil._psutil_linux' extension 18:02:59 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 18:03:00 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 18:03:00 INFO - building 'psutil._psutil_posix' extension 18:03:00 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 18:03:00 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 18:03:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:03:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:03:00 INFO - Successfully installed psutil 18:03:00 INFO - Cleaning up... 18:03:00 INFO - Return code: 0 18:03:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:00 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:03:00 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 18:03:00 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 18:03:00 INFO - Using env: {'DISPLAY': ':0', 18:03:00 INFO - 'HOME': '/home/cltbld', 18:03:00 INFO - 'LANG': 'en_US.UTF-8', 18:03:00 INFO - 'LANGUAGE': 'en_US:en', 18:03:00 INFO - 'LOGNAME': 'cltbld', 18:03:00 INFO - 'MAIL': '/var/mail/cltbld', 18:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:00 INFO - 'MOZ_NO_REMOTE': '1', 18:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:00 INFO - 'NO_EM_RESTART': '1', 18:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:00 INFO - 'PWD': '/builds/slave/test', 18:03:00 INFO - 'SHELL': '/bin/bash', 18:03:00 INFO - 'SHLVL': '1', 18:03:00 INFO - 'TERM': 'linux', 18:03:00 INFO - 'TMOUT': '86400', 18:03:00 INFO - 'USER': 'cltbld', 18:03:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:00 INFO - '_': '/tools/buildbot/bin/python'} 18:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:03:00 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 18:03:00 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 18:03:00 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 18:03:00 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 18:03:00 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 18:03:00 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 18:03:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:03:02 INFO - Installing collected packages: mozsystemmonitor 18:03:02 INFO - Running setup.py install for mozsystemmonitor 18:03:02 INFO - Successfully installed mozsystemmonitor 18:03:02 INFO - Cleaning up... 18:03:02 INFO - Return code: 0 18:03:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:02 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:03:02 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 18:03:02 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 18:03:02 INFO - Using env: {'DISPLAY': ':0', 18:03:02 INFO - 'HOME': '/home/cltbld', 18:03:02 INFO - 'LANG': 'en_US.UTF-8', 18:03:02 INFO - 'LANGUAGE': 'en_US:en', 18:03:02 INFO - 'LOGNAME': 'cltbld', 18:03:02 INFO - 'MAIL': '/var/mail/cltbld', 18:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:02 INFO - 'MOZ_NO_REMOTE': '1', 18:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:02 INFO - 'NO_EM_RESTART': '1', 18:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:02 INFO - 'PWD': '/builds/slave/test', 18:03:02 INFO - 'SHELL': '/bin/bash', 18:03:02 INFO - 'SHLVL': '1', 18:03:02 INFO - 'TERM': 'linux', 18:03:02 INFO - 'TMOUT': '86400', 18:03:02 INFO - 'USER': 'cltbld', 18:03:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:02 INFO - '_': '/tools/buildbot/bin/python'} 18:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:02 INFO - Downloading/unpacking blobuploader==1.2.4 18:03:02 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 18:03:02 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 18:03:02 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 18:03:02 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 18:03:02 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 18:03:02 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 18:03:04 INFO - Downloading blobuploader-1.2.4.tar.gz 18:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:03:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:03:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:03:05 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 18:03:05 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 18:03:05 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 18:03:05 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 18:03:05 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 18:03:05 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 18:03:05 INFO - Downloading docopt-0.6.1.tar.gz 18:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:03:05 INFO - Installing collected packages: blobuploader, requests, docopt 18:03:05 INFO - Running setup.py install for blobuploader 18:03:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:03:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:03:05 INFO - Running setup.py install for requests 18:03:05 INFO - Running setup.py install for docopt 18:03:06 INFO - Successfully installed blobuploader requests docopt 18:03:06 INFO - Cleaning up... 18:03:06 INFO - Return code: 0 18:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:06 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')]} 18:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:06 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')]} 18:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:06 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:03:06 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 18:03:06 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 18:03:06 INFO - Using env: {'DISPLAY': ':0', 18:03:06 INFO - 'HOME': '/home/cltbld', 18:03:06 INFO - 'LANG': 'en_US.UTF-8', 18:03:06 INFO - 'LANGUAGE': 'en_US:en', 18:03:06 INFO - 'LOGNAME': 'cltbld', 18:03:06 INFO - 'MAIL': '/var/mail/cltbld', 18:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:06 INFO - 'MOZ_NO_REMOTE': '1', 18:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:06 INFO - 'NO_EM_RESTART': '1', 18:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:06 INFO - 'PWD': '/builds/slave/test', 18:03:06 INFO - 'SHELL': '/bin/bash', 18:03:06 INFO - 'SHLVL': '1', 18:03:06 INFO - 'TERM': 'linux', 18:03:06 INFO - 'TMOUT': '86400', 18:03:06 INFO - 'USER': 'cltbld', 18:03:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:06 INFO - '_': '/tools/buildbot/bin/python'} 18:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:03:06 INFO - Running setup.py (path:/tmp/pip-gZkU2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:03:06 INFO - Running setup.py (path:/tmp/pip-gZrzIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:03:06 INFO - Running setup.py (path:/tmp/pip-CTuDHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:03:06 INFO - Running setup.py (path:/tmp/pip-UOhlsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:03:06 INFO - Running setup.py (path:/tmp/pip-F2Nqz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:03:06 INFO - Running setup.py (path:/tmp/pip-F3wjjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:03:06 INFO - Running setup.py (path:/tmp/pip-o8AGfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:03:06 INFO - Running setup.py (path:/tmp/pip-lKM36y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:03:06 INFO - Running setup.py (path:/tmp/pip-4zHUsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:03:06 INFO - Running setup.py (path:/tmp/pip-tQlrMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:03:07 INFO - Running setup.py (path:/tmp/pip-9AVNcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:03:07 INFO - Running setup.py (path:/tmp/pip-Sm4OzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:03:07 INFO - Running setup.py (path:/tmp/pip-KJMm8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:03:07 INFO - Running setup.py (path:/tmp/pip-VetFwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:07 INFO - Running setup.py (path:/tmp/pip-SBLREP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:03:07 INFO - Running setup.py (path:/tmp/pip-brLyyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:03:07 INFO - Running setup.py (path:/tmp/pip-DTR94Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:03:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:03:07 INFO - Running setup.py install for manifestparser 18:03:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for mozcrash 18:03:07 INFO - Running setup.py install for mozdebug 18:03:07 INFO - Running setup.py install for mozdevice 18:03:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for mozfile 18:03:08 INFO - Running setup.py install for mozhttpd 18:03:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Running setup.py install for mozinfo 18:03:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Running setup.py install for mozInstall 18:03:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Running setup.py install for mozleak 18:03:08 INFO - Running setup.py install for mozlog 18:03:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Running setup.py install for moznetwork 18:03:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Running setup.py install for mozprocess 18:03:08 INFO - Running setup.py install for mozprofile 18:03:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Running setup.py install for mozrunner 18:03:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:03:09 INFO - Running setup.py install for mozscreenshot 18:03:09 INFO - Running setup.py install for moztest 18:03:09 INFO - Running setup.py install for mozversion 18:03:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:03:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:03:09 INFO - Cleaning up... 18:03:09 INFO - Return code: 0 18:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:09 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')]} 18:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:09 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')]} 18:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:09 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:03:09 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 18:03:09 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 18:03:09 INFO - Using env: {'DISPLAY': ':0', 18:03:09 INFO - 'HOME': '/home/cltbld', 18:03:09 INFO - 'LANG': 'en_US.UTF-8', 18:03:09 INFO - 'LANGUAGE': 'en_US:en', 18:03:09 INFO - 'LOGNAME': 'cltbld', 18:03:09 INFO - 'MAIL': '/var/mail/cltbld', 18:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:09 INFO - 'MOZ_NO_REMOTE': '1', 18:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:09 INFO - 'NO_EM_RESTART': '1', 18:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:09 INFO - 'PWD': '/builds/slave/test', 18:03:09 INFO - 'SHELL': '/bin/bash', 18:03:09 INFO - 'SHLVL': '1', 18:03:09 INFO - 'TERM': 'linux', 18:03:09 INFO - 'TMOUT': '86400', 18:03:09 INFO - 'USER': 'cltbld', 18:03:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:09 INFO - '_': '/tools/buildbot/bin/python'} 18:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:03:09 INFO - Running setup.py (path:/tmp/pip-OzBeVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:03:09 INFO - Running setup.py (path:/tmp/pip-vF0tzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:03:09 INFO - Running setup.py (path:/tmp/pip-8Zzvrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:03:09 INFO - Running setup.py (path:/tmp/pip-lsEhUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:03:09 INFO - Running setup.py (path:/tmp/pip-AH_s4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:03:09 INFO - Running setup.py (path:/tmp/pip-Q4PVxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:03:09 INFO - Running setup.py (path:/tmp/pip-ttRqMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:03:10 INFO - Running setup.py (path:/tmp/pip-PE4HXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:03:10 INFO - Running setup.py (path:/tmp/pip-QYqnKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:03:10 INFO - Running setup.py (path:/tmp/pip-09zmn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:03:10 INFO - Running setup.py (path:/tmp/pip-FBtbVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:03:10 INFO - Running setup.py (path:/tmp/pip-tFG2Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:03:10 INFO - Running setup.py (path:/tmp/pip-QwbQM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:03:10 INFO - Running setup.py (path:/tmp/pip-g6SP3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:10 INFO - Running setup.py (path:/tmp/pip-YOXX6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:03:10 INFO - Running setup.py (path:/tmp/pip-EBwog8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:03:10 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)) 18:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:03:10 INFO - Running setup.py (path:/tmp/pip-ZQcZJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:03:10 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)) 18:03:10 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)) 18:03:10 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)) 18:03:10 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)) 18:03:10 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)) 18:03:10 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)) 18:03:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:03:10 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 18:03:10 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 18:03:10 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 18:03:10 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 18:03:10 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 18:03:10 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 18:03:12 INFO - Downloading blessings-1.6.tar.gz 18:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:03:12 INFO - Installing collected packages: blessings 18:03:12 INFO - Running setup.py install for blessings 18:03:12 INFO - Successfully installed blessings 18:03:12 INFO - Cleaning up... 18:03:12 INFO - Return code: 0 18:03:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:03:13 INFO - Reading from file tmpfile_stdout 18:03:13 INFO - Current package versions: 18:03:13 INFO - argparse == 1.2.1 18:03:13 INFO - blessings == 1.6 18:03:13 INFO - blobuploader == 1.2.4 18:03:13 INFO - docopt == 0.6.1 18:03:13 INFO - manifestparser == 1.1 18:03:13 INFO - mozInstall == 1.12 18:03:13 INFO - mozcrash == 0.17 18:03:13 INFO - mozdebug == 0.1 18:03:13 INFO - mozdevice == 0.48 18:03:13 INFO - mozfile == 1.2 18:03:13 INFO - mozhttpd == 0.7 18:03:13 INFO - mozinfo == 0.9 18:03:13 INFO - mozleak == 0.1 18:03:13 INFO - mozlog == 3.1 18:03:13 INFO - moznetwork == 0.27 18:03:13 INFO - mozprocess == 0.22 18:03:13 INFO - mozprofile == 0.28 18:03:13 INFO - mozrunner == 6.11 18:03:13 INFO - mozscreenshot == 0.1 18:03:13 INFO - mozsystemmonitor == 0.0 18:03:13 INFO - moztest == 0.7 18:03:13 INFO - mozversion == 1.4 18:03:13 INFO - psutil == 3.1.1 18:03:13 INFO - requests == 1.2.3 18:03:13 INFO - wsgiref == 0.1.2 18:03:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:13 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')]} 18:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:13 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')]} 18:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:13 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:03:13 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 18:03:13 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 18:03:13 INFO - Using env: {'DISPLAY': ':0', 18:03:13 INFO - 'HOME': '/home/cltbld', 18:03:13 INFO - 'LANG': 'en_US.UTF-8', 18:03:13 INFO - 'LANGUAGE': 'en_US:en', 18:03:13 INFO - 'LOGNAME': 'cltbld', 18:03:13 INFO - 'MAIL': '/var/mail/cltbld', 18:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:13 INFO - 'MOZ_NO_REMOTE': '1', 18:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:13 INFO - 'NO_EM_RESTART': '1', 18:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:13 INFO - 'PWD': '/builds/slave/test', 18:03:13 INFO - 'SHELL': '/bin/bash', 18:03:13 INFO - 'SHLVL': '1', 18:03:13 INFO - 'TERM': 'linux', 18:03:13 INFO - 'TMOUT': '86400', 18:03:13 INFO - 'USER': 'cltbld', 18:03:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:13 INFO - '_': '/tools/buildbot/bin/python'} 18:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 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)) 18:03:13 INFO - Cleaning up... 18:03:13 INFO - Return code: 0 18:03:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:03:13 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')]} 18:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:13 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')]} 18:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:13 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:03:13 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 18:03:13 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 18:03:13 INFO - Using env: {'DISPLAY': ':0', 18:03:13 INFO - 'HOME': '/home/cltbld', 18:03:13 INFO - 'LANG': 'en_US.UTF-8', 18:03:13 INFO - 'LANGUAGE': 'en_US:en', 18:03:13 INFO - 'LOGNAME': 'cltbld', 18:03:13 INFO - 'MAIL': '/var/mail/cltbld', 18:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:13 INFO - 'MOZ_NO_REMOTE': '1', 18:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:13 INFO - 'NO_EM_RESTART': '1', 18:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:13 INFO - 'PWD': '/builds/slave/test', 18:03:13 INFO - 'SHELL': '/bin/bash', 18:03:13 INFO - 'SHLVL': '1', 18:03:13 INFO - 'TERM': 'linux', 18:03:13 INFO - 'TMOUT': '86400', 18:03:13 INFO - 'USER': 'cltbld', 18:03:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:13 INFO - '_': '/tools/buildbot/bin/python'} 18:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:13 INFO - Downloading/unpacking jsonschema 18:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:03:15 INFO - Downloading/unpacking functools32 (from jsonschema) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:15 INFO - Downloading functools32-3.2.3-2.tar.gz 18:03:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:03:15 INFO - warning: no files found matching '*.txt' 18:03:15 INFO - no previously-included directories found matching 'build' 18:03:15 INFO - no previously-included directories found matching 'dist' 18:03:15 INFO - no previously-included directories found matching '.git*' 18:03:15 INFO - Installing collected packages: jsonschema, functools32 18:03:15 INFO - Running setup.py install for functools32 18:03:15 INFO - warning: no files found matching '*.txt' 18:03:15 INFO - no previously-included directories found matching 'build' 18:03:15 INFO - no previously-included directories found matching 'dist' 18:03:15 INFO - no previously-included directories found matching '.git*' 18:03:15 INFO - Successfully installed jsonschema functools32 18:03:15 INFO - Cleaning up... 18:03:15 INFO - Return code: 0 18:03:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:15 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 0x7fdce8656f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', '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 18:03:15 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 18:03:15 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 18:03:15 INFO - Using env: {'DISPLAY': ':0', 18:03:15 INFO - 'HOME': '/home/cltbld', 18:03:15 INFO - 'LANG': 'en_US.UTF-8', 18:03:15 INFO - 'LANGUAGE': 'en_US:en', 18:03:15 INFO - 'LOGNAME': 'cltbld', 18:03:15 INFO - 'MAIL': '/var/mail/cltbld', 18:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:15 INFO - 'MOZ_NO_REMOTE': '1', 18:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:15 INFO - 'NO_EM_RESTART': '1', 18:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:15 INFO - 'PWD': '/builds/slave/test', 18:03:15 INFO - 'SHELL': '/bin/bash', 18:03:15 INFO - 'SHLVL': '1', 18:03:15 INFO - 'TERM': 'linux', 18:03:15 INFO - 'TMOUT': '86400', 18:03:15 INFO - 'USER': 'cltbld', 18:03:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:15 INFO - '_': '/tools/buildbot/bin/python'} 18:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:16 INFO - Downloading/unpacking flake8 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:03:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:03:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:03:18 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 18:03:18 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 18:03:18 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 18:03:18 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 18:03:18 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 18:03:18 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 18:03:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:03:18 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 18:03:18 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 18:03:18 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 18:03:18 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 18:03:18 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 18:03:18 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 18:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:03:18 INFO - no previously-included directories found matching 'docs/_build' 18:03:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:03:18 INFO - Running setup.py install for pep8 18:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:03:18 INFO - no previously-included directories found matching 'docs/_build' 18:03:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:03:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:03:18 INFO - Cleaning up... 18:03:18 INFO - Return code: 0 18:03:18 INFO - Running post-action listener: _resource_record_post_action 18:03:18 INFO - Running post-action listener: _start_resource_monitoring 18:03:18 INFO - Starting resource monitoring. 18:03:18 INFO - ##### 18:03:18 INFO - ##### Running install step. 18:03:18 INFO - ##### 18:03:18 INFO - Running pre-action listener: _resource_record_pre_action 18:03:18 INFO - Running main action method: install 18:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:03:19 INFO - Reading from file tmpfile_stdout 18:03:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:03:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:03:19 INFO - Reading from file tmpfile_stdout 18:03:19 INFO - Output received: 18:03:19 INFO - Usage: mozinstall [options] installer 18:03:19 INFO - Options: 18:03:19 INFO - -h, --help show this help message and exit 18:03:19 INFO - -d DEST, --destination=DEST 18:03:19 INFO - Directory to install application into. [default: 18:03:19 INFO - "/builds/slave/test"] 18:03:19 INFO - --app=APP Application being installed. [default: firefox] 18:03:19 INFO - mkdir: /builds/slave/test/build/application 18:03:19 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'] 18:03:19 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 18:03:35 INFO - Reading from file tmpfile_stdout 18:03:35 INFO - Output received: 18:03:35 INFO - /builds/slave/test/build/application/firefox/firefox 18:03:35 INFO - Running post-action listener: _resource_record_post_action 18:03:35 INFO - ##### 18:03:35 INFO - ##### Running run-tests step. 18:03:35 INFO - ##### 18:03:35 INFO - Running pre-action listener: _resource_record_pre_action 18:03:35 INFO - Running main action method: run_tests 18:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:03:35 INFO - Python 2.7.3 18:03:35 INFO - Return code: 0 18:03:35 INFO - grabbing minidump binary from tooltool 18:03:35 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')]} 18:03:35 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 0x13d1410>, '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 0x13d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:03:35 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 18:03:35 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 18:03:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:03:35 INFO - Return code: 0 18:03:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:03:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:03:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:03:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:03:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:03:36 INFO - Return code: 0 18:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:03:36 INFO - Using env: {'DISPLAY': ':0', 18:03:36 INFO - 'HOME': '/home/cltbld', 18:03:36 INFO - 'LANG': 'en_US.UTF-8', 18:03:36 INFO - 'LANGUAGE': 'en_US:en', 18:03:36 INFO - 'LOGNAME': 'cltbld', 18:03:36 INFO - 'MAIL': '/var/mail/cltbld', 18:03:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:03:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:36 INFO - 'MOZ_NO_REMOTE': '1', 18:03:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:36 INFO - 'NO_EM_RESTART': '1', 18:03:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:36 INFO - 'PWD': '/builds/slave/test', 18:03:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:03:36 INFO - 'SHELL': '/bin/bash', 18:03:36 INFO - 'SHLVL': '1', 18:03:36 INFO - 'TERM': 'linux', 18:03:36 INFO - 'TMOUT': '86400', 18:03:36 INFO - 'USER': 'cltbld', 18:03:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082', 18:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:36 INFO - '_': '/tools/buildbot/bin/python'} 18:03:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:03:36 INFO - mozversion application_buildid: 20160429172135 18:03:36 INFO - mozversion application_changeset: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a 18:03:36 INFO - mozversion application_display_name: Nightly 18:03:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:03:36 INFO - mozversion application_name: Firefox 18:03:36 INFO - mozversion application_remotingname: firefox 18:03:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:03:36 INFO - mozversion application_vendor: Mozilla 18:03:36 INFO - mozversion application_version: 49.0a1 18:03:36 INFO - mozversion platform_buildid: 20160429172135 18:03:36 INFO - mozversion platform_changeset: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a 18:03:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:03:36 INFO - mozversion platform_version: 49.0a1 18:03:36 INFO - using testdate: 1461978216 18:03:36 INFO - actual date: 1461978216 18:03:36 INFO - starting webserver on 'localhost:55563' 18:03:36 INFO - SUITE-START | Running 2 tests 18:03:36 INFO - TEST-START | dromaeo_css 18:03:36 INFO - operating with platform_type : linux_ 18:03:36 INFO - Initialising browser for dromaeo_css test... 18:03:36 INFO - TEST-INFO | started process 26528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sRMt5/profile http://localhost:55563/getInfo.html) 18:03:40 INFO - PROCESS | 26528 | __metrics Screen width/height:1600/1200 18:03:40 INFO - PROCESS | 26528 | colorDepth:24 18:03:40 INFO - PROCESS | 26528 | Browser inner width/height: 1024/697 18:03:40 INFO - PROCESS | 26528 | __metrics 18:03:41 ERROR - PROCESS | 26528 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:03:42 INFO - TEST-INFO | 26528: exit 0 18:03:42 INFO - Browser initialized. 18:03:42 INFO - Running cycle 1/1 for dromaeo_css test... 18:03:42 INFO - TEST-INFO | started process 26609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sRMt5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:54 INFO - PROCESS | 26609 | RSS: Main: 155934720 18:03:54 INFO - PROCESS | 26609 | 18:04:45 INFO - PROCESS | 26609 | 1461978285992 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] 18:06:56 INFO - PROCESS | 26609 | Cycle 1(1): loaded http://localhost:55563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55563/tests/dromaeo/cssquery-ext.html) 18:06:58 INFO - PROCESS | 26609 | RSS: Main: 227708928 18:06:58 INFO - PROCESS | 26609 | 18:10:01 INFO - PROCESS | 26609 | Cycle 1(1): loaded http://localhost:55563/tests/dromaeo/cssquery-ext.html (next: http://localhost:55563/tests/dromaeo/cssquery-jquery.html) 18:10:01 INFO - PROCESS | 26609 | RSS: Main: 238952448 18:10:01 INFO - PROCESS | 26609 | 18:13:03 INFO - PROCESS | 26609 | Cycle 1(1): loaded http://localhost:55563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55563/tests/dromaeo/cssquery-mootools.html) 18:13:04 INFO - PROCESS | 26609 | RSS: Main: 247533568 18:13:04 INFO - PROCESS | 26609 | 18:16:06 INFO - PROCESS | 26609 | Cycle 1(1): loaded http://localhost:55563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55563/tests/dromaeo/cssquery-prototype.html) 18:16:07 INFO - PROCESS | 26609 | RSS: Main: 234434560 18:16:07 INFO - PROCESS | 26609 | 18:19:10 INFO - PROCESS | 26609 | Cycle 1(1): loaded http://localhost:55563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55563/tests/dromaeo/cssquery-yui.html) 18:19:10 INFO - PROCESS | 26609 | RSS: Main: 207593472 18:19:10 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | Cycle 1(1): loaded http://localhost:55563/tests/dromaeo/cssquery-yui.html (next: http://localhost:55563/tests/dromaeo/cssquery-dojo.html) 18:22:13 INFO - PROCESS | 26609 | RSS: Main: 271872000 18:22:13 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | __start_tp_report 18:22:13 INFO - PROCESS | 26609 | _x_x_mozilla_page_load 18:22:13 INFO - PROCESS | 26609 | _x_x_mozilla_page_load_details 18:22:13 INFO - PROCESS | 26609 | |i|pagename|runs| 18:22:13 INFO - PROCESS | 26609 | |0;dojo.html;2543.478586889687;2618.253797667665;2629.250663560883;2643.841369517828;2657.641218435511;4525.230710779168;4612.308153776931;4619.145458090252;4621.283701026337;4647.395838540993;4599.816007359702;4630.0739852029565;4640.373549570815;4703;4712.717236965776;4216.262154123032;4229.5770422957685;4256.127493863751;4277.080427708042;4311.073119279355;4286.164197981395;4299.333603291495;4319.611234988851;4349.391085248052;4354.825806967733;4145.585441455861;4167.041580436517;4176;4235.724677895927;4264.76543790093;4226.577342265779;4263.062126332202;4268.658507319407;4288.185244803477;4309.267424537836;4185.079282557863;4200.05498762779;4202.9789851050855;4206.8737937861915;4247.065645557972;4391.231534481485;4493.348464472666;4512.638988880914;4515.729056256635;4576.496585375606;4960;4968.22992436173;4969.701817890902;4970.950290497121;4982.352294201767;4959.256111583255;4967.528084831935;4992;5007.073691367073;5046.84859454217;4540.931886021713;4635.072985402933;4652.441706995149;4705.341252224691;4717.410323709536;5049.368828896388;5063.063333283354;5072.213806859942;5076.923846142311;5078.339815823993;4870.780814863339;4871.951280487221;4874.2201247800185;4879.5120487951635;4927.704337739747;4799.472058073609;4948.406191257072;5028.874278143076;5036;5038.470960549163;4877.5366340197625;4914.852554423373;4915.680480768739;4918.729469879191;4973.104841128559;4882.853514394574;4901.411830580353;4901.970586176943;4908;4958.752062396866;4115.609017143366;4192.601702838226;4211.410402543646;4280.5505421930875;4285.421468101828;3679.282539904693;3704.629537046274;3708.4066549351974;3742.251549690073;3746.7939263340777;4306.870793876189;4315.201687687725;4316.978415107905;4317.762523061199;4360.4767427908855;4854.2233242681;4917.139500587455;4952.678075925053;4991.725455100004;5003.874903127378;4236.843551554112;4237.936430953539;4239.1521695660995;4240.257954857888;4256.2551553478015;4379.934300985487;4432.512423633398;4438.134563760101;4474.418325617649;4495.775211239425;4661.673682842236;4694.92957605643;4712.43450785901;4747.501512341154;4749.477557468745;4918.213085906238;4923.212286034217;4932.950670493393;4934.925976110433;4986.526280003394;4537.682362234744;4628.421447319085;4630.143423466669;4637.721736695674;4681.7190968542;4772.928406073842;4811.807527698853;4816.277558366273;4826.855194344175;4828.203346447796;4888.095702295087;4892.217245240744;4895.926561101657;4896.951030489792;4901.779419926183;4767.33257343979;4827.275908613736;4864.708117512961;4906.803727850846;4915.11527924977;4842.128416884994;4856.465788763304;4856.538628830255;4860.8298709545;4901.3383193268455;4626.907461850811;4782.163121453801;4783.473817879961;4793.664443488922;4839.080574690797;4778.617710583215;4869.926951095807;4911.8280860169725;4933.260010998379;4951.9257211142585;4705.905881882275;4753.263244197155;4773.785179666993;4780.760961951819;4786.2581299898575 18:22:13 INFO - PROCESS | 26609 | |1;ext.html;579.8202557207265;588.7703795519747;611.3794498583939;616.7717944360585;625.5746092656991;27100.864495677517;34092.65907340926;34834.65165348349;34877.302453950906;35168.824155879185;37233.62766372335;37839;38115;38154.809225953904;38156.80921595388;7404.888926666091;7603.163651998276;7621.542707437544;7623.9237607624045;7631.198724133969;7469.066366704162;7616.124145723257;7619.42854285928;7620.618969051553;7621.8475630487355;7763.611819409035;7833.686652533892;7839.216078392144;7844.1763614820475;7848.332891704212;7711.8072048198965;7797.727079552188;7800.063992320929;7803.258690424401;7809.219078092174;7559.58422286774;7669.96745862347;7677.193894641094;7678.923210767933;7682.193369696157;36689.81655091734;37070.44394334087;37216.81391593052;37242;37267.813660931795;3275.4431746603136;3282.261491164493;3288.901332960015;3474.009907176468;3641.8543258269638;25867.482650346887;25881.22356329313;26009.21972340833;26665.866670666717;26766.063187788528;3112.128603990886;3143.117339397949;3188.872445102193;3209.1816586770456;3292.884749033796;178455;179089.1045544777;179121;179997.1000144991;180090;39916.800415997735;41142.79428602838;52717.94564108773;54415.72792136014;54492.45507544953;48329;49175.50824491781;49337.259941100914;49364.25953610699;49514;15029.248537573078;15185.696286074217;15201.467948621745;15314.617134571503;15320.310586023656;11066.557337706401;11089.722756931142;11090.500927458284;11091.83362249567;11105.500252488657;14947.850521494864;15278.46525371629;15296.311665975058;16582.17089145538;17290.394836180672;6474.967625161844;6542.967285163544;6694.665266736643;6855.245922948472;6875.931240687529;696.6307856835886;782.8708263136518;916.8991410944791;922.9769255768659;929.9581518831534;25901.74098259031;26068.217953461426;26278.343041423734;26458.14792964474;26477.735222647912;973.9902600974041;1004.0160642570322;1016.9644062457778;1034.6689059501039;1052.7736536644504;14605.853941460662;15023.319615912209;15085.24573771307;15221.31504082319;15224.771628425582;342971;349694;350337;351206;352528;48203;49124.263136052985;49199.75400122976;49258.75370623124;49259.26111108336;1187.0622208455395;1221.712897469094;1239.9318037508024;1245.5765039886483;1353.4045020191083;26048.609270860572;26457.60313595259;27378.178654640393;27585.448291034467;27653.170404887886;42460.15079698327;43023.56976430196;43118.78440607777;43119.35320970125;43147;270326;276054;277733;278459;278820;19889.303874364326;22495.887520562294;23210.1876434324;24877.751222487543;25242.873785630953;38369.23261534698;39369.40945885757;40168.39747403733;40204.59795402126;40280.395794062526;34059;34597.30805383928;34657.30685386329;35044.82477587596;35449.645503544634;34108.82945585256;34648;34936.475952861234;35020.47469287912;35350;29500.262493437836;29969.250768730082;30041.399172016;30133.3973320528;35121.297574048884;29656.703432965394;31308.373832523677;31499.84250078735;31506.527402089447;31534.526982095747;23756.52486950286;23937.52124957526;24039.75960240445;24287.392815179763;24370.147044853344 18:22:13 INFO - PROCESS | 26609 | |2;jquery.html;376.38836890053665;381.477375994887;383.40572113224493;385.4026259298087;385.9884203473895;15814.762778558317;16249.918750406247;16957.406490772824;17060.23228954697;17086.145692715378;17367.913160434182;17936.910315448404;18154.81845181551;18189.63620727588;18226.817731822677;5703.31560212775;5844.064949608063;5879.911801322984;5929.88140237195;5934.64392136471;4144.834206631746;4189.874303770876;7108.395786358165;7122.750703725371;7129.714811407537;6955.89566156508;7088.71645134194;7131.500794944356;7133.179684336315;7177.748778792743;6972.9999999999745;7084.468664850106;7136.928630713678;7196.244394338598;7198.532095413808;4064.979675101635;5508.641938274;6962.060121883532;6972.965135174342;6976.720931162748;21824.563508729894;22006.339809805733;22901.083956641713;23330;23362.766372336228;1864.6270745850884;1874.7937726850037;1962.80371962804;2053.404512691318;2149.0544160569298;13579;13677.452901883913;14068.874490040875;14142;14375;1932.9613407731906;1950.112698722078;1970.8324792392664;1997.5205950571903;1997.990010049955;77744.22255777426;82636.58681706553;82681.58659206665;82755;83135.5843220786;16270.83729162717;16385.836141638432;16592.419265325654;16910.492685219462;16910.915445422695;29425.411491770046;29554.852225739163;29720.2569935749;29747.553786693217;29830.850845745634;8973.955130224438;9315.487648179414;9343.299252556086;9528.142467177988;9529.523523823782;7562.395008399315;7754.844903102019;7756.534607923542;7810.960945195237;7904.170062143392;8500.40497165205;8560.357973151915;8577.999730596634;8588;8719.215270625675;3306.123877172551;3321.555123521276;3476.913077173091;3493.807840568793;3629.473726309723;860.8966923969039;873.3973558244791;923.8891333040078;990.5493000684671;1002.1031177096457;16299.429519966745;16841.6631667366;16966.23651935666;17430;17433.302667893397;840.2019677889322;847.5803029924851;870.4124715816798;874.5321253129545;908.2370808520874;9394.107559781809;9664.661736839318;9743.951280243695;9750.804983900282;9793.559289831976;322434;407420;410992;411299;412666;54772.72613636986;66372;72066.63966680133;73141;86766.56616716876;426.1200620718207;440.5154330236714;443.17126972560874;443.962263207631;445.41872855922685;8022.3181029610805;9314.20829229523;9826.75433114178;9928.255380846322;9986.201103911524;34082.31835363329;35516.28967420689;35571.11072223215;35865.28269434649;36178.4573231407;44815.32777008413;45551.544484556056;45973;46083.53916460792;46178.53821461742;7559;7670.386369090571;7680.078390593165;7750.534967901944;7832.804179895548;10243.436610986468;10545.57817687284;10789.784204316027;11068.723281918017;11615.419229038345;8819.823603528022;8834.29325653959;9027.322950778587;9137.771555710895;9241.260699143917;9742;10155.89844101579;10168.949155254177;10194.490275486345;10213.84679229827;9231.753713248625;9391.342606017786;9414;9450.338476306593;9518.333716639769;7628.80927976805;7648.120466146464;7703.191164927826;7744.92255077442;7754.7592385218095;7280.162781280221;8443.577821108796;9266.583003764981;9282.164605185566;9303.76740581491 18:22:13 INFO - PROCESS | 26609 | |3;mootools.html;1246.750649870026;1421.3674914662972;1474.8893832962526;1569.3565638088378;1778.030973119649;6514.6742662866845;6868.313168683129;7330.523515971471;7560.92439075609;7575.583342916138;7412.888806667905;7423.665935032923;7489.887651685229;7493.73771917983;7506.024216851802;1853.6478069166815;2103.968440473394;2106.0838535237144;2142.721446211998;2143.8499305048654;2128.5104425982036;2151.601953638582;2153.881536515491;2153.9030743616577;2155.5473350596317;2081.4900349414415;2101.684747287904;2113.070249090403;2120.7243058402387;2125.957480850382;1804.9458516244467;1997.9200831966705;2047.8976051197455;2052.2098991888083;2053.4455696961736;2034.806693364128;2058.53682921343;2060.8351331893564;2061.7319748432756;2061.845366594712;7213.206547279795;7267.200607933176;7283.490155689104;7294.343509084208;7295.343419092307;4164.333706606928;4221.831126754926;4324.437823083011;4332.7400355978425;4334;2811;2847.7721782257368;2889.2487953132127;2921.0214578116356;2924.1666125154443;875.1030194051085;877.9165979232026;880.3485420788635;888.076400543434;898.7977705016384;10340.741481462948;10342.741431464274;10365.326253793555;10386.324888882198;10390.168786497063;4044.4539987101953;4071.3892916062828;4116.608922152391;4174.979125104355;4197.979010104991;8823.558822059;8835;8851.07063758309;8852.955735221412;8855.114488551093;4443.644508439317;4458;4463.642908567307;4473.575010374009;4477.529859364785;3611.1513794258326;4004.4994375703036;4120.91758164841;4125.29869922114;4127.050778320943;3532.1699400640828;3538.3984722596706;3628.5282913221113;3642.4900513928073;3677.852885884588;1133.1388145009853;1163.8894305041008;1173.565780661161;1175.835383046374;1180.8996235320094;851.7742798158492;859.0979471554842;884.9115088491228;895.5746020640274;904.1500989070253;5338.119210330252;5388.91916621251;5465.316835395575;5593.524550413179;5649.576281778883;837.3134030095385;852.2755657690913;875.2429148786254;911.125319693102;940.2571968145089;3690.409534474471;3776.4712940188397;3781.357169281229;3798.4492248623797;3836.462895194675;8747.825043499095;9020.05289444612;9115.225205857443;9167.816643667089;9299.20956718673;9097.13577210164;9346.299027572823;9393.436393816393;9396.577154028086;9432.858507122399;6591.011348297698;7050.788476345718;7211.567305961659;7231.204567497571;7248.4563657725885;5294.7352632369;5370.3287089113865;5407.513323800877;5408.648437851527;5413.945860541344;8294.668213271401;8443.915560844312;8679.652813887375;8720.12798720123;8758.649654014023;8758.60586273632;8823.294136469196;8832.205101540892;8834.337424693302;8884.111588841322;6250.718717657625;6815.863682726219;7031;7069.681864316015;7195.748148814766;7185.17370502378;7187.245339239514;7255.056842610426;7255.09311336083;7266.600336981517;6468.417842394207;6583.30875258091;6672.099266598947;6725.865482690417;6729.2934241903895;6204.13142160107;6305.779297724557;6324.557280990471;6495.058216558478;6517.250516190698;5961;5970.194023806731;6028.2766068072115;6033.064874944391;6037.366076562073;4474.865754027384;4608.930866037079;4636;4642.907141857077;4655.162070827284;4663;4664.743439110882;4679.204535229087;4740.928886066643;4790.329353890388 18:22:13 INFO - PROCESS | 26609 | |4;prototype.html;302.1509558141622;303.8389653483653;305.8990533124069;307.9322549039213;307.9538069289605;4681.765911704414;4686.875149964009;4746.288056791479;4746.406699162605;4766.713997160173;4629.62962962963;4677.894947273732;4686.156491831469;4693.71837689738;4708.046160843246;3489.8080605566684;3580.7493475456727;3620.4931309616545;3692.2246328271094;3732.2908647357053;3672.7429079964413;3679.075135267469;3690.9630903691022;3700.5374328208973;3720.7395482316247;3685.8709945151927;3692.335379631665;3695.0947017980634;3701.130234394915;3704.2221133561984;3485.9302813943705;3543.167355671415;3674.2651469706166;3679.8712045078296;3697.4638677391627;3268.297316077055;3269.3788180245915;3274.279658475132;3275.2303208745925;3286.802791832498;4507.109785882321;4509.812740820732;4525.298578720303;4532.637389008872;4541.591256786905;3944.5266568011734;4169.1661667666285;4182.226288136674;4202.201581699498;4202.70581059326;4868.878278043042;4892.535209155125;4912.901741965141;4932.2108462646165;4934.728589927553;3528.6471352864764;3530.1704099536587;3536.681698647134;3540;3549.503069570262;4992.925106123411;5119.948800512022;5132.974335128338;5173.870653233662;5185.429602743695;3607.855685772592;3609.9639003610155;3628.2017956049626;3636.2182130841998;3639.70882329413;3618.095476130967;3650.142216579102;3652.652997965189;3655.744097913174;3673;4121.711480196417;4175.749455032707;4181.163767246563;4181.853635122756;4206.789660516962;4844.781984810692;4899.16281394477;4932.210846264652;4983.750812459362;4991.201407774739;1311.658968668134;1314.2443095220287;1316.5589527508391;1325.6354502511886;1328.4818920620964;838.2037064788475;878.7934835313696;886.8603844060351;901.6123067081218;907.7412937312835;4289.270823959934;4395.604395604411;4407.2895169471185;4420.160169567772;4423.778811059434;5097.209932460474;5122.769475373617;5131.692098474104;5131.871703207375;5149.588032957355;4389.802458889358;4391.538888416734;4431.490378606437;4432.357308190294;4435.1351486459835;2778.9583156252675;2916.5479350700675;2921.956170657442;2930.6483222013494;2938.794284400114;5136.794528218904;5146.794128234828;5154.690718556899;5198.350206224222;5200;5378.2470454136455;5556.388797232301;5571.470710282517;5575.208857976534;5590.944090559043;5086.796528138833;5093.745312734422;5094.898102038012;5170.663906846043;5185.248139019896;5412.404635490014;5444.891102177855;5453.636590852287;5454.672719636835;5470.425605311544;4799.736014519095;5022.698638081727;5029;5301.416844147064;5311.575073993994;4853.563179313879;4854.393200849894;4858.271259311132;4861.708297502161;4870.196417591058;3638.2541578976775;3671.2290419012306;3674.6876515496483;3681.6870566001116;3694.3904255797493;4981.007596961244;5029.220470826881;5090.643654944119;5141.511556402136;5157.896842063063;4951.158303088556;4988.201887697951;4994.028553010952;4995.125852975642;5008.223725322581;4947.727874966911;4964.553190212898;4975.159191099317;4986.650934434555;4991.750412479289;4789.377380940595;4856.490068542894;4896.779644916059;4905.754712264301;4917.803287868445;4738.763061846963;4890.853274401774;5016.54851063406;5023.623228257969;5029.119904016856;4913.70517768935;4935.950640493693;4943.283223932582;4944.258361245698;4945.406551213878 18:22:13 INFO - PROCESS | 26609 | |5;yui.html;724.2612535214081;733.7688628082157;741.5439504704601;750.2010358967702;758.1130077808963;12097.455614497347;12730.045246606507;13272.601821945333;13275.933620331909;13292;13568.932155339235;13604.795928061087;13629.727405451886;13690.52083177089;13698.93150534246;632.8670979094372;790.2453157234827;803.9839203215932;819.6639377855081;822.1326500541926;820.0364571628343;823.0658202939677;823.6293667849462;824.0770337222319;824.5423789796661;839.8908141941539;844.071521326542;845.6701886264361;846.5767116441779;847.2036285891273;656.4846595422571;807.5397023696495;832.317499650287;842.5197637346715;842.9072801991776;607.538270914104;607.9057746049325;608.3034925010882;608.9451949324582;609.0377204017642;12778.808317875239;12839.614811555575;12846.229226246454;12848.743025139538;12854.935725321408;11102.167337449642;11328.320300781897;11458.369789661565;11644.835516448287;11687.532498700042;9182.90817091834;9293.953530232373;9377.640242164847;9569.808603827885;9756.95121524395;3167.0657156138996;3176.587043684306;3216.549683044352;3327.035159803654;3335.0828522156357;42052.57947420517;42632.14735705299;42948.1410371794;43003.784981074896;43372.783136084116;9164.770880727901;9516;9730.562124704264;9967.850482242773;10056.497175141214;15727.921360393124;16151.111688857225;16219.107949062914;16233.107179105262;16243.918780406259;6338.112664227012;6517.120188774455;6555.410013098844;6619.50353723463;6721.294264102199;3513;3587.892363229107;3589.1565482111682;3669.1560940983723;3684;2726.5364887969095;2747.2719729271357;2758.8344699317704;2761.8757155928033;2769.404578015736;484.3146947069857;514.4495389932811;532.1140301398206;534.9224362467498;535.2987586262009;427.89516568440933;517.9948200518022;521.8512723873754;536.0806217337285;538.7414041260139;6777.186737591521;6866.141732283465;6972.860542789217;7043.7534686285735;7057.576545407292;541.775163307231;552.2765177617254;560.7252446301283;575.720775423919;587.3509771702293;3274.148721332423;3345.3142105868237;3375.0887260439545;3377.088186189715;3413.232022794851;49718;50776.492235077916;51167.744161278955;51497.22754158691;51738;43463.782681087025;45425.091498170514;45547.77226113848;46127.53872461232;47063.5293647066;41728.791356043635;41952;42661.36007959883;42764.57235427606;42791.074401652004;6360.332165122781;6716.361945615159;6739.19129704419;6757.797266082025;7010.088688470466;27915.720842792125;28640.71359286464;28896.133116006553;28943;29109.41781164407;34161.14597135092;34829.477557836144;36945.26109477849;37062.25875482529;37461.81269093637;8179.959100204461;8348.415610907177;8362.372822038249;8448.83102337962;8490.915090849012;9464.242860571276;9608.615655373986;9630.614775408905;9670.613175473183;9715.902840971783;8524.010703417061;8679.479231246145;8739;8957.552122393723;8972.461652300623;8529.530875801891;8547.358948078794;8675;8707.78230544216;8749.693760718344;8546.059933407445;8550.187732165434;8577;8683.088275730957;8701.738947831574;7778.299953004257;7795.610219489116;7911.28798408146;8026.1572534883;8027.5584842834205;7664.463487555818;7727.42044346665;7793.181715919747;7812.335951444191;7953.085395179628 18:22:13 INFO - PROCESS | 26609 | __end_tp_report 18:22:13 INFO - PROCESS | 26609 | __start_cc_report 18:22:13 INFO - PROCESS | 26609 | _x_x_mozilla_cycle_collect,1557 18:22:13 INFO - PROCESS | 26609 | __end_cc_report 18:22:13 INFO - PROCESS | 26609 | __startTimestamp1461979333454__endTimestamp 18:22:13 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | ------- Summary: start ------- 18:22:13 INFO - PROCESS | 26609 | Number of tests: 6 18:22:13 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | [#0] dojo.html Cycles:165 Average:4575.98 Median:4712.43 stddev:472.82 (10.0%) stddev-sans-first:446.58 18:22:13 INFO - PROCESS | 26609 | Values: 2543.5 2618.3 2629.3 2643.8 2657.6 4525.2 4612.3 4619.1 4621.3 4647.4 4599.8 4630.1 4640.4 4703.0 4712.7 4216.3 4229.6 4256.1 4277.1 4311.1 4286.2 4299.3 4319.6 4349.4 4354.8 4145.6 4167.0 4176.0 4235.7 4264.8 4226.6 4263.1 4268.7 4288.2 4309.3 4185.1 4200.1 4203.0 4206.9 4247.1 4391.2 4493.3 4512.6 4515.7 4576.5 4960.0 4968.2 4969.7 4971.0 4982.4 4959.3 4967.5 4992.0 5007.1 5046.8 4540.9 4635.1 4652.4 4705.3 4717.4 5049.4 5063.1 5072.2 5076.9 5078.3 4870.8 4872.0 4874.2 4879.5 4927.7 4799.5 4948.4 5028.9 5036.0 5038.5 4877.5 4914.9 4915.7 4918.7 4973.1 4882.9 4901.4 4902.0 4908.0 4958.8 4115.6 4192.6 4211.4 4280.6 4285.4 3679.3 3704.6 3708.4 3742.3 3746.8 4306.9 4315.2 4317.0 4317.8 4360.5 4854.2 4917.1 4952.7 4991.7 5003.9 4236.8 4237.9 4239.2 4240.3 4256.3 4379.9 4432.5 4438.1 4474.4 4495.8 4661.7 4694.9 4712.4 4747.5 4749.5 4918.2 4923.2 4933.0 4934.9 4986.5 4537.7 4628.4 4630.1 4637.7 4681.7 4772.9 4811.8 4816.3 4826.9 4828.2 4888.1 4892.2 4895.9 4897.0 4901.8 4767.3 4827.3 4864.7 4906.8 4915.1 4842.1 4856.5 4856.5 4860.8 4901.3 4626.9 4782.2 4783.5 4793.7 4839.1 4778.6 4869.9 4911.8 4933.3 4951.9 4705.9 4753.3 4773.8 4780.8 4786.3 18:22:13 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | [#1] ext.html Cycles:180 Average:42041.98 Median:34855.98 stddev:72902.80 (209.2%) stddev-sans-first:73040.84 18:22:13 INFO - PROCESS | 26609 | Values: 579.8 588.8 611.4 616.8 625.6 27100.9 34092.7 34834.7 34877.3 35168.8 37233.6 37839.0 38115.0 38154.8 38156.8 7404.9 7603.2 7621.5 7623.9 7631.2 7469.1 7616.1 7619.4 7620.6 7621.8 7763.6 7833.7 7839.2 7844.2 7848.3 7711.8 7797.7 7800.1 7803.3 7809.2 7559.6 7670.0 7677.2 7678.9 7682.2 36689.8 37070.4 37216.8 37242.0 37267.8 3275.4 3282.3 3288.9 3474.0 3641.9 25867.5 25881.2 26009.2 26665.9 26766.1 3112.1 3143.1 3188.9 3209.2 3292.9 178455.0 179089.1 179121.0 179997.1 180090.0 39916.8 41142.8 52717.9 54415.7 54492.5 48329.0 49175.5 49337.3 49364.3 49514.0 15029.2 15185.7 15201.5 15314.6 15320.3 11066.6 11089.7 11090.5 11091.8 11105.5 14947.9 15278.5 15296.3 16582.2 17290.4 6475.0 6543.0 6694.7 6855.2 6875.9 696.6 782.9 916.9 923.0 930.0 25901.7 26068.2 26278.3 26458.1 26477.7 974.0 1004.0 1017.0 1034.7 1052.8 14605.9 15023.3 15085.2 15221.3 15224.8 342971.0 349694.0 350337.0 351206.0 352528.0 48203.0 49124.3 49199.8 49258.8 49259.3 1187.1 1221.7 1239.9 1245.6 1353.4 26048.6 26457.6 27378.2 27585.4 27653.2 42460.2 43023.6 43118.8 43119.4 43147.0 270326.0 276054.0 277733.0 278459.0 278820.0 19889.3 22495.9 23210.2 24877.8 25242.9 38369.2 39369.4 40168.4 40204.6 40280.4 34059.0 34597.3 34657.3 35044.8 35449.6 34108.8 34648.0 34936.5 35020.5 35350.0 29500.3 29969.3 30041.4 30133.4 35121.3 29656.7 31308.4 31499.8 31506.5 31534.5 23756.5 23937.5 24039.8 24287.4 24370.1 18:22:13 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | [#2] jquery.html Cycles:180 Average:25317.60 Median:5773.69 stddev:65096.31 (1127.5%) stddev-sans-first:65251.98 18:22:13 INFO - PROCESS | 26609 | Values: 376.4 381.5 383.4 385.4 386.0 15814.8 16249.9 16957.4 17060.2 17086.1 17367.9 17936.9 18154.8 18189.6 18226.8 5703.3 5844.1 5879.9 5929.9 5934.6 4144.8 4189.9 7108.4 7122.8 7129.7 6955.9 7088.7 7131.5 7133.2 7177.7 6973.0 7084.5 7136.9 7196.2 7198.5 4065.0 5508.6 6962.1 6973.0 6976.7 21824.6 22006.3 22901.1 23330.0 23362.8 1864.6 1874.8 1962.8 2053.4 2149.1 13579.0 13677.5 14068.9 14142.0 14375.0 1933.0 1950.1 1970.8 1997.5 1998.0 77744.2 82636.6 82681.6 82755.0 83135.6 16270.8 16385.8 16592.4 16910.5 16910.9 29425.4 29554.9 29720.3 29747.6 29830.9 8974.0 9315.5 9343.3 9528.1 9529.5 7562.4 7754.8 7756.5 7811.0 7904.2 8500.4 8560.4 8578.0 8588.0 8719.2 3306.1 3321.6 3476.9 3493.8 3629.5 860.9 873.4 923.9 990.5 1002.1 16299.4 16841.7 16966.2 17430.0 17433.3 840.2 847.6 870.4 874.5 908.2 9394.1 9664.7 9744.0 9750.8 9793.6 322434.0 407420.0 410992.0 411299.0 412666.0 54772.7 66372.0 72066.6 73141.0 86766.6 426.1 440.5 443.2 444.0 445.4 8022.3 9314.2 9826.8 9928.3 9986.2 34082.3 35516.3 35571.1 35865.3 36178.5 44815.3 45551.5 45973.0 46083.5 46178.5 7559.0 7670.4 7680.1 7750.5 7832.8 10243.4 10545.6 10789.8 11068.7 11615.4 8819.8 8834.3 9027.3 9137.8 9241.3 9742.0 10155.9 10168.9 10194.5 10213.8 9231.8 9391.3 9414.0 9450.3 9518.3 7628.8 7648.1 7703.2 7744.9 7754.8 7280.2 8443.6 9266.6 9282.2 9303.8 18:22:13 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | [#3] mootools.html Cycles:180 Average:5002.28 Median:5411.30 stddev:2761.43 (51.0%) stddev-sans-first:2754.75 18:22:13 INFO - PROCESS | 26609 | Values: 1246.8 1421.4 1474.9 1569.4 1778.0 6514.7 6868.3 7330.5 7560.9 7575.6 7412.9 7423.7 7489.9 7493.7 7506.0 1853.6 2104.0 2106.1 2142.7 2143.8 2128.5 2151.6 2153.9 2153.9 2155.5 2081.5 2101.7 2113.1 2120.7 2126.0 1804.9 1997.9 2047.9 2052.2 2053.4 2034.8 2058.5 2060.8 2061.7 2061.8 7213.2 7267.2 7283.5 7294.3 7295.3 4164.3 4221.8 4324.4 4332.7 4334.0 2811.0 2847.8 2889.2 2921.0 2924.2 875.1 877.9 880.3 888.1 898.8 10340.7 10342.7 10365.3 10386.3 10390.2 4044.5 4071.4 4116.6 4175.0 4198.0 8823.6 8835.0 8851.1 8853.0 8855.1 4443.6 4458.0 4463.6 4473.6 4477.5 3611.2 4004.5 4120.9 4125.3 4127.1 3532.2 3538.4 3628.5 3642.5 3677.9 1133.1 1163.9 1173.6 1175.8 1180.9 851.8 859.1 884.9 895.6 904.2 5338.1 5388.9 5465.3 5593.5 5649.6 837.3 852.3 875.2 911.1 940.3 3690.4 3776.5 3781.4 3798.4 3836.5 8747.8 9020.1 9115.2 9167.8 9299.2 9097.1 9346.3 9393.4 9396.6 9432.9 6591.0 7050.8 7211.6 7231.2 7248.5 5294.7 5370.3 5407.5 5408.6 5413.9 8294.7 8443.9 8679.7 8720.1 8758.6 8758.6 8823.3 8832.2 8834.3 8884.1 6250.7 6815.9 7031.0 7069.7 7195.7 7185.2 7187.2 7255.1 7255.1 7266.6 6468.4 6583.3 6672.1 6725.9 6729.3 6204.1 6305.8 6324.6 6495.1 6517.3 5961.0 5970.2 6028.3 6033.1 6037.4 4474.9 4608.9 4636.0 4642.9 4655.2 4663.0 4664.7 4679.2 4740.9 4790.3 18:22:13 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | [#4] prototype.html Cycles:180 Average:4164.99 Median:4700.88 stddev:1216.30 (25.9%) stddev-sans-first:1184.66 18:22:13 INFO - PROCESS | 26609 | Values: 302.2 303.8 305.9 307.9 308.0 4681.8 4686.9 4746.3 4746.4 4766.7 4629.6 4677.9 4686.2 4693.7 4708.0 3489.8 3580.7 3620.5 3692.2 3732.3 3672.7 3679.1 3691.0 3700.5 3720.7 3685.9 3692.3 3695.1 3701.1 3704.2 3485.9 3543.2 3674.3 3679.9 3697.5 3268.3 3269.4 3274.3 3275.2 3286.8 4507.1 4509.8 4525.3 4532.6 4541.6 3944.5 4169.2 4182.2 4202.2 4202.7 4868.9 4892.5 4912.9 4932.2 4934.7 3528.6 3530.2 3536.7 3540.0 3549.5 4992.9 5119.9 5133.0 5173.9 5185.4 3607.9 3610.0 3628.2 3636.2 3639.7 3618.1 3650.1 3652.7 3655.7 3673.0 4121.7 4175.7 4181.2 4181.9 4206.8 4844.8 4899.2 4932.2 4983.8 4991.2 1311.7 1314.2 1316.6 1325.6 1328.5 838.2 878.8 886.9 901.6 907.7 4289.3 4395.6 4407.3 4420.2 4423.8 5097.2 5122.8 5131.7 5131.9 5149.6 4389.8 4391.5 4431.5 4432.4 4435.1 2779.0 2916.5 2922.0 2930.6 2938.8 5136.8 5146.8 5154.7 5198.4 5200.0 5378.2 5556.4 5571.5 5575.2 5590.9 5086.8 5093.7 5094.9 5170.7 5185.2 5412.4 5444.9 5453.6 5454.7 5470.4 4799.7 5022.7 5029.0 5301.4 5311.6 4853.6 4854.4 4858.3 4861.7 4870.2 3638.3 3671.2 3674.7 3681.7 3694.4 4981.0 5029.2 5090.6 5141.5 5157.9 4951.2 4988.2 4994.0 4995.1 5008.2 4947.7 4964.6 4975.2 4986.7 4991.8 4789.4 4856.5 4896.8 4905.8 4917.8 4738.8 4890.9 5016.5 5023.6 5029.1 4913.7 4936.0 4943.3 4944.3 4945.4 18:22:13 INFO - PROCESS | 26609 | 18:22:13 INFO - PROCESS | 26609 | [#5] yui.html Cycles:180 Average:11989.76 Median:597.44 stddev:14024.84 (2347.5%) stddev-sans-first:14038.67 18:22:13 INFO - PROCESS | 26609 | Values: 724.3 733.8 741.5 750.2 758.1 12097.5 12730.0 13272.6 13275.9 13292.0 13568.9 13604.8 13629.7 13690.5 13698.9 632.9 790.2 804.0 819.7 822.1 820.0 823.1 823.6 824.1 824.5 839.9 844.1 845.7 846.6 847.2 656.5 807.5 832.3 842.5 842.9 607.5 607.9 608.3 608.9 609.0 12778.8 12839.6 12846.2 12848.7 12854.9 11102.2 11328.3 11458.4 11644.8 11687.5 9182.9 9294.0 9377.6 9569.8 9757.0 3167.1 3176.6 3216.5 3327.0 3335.1 42052.6 42632.1 42948.1 43003.8 43372.8 9164.8 9516.0 9730.6 9967.9 10056.5 15727.9 16151.1 16219.1 16233.1 16243.9 6338.1 6517.1 6555.4 6619.5 6721.3 3513.0 3587.9 3589.2 3669.2 3684.0 2726.5 2747.3 2758.8 2761.9 2769.4 484.3 514.4 532.1 534.9 535.3 427.9 518.0 521.9 536.1 538.7 6777.2 6866.1 6972.9 7043.8 7057.6 541.8 552.3 560.7 575.7 587.4 3274.1 3345.3 3375.1 3377.1 3413.2 49718.0 50776.5 51167.7 51497.2 51738.0 43463.8 45425.1 45547.8 46127.5 47063.5 41728.8 41952.0 42661.4 42764.6 42791.1 6360.3 6716.4 6739.2 6757.8 7010.1 27915.7 28640.7 28896.1 28943.0 29109.4 34161.1 34829.5 36945.3 37062.3 37461.8 8180.0 8348.4 8362.4 8448.8 8490.9 9464.2 9608.6 9630.6 9670.6 9715.9 8524.0 8679.5 8739.0 8957.6 8972.5 8529.5 8547.4 8675.0 8707.8 8749.7 8546.1 8550.2 8577.0 8683.1 8701.7 7778.3 7795.6 7911.3 8026.2 8027.6 7664.5 7727.4 7793.2 7812.3 7953.1 18:22:13 INFO - PROCESS | 26609 | -------- Summary: end -------- 18:22:13 INFO - PROCESS | 26609 | 18:22:14 INFO - TEST-INFO | 26609: exit 0 18:22:14 INFO - TEST-OK | dromaeo_css | took 1118000ms 18:22:14 INFO - TEST-START | kraken 18:22:14 INFO - operating with platform_type : linux_ 18:22:14 INFO - Initialising browser for kraken test... 18:22:14 INFO - TEST-INFO | started process 26789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6X1AWw/profile http://localhost:55563/getInfo.html) 18:22:18 INFO - PROCESS | 26789 | __metrics Screen width/height:1600/1200 18:22:18 INFO - PROCESS | 26789 | colorDepth:24 18:22:18 INFO - PROCESS | 26789 | Browser inner width/height: 1024/697 18:22:18 INFO - PROCESS | 26789 | __metrics 18:22:20 ERROR - PROCESS | 26789 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:22:20 INFO - TEST-INFO | 26789: exit 0 18:22:20 INFO - Browser initialized. 18:22:20 INFO - Running cycle 1/1 for kraken test... 18:22:20 INFO - TEST-INFO | started process 26870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6X1AWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:32 INFO - PROCESS | 26870 | RSS: Main: 156377088 18:22:32 INFO - PROCESS | 26870 | 18:22:35 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55563/tests/kraken/driver.html?testName=audio-beat-detection) 18:22:36 INFO - PROCESS | 26870 | RSS: Main: 210964480 18:22:36 INFO - PROCESS | 26870 | 18:22:39 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55563/tests/kraken/driver.html?testName=audio-dft) 18:22:40 INFO - PROCESS | 26870 | RSS: Main: 197386240 18:22:40 INFO - PROCESS | 26870 | 18:22:43 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55563/tests/kraken/driver.html?testName=audio-fft) 18:22:43 INFO - PROCESS | 26870 | RSS: Main: 267870208 18:22:43 INFO - PROCESS | 26870 | 18:22:46 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55563/tests/kraken/driver.html?testName=audio-oscillator) 18:22:46 INFO - PROCESS | 26870 | RSS: Main: 175120384 18:22:46 INFO - PROCESS | 26870 | 18:22:48 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:22:49 INFO - PROCESS | 26870 | RSS: Main: 179306496 18:22:49 INFO - PROCESS | 26870 | 18:22:52 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55563/tests/kraken/driver.html?testName=imaging-darkroom) 18:22:53 INFO - PROCESS | 26870 | RSS: Main: 215584768 18:22:53 INFO - PROCESS | 26870 | 18:22:56 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55563/tests/kraken/driver.html?testName=imaging-desaturate) 18:22:57 INFO - PROCESS | 26870 | RSS: Main: 216965120 18:22:57 INFO - PROCESS | 26870 | 18:23:00 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55563/tests/kraken/driver.html?testName=json-parse-financial) 18:23:00 INFO - PROCESS | 26870 | RSS: Main: 216690688 18:23:00 INFO - PROCESS | 26870 | 18:23:02 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:23:03 INFO - PROCESS | 26870 | RSS: Main: 202305536 18:23:03 INFO - PROCESS | 26870 | 18:23:05 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55563/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:23:05 INFO - PROCESS | 26870 | RSS: Main: 204218368 18:23:05 INFO - PROCESS | 26870 | 18:23:07 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:23:08 INFO - PROCESS | 26870 | RSS: Main: 217448448 18:23:08 INFO - PROCESS | 26870 | 18:23:11 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:23:12 INFO - PROCESS | 26870 | RSS: Main: 223440896 18:23:12 INFO - PROCESS | 26870 | 18:23:15 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:23:15 INFO - PROCESS | 26870 | RSS: Main: 223252480 18:23:15 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:55563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55563/tests/kraken/driver.html?testName=ai-astar) 18:23:17 INFO - PROCESS | 26870 | RSS: Main: 286502912 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | __start_tp_report 18:23:17 INFO - PROCESS | 26870 | _x_x_mozilla_page_load 18:23:17 INFO - PROCESS | 26870 | _x_x_mozilla_page_load_details 18:23:17 INFO - PROCESS | 26870 | |i|pagename|runs| 18:23:17 INFO - PROCESS | 26870 | |0;ai-astar;112;114;109;115;114;115;103;114;116;115 18:23:17 INFO - PROCESS | 26870 | |1;audio-beat-detection;170;134;160;192;138;157;168;138;199;141 18:23:17 INFO - PROCESS | 26870 | |2;audio-dft;161;160;160;161;161;161;163;163;163;162 18:23:17 INFO - PROCESS | 26870 | |3;audio-fft;79;77;112;112;77;76;77;112;104;75 18:23:17 INFO - PROCESS | 26870 | |4;audio-oscillator;95;94;148;93;95;94;146;93;93;150 18:23:17 INFO - PROCESS | 26870 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;116;116;116 18:23:17 INFO - PROCESS | 26870 | |6;imaging-darkroom;145;146;146;145;145;145;146;146;145;145 18:23:17 INFO - PROCESS | 26870 | |7;imaging-desaturate;95;96;95;95;95;95;96;96;96;95 18:23:17 INFO - PROCESS | 26870 | |8;json-parse-financial;69;69;69;69;70;69;68;89;66;66 18:23:17 INFO - PROCESS | 26870 | |9;json-stringify-tinderbox;66;65;66;65;65;67;66;65;65;66 18:23:17 INFO - PROCESS | 26870 | |10;stanford-crypto-aes;81;89;81;84;83;82;82;82;83;81 18:23:17 INFO - PROCESS | 26870 | |11;stanford-crypto-ccm;132;134;131;133;130;134;138;131;225;137 18:23:17 INFO - PROCESS | 26870 | |12;stanford-crypto-pbkdf2;183;182;177;176;183;177;174;178;182;173 18:23:17 INFO - PROCESS | 26870 | |13;stanford-crypto-sha256-iterative;75;75;85;83;75;74;77;73;74;74 18:23:17 INFO - PROCESS | 26870 | __end_tp_report 18:23:17 INFO - PROCESS | 26870 | __start_cc_report 18:23:17 INFO - PROCESS | 26870 | _x_x_mozilla_cycle_collect,1885 18:23:17 INFO - PROCESS | 26870 | __end_cc_report 18:23:17 INFO - PROCESS | 26870 | __startTimestamp1461979397782__endTimestamp 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | ------- Summary: start ------- 18:23:17 INFO - PROCESS | 26870 | Number of tests: 14 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.50 stddev:3.95 (3.4%) stddev-sans-first:4.18 18:23:17 INFO - PROCESS | 26870 | Values: 112.0 114.0 109.0 115.0 114.0 115.0 103.0 114.0 116.0 115.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#1] audio-beat-detection Cycles:10 Average:159.70 Median:164.00 stddev:22.91 (14.0%) stddev-sans-first:23.99 18:23:17 INFO - PROCESS | 26870 | Values: 170.0 134.0 160.0 192.0 138.0 157.0 168.0 138.0 199.0 141.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.18 (0.7%) stddev-sans-first:1.24 18:23:17 INFO - PROCESS | 26870 | Values: 161.0 160.0 160.0 161.0 161.0 161.0 163.0 163.0 163.0 162.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#3] audio-fft Cycles:10 Average:90.10 Median:76.50 stddev:17.31 (22.6%) stddev-sans-first:17.89 18:23:17 INFO - PROCESS | 26870 | Values: 79.0 77.0 112.0 112.0 77.0 76.0 77.0 112.0 104.0 75.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.50 stddev:26.18 (28.0%) stddev-sans-first:27.19 18:23:17 INFO - PROCESS | 26870 | Values: 95.0 94.0 148.0 93.0 95.0 94.0 146.0 93.0 93.0 150.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:23:17 INFO - PROCESS | 26870 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:23:17 INFO - PROCESS | 26870 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:23:17 INFO - PROCESS | 26870 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#8] json-parse-financial Cycles:10 Average:70.40 Median:69.00 stddev:6.67 (9.7%) stddev-sans-first:7.06 18:23:17 INFO - PROCESS | 26870 | Values: 69.0 69.0 69.0 69.0 70.0 69.0 68.0 89.0 66.0 66.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 18:23:17 INFO - PROCESS | 26870 | Values: 66.0 65.0 66.0 65.0 65.0 67.0 66.0 65.0 65.0 66.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.39 (2.9%) stddev-sans-first:2.45 18:23:17 INFO - PROCESS | 26870 | Values: 81.0 89.0 81.0 84.0 83.0 82.0 82.0 82.0 83.0 81.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:134.00 stddev:29.10 (21.7%) stddev-sans-first:30.62 18:23:17 INFO - PROCESS | 26870 | Values: 132.0 134.0 131.0 133.0 130.0 134.0 138.0 131.0 225.0 137.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:180.00 stddev:3.75 (2.1%) stddev-sans-first:3.61 18:23:17 INFO - PROCESS | 26870 | Values: 183.0 182.0 177.0 176.0 183.0 177.0 174.0 178.0 182.0 173.0 18:23:17 INFO - PROCESS | 26870 | 18:23:17 INFO - PROCESS | 26870 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:75.00 stddev:4.12 (5.5%) stddev-sans-first:4.33 18:23:17 INFO - PROCESS | 26870 | Values: 75.0 75.0 85.0 83.0 75.0 74.0 77.0 73.0 74.0 74.0 18:23:17 INFO - PROCESS | 26870 | -------- Summary: end -------- 18:23:17 INFO - PROCESS | 26870 | 18:23:18 INFO - TEST-INFO | 26870: exit 0 18:23:19 INFO - TEST-OK | kraken | took 64789ms 18:23:19 INFO - SUITE-END | took 1182s 18:23:19 INFO - Completed test suite (00:19:43) 18:23:19 INFO - javascript benchmark 18:23:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2543.478586889687, 2618.253797667665, 2629.250663560883, 2643.841369517828, 2657.641218435511, 4525.230710779168, 4612.308153776931, 4619.145458090252, 4621.283701026337, 4647.395838540993, 4599.816007359702, 4630.0739852029565, 4640.373549570815, 4703.0, 4712.717236965776, 4216.262154123032, 4229.5770422957685, 4256.127493863751, 4277.080427708042, 4311.073119279355, 4286.164197981395, 4299.333603291495, 4319.611234988851, 4349.391085248052, 4354.825806967733, 4145.585441455861, 4167.041580436517, 4176.0, 4235.724677895927, 4264.76543790093, 4226.577342265779, 4263.062126332202, 4268.658507319407, 4288.185244803477, 4309.267424537836, 4185.079282557863, 4200.05498762779, 4202.9789851050855, 4206.8737937861915, 4247.065645557972, 4391.231534481485, 4493.348464472666, 4512.638988880914, 4515.729056256635, 4576.496585375606, 4960.0, 4968.22992436173, 4969.701817890902, 4970.950290497121, 4982.352294201767, 4959.256111583255, 4967.528084831935, 4992.0, 5007.073691367073, 5046.84859454217, 4540.931886021713, 4635.072985402933, 4652.441706995149, 4705.341252224691, 4717.410323709536, 5049.368828896388, 5063.063333283354, 5072.213806859942, 5076.923846142311, 5078.339815823993, 4870.780814863339, 4871.951280487221, 4874.2201247800185, 4879.5120487951635, 4927.704337739747, 4799.472058073609, 4948.406191257072, 5028.874278143076, 5036.0, 5038.470960549163, 4877.5366340197625, 4914.852554423373, 4915.680480768739, 4918.729469879191, 4973.104841128559, 4882.853514394574, 4901.411830580353, 4901.970586176943, 4908.0, 4958.752062396866, 4115.609017143366, 4192.601702838226, 4211.410402543646, 4280.5505421930875, 4285.421468101828, 3679.282539904693, 3704.629537046274, 3708.4066549351974, 3742.251549690073, 3746.7939263340777, 4306.870793876189, 4315.201687687725, 4316.978415107905, 4317.762523061199, 4360.4767427908855, 4854.2233242681, 4917.139500587455, 4952.678075925053, 4991.725455100004, 5003.874903127378, 4236.843551554112, 4237.936430953539, 4239.1521695660995, 4240.257954857888, 4256.2551553478015, 4379.934300985487, 4432.512423633398, 4438.134563760101, 4474.418325617649, 4495.775211239425, 4661.673682842236, 4694.92957605643, 4712.43450785901, 4747.501512341154, 4749.477557468745, 4918.213085906238, 4923.212286034217, 4932.950670493393, 4934.925976110433, 4986.526280003394, 4537.682362234744, 4628.421447319085, 4630.143423466669, 4637.721736695674, 4681.7190968542, 4772.928406073842, 4811.807527698853, 4816.277558366273, 4826.855194344175, 4828.203346447796, 4888.095702295087, 4892.217245240744, 4895.926561101657, 4896.951030489792, 4901.779419926183, 4767.33257343979, 4827.275908613736, 4864.708117512961, 4906.803727850846, 4915.11527924977, 4842.128416884994, 4856.465788763304, 4856.538628830255, 4860.8298709545, 4901.3383193268455, 4626.907461850811, 4782.163121453801, 4783.473817879961, 4793.664443488922, 4839.080574690797, 4778.617710583215, 4869.926951095807, 4911.8280860169725, 4933.260010998379, 4951.9257211142585, 4705.905881882275, 4753.263244197155, 4773.785179666993, 4780.760961951819, 4786.2581299898575], "value": 4546.384367013547, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.8202557207265, 588.7703795519747, 611.3794498583939, 616.7717944360585, 625.5746092656991, 27100.864495677517, 34092.65907340926, 34834.65165348349, 34877.302453950906, 35168.824155879185, 37233.62766372335, 37839.0, 38115.0, 38154.809225953904, 38156.80921595388, 7404.888926666091, 7603.163651998276, 7621.542707437544, 7623.9237607624045, 7631.198724133969, 7469.066366704162, 7616.124145723257, 7619.42854285928, 7620.618969051553, 7621.8475630487355, 7763.611819409035, 7833.686652533892, 7839.216078392144, 7844.1763614820475, 7848.332891704212, 7711.8072048198965, 7797.727079552188, 7800.063992320929, 7803.258690424401, 7809.219078092174, 7559.58422286774, 7669.96745862347, 7677.193894641094, 7678.923210767933, 7682.193369696157, 36689.81655091734, 37070.44394334087, 37216.81391593052, 37242.0, 37267.813660931795, 3275.4431746603136, 3282.261491164493, 3288.901332960015, 3474.009907176468, 3641.8543258269638, 25867.482650346887, 25881.22356329313, 26009.21972340833, 26665.866670666717, 26766.063187788528, 3112.128603990886, 3143.117339397949, 3188.872445102193, 3209.1816586770456, 3292.884749033796, 178455.0, 179089.1045544777, 179121.0, 179997.1000144991, 180090.0, 39916.800415997735, 41142.79428602838, 52717.94564108773, 54415.72792136014, 54492.45507544953, 48329.0, 49175.50824491781, 49337.259941100914, 49364.25953610699, 49514.0, 15029.248537573078, 15185.696286074217, 15201.467948621745, 15314.617134571503, 15320.310586023656, 11066.557337706401, 11089.722756931142, 11090.500927458284, 11091.83362249567, 11105.500252488657, 14947.850521494864, 15278.46525371629, 15296.311665975058, 16582.17089145538, 17290.394836180672, 6474.967625161844, 6542.967285163544, 6694.665266736643, 6855.245922948472, 6875.931240687529, 696.6307856835886, 782.8708263136518, 916.8991410944791, 922.9769255768659, 929.9581518831534, 25901.74098259031, 26068.217953461426, 26278.343041423734, 26458.14792964474, 26477.735222647912, 973.9902600974041, 1004.0160642570322, 1016.9644062457778, 1034.6689059501039, 1052.7736536644504, 14605.853941460662, 15023.319615912209, 15085.24573771307, 15221.31504082319, 15224.771628425582, 342971.0, 349694.0, 350337.0, 351206.0, 352528.0, 48203.0, 49124.263136052985, 49199.75400122976, 49258.75370623124, 49259.26111108336, 1187.0622208455395, 1221.712897469094, 1239.9318037508024, 1245.5765039886483, 1353.4045020191083, 26048.609270860572, 26457.60313595259, 27378.178654640393, 27585.448291034467, 27653.170404887886, 42460.15079698327, 43023.56976430196, 43118.78440607777, 43119.35320970125, 43147.0, 270326.0, 276054.0, 277733.0, 278459.0, 278820.0, 19889.303874364326, 22495.887520562294, 23210.1876434324, 24877.751222487543, 25242.873785630953, 38369.23261534698, 39369.40945885757, 40168.39747403733, 40204.59795402126, 40280.395794062526, 34059.0, 34597.30805383928, 34657.30685386329, 35044.82477587596, 35449.645503544634, 34108.82945585256, 34648.0, 34936.475952861234, 35020.47469287912, 35350.0, 29500.262493437836, 29969.250768730082, 30041.399172016, 30133.3973320528, 35121.297574048884, 29656.703432965394, 31308.373832523677, 31499.84250078735, 31506.527402089447, 31534.526982095747, 23756.52486950286, 23937.52124957526, 24039.75960240445, 24287.392815179763, 24370.147044853344], "value": 16679.412066109144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.38836890053665, 381.477375994887, 383.40572113224493, 385.4026259298087, 385.9884203473895, 15814.762778558317, 16249.918750406247, 16957.406490772824, 17060.23228954697, 17086.145692715378, 17367.913160434182, 17936.910315448404, 18154.81845181551, 18189.63620727588, 18226.817731822677, 5703.31560212775, 5844.064949608063, 5879.911801322984, 5929.88140237195, 5934.64392136471, 4144.834206631746, 4189.874303770876, 7108.395786358165, 7122.750703725371, 7129.714811407537, 6955.89566156508, 7088.71645134194, 7131.500794944356, 7133.179684336315, 7177.748778792743, 6972.9999999999745, 7084.468664850106, 7136.928630713678, 7196.244394338598, 7198.532095413808, 4064.979675101635, 5508.641938274, 6962.060121883532, 6972.965135174342, 6976.720931162748, 21824.563508729894, 22006.339809805733, 22901.083956641713, 23330.0, 23362.766372336228, 1864.6270745850884, 1874.7937726850037, 1962.80371962804, 2053.404512691318, 2149.0544160569298, 13579.0, 13677.452901883913, 14068.874490040875, 14142.0, 14375.0, 1932.9613407731906, 1950.112698722078, 1970.8324792392664, 1997.5205950571903, 1997.990010049955, 77744.22255777426, 82636.58681706553, 82681.58659206665, 82755.0, 83135.5843220786, 16270.83729162717, 16385.836141638432, 16592.419265325654, 16910.492685219462, 16910.915445422695, 29425.411491770046, 29554.852225739163, 29720.2569935749, 29747.553786693217, 29830.850845745634, 8973.955130224438, 9315.487648179414, 9343.299252556086, 9528.142467177988, 9529.523523823782, 7562.395008399315, 7754.844903102019, 7756.534607923542, 7810.960945195237, 7904.170062143392, 8500.40497165205, 8560.357973151915, 8577.999730596634, 8588.0, 8719.215270625675, 3306.123877172551, 3321.555123521276, 3476.913077173091, 3493.807840568793, 3629.473726309723, 860.8966923969039, 873.3973558244791, 923.8891333040078, 990.5493000684671, 1002.1031177096457, 16299.429519966745, 16841.6631667366, 16966.23651935666, 17430.0, 17433.302667893397, 840.2019677889322, 847.5803029924851, 870.4124715816798, 874.5321253129545, 908.2370808520874, 9394.107559781809, 9664.661736839318, 9743.951280243695, 9750.804983900282, 9793.559289831976, 322434.0, 407420.0, 410992.0, 411299.0, 412666.0, 54772.72613636986, 66372.0, 72066.63966680133, 73141.0, 86766.56616716876, 426.1200620718207, 440.5154330236714, 443.17126972560874, 443.962263207631, 445.41872855922685, 8022.3181029610805, 9314.20829229523, 9826.75433114178, 9928.255380846322, 9986.201103911524, 34082.31835363329, 35516.28967420689, 35571.11072223215, 35865.28269434649, 36178.4573231407, 44815.32777008413, 45551.544484556056, 45973.0, 46083.53916460792, 46178.53821461742, 7559.0, 7670.386369090571, 7680.078390593165, 7750.534967901944, 7832.804179895548, 10243.436610986468, 10545.57817687284, 10789.784204316027, 11068.723281918017, 11615.419229038345, 8819.823603528022, 8834.29325653959, 9027.322950778587, 9137.771555710895, 9241.260699143917, 9742.0, 10155.89844101579, 10168.949155254177, 10194.490275486345, 10213.84679229827, 9231.753713248625, 9391.342606017786, 9414.0, 9450.338476306593, 9518.333716639769, 7628.80927976805, 7648.120466146464, 7703.191164927826, 7744.92255077442, 7754.7592385218095, 7280.162781280221, 8443.577821108796, 9266.583003764981, 9282.164605185566, 9303.76740581491], "value": 8908.902487601277, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.750649870026, 1421.3674914662972, 1474.8893832962526, 1569.3565638088378, 1778.030973119649, 6514.6742662866845, 6868.313168683129, 7330.523515971471, 7560.92439075609, 7575.583342916138, 7412.888806667905, 7423.665935032923, 7489.887651685229, 7493.73771917983, 7506.024216851802, 1853.6478069166815, 2103.968440473394, 2106.0838535237144, 2142.721446211998, 2143.8499305048654, 2128.5104425982036, 2151.601953638582, 2153.881536515491, 2153.9030743616577, 2155.5473350596317, 2081.4900349414415, 2101.684747287904, 2113.070249090403, 2120.7243058402387, 2125.957480850382, 1804.9458516244467, 1997.9200831966705, 2047.8976051197455, 2052.2098991888083, 2053.4455696961736, 2034.806693364128, 2058.53682921343, 2060.8351331893564, 2061.7319748432756, 2061.845366594712, 7213.206547279795, 7267.200607933176, 7283.490155689104, 7294.343509084208, 7295.343419092307, 4164.333706606928, 4221.831126754926, 4324.437823083011, 4332.7400355978425, 4334.0, 2811.0, 2847.7721782257368, 2889.2487953132127, 2921.0214578116356, 2924.1666125154443, 875.1030194051085, 877.9165979232026, 880.3485420788635, 888.076400543434, 898.7977705016384, 10340.741481462948, 10342.741431464274, 10365.326253793555, 10386.324888882198, 10390.168786497063, 4044.4539987101953, 4071.3892916062828, 4116.608922152391, 4174.979125104355, 4197.979010104991, 8823.558822059, 8835.0, 8851.07063758309, 8852.955735221412, 8855.114488551093, 4443.644508439317, 4458.0, 4463.642908567307, 4473.575010374009, 4477.529859364785, 3611.1513794258326, 4004.4994375703036, 4120.91758164841, 4125.29869922114, 4127.050778320943, 3532.1699400640828, 3538.3984722596706, 3628.5282913221113, 3642.4900513928073, 3677.852885884588, 1133.1388145009853, 1163.8894305041008, 1173.565780661161, 1175.835383046374, 1180.8996235320094, 851.7742798158492, 859.0979471554842, 884.9115088491228, 895.5746020640274, 904.1500989070253, 5338.119210330252, 5388.91916621251, 5465.316835395575, 5593.524550413179, 5649.576281778883, 837.3134030095385, 852.2755657690913, 875.2429148786254, 911.125319693102, 940.2571968145089, 3690.409534474471, 3776.4712940188397, 3781.357169281229, 3798.4492248623797, 3836.462895194675, 8747.825043499095, 9020.05289444612, 9115.225205857443, 9167.816643667089, 9299.20956718673, 9097.13577210164, 9346.299027572823, 9393.436393816393, 9396.577154028086, 9432.858507122399, 6591.011348297698, 7050.788476345718, 7211.567305961659, 7231.204567497571, 7248.4563657725885, 5294.7352632369, 5370.3287089113865, 5407.513323800877, 5408.648437851527, 5413.945860541344, 8294.668213271401, 8443.915560844312, 8679.652813887375, 8720.12798720123, 8758.649654014023, 8758.60586273632, 8823.294136469196, 8832.205101540892, 8834.337424693302, 8884.111588841322, 6250.718717657625, 6815.863682726219, 7031.0, 7069.681864316015, 7195.748148814766, 7185.17370502378, 7187.245339239514, 7255.056842610426, 7255.09311336083, 7266.600336981517, 6468.417842394207, 6583.30875258091, 6672.099266598947, 6725.865482690417, 6729.2934241903895, 6204.13142160107, 6305.779297724557, 6324.557280990471, 6495.058216558478, 6517.250516190698, 5961.0, 5970.194023806731, 6028.2766068072115, 6033.064874944391, 6037.366076562073, 4474.865754027384, 4608.930866037079, 4636.0, 4642.907141857077, 4655.162070827284, 4663.0, 4664.743439110882, 4679.204535229087, 4740.928886066643, 4790.329353890388], "value": 4050.3933347496104, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.1509558141622, 303.8389653483653, 305.8990533124069, 307.9322549039213, 307.9538069289605, 4681.765911704414, 4686.875149964009, 4746.288056791479, 4746.406699162605, 4766.713997160173, 4629.62962962963, 4677.894947273732, 4686.156491831469, 4693.71837689738, 4708.046160843246, 3489.8080605566684, 3580.7493475456727, 3620.4931309616545, 3692.2246328271094, 3732.2908647357053, 3672.7429079964413, 3679.075135267469, 3690.9630903691022, 3700.5374328208973, 3720.7395482316247, 3685.8709945151927, 3692.335379631665, 3695.0947017980634, 3701.130234394915, 3704.2221133561984, 3485.9302813943705, 3543.167355671415, 3674.2651469706166, 3679.8712045078296, 3697.4638677391627, 3268.297316077055, 3269.3788180245915, 3274.279658475132, 3275.2303208745925, 3286.802791832498, 4507.109785882321, 4509.812740820732, 4525.298578720303, 4532.637389008872, 4541.591256786905, 3944.5266568011734, 4169.1661667666285, 4182.226288136674, 4202.201581699498, 4202.70581059326, 4868.878278043042, 4892.535209155125, 4912.901741965141, 4932.2108462646165, 4934.728589927553, 3528.6471352864764, 3530.1704099536587, 3536.681698647134, 3540.0, 3549.503069570262, 4992.925106123411, 5119.948800512022, 5132.974335128338, 5173.870653233662, 5185.429602743695, 3607.855685772592, 3609.9639003610155, 3628.2017956049626, 3636.2182130841998, 3639.70882329413, 3618.095476130967, 3650.142216579102, 3652.652997965189, 3655.744097913174, 3673.0, 4121.711480196417, 4175.749455032707, 4181.163767246563, 4181.853635122756, 4206.789660516962, 4844.781984810692, 4899.16281394477, 4932.210846264652, 4983.750812459362, 4991.201407774739, 1311.658968668134, 1314.2443095220287, 1316.5589527508391, 1325.6354502511886, 1328.4818920620964, 838.2037064788475, 878.7934835313696, 886.8603844060351, 901.6123067081218, 907.7412937312835, 4289.270823959934, 4395.604395604411, 4407.2895169471185, 4420.160169567772, 4423.778811059434, 5097.209932460474, 5122.769475373617, 5131.692098474104, 5131.871703207375, 5149.588032957355, 4389.802458889358, 4391.538888416734, 4431.490378606437, 4432.357308190294, 4435.1351486459835, 2778.9583156252675, 2916.5479350700675, 2921.956170657442, 2930.6483222013494, 2938.794284400114, 5136.794528218904, 5146.794128234828, 5154.690718556899, 5198.350206224222, 5200.0, 5378.2470454136455, 5556.388797232301, 5571.470710282517, 5575.208857976534, 5590.944090559043, 5086.796528138833, 5093.745312734422, 5094.898102038012, 5170.663906846043, 5185.248139019896, 5412.404635490014, 5444.891102177855, 5453.636590852287, 5454.672719636835, 5470.425605311544, 4799.736014519095, 5022.698638081727, 5029.0, 5301.416844147064, 5311.575073993994, 4853.563179313879, 4854.393200849894, 4858.271259311132, 4861.708297502161, 4870.196417591058, 3638.2541578976775, 3671.2290419012306, 3674.6876515496483, 3681.6870566001116, 3694.3904255797493, 4981.007596961244, 5029.220470826881, 5090.643654944119, 5141.511556402136, 5157.896842063063, 4951.158303088556, 4988.201887697951, 4994.028553010952, 4995.125852975642, 5008.223725322581, 4947.727874966911, 4964.553190212898, 4975.159191099317, 4986.650934434555, 4991.750412479289, 4789.377380940595, 4856.490068542894, 4896.779644916059, 4905.754712264301, 4917.803287868445, 4738.763061846963, 4890.853274401774, 5016.54851063406, 5023.623228257969, 5029.119904016856, 4913.70517768935, 4935.950640493693, 4943.283223932582, 4944.258361245698, 4945.406551213878], "value": 3786.426399577364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.2612535214081, 733.7688628082157, 741.5439504704601, 750.2010358967702, 758.1130077808963, 12097.455614497347, 12730.045246606507, 13272.601821945333, 13275.933620331909, 13292.0, 13568.932155339235, 13604.795928061087, 13629.727405451886, 13690.52083177089, 13698.93150534246, 632.8670979094372, 790.2453157234827, 803.9839203215932, 819.6639377855081, 822.1326500541926, 820.0364571628343, 823.0658202939677, 823.6293667849462, 824.0770337222319, 824.5423789796661, 839.8908141941539, 844.071521326542, 845.6701886264361, 846.5767116441779, 847.2036285891273, 656.4846595422571, 807.5397023696495, 832.317499650287, 842.5197637346715, 842.9072801991776, 607.538270914104, 607.9057746049325, 608.3034925010882, 608.9451949324582, 609.0377204017642, 12778.808317875239, 12839.614811555575, 12846.229226246454, 12848.743025139538, 12854.935725321408, 11102.167337449642, 11328.320300781897, 11458.369789661565, 11644.835516448287, 11687.532498700042, 9182.90817091834, 9293.953530232373, 9377.640242164847, 9569.808603827885, 9756.95121524395, 3167.0657156138996, 3176.587043684306, 3216.549683044352, 3327.035159803654, 3335.0828522156357, 42052.57947420517, 42632.14735705299, 42948.1410371794, 43003.784981074896, 43372.783136084116, 9164.770880727901, 9516.0, 9730.562124704264, 9967.850482242773, 10056.497175141214, 15727.921360393124, 16151.111688857225, 16219.107949062914, 16233.107179105262, 16243.918780406259, 6338.112664227012, 6517.120188774455, 6555.410013098844, 6619.50353723463, 6721.294264102199, 3513.0, 3587.892363229107, 3589.1565482111682, 3669.1560940983723, 3684.0, 2726.5364887969095, 2747.2719729271357, 2758.8344699317704, 2761.8757155928033, 2769.404578015736, 484.3146947069857, 514.4495389932811, 532.1140301398206, 534.9224362467498, 535.2987586262009, 427.89516568440933, 517.9948200518022, 521.8512723873754, 536.0806217337285, 538.7414041260139, 6777.186737591521, 6866.141732283465, 6972.860542789217, 7043.7534686285735, 7057.576545407292, 541.775163307231, 552.2765177617254, 560.7252446301283, 575.720775423919, 587.3509771702293, 3274.148721332423, 3345.3142105868237, 3375.0887260439545, 3377.088186189715, 3413.232022794851, 49718.0, 50776.492235077916, 51167.744161278955, 51497.22754158691, 51738.0, 43463.782681087025, 45425.091498170514, 45547.77226113848, 46127.53872461232, 47063.5293647066, 41728.791356043635, 41952.0, 42661.36007959883, 42764.57235427606, 42791.074401652004, 6360.332165122781, 6716.361945615159, 6739.19129704419, 6757.797266082025, 7010.088688470466, 27915.720842792125, 28640.71359286464, 28896.133116006553, 28943.0, 29109.41781164407, 34161.14597135092, 34829.477557836144, 36945.26109477849, 37062.25875482529, 37461.81269093637, 8179.959100204461, 8348.415610907177, 8362.372822038249, 8448.83102337962, 8490.915090849012, 9464.242860571276, 9608.615655373986, 9630.614775408905, 9670.613175473183, 9715.902840971783, 8524.010703417061, 8679.479231246145, 8739.0, 8957.552122393723, 8972.461652300623, 8529.530875801891, 8547.358948078794, 8675.0, 8707.78230544216, 8749.693760718344, 8546.059933407445, 8550.187732165434, 8577.0, 8683.088275730957, 8701.738947831574, 7778.299953004257, 7795.610219489116, 7911.28798408146, 8026.1572534883, 8027.5584842834205, 7664.463487555818, 7727.42044346665, 7793.181715919747, 7812.335951444191, 7953.085395179628], "value": 5521.70603221094, "unit": "score"}], "name": "dromaeo_css", "value": 6207.551978746227, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 109.0, 115.0, 114.0, 115.0, 103.0, 114.0, 116.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 134.0, 160.0, 192.0, 138.0, 157.0, 168.0, 138.0, 199.0, 141.0], "value": 159.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 163.0, 163.0, 163.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 112.0, 112.0, 77.0, 76.0, 77.0, 112.0, 104.0, 75.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 148.0, 93.0, 95.0, 94.0, 146.0, 93.0, 93.0, 150.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 68.0, 89.0, 66.0, 66.0], "value": 70.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 67.0, 66.0, 65.0, 65.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 81.0, 84.0, 83.0, 82.0, 82.0, 82.0, 83.0, 81.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 131.0, 133.0, 130.0, 134.0, 138.0, 131.0, 225.0, 137.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 177.0, 176.0, 183.0, 177.0, 174.0, 178.0, 182.0, 173.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 85.0, 83.0, 75.0, 74.0, 77.0, 73.0, 74.0, 74.0], "value": 76.5, "unit": "score"}], "name": "kraken", "value": 1607.6999999999998, "alertThreshold": 2.0}]} 18:23:19 INFO - Return code: 0 18:23:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:23:19 ERROR - # TBPL SUCCESS # 18:23:19 INFO - Running post-action listener: _resource_record_post_action 18:23:19 INFO - Running post-run listener: _resource_record_post_run 18:23:20 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536338432; Read time: 256; Write time: 487672 18:23:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 143245312; Read time: 0; Write time: 202700 18:23:20 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293085184; Read time: 256; Write time: 203676 18:23:20 INFO - Running post-run listener: _upload_blobber_files 18:23:20 INFO - Blob upload gear active. 18:23:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:23:20 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 18:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:23:21 INFO - (blobuploader) - INFO - Open directory for files ... 18:23:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:23:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:23:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:23:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:23:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:23:21 INFO - (blobuploader) - INFO - Done attempting. 18:23:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:23:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:23:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:23:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:23:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:23:22 INFO - (blobuploader) - INFO - Done attempting. 18:23:22 INFO - (blobuploader) - INFO - Iteration through files over. 18:23:22 INFO - Return code: 0 18:23:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:23:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:23:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b72aeaff7af1283560c54c8482eee042d79662b7d592a57259b0485c08aa6893d6f21ffb6d19a73de390d4aeb5decf9d625506f812526d319ea54fe60633593", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d83671478d55e1b35b30826f000f5c1ac0a623f926886a7c5c10a77e2ee4f131ce25606c80f9ac104afe95d36e513a3da4618e34ad972b18855401698c9579ba"} 18:23:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:23:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:23:22 INFO - Contents: 18:23:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b72aeaff7af1283560c54c8482eee042d79662b7d592a57259b0485c08aa6893d6f21ffb6d19a73de390d4aeb5decf9d625506f812526d319ea54fe60633593", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d83671478d55e1b35b30826f000f5c1ac0a623f926886a7c5c10a77e2ee4f131ce25606c80f9ac104afe95d36e513a3da4618e34ad972b18855401698c9579ba"} 18:23:22 INFO - Running post-run listener: copy_logs_to_upload_dir 18:23:22 INFO - Copying logs to upload dir... 18:23:22 INFO - mkdir: /builds/slave/test/build/upload/logs 18:23:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.157751 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-29 18:23:21.582146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 18:23:21.586093) ========= 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=eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b72aeaff7af1283560c54c8482eee042d79662b7d592a57259b0485c08aa6893d6f21ffb6d19a73de390d4aeb5decf9d625506f812526d319ea54fe60633593", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d83671478d55e1b35b30826f000f5c1ac0a623f926886a7c5c10a77e2ee4f131ce25606c80f9ac104afe95d36e513a3da4618e34ad972b18855401698c9579ba"} build_url:https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b72aeaff7af1283560c54c8482eee042d79662b7d592a57259b0485c08aa6893d6f21ffb6d19a73de390d4aeb5decf9d625506f812526d319ea54fe60633593", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d83671478d55e1b35b30826f000f5c1ac0a623f926886a7c5c10a77e2ee4f131ce25606c80f9ac104afe95d36e513a3da4618e34ad972b18855401698c9579ba"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 18:23:21.611605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:23:21.612011) ========= 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=eca2ab57546de7b41f256b19000001ef-1461974931.709104-193327082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:23:21.695786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 18:23:21.696105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 18:23:21.696424) ========= ========= Total master_lag: 0.18 =========