builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1462666052.81 results: success (0) buildid: 20160507143015 builduid: a52a5e81315649318e331c15cfdb7942 revision: 95f7873a791026df547054351c8a04a427d79a57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:32.810152) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:32.810620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:32.810906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:32.850825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:32.851095) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-07 17:07:33-- 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% 113M=0s 2016-05-07 17:07:33 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:32.998070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:32.998364) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018512 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:33.055406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:33.055740) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 95f7873a791026df547054351c8a04a427d79a57 --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 95f7873a791026df547054351c8a04a427d79a57 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-07 17:07:33,364 truncating revision to first 12 chars 2016-05-07 17:07:33,364 Setting DEBUG logging. 2016-05-07 17:07:33,364 attempt 1/10 2016-05-07 17:07:33,364 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/95f7873a7910?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-07 17:07:33,650 unpacking tar archive at: fx-team-95f7873a7910/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:33.633505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:33.633871) ========= script_repo_revision: 95f7873a791026df547054351c8a04a427d79a57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:33.634303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:33.634601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 17:07:33.644709) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-07 17:07:33.645117) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:07:34 INFO - MultiFileLogger online at 20160507 17:07:34 in /builds/slave/test 17:07:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:07:34 INFO - {'append_to_log': False, 17:07:34 INFO - 'base_work_dir': '/builds/slave/test', 17:07:34 INFO - 'blob_upload_branch': 'Fx-Team', 17:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:07:34 INFO - 'branch': 'Fx-Team', 17:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:07:34 INFO - 'config_files': ('talos/linux_config.py',), 17:07:34 INFO - 'default_actions': ('clobber', 17:07:34 INFO - 'read-buildbot-config', 17:07:34 INFO - 'download-and-extract', 17:07:34 INFO - 'populate-webroot', 17:07:34 INFO - 'create-virtualenv', 17:07:34 INFO - 'install', 17:07:34 INFO - 'run-tests'), 17:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:07:34 INFO - 'download_minidump_stackwalk': True, 17:07:34 INFO - 'download_symbols': 'ondemand', 17:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:07:34 INFO - 'installer_path': 'installer.exe', 17:07:34 INFO - 'log_level': 'info', 17:07:34 INFO - 'log_name': 'talos', 17:07:34 INFO - 'log_to_console': True, 17:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:07:34 INFO - 'opt_config_files': (), 17:07:34 INFO - 'pip_index': False, 17:07:34 INFO - 'sps_profile': False, 17:07:34 INFO - 'sps_profile_interval': 0, 17:07:34 INFO - 'suite': 'dromaeojs', 17:07:34 INFO - 'system_bits': '32', 17:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:07:34 INFO - 'title': 'talos-linux64-ix-037', 17:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:07:34 INFO - 'use_talos_json': True, 17:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:07:34 INFO - 'work_dir': 'build'} 17:07:34 INFO - ##### 17:07:34 INFO - ##### Running clobber step. 17:07:34 INFO - ##### 17:07:34 INFO - Running pre-action listener: _resource_record_pre_action 17:07:34 INFO - Running main action method: clobber 17:07:34 INFO - rmtree: /builds/slave/test/build 17:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:07:34 INFO - Running post-action listener: _resource_record_post_action 17:07:34 INFO - ##### 17:07:34 INFO - ##### Finished clobber step (success) 17:07:34 INFO - ##### 17:07:34 INFO - ##### 17:07:34 INFO - ##### Running read-buildbot-config step. 17:07:34 INFO - ##### 17:07:34 INFO - Running pre-action listener: _resource_record_pre_action 17:07:34 INFO - Running main action method: read_buildbot_config 17:07:34 INFO - Using buildbot properties: 17:07:34 INFO - { 17:07:34 INFO - "project": "", 17:07:34 INFO - "product": "firefox", 17:07:34 INFO - "script_repo_revision": "production", 17:07:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:07:34 INFO - "repository": "", 17:07:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:07:34 INFO - "buildid": "20160507143015", 17:07:34 INFO - "pgo_build": "True", 17:07:34 INFO - "basedir": "/builds/slave/test", 17:07:34 INFO - "buildnumber": 653, 17:07:34 INFO - "slavename": "talos-linux64-ix-037", 17:07:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:07:34 INFO - "platform": "ubuntu64_hw", 17:07:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:07:34 INFO - "branch": "fx-team", 17:07:34 INFO - "repo_path": "integration/fx-team", 17:07:34 INFO - "revision": "95f7873a791026df547054351c8a04a427d79a57", 17:07:34 INFO - "stage_platform": "linux64-pgo", 17:07:34 INFO - "builduid": "a52a5e81315649318e331c15cfdb7942", 17:07:34 INFO - "slavebuilddir": "test" 17:07:34 INFO - } 17:07:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:07:34 INFO - Running post-action listener: _resource_record_post_action 17:07:34 INFO - ##### 17:07:34 INFO - ##### Finished read-buildbot-config step (success) 17:07:34 INFO - ##### 17:07:34 INFO - ##### 17:07:34 INFO - ##### Running download-and-extract step. 17:07:34 INFO - ##### 17:07:34 INFO - Running pre-action listener: _resource_record_pre_action 17:07:34 INFO - Running main action method: download_and_extract 17:07:34 INFO - mkdir: /builds/slave/test/build/tests 17:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:34 INFO - https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:35 INFO - Downloaded 1361 bytes. 17:07:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:07:35 INFO - Using the following test package requirements: 17:07:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:07:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:07:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:07:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:07:35 INFO - u'jsshell-linux-x86_64.zip'], 17:07:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:07:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:07:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:07:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:07:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:07:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:07:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:07: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')]} 17:07:35 INFO - https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:38 INFO - Downloaded 23895393 bytes. 17:07:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:07:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:07:39 INFO - Return code: 0 17:07:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:39 INFO - https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:51 INFO - Downloaded 23895393 bytes. 17:07:51 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'] 17:07:51 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 17:07:52 INFO - Return code: 0 17:07:52 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')]} 17:07:52 INFO - https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:54 INFO - Downloaded 10840152 bytes. 17:07:54 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'] 17:07:54 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 17:07:54 INFO - Return code: 0 17:07:54 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')]} 17:07:54 INFO - https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:07:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:07:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:07:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lv08ntNcRseD0fjW5bjuGA/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 17:07:55 INFO - Downloaded 58428922 bytes. 17:07:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:07:55 INFO - mkdir: /builds/slave/test/properties 17:07:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:07:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:07:55 INFO - Contents: 17:07:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:07:56 INFO - Running post-action listener: _resource_record_post_action 17:07:56 INFO - Running post-action listener: set_extra_try_arguments 17:07:56 INFO - ##### 17:07:56 INFO - ##### Finished download-and-extract step (success) 17:07:56 INFO - ##### 17:07:56 INFO - ##### 17:07:56 INFO - ##### Running populate-webroot step. 17:07:56 INFO - ##### 17:07:56 INFO - Running pre-action listener: _resource_record_pre_action 17:07:56 INFO - Running main action method: populate_webroot 17:07:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:07:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:07:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:07:56 INFO - '--tppagecycles', 17:07:56 INFO - '7'], 17:07:56 INFO - 'tests': ['tsvgm']}}, 17:07:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:07:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:07:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:07:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:07:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:56 INFO - 'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:56 INFO - 'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['damp', 'tps']}, 17:07:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:56 INFO - 'tests': ['damp', 'tps']}, 17:07:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['dromaeo_dom']}, 17:07:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:07:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['a11yr', 17:07:56 INFO - 'ts_paint', 17:07:56 INFO - 'tpaint', 17:07:56 INFO - 'sessionrestore', 17:07:56 INFO - 'sessionrestore_no_auto_restore', 17:07:56 INFO - 'tabpaint']}, 17:07:56 INFO - 'other-e10s': {'tests': ['a11yr', 17:07:56 INFO - 'ts_paint', 17:07:56 INFO - 'tpaint', 17:07:56 INFO - 'sessionrestore', 17:07:56 INFO - 'sessionrestore_no_auto_restore', 17:07:56 INFO - 'tabpaint']}, 17:07:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:07:56 INFO - 'ts_paint', 17:07:56 INFO - 'tpaint', 17:07:56 INFO - 'sessionrestore', 17:07:56 INFO - 'sessionrestore_no_auto_restore', 17:07:56 INFO - 'tabpaint']}, 17:07:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:07:56 INFO - 'ts_paint', 17:07:56 INFO - 'tpaint', 17:07:56 INFO - 'sessionrestore', 17:07:56 INFO - 'sessionrestore_no_auto_restore', 17:07:56 INFO - 'tabpaint']}, 17:07:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['a11yr', 17:07:56 INFO - 'ts_paint', 17:07:56 INFO - 'tpaint', 17:07:56 INFO - 'sessionrestore', 17:07:56 INFO - 'sessionrestore_no_auto_restore', 17:07:56 INFO - 'tabpaint']}, 17:07:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['a11yr', 17:07:56 INFO - 'ts_paint', 17:07:56 INFO - 'tpaint', 17:07:56 INFO - 'sessionrestore', 17:07:56 INFO - 'sessionrestore_no_auto_restore', 17:07:56 INFO - 'tabpaint']}, 17:07:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['tsvgx', 17:07:56 INFO - 'tsvgr_opacity', 17:07:56 INFO - 'tart', 17:07:56 INFO - 'tscrollx', 17:07:56 INFO - 'cart']}, 17:07:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:07:56 INFO - 'tsvgr_opacity', 17:07:56 INFO - 'tart', 17:07:56 INFO - 'tscrollx', 17:07:56 INFO - 'cart']}, 17:07:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:56 INFO - 'talos_options': ['--disable-e10s'], 17:07:56 INFO - 'tests': ['tp5o']}, 17:07:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:56 INFO - 'tests': ['tp5o']}, 17:07:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:56 INFO - 'talos_options': ['--disable-e10s', 17:07:56 INFO - '--xperf_path', 17:07:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:56 INFO - 'tests': ['tp5n']}, 17:07:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:56 INFO - 'talos_options': ['--xperf_path', 17:07:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:56 INFO - 'tests': ['tp5n']}}, 17:07:56 INFO - 'talos.zip': {'path': '', 17:07:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:07:56 INFO - Running post-action listener: _resource_record_post_action 17:07:56 INFO - ##### 17:07:56 INFO - ##### Finished populate-webroot step (success) 17:07:56 INFO - ##### 17:07:56 INFO - ##### 17:07:56 INFO - ##### Running create-virtualenv step. 17:07:56 INFO - ##### 17:07:56 INFO - Running pre-action listener: _resource_record_pre_action 17:07:56 INFO - Running main action method: create_virtualenv 17:07:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:07:56 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 17:07:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:07:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:07:56 INFO - Using real prefix '/usr' 17:07:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:07:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:07:59 INFO - Installing pip.................done. 17:07:59 INFO - Return code: 0 17:07:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:07:59 INFO - Using env: {'DISPLAY': ':0', 17:07:59 INFO - 'HOME': '/home/cltbld', 17:07:59 INFO - 'LANG': 'en_US.UTF-8', 17:07:59 INFO - 'LANGUAGE': 'en_US:en', 17:07:59 INFO - 'LOGNAME': 'cltbld', 17:07:59 INFO - 'MAIL': '/var/mail/cltbld', 17:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:59 INFO - 'MOZ_NO_REMOTE': '1', 17:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:59 INFO - 'NO_EM_RESTART': '1', 17:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:59 INFO - 'PWD': '/builds/slave/test', 17:07:59 INFO - 'SHELL': '/bin/bash', 17:07:59 INFO - 'SHLVL': '1', 17:07:59 INFO - 'TERM': 'linux', 17:07:59 INFO - 'TMOUT': '86400', 17:07:59 INFO - 'USER': 'cltbld', 17:07:59 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:59 INFO - '_': '/tools/buildbot/bin/python'} 17:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:59 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 17:07:59 INFO - Cleaning up... 17:07:59 INFO - Return code: 0 17:07:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:07:59 INFO - Using env: {'DISPLAY': ':0', 17:07:59 INFO - 'HOME': '/home/cltbld', 17:07:59 INFO - 'LANG': 'en_US.UTF-8', 17:07:59 INFO - 'LANGUAGE': 'en_US:en', 17:07:59 INFO - 'LOGNAME': 'cltbld', 17:07:59 INFO - 'MAIL': '/var/mail/cltbld', 17:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:59 INFO - 'MOZ_NO_REMOTE': '1', 17:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:59 INFO - 'NO_EM_RESTART': '1', 17:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:59 INFO - 'PWD': '/builds/slave/test', 17:07:59 INFO - 'SHELL': '/bin/bash', 17:07:59 INFO - 'SHLVL': '1', 17:07:59 INFO - 'TERM': 'linux', 17:07:59 INFO - 'TMOUT': '86400', 17:07:59 INFO - 'USER': 'cltbld', 17:07:59 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:59 INFO - '_': '/tools/buildbot/bin/python'} 17:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:59 INFO - Downloading/unpacking psutil>=0.7.1 17:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:01 INFO - Installing collected packages: psutil 17:08:01 INFO - Running setup.py install for psutil 17:08:01 INFO - building 'psutil._psutil_linux' extension 17:08:01 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 17:08:02 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 17:08:02 INFO - building 'psutil._psutil_posix' extension 17:08:02 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 17:08:02 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 17:08:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:02 INFO - Successfully installed psutil 17:08:02 INFO - Cleaning up... 17:08:02 INFO - Return code: 0 17:08:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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', '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 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:08: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:08: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 mozsystemmonitor==0.0.0 17:08:02 INFO - Using env: {'DISPLAY': ':0', 17:08:02 INFO - 'HOME': '/home/cltbld', 17:08:02 INFO - 'LANG': 'en_US.UTF-8', 17:08:02 INFO - 'LANGUAGE': 'en_US:en', 17:08:02 INFO - 'LOGNAME': 'cltbld', 17:08:02 INFO - 'MAIL': '/var/mail/cltbld', 17:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:02 INFO - 'MOZ_NO_REMOTE': '1', 17:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:02 INFO - 'NO_EM_RESTART': '1', 17:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:02 INFO - 'PWD': '/builds/slave/test', 17:08:02 INFO - 'SHELL': '/bin/bash', 17:08:02 INFO - 'SHLVL': '1', 17:08:02 INFO - 'TERM': 'linux', 17:08:02 INFO - 'TMOUT': '86400', 17:08:02 INFO - 'USER': 'cltbld', 17:08:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:02 INFO - '_': '/tools/buildbot/bin/python'} 17:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:08:04 INFO - Installing collected packages: mozsystemmonitor 17:08:04 INFO - Running setup.py install for mozsystemmonitor 17:08:04 INFO - Successfully installed mozsystemmonitor 17:08:04 INFO - Cleaning up... 17:08:04 INFO - Return code: 0 17:08:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:08:04 INFO - Using env: {'DISPLAY': ':0', 17:08:04 INFO - 'HOME': '/home/cltbld', 17:08:04 INFO - 'LANG': 'en_US.UTF-8', 17:08:04 INFO - 'LANGUAGE': 'en_US:en', 17:08:04 INFO - 'LOGNAME': 'cltbld', 17:08:04 INFO - 'MAIL': '/var/mail/cltbld', 17:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:04 INFO - 'MOZ_NO_REMOTE': '1', 17:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:04 INFO - 'NO_EM_RESTART': '1', 17:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:04 INFO - 'PWD': '/builds/slave/test', 17:08:04 INFO - 'SHELL': '/bin/bash', 17:08:04 INFO - 'SHLVL': '1', 17:08:04 INFO - 'TERM': 'linux', 17:08:04 INFO - 'TMOUT': '86400', 17:08:04 INFO - 'USER': 'cltbld', 17:08:04 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:04 INFO - '_': '/tools/buildbot/bin/python'} 17:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:06 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:08:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:07 INFO - Downloading docopt-0.6.1.tar.gz 17:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:07 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:07 INFO - Running setup.py install for blobuploader 17:08:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:08:07 INFO - Running setup.py install for requests 17:08:07 INFO - Running setup.py install for docopt 17:08:08 INFO - Successfully installed blobuploader requests docopt 17:08:08 INFO - Cleaning up... 17:08:08 INFO - Return code: 0 17:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:08 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 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:08:08 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 17:08:08 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 17:08:08 INFO - Using env: {'DISPLAY': ':0', 17:08:08 INFO - 'HOME': '/home/cltbld', 17:08:08 INFO - 'LANG': 'en_US.UTF-8', 17:08:08 INFO - 'LANGUAGE': 'en_US:en', 17:08:08 INFO - 'LOGNAME': 'cltbld', 17:08:08 INFO - 'MAIL': '/var/mail/cltbld', 17:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:08 INFO - 'MOZ_NO_REMOTE': '1', 17:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:08 INFO - 'NO_EM_RESTART': '1', 17:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:08 INFO - 'PWD': '/builds/slave/test', 17:08:08 INFO - 'SHELL': '/bin/bash', 17:08:08 INFO - 'SHLVL': '1', 17:08:08 INFO - 'TERM': 'linux', 17:08:08 INFO - 'TMOUT': '86400', 17:08:08 INFO - 'USER': 'cltbld', 17:08:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:08 INFO - '_': '/tools/buildbot/bin/python'} 17:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:08 INFO - Running setup.py (path:/tmp/pip-i4f635-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:08 INFO - Running setup.py (path:/tmp/pip-GZxoKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:08 INFO - Running setup.py (path:/tmp/pip-v3c00y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:08 INFO - Running setup.py (path:/tmp/pip-ubVa4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:08 INFO - Running setup.py (path:/tmp/pip-waaAkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:08 INFO - Running setup.py (path:/tmp/pip-kAh4pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:08 INFO - Running setup.py (path:/tmp/pip-le7Hai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:08 INFO - Running setup.py (path:/tmp/pip-GhP_JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:08 INFO - Running setup.py (path:/tmp/pip-YCikMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:08 INFO - Running setup.py (path:/tmp/pip-iyfWls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:09 INFO - Running setup.py (path:/tmp/pip-KkGe00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:09 INFO - Running setup.py (path:/tmp/pip-EbeEBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:09 INFO - Running setup.py (path:/tmp/pip-qtvDcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:09 INFO - Running setup.py (path:/tmp/pip-jY3r7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:09 INFO - Running setup.py (path:/tmp/pip-sDevL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:09 INFO - Running setup.py (path:/tmp/pip-T0eQt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:09 INFO - Running setup.py (path:/tmp/pip-fCl7Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:09 INFO - Running setup.py install for manifestparser 17:08:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:09 INFO - Running setup.py install for mozcrash 17:08:09 INFO - Running setup.py install for mozdebug 17:08:09 INFO - Running setup.py install for mozdevice 17:08:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:08:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:09 INFO - Running setup.py install for mozfile 17:08:10 INFO - Running setup.py install for mozhttpd 17:08:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Running setup.py install for mozinfo 17:08:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Running setup.py install for mozInstall 17:08:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Running setup.py install for mozleak 17:08:10 INFO - Running setup.py install for mozlog 17:08:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Running setup.py install for moznetwork 17:08:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Running setup.py install for mozprocess 17:08:10 INFO - Running setup.py install for mozprofile 17:08:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:10 INFO - Running setup.py install for mozrunner 17:08:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:11 INFO - Running setup.py install for mozscreenshot 17:08:11 INFO - Running setup.py install for moztest 17:08:11 INFO - Running setup.py install for mozversion 17:08:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:11 INFO - Cleaning up... 17:08:11 INFO - Return code: 0 17:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:11 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 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:08:11 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 17:08:11 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 17:08:11 INFO - Using env: {'DISPLAY': ':0', 17:08:11 INFO - 'HOME': '/home/cltbld', 17:08:11 INFO - 'LANG': 'en_US.UTF-8', 17:08:11 INFO - 'LANGUAGE': 'en_US:en', 17:08:11 INFO - 'LOGNAME': 'cltbld', 17:08:11 INFO - 'MAIL': '/var/mail/cltbld', 17:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:11 INFO - 'MOZ_NO_REMOTE': '1', 17:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:11 INFO - 'NO_EM_RESTART': '1', 17:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:11 INFO - 'PWD': '/builds/slave/test', 17:08:11 INFO - 'SHELL': '/bin/bash', 17:08:11 INFO - 'SHLVL': '1', 17:08:11 INFO - 'TERM': 'linux', 17:08:11 INFO - 'TMOUT': '86400', 17:08:11 INFO - 'USER': 'cltbld', 17:08:11 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:11 INFO - '_': '/tools/buildbot/bin/python'} 17:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:11 INFO - Running setup.py (path:/tmp/pip-S4p0o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:11 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)) 17:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:11 INFO - Running setup.py (path:/tmp/pip-BuETeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:11 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)) 17:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:11 INFO - Running setup.py (path:/tmp/pip-alG_Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:11 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)) 17:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:11 INFO - Running setup.py (path:/tmp/pip-up7rKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:11 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)) 17:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:11 INFO - Running setup.py (path:/tmp/pip-4DezgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:11 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)) 17:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:11 INFO - Running setup.py (path:/tmp/pip-y9nJEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:11 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)) 17:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:11 INFO - Running setup.py (path:/tmp/pip-V9AVlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:12 INFO - Running setup.py (path:/tmp/pip-sBnoQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:12 INFO - Running setup.py (path:/tmp/pip-J7D3mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:12 INFO - Running setup.py (path:/tmp/pip-N4hmr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:12 INFO - Running setup.py (path:/tmp/pip-pTpSxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:12 INFO - Running setup.py (path:/tmp/pip-mIrhHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:12 INFO - Running setup.py (path:/tmp/pip-_25E1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:12 INFO - Running setup.py (path:/tmp/pip-8dNz8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:12 INFO - Running setup.py (path:/tmp/pip-8LZgwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:12 INFO - Running setup.py (path:/tmp/pip-WYvHfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:12 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)) 17:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:12 INFO - Running setup.py (path:/tmp/pip-lFvvRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:12 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)) 17:08:12 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)) 17:08:12 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)) 17:08:12 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)) 17:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:08:12 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)) 17:08:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:14 INFO - Downloading blessings-1.6.tar.gz 17:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:14 INFO - Installing collected packages: blessings 17:08:14 INFO - Running setup.py install for blessings 17:08:14 INFO - Successfully installed blessings 17:08:14 INFO - Cleaning up... 17:08:14 INFO - Return code: 0 17:08:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:15 INFO - Reading from file tmpfile_stdout 17:08:15 INFO - Current package versions: 17:08:15 INFO - argparse == 1.2.1 17:08:15 INFO - blessings == 1.6 17:08:15 INFO - blobuploader == 1.2.4 17:08:15 INFO - docopt == 0.6.1 17:08:15 INFO - manifestparser == 1.1 17:08:15 INFO - mozInstall == 1.12 17:08:15 INFO - mozcrash == 0.17 17:08:15 INFO - mozdebug == 0.1 17:08:15 INFO - mozdevice == 0.48 17:08:15 INFO - mozfile == 1.2 17:08:15 INFO - mozhttpd == 0.7 17:08:15 INFO - mozinfo == 0.9 17:08:15 INFO - mozleak == 0.1 17:08:15 INFO - mozlog == 3.1 17:08:15 INFO - moznetwork == 0.27 17:08:15 INFO - mozprocess == 0.22 17:08:15 INFO - mozprofile == 0.28 17:08:15 INFO - mozrunner == 6.11 17:08:15 INFO - mozscreenshot == 0.1 17:08:15 INFO - mozsystemmonitor == 0.0 17:08:15 INFO - moztest == 0.7 17:08:15 INFO - mozversion == 1.4 17:08:15 INFO - psutil == 3.1.1 17:08:15 INFO - requests == 1.2.3 17:08:15 INFO - wsgiref == 0.1.2 17:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:15 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 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:08:15 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 17:08:15 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 17:08:15 INFO - Using env: {'DISPLAY': ':0', 17:08:15 INFO - 'HOME': '/home/cltbld', 17:08:15 INFO - 'LANG': 'en_US.UTF-8', 17:08:15 INFO - 'LANGUAGE': 'en_US:en', 17:08:15 INFO - 'LOGNAME': 'cltbld', 17:08:15 INFO - 'MAIL': '/var/mail/cltbld', 17:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:15 INFO - 'MOZ_NO_REMOTE': '1', 17:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:15 INFO - 'NO_EM_RESTART': '1', 17:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:15 INFO - 'PWD': '/builds/slave/test', 17:08:15 INFO - 'SHELL': '/bin/bash', 17:08:15 INFO - 'SHLVL': '1', 17:08:15 INFO - 'TERM': 'linux', 17:08:15 INFO - 'TMOUT': '86400', 17:08:15 INFO - 'USER': 'cltbld', 17:08:15 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:15 INFO - '_': '/tools/buildbot/bin/python'} 17:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 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)) 17:08:15 INFO - Cleaning up... 17:08:15 INFO - Return code: 0 17:08:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:08: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', 'jsonschema'] in /builds/slave/test/build 17:08: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 jsonschema 17:08:15 INFO - Using env: {'DISPLAY': ':0', 17:08:15 INFO - 'HOME': '/home/cltbld', 17:08:15 INFO - 'LANG': 'en_US.UTF-8', 17:08:15 INFO - 'LANGUAGE': 'en_US:en', 17:08:15 INFO - 'LOGNAME': 'cltbld', 17:08:15 INFO - 'MAIL': '/var/mail/cltbld', 17:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:15 INFO - 'MOZ_NO_REMOTE': '1', 17:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:15 INFO - 'NO_EM_RESTART': '1', 17:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:15 INFO - 'PWD': '/builds/slave/test', 17:08:15 INFO - 'SHELL': '/bin/bash', 17:08:15 INFO - 'SHLVL': '1', 17:08:15 INFO - 'TERM': 'linux', 17:08:15 INFO - 'TMOUT': '86400', 17:08:15 INFO - 'USER': 'cltbld', 17:08:15 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:15 INFO - '_': '/tools/buildbot/bin/python'} 17:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:15 INFO - Downloading/unpacking jsonschema 17:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:08:17 INFO - Downloading/unpacking functools32 (from jsonschema) 17:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:17 INFO - Downloading functools32-3.2.3-2.tar.gz 17:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:08:17 INFO - warning: no files found matching '*.txt' 17:08:17 INFO - no previously-included directories found matching 'build' 17:08:17 INFO - no previously-included directories found matching 'dist' 17:08:17 INFO - no previously-included directories found matching '.git*' 17:08:17 INFO - Installing collected packages: jsonschema, functools32 17:08:17 INFO - Running setup.py install for functools32 17:08:17 INFO - warning: no files found matching '*.txt' 17:08:17 INFO - no previously-included directories found matching 'build' 17:08:17 INFO - no previously-included directories found matching 'dist' 17:08:17 INFO - no previously-included directories found matching '.git*' 17:08:17 INFO - Successfully installed jsonschema functools32 17:08:17 INFO - Cleaning up... 17:08:17 INFO - Return code: 0 17:08:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d8f29af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1add770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', '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 17:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:08:17 INFO - Using env: {'DISPLAY': ':0', 17:08:17 INFO - 'HOME': '/home/cltbld', 17:08:17 INFO - 'LANG': 'en_US.UTF-8', 17:08:17 INFO - 'LANGUAGE': 'en_US:en', 17:08:17 INFO - 'LOGNAME': 'cltbld', 17:08:17 INFO - 'MAIL': '/var/mail/cltbld', 17:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:17 INFO - 'MOZ_NO_REMOTE': '1', 17:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:17 INFO - 'NO_EM_RESTART': '1', 17:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:17 INFO - 'PWD': '/builds/slave/test', 17:08:17 INFO - 'SHELL': '/bin/bash', 17:08:17 INFO - 'SHLVL': '1', 17:08:17 INFO - 'TERM': 'linux', 17:08:17 INFO - 'TMOUT': '86400', 17:08:17 INFO - 'USER': 'cltbld', 17:08:17 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:17 INFO - '_': '/tools/buildbot/bin/python'} 17:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:18 INFO - Downloading/unpacking flake8 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:08:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:08:19 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 17:08:19 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 17:08:19 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 17:08:19 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 17:08:19 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 17:08:19 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 17:08:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:08:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:20 INFO - no previously-included directories found matching 'docs/_build' 17:08:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:08:20 INFO - Running setup.py install for pep8 17:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:20 INFO - no previously-included directories found matching 'docs/_build' 17:08:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:08:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:08:20 INFO - Cleaning up... 17:08:20 INFO - Return code: 0 17:08:20 INFO - Running post-action listener: _resource_record_post_action 17:08:20 INFO - Running post-action listener: _start_resource_monitoring 17:08:20 INFO - Starting resource monitoring. 17:08:20 INFO - ##### 17:08:20 INFO - ##### Finished create-virtualenv step (success) 17:08:20 INFO - ##### 17:08:20 INFO - ##### 17:08:20 INFO - ##### Running install step. 17:08:20 INFO - ##### 17:08:20 INFO - Running pre-action listener: _resource_record_pre_action 17:08:20 INFO - Running main action method: install 17:08:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:21 INFO - Reading from file tmpfile_stdout 17:08:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:08:21 INFO - Reading from file tmpfile_stdout 17:08:21 INFO - Output received: 17:08:21 INFO - Usage: mozinstall [options] installer 17:08:21 INFO - Options: 17:08:21 INFO - -h, --help show this help message and exit 17:08:21 INFO - -d DEST, --destination=DEST 17:08:21 INFO - Directory to install application into. [default: 17:08:21 INFO - "/builds/slave/test"] 17:08:21 INFO - --app=APP Application being installed. [default: firefox] 17:08:21 INFO - mkdir: /builds/slave/test/build/application 17:08:21 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'] 17:08:21 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 17:08:37 INFO - Reading from file tmpfile_stdout 17:08:37 INFO - Output received: 17:08:37 INFO - /builds/slave/test/build/application/firefox/firefox 17:08:37 INFO - Running post-action listener: _resource_record_post_action 17:08:37 INFO - ##### 17:08:37 INFO - ##### Finished install step (success) 17:08:37 INFO - ##### 17:08:37 INFO - ##### 17:08:37 INFO - ##### Running run-tests step. 17:08:37 INFO - ##### 17:08:37 INFO - Running pre-action listener: _resource_record_pre_action 17:08:37 INFO - Running main action method: run_tests 17:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:08:37 INFO - Python 2.7.3 17:08:37 INFO - Return code: 0 17:08:37 INFO - grabbing minidump binary from tooltool 17:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:37 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 0x1b6c9c0>, '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 0x1b6d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:08:37 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 17:08:37 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 17:08:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:08:37 INFO - Return code: 0 17:08:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:08:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:08:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:08:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:08:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:08:38 INFO - Return code: 0 17:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:08:38 INFO - Using env: {'DISPLAY': ':0', 17:08:38 INFO - 'HOME': '/home/cltbld', 17:08:38 INFO - 'LANG': 'en_US.UTF-8', 17:08:38 INFO - 'LANGUAGE': 'en_US:en', 17:08:38 INFO - 'LOGNAME': 'cltbld', 17:08:38 INFO - 'MAIL': '/var/mail/cltbld', 17:08:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:08:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:38 INFO - 'MOZ_NO_REMOTE': '1', 17:08:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:38 INFO - 'NO_EM_RESTART': '1', 17:08:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:38 INFO - 'PWD': '/builds/slave/test', 17:08:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:08:38 INFO - 'SHELL': '/bin/bash', 17:08:38 INFO - 'SHLVL': '1', 17:08:38 INFO - 'TERM': 'linux', 17:08:38 INFO - 'TMOUT': '86400', 17:08:38 INFO - 'USER': 'cltbld', 17:08:38 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010', 17:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:38 INFO - '_': '/tools/buildbot/bin/python'} 17:08:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:08:39 INFO - mozversion application_buildid: 20160507143015 17:08:39 INFO - mozversion application_changeset: 95f7873a791026df547054351c8a04a427d79a57 17:08:39 INFO - mozversion application_display_name: Nightly 17:08:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:08:39 INFO - mozversion application_name: Firefox 17:08:39 INFO - mozversion application_remotingname: firefox 17:08:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:08:39 INFO - mozversion application_vendor: Mozilla 17:08:39 INFO - mozversion application_version: 49.0a1 17:08:39 INFO - mozversion platform_buildid: 20160507143015 17:08:39 INFO - mozversion platform_changeset: 95f7873a791026df547054351c8a04a427d79a57 17:08:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:08:39 INFO - mozversion platform_version: 49.0a1 17:08:39 INFO - using testdate: 1462666119 17:08:39 INFO - actual date: 1462666119 17:08:39 INFO - starting webserver on 'localhost:52005' 17:08:39 INFO - SUITE-START | Running 2 tests 17:08:39 INFO - TEST-START | dromaeo_css 17:08:39 INFO - operating with platform_type : linux_ 17:08:39 INFO - Initialising browser for dromaeo_css test... 17:08:39 INFO - TEST-INFO | started process 22010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq8ula2/profile http://localhost:52005/getInfo.html) 17:08:43 INFO - PROCESS | 22010 | __metrics Screen width/height:1600/1200 17:08:43 INFO - PROCESS | 22010 | colorDepth:24 17:08:43 INFO - PROCESS | 22010 | Browser inner width/height: 1024/697 17:08:43 INFO - PROCESS | 22010 | __metrics 17:08:44 ERROR - PROCESS | 22010 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:08:45 INFO - TEST-INFO | 22010: exit 0 17:08:45 INFO - Browser initialized. 17:08:45 INFO - Running cycle 1/1 for dromaeo_css test... 17:08:45 INFO - TEST-INFO | started process 22089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq8ula2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:56 INFO - PROCESS | 22089 | RSS: Main: 151687168 17:08:56 INFO - PROCESS | 22089 | 17:09:47 INFO - PROCESS | 22089 | 1462666187941 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] 17:11:55 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52005/tests/dromaeo/cssquery-ext.html) 17:11:56 INFO - PROCESS | 22089 | RSS: Main: 243703808 17:11:56 INFO - PROCESS | 22089 | 17:14:59 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-ext.html (next: http://localhost:52005/tests/dromaeo/cssquery-jquery.html) 17:14:59 INFO - PROCESS | 22089 | RSS: Main: 246820864 17:14:59 INFO - PROCESS | 22089 | 17:18:01 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52005/tests/dromaeo/cssquery-mootools.html) 17:18:02 INFO - PROCESS | 22089 | RSS: Main: 247263232 17:18:02 INFO - PROCESS | 22089 | 17:21:04 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52005/tests/dromaeo/cssquery-prototype.html) 17:21:04 INFO - PROCESS | 22089 | RSS: Main: 240427008 17:21:04 INFO - PROCESS | 22089 | 17:24:07 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52005/tests/dromaeo/cssquery-yui.html) 17:24:08 INFO - PROCESS | 22089 | RSS: Main: 225492992 17:24:08 INFO - PROCESS | 22089 | 17:27:10 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-yui.html (next: http://localhost:52005/tests/dromaeo/cssquery-dojo.html) 17:27:11 INFO - PROCESS | 22089 | RSS: Main: 272060416 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - PROCESS | 22089 | __start_tp_report 17:27:11 INFO - PROCESS | 22089 | _x_x_mozilla_page_load 17:27:11 INFO - PROCESS | 22089 | _x_x_mozilla_page_load_details 17:27:11 INFO - PROCESS | 22089 | |i|pagename|runs| 17:27:11 INFO - PROCESS | 22089 | |0;dojo.html;3095.2880837407397;3108.891188808391;3131.5459258407523;3146.1977195815093;3173.7302329302006;5253.264542963979;5266.868328291795;5292.603054770898;5365.382980957191;5393.973030134849;5329.413764485904;5341.412444631087;5349.983503134402;5373.382061062979;5427.48438898305;4795.688280261789;4805.543473370024;4914.557689807916;4966.130927087764;5025.798968041274;4925.33507976424;4934.40787105546;4960.181570040939;4988.42633097193;4991.925121123186;4737.644676649248;4774.594159496447;4797.520247975192;4817.51824817519;4843.273508973647;4849.515048495157;4852.951470485285;4863.221884498464;4903.950960490385;4917.7786999585105;4826.855194344175;4858.076965376567;4868.221084626478;4873.244647079709;4902.975485122587;5139.023585518739;5231.110711179109;5273.446288139767;5295.814646487393;5307.681539107666;5802.274715660543;5841.795537156222;5851.151583020481;5859.589828711992;5859.7656093756195;5823.4467725566;5848.093545500455;5887.5584331174905;5903.380145084747;5906;5236.947630523684;5314.043472175007;5358.062339090644;5358.330208723948;5427.914417116593;5904.675242861684;5912.024515954905;5914.822555323261;5917.023691091008;5924.496417804448;5522.282103326542;5680.914786278209;5691.743871525791;5692.57305702074;5694.886102277931;5633.155026746021;5702.914456283159;5705.22979397776;5712.971435142881;5741.655500669973;5716.514096301861;5719.771209151588;5720.628159169641;5721.456461636138;5722.942770572325;5551.916721249185;5580.86047848807;5679.4320567943705;5721.828345149652;5742;4267.8292868284925;4277.251480990814;4279.529251782302;4311.48262208537;4319.9784001080425;3812.961870381316;3819.541655001362;3825.311443940062;3858.2862170498547;3862.092408284051;5264.710440925785;5340.519353258148;5342.839714808562;5372.5970552207955;5377.569794416438;5733.512651424676;5769.68266745333;5782.913256301074;5784.71076446176;5842.532597392198;5374.978754036721;5376.220448035013;5384.003959267548;5388.299521062315;5396.163594642837;4664.346991421204;4688.296755486636;4734.218853889139;4783.904321913542;4835.347228124158;5885.26434195717;5911.881762364728;5914.378990206053;5914.556408269397;5949.881002380015;5718.628289161191;5728;5730.770769169187;5735.627184233012;5736.311642602915;5730.283714535683;5881.235439392852;5884.7940322088525;5909.172715819703;5948.196993405835;5707;5710.914336285042;5711.114777209539;5712.228849105318;5720.027595308724;5769.8557536061935;5771.884562308815;5796.971015144897;5818.44724751148;5829.6793676346515;5376.462353764592;5473.945260547343;5492.423295554069;5538.224648549287;5599.132134519156;5576.944230557642;5581.972090139523;5586.664800112007;5588.720563971704;5599.748011339418;5269.657472264291;5479.205515200353;5479.890402192013;5484.424135465878;5532.6680399176175;5556.361018482765;5614.6069775116985;5635.774569017193;5659.575531835211;5713.571482138773;5540.335159780852;5546.389897111395;5552.361478430033;5559.583031272751;5591.384947655836 17:27:11 INFO - PROCESS | 22089 | |1;ext.html;624.5784095735378;629.0972454527756;660.6696651674163;660.8083655739836;666.9866602667945;29882.701172988265;42282;42661.14677706448;42682.57317426825;47347.763261183645;44013.77993110038;44327.77836110823;44442.555574444246;44459;44546;8801.07588703185;8940.597673104727;8943.284537237038;8944.597493112826;8945.373823832335;8786.780330491756;8880.467171969702;8901.287896968259;8909.465432074096;8911.242544383735;8929.374943753939;8951.776205594848;8968.551572421386;8974.41666291689;8975.95512022439;8857.911420885774;8884.244839188677;8884.600192991331;8901.421407608485;8904.154105360012;8727.301815854717;8784.077671844429;8785.42894711848;8785.648574057093;8789.25291350236;40569;40807.7959610203;40854.79572602118;40990.38514422286;41000.17999639991;3584.8566057357675;3750.8124593770476;3763.7741735495956;4128.525219599755;4140;32087.358252835045;32187.51718724221;32336.514952275735;33089;33265;4189.874303770892;4227.196832601827;4241.87274381769;4381.474223093217;4428.800703968297;293509;293728;294487.52756236296;294996;296037;57152.714236428554;57207.71396142992;57637.423625764044;57986.7100664494;58056.709716451995;54683.45316546863;60421;60618;60677.39322606806;62160.378396216365;15499.612509687347;16485.423010194587;16513.422030229125;16522.83477165237;16528.6694266114;12633.305168215653;12708.903030999967;12772.552960646519;12787.488500460064;12794.296313702649;16117.435889743803;17014.744778828328;17458.127093645522;17612.471625851245;17717.29130834778;6582.045603387482;6753.534959739758;6890.483213758988;6906.585604863624;6968.721251149897;981.5386768218925;1018.4449475036123;1048.5438834107188;1060.3743791163251;1236.1779416687982;31875.52186717201;32540.186495337333;32620.673793261765;32672.836635816668;33246.66753332484;1133.2973556395089;1148.2077366617007;1161.4726634475637;1176.65876895701;1179.1215544419463;17068.2319295632;17211.741823872653;17251.3962011329;17275;17372;444954;447368;448361;448513;448974;55592;56632.433675662716;56675.99999999918;56727;56883.14675279874;1300.674831292177;1378.4555100735154;1398.825146856643;1415.946877028313;1423.1247782613618;32115.19712007125;33742.650293987965;33812.323753525285;33882.32235355328;34162.31675366528;48147.5185248143;48578.75710621566;48663;48687.513124868296;48725.26912096392;336509;337832;338064;338706;339732;40014.599854001084;40875.18249634931;41602;41660.16679666329;41673;45993.77003114963;46198.53801462077;46550.30174547317;47163.80933505076;47415.28877066778;39961;40139.197216054934;40672.79663601663;40876.79561602292;40911;40437.59562404338;40504.59495405008;40585;41007.38488922728;41149.588504114574;40071.39892901667;40526.79736601298;41343.96640084022;41780.791096044326;41808.58191418047;35518.289634207686;35923.281534369686;36299.63700362963;36758.44862327121;36855.44716829196;28091.859540702164;28304.292392690346;28440.85779571089;28468.288292792848;28479.857600711865 17:27:11 INFO - PROCESS | 22089 | |2;jquery.html;399.53055160186784;402.27188788293194;402.3240955195272;404.6378491250333;416.58420740154367;17703.203355848986;19302.420927372164;19426.708599371002;19431.125599348026;20465.283715069938;19080.522986925334;19553.51116222095;19568.510787230327;19599.314024009163;19676.311329103486;5459.535939445152;5548.44515548445;5693.259876216107;5702.971485142589;5710.600257981943;5677.801276955307;5682.119271512902;5690.9146362804595;5712.857178570527;5714.77140914365;5411.675299482024;5600.467955544237;5600.6079574429805;5607.691576963265;5611.298587676541;5414.566834653218;5459.645123066988;5482.451754824526;5513.7794488220425;5523.834284971457;4907.4356449008465;5035.370578677665;5051.191809310492;5054.368203974504;5064.746762661852;22733.204337848263;22764.203252886236;22878;23397.41506462335;23446.413839653975;2375.5367703297866;2483.4908843687;2622.409957759508;2656.0836511403536;2735.179446166142;14060.156390616596;14210.786838197435;14217.857821421756;14326.713465730627;14521.300504419896;1975.7332760077493;2004.7393838801008;2056.969145462819;2064.576761763835;2091.8326533877253;76988;78862;78936.99999999943;79287.60356198181;79733.60133199296;10570.735731606617;10766.654168228972;11216.887831121585;11336.238779712541;11470.38869822005;15985.360585576447;16005.279762410719;16094.356225751073;16104.19479026044;16126.596835078983;7766.184550622216;7892.763217103496;7932.246436588515;8012;8145.796355091052;7548.508992032616;7576.5832879191075;7668.1181664109345;7761;7816.140224575406;4846.200376937836;4861.052094841542;4863.975680121647;4875.95124048762;4936.851894443173;1948.3959972408315;1960.5784756277183;1988;2041.795820417976;2050.8872012039483;460.6084827896261;463.82606522554045;470.3744020452858;901.963921443135;1006.335818359879;11384.943075284737;12025.879741202476;12030.578929737418;12116.21244619097;12238.449269782881;473.9313046962701;486.3361511536727;488.25541049899186;488.7043338779987;496.7119070938847;6467.223933127961;6482.189726284215;6498.285188629247;6537.738490460423;6549.181352330958;358746;361662;363278;470133;488229;97586.51206743921;103154;103514;104714.4764276189;105661.47169264258;1115.141341167313;1124.3310230412892;1129.8531190945125;1133.5805751871696;1138.8177891537148;17251;17310.65378692394;17868.910655446638;17886.910565447088;18118.81881181224;37206;38662.613373865905;40520;41331.586684133974;43350;53271.46728532665;57229.713851430475;57380.426195737506;57839.710801445726;58041.419585803604;7549.245075492627;7871.763847084597;8508.957455212685;8622.137786221328;9090.318226133199;13078.346082696018;13406.597802065953;13572.1856688599;13646.522371716943;13843.86156138466;10906.018458338787;11561.653150405502;11737.35444550558;12074.818877716665;12089.516419343128;10109.949450252701;11278.774424511628;12142.817857732318;12182.512699491921;12201.572944946884;10864.239503234698;11219.439028048402;11494.252873563191;11792.646220613395;11907.404629768303;7790.337821285254;7817.570033647977;7989.600519973862;8025.398095143005;8116.715914942949;9396.248300135836;10591.311564748266;10638.308509946828;10651.946740266249;10897.78204435891 17:27:11 INFO - PROCESS | 22089 | |3;mootools.html;1415.8301003879535;1517.3778750712204;1549.2563569486647;1703.6507515959229;1844.723291506273;7659.234076592338;7967.083785364692;7975.760727178186;8188.467749596272;8193.918060819406;7921.049474063106;8078.71724489643;8086.47437916535;8093.028836539609;8100.189981001897;1865.291189348046;2163.891805409731;2217.756046834851;2227.7438094619165;2246.5731511012855;2110.1981247126146;2121.469632591852;2123.5540536487356;2125.2455378340696;2129.2015494189677;2146.0771868096713;2154.429076294783;2156;2168.9240876569324;2171.3703026122407;1855.2578968412608;2087.6242276390244;2171.337741988693;2173.3697227803996;2181.334692918659;2038.052305677852;2058.464799152216;2063.7007633893;2065.308121779206;2095.203822547422;8040.195980401913;8095.392845536609;8099.352051835839;8100.959495202486;8108.959455202746;4622.9075418491775;4746.406699162605;4781.402324709411;4781.8087276508895;4786.760661966888;3005.143534092795;3034.499307614241;3089.629244490653;3098.6746391629003;3121.1416860363356;1043.6190790361538;1044.0499145777305;1051.2588625019343;1052.1162223732026;1076.3488089705693;10381.948090259575;10639.734006649818;10690.625828096057;11007.559697612165;11263.718407039807;4051.513818341818;4098.877033688994;4158;4190.1200747843295;4198.85304014358;8873.866891996626;8940.284777217807;8944.686935957341;8950.597223124974;8975.147361000694;4318.848840290575;4725.125851717443;4738.739369334719;4770.737609431515;4777.402824646919;4338.197433474754;4437.667174961826;4451.799669014902;4477.753723545171;4495.685302028826;3531.4526248431534;3565.3404120237838;3611.909702257412;3620.3845346291196;3676.669099780979;1063.1176123817213;1090.5831382899225;1096.1888202729922;1098.5990113608475;1109.6837401340579;973.2603221551531;977.1205914676848;983.5426526665135;986.0730912941812;1004.4324956399611;5408.756605952742;5457.890842183214;5589.413111623302;5604.047311956977;5652.349979752381;455.6423207781875;461.91916414627303;476.4235275316836;478.8252287914956;478.9928151077667;3753.9061523462133;3820.255050265227;3822.3310920588788;3864.574896761354;3864.9227015459533;10063.345882517613;10368.637097701545;10563.788724225473;10568.630097946689;10585;10163.4918254087;10354.585816567404;10386.37681739083;10512.894871051192;10518.842217366746;7488.663010164556;7588.468807183554;7632.732854350183;7652;7849.568273745113;5504.22940788298;5542.224088627515;5622.437756224344;5622.746976385991;5797.4782269595935;9218.124278193562;9247.289251488497;9255.814883702153;9340.439573625605;9371.625134994523;8710.651573936972;9376.437413755197;9423.764405889908;9469.242460603273;9533.427994320364;6685.197776266879;6815.488838337045;6868.690908909211;6870.31296870309;7172.0676312079095;7483.738069167553;7650.502717323357;7856.25365590268;7895.171007044408;8096.87854682192;6981.790546283416;7114.715411383694;7199.280071992759;7221.205667376689;7236.276372362932;7241.565506069653;7293.197748247795;7307.1231452226075;7317.304856038668;7333.266673332624;6620.3710647488415;6672.466202703869;6696.1629796275465;6698.7320507179165;6699.497537684791;4807.158747219153;4856.077345304381;4879.414470263449;4938.407391113089;4968.975155124202;4958.256261560795;5004.77478513475;5009.849704508871;5047.419546752024;5077.5684066853255 17:27:11 INFO - PROCESS | 22089 | |4;prototype.html;322.41803544602;324.9642539320675;333.28842920365014;333.36826713378156;335.34272825262485;5205;5223.268742376061;5264;5273.6308458407975;5295.179247216678;5169.767360468779;5173.974130129344;5199.532042116209;5238.476152384759;5239.659422137558;3893.6885049196;3924.2543916655886;4088.1823635272917;4103.938440923389;4116.814743336557;3998.3802510610903;4068.9796551017203;4090.365993271048;4106.630403263705;4117.8970525736795;3894.805259737016;4041.3937909313545;4056.472658554384;4070.328395814687;4094.6928980326447;3995.3407687731487;4077.7553346799286;4085.121698834735;4102.343625020012;4128.422020917059;3596.6942809861193;3623.981880090609;3628.4738712886483;3629.0947252692285;3632.981835090834;4942.802287908479;4961.603071754251;4987.276844857512;5006.123928312531;5020.246962955586;4523.253663145577;4611.432113081569;4622.1911165546235;4639.489656137822;4647.930281045787;5375.865603359947;5412.783488660449;5413.968177820433;5419.268398766156;5425.240466334716;3932.1742434088874;3940.089056807446;3942.48747662802;3954.920901581981;3966.226585815767;5431.185322201662;5703.629264097862;5712.600117991742;5734.222391058785;5743.62666426681;3938.03518138058;3965.6232657897453;4030.6775457963295;4040.7979601019833;4064.552899181088;4061.472008638858;4064.532578753481;4098.836046558164;4103.420183229418;4104.748051844216;4373.278409062469;4643.605293550086;4664.137134630104;4693.413323334583;4698.929516057262;5506.504414602705;5529.682190685557;5532.502074813206;5534.335879694462;5550.16747487872;1378.5106287268077;1382.7165431086603;1383.7509248335195;1387.653086728318;1389.2775756606509;912.2565109435789;961.8220629183623;978.6819283732673;1000.4147573669485;1001.5827603940488;5080.49195080489;5100.56645185156;5115.462876397999;5200.271961925334;5204.947950520446;5419.34967803866;5437.619366644376;5501.752421141058;5524.674078221198;5531.280933478622;4990.201567749215;5071.898562028812;5114.491225088608;5147.897042059213;5166.560842328369;2858.3997360554517;2879.611252480888;2883.6972117927735;2888.465633857743;2888.638920134983;5347.8395648129845;5583.637063590853;5585.58108141891;5586.357568879631;5619.061423808861;5505.348395481339;5512.2558454608115;5517.5585953123655;5530.5852061095575;5609.803656872072;5609.887802243932;5633.887322253532;5648.519875810438;5652.180433837153;5678.346990096109;5325.653832500875;5477.945220547744;5479.452054794648;5490.5607551395;5498.140966697215;5409.540189083972;5436.483534064258;5438.782448702166;5452.400235974119;5462.726863656881;5495.945040549704;5543.2538750293525;5575.832725018256;5596.377050655265;5603;3744.400895856759;4016.8393264269102;4030.858919937788;4040.91918161641;4053.6959728021106;5614.63504872182;5669.092945128759;5672.574556908331;5681.2330335404195;5682.403347648603;5511.2994632630525;5546.667199968015;5548.944510554843;5553.694546799965;5555.3611334697025;5283.784729512156;5528.806491772769;5529;5529.198266251291;5544.695041772741;5179.30079439286;5220.504052115043;5390.460953904578;5423.403425623257;5424.620276580601;5531.446855314436;5540.168974653834;5554.805716770752;5560.91658625129;5563;5335.413104558573;5346.893062138658;5371.462853714597;5372.489613486712;5396.64921780083 17:27:11 INFO - PROCESS | 22089 | |5;yui.html;739.7706710919615;806.3388021822108;832.9541875196862;855.9529225892574;856.4304737349664;15026.624334391632;15454.1500217488;15457.30442130104;15479.613009674764;15495.83781216409;14747.852521474782;14805.333759980827;14825.110493370405;14835.92582037091;14907.552773416788;683.3508167241116;797.6450479536609;836.803351212466;843.1147295339899;843.5487014447272;838;843.6667516331046;843.7342237195264;844.0968164064423;844.586152785137;855.56366253211;863.5552690364467;866.7183165471215;867.0549101479386;867.9696210632629;708.4084789201023;827.0530242871878;849.6346570974479;850.196564246784;858.7466697324304;616.8951278282702;619.7118339971935;620.8758248350348;621.5245337316957;621.6052806467925;11795.115366347558;11844.111691623162;11847.94076029623;11850.407479625985;11868;11429;11621.767564648744;11829.467673954692;11953.22304050234;12233.632991010283;11197.384143872085;11228.270162439416;12427.316497592628;12598.433070511757;12647.241165530098;4477.686561940665;4503.099380123988;4621.792019359137;4653.906921861578;4758.666893317469;53503.73248133734;53777;54888.72555637236;55009.724951375385;56086.71956640232;10632.94683526593;10719.410432426292;10752.139828813677;11513;11675.532978680927;20370.592588148153;20624.27815026467;20640.174393024412;20655;20664.380068597966;8635.395522313504;8796.648134074694;8835.779105522284;8900.910990890137;9092.81814363709;4859.246816743411;4868.245421959602;4874.488178741181;4917;4960.776765045582;3345.8661653534073;3437.724982001434;3441.105312618737;3442.294329662413;3447.0865220716532;550.9724513774376;633.0693879996398;647.3009150117862;650.2814390098968;668.2281964331205;654.2606854254661;728.1880703016099;748.4723270094679;780.5199802121655;791.4934441957153;8787.5166865823;9077.137671921157;9145.451272923512;9170.44977301364;9195.080491950885;633.5311869216838;668.7391917152314;750.5009168902618;756.2173150789017;783.5572901310741;4347.6304514116655;4429.712068715523;4634.397528321297;4647.814087436533;4726.314684370747;68534.65732671304;70195.64902175457;72720;73075;73145.6342718283;61011.08483372753;61245;61761.38238617646;63656.36343636597;64913;55532.889342212926;55727.164092538645;55838;55846.44153558413;56120.719396402754;8515.616797244264;8587.742367728979;8624.78438039054;8695.565221739014;8784.912150878665;35232.64767352294;35821.46267805933;36391;36441.81779091088;36444.81777591201;46490.53509464862;49932;50275.74862125666;50427.243591345425;51052;11407.372594507382;11423.257488263236;12116.878831211576;12243.387830608255;12534.435950382436;12023.21849079807;12116.091293152873;13034.217946923214;13315.800262996256;13650.93174534121;11403.429828508708;11457.312561246352;12008.099392545419;12306.630801075982;12593.055520836157;11050.778984420105;11086.334819910831;11432.657020289405;11518.193726439069;11560.13299002595;11033;11036.337819730841;11206.551737930718;11322.773544529227;11991.400429978641;9610.346840710623;10015.499225038573;10040.046195611405;10152.39085654863;10223.95520895809;9740;9899.208063355058;9939.403635781877;9941;10116.797664046826 17:27:11 INFO - PROCESS | 22089 | __end_tp_report 17:27:11 INFO - PROCESS | 22089 | __start_cc_report 17:27:11 INFO - PROCESS | 22089 | _x_x_mozilla_cycle_collect,832 17:27:11 INFO - PROCESS | 22089 | __end_cc_report 17:27:11 INFO - PROCESS | 22089 | __startTimestamp1462667231022__endTimestamp 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - PROCESS | 22089 | ------- Summary: start ------- 17:27:11 INFO - PROCESS | 22089 | Number of tests: 6 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - PROCESS | 22089 | [#0] dojo.html Cycles:165 Average:5311.68 Median:5522.28 stddev:620.02 (11.2%) stddev-sans-first:597.04 17:27:11 INFO - PROCESS | 22089 | Values: 3095.3 3108.9 3131.5 3146.2 3173.7 5253.3 5266.9 5292.6 5365.4 5394.0 5329.4 5341.4 5350.0 5373.4 5427.5 4795.7 4805.5 4914.6 4966.1 5025.8 4925.3 4934.4 4960.2 4988.4 4991.9 4737.6 4774.6 4797.5 4817.5 4843.3 4849.5 4853.0 4863.2 4904.0 4917.8 4826.9 4858.1 4868.2 4873.2 4903.0 5139.0 5231.1 5273.4 5295.8 5307.7 5802.3 5841.8 5851.2 5859.6 5859.8 5823.4 5848.1 5887.6 5903.4 5906.0 5236.9 5314.0 5358.1 5358.3 5427.9 5904.7 5912.0 5914.8 5917.0 5924.5 5522.3 5680.9 5691.7 5692.6 5694.9 5633.2 5702.9 5705.2 5713.0 5741.7 5716.5 5719.8 5720.6 5721.5 5722.9 5551.9 5580.9 5679.4 5721.8 5742.0 4267.8 4277.3 4279.5 4311.5 4320.0 3813.0 3819.5 3825.3 3858.3 3862.1 5264.7 5340.5 5342.8 5372.6 5377.6 5733.5 5769.7 5782.9 5784.7 5842.5 5375.0 5376.2 5384.0 5388.3 5396.2 4664.3 4688.3 4734.2 4783.9 4835.3 5885.3 5911.9 5914.4 5914.6 5949.9 5718.6 5728.0 5730.8 5735.6 5736.3 5730.3 5881.2 5884.8 5909.2 5948.2 5707.0 5710.9 5711.1 5712.2 5720.0 5769.9 5771.9 5797.0 5818.4 5829.7 5376.5 5473.9 5492.4 5538.2 5599.1 5576.9 5582.0 5586.7 5588.7 5599.7 5269.7 5479.2 5479.9 5484.4 5532.7 5556.4 5614.6 5635.8 5659.6 5713.6 5540.3 5546.4 5552.4 5559.6 5591.4 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - PROCESS | 22089 | [#1] ext.html Cycles:180 Average:53599.48 Median:41078.49 stddev:96242.27 (234.3%) stddev-sans-first:96430.07 17:27:11 INFO - PROCESS | 22089 | Values: 624.6 629.1 660.7 660.8 667.0 29882.7 42282.0 42661.1 42682.6 47347.8 44013.8 44327.8 44442.6 44459.0 44546.0 8801.1 8940.6 8943.3 8944.6 8945.4 8786.8 8880.5 8901.3 8909.5 8911.2 8929.4 8951.8 8968.6 8974.4 8976.0 8857.9 8884.2 8884.6 8901.4 8904.2 8727.3 8784.1 8785.4 8785.6 8789.3 40569.0 40807.8 40854.8 40990.4 41000.2 3584.9 3750.8 3763.8 4128.5 4140.0 32087.4 32187.5 32336.5 33089.0 33265.0 4189.9 4227.2 4241.9 4381.5 4428.8 293509.0 293728.0 294487.5 294996.0 296037.0 57152.7 57207.7 57637.4 57986.7 58056.7 54683.5 60421.0 60618.0 60677.4 62160.4 15499.6 16485.4 16513.4 16522.8 16528.7 12633.3 12708.9 12772.6 12787.5 12794.3 16117.4 17014.7 17458.1 17612.5 17717.3 6582.0 6753.5 6890.5 6906.6 6968.7 981.5 1018.4 1048.5 1060.4 1236.2 31875.5 32540.2 32620.7 32672.8 33246.7 1133.3 1148.2 1161.5 1176.7 1179.1 17068.2 17211.7 17251.4 17275.0 17372.0 444954.0 447368.0 448361.0 448513.0 448974.0 55592.0 56632.4 56676.0 56727.0 56883.1 1300.7 1378.5 1398.8 1415.9 1423.1 32115.2 33742.7 33812.3 33882.3 34162.3 48147.5 48578.8 48663.0 48687.5 48725.3 336509.0 337832.0 338064.0 338706.0 339732.0 40014.6 40875.2 41602.0 41660.2 41673.0 45993.8 46198.5 46550.3 47163.8 47415.3 39961.0 40139.2 40672.8 40876.8 40911.0 40437.6 40504.6 40585.0 41007.4 41149.6 40071.4 40526.8 41344.0 41780.8 41808.6 35518.3 35923.3 36299.6 36758.4 36855.4 28091.9 28304.3 28440.9 28468.3 28479.9 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - PROCESS | 22089 | [#2] jquery.html Cycles:180 Average:26626.06 Median:362470.00 stddev:68871.24 (19.0%) stddev-sans-first:69036.29 17:27:11 INFO - PROCESS | 22089 | Values: 399.5 402.3 402.3 404.6 416.6 17703.2 19302.4 19426.7 19431.1 20465.3 19080.5 19553.5 19568.5 19599.3 19676.3 5459.5 5548.4 5693.3 5703.0 5710.6 5677.8 5682.1 5690.9 5712.9 5714.8 5411.7 5600.5 5600.6 5607.7 5611.3 5414.6 5459.6 5482.5 5513.8 5523.8 4907.4 5035.4 5051.2 5054.4 5064.7 22733.2 22764.2 22878.0 23397.4 23446.4 2375.5 2483.5 2622.4 2656.1 2735.2 14060.2 14210.8 14217.9 14326.7 14521.3 1975.7 2004.7 2057.0 2064.6 2091.8 76988.0 78862.0 78937.0 79287.6 79733.6 10570.7 10766.7 11216.9 11336.2 11470.4 15985.4 16005.3 16094.4 16104.2 16126.6 7766.2 7892.8 7932.2 8012.0 8145.8 7548.5 7576.6 7668.1 7761.0 7816.1 4846.2 4861.1 4864.0 4876.0 4936.9 1948.4 1960.6 1988.0 2041.8 2050.9 460.6 463.8 470.4 902.0 1006.3 11384.9 12025.9 12030.6 12116.2 12238.4 473.9 486.3 488.3 488.7 496.7 6467.2 6482.2 6498.3 6537.7 6549.2 358746.0 361662.0 363278.0 470133.0 488229.0 97586.5 103154.0 103514.0 104714.5 105661.5 1115.1 1124.3 1129.9 1133.6 1138.8 17251.0 17310.7 17868.9 17886.9 18118.8 37206.0 38662.6 40520.0 41331.6 43350.0 53271.5 57229.7 57380.4 57839.7 58041.4 7549.2 7871.8 8509.0 8622.1 9090.3 13078.3 13406.6 13572.2 13646.5 13843.9 10906.0 11561.7 11737.4 12074.8 12089.5 10109.9 11278.8 12142.8 12182.5 12201.6 10864.2 11219.4 11494.3 11792.6 11907.4 7790.3 7817.6 7989.6 8025.4 8116.7 9396.2 10591.3 10638.3 10651.9 10897.8 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - PROCESS | 22089 | [#3] mootools.html Cycles:180 Average:5335.43 Median:2628.11 stddev:3033.57 (115.4%) stddev-sans-first:3027.78 17:27:11 INFO - PROCESS | 22089 | Values: 1415.8 1517.4 1549.3 1703.7 1844.7 7659.2 7967.1 7975.8 8188.5 8193.9 7921.0 8078.7 8086.5 8093.0 8100.2 1865.3 2163.9 2217.8 2227.7 2246.6 2110.2 2121.5 2123.6 2125.2 2129.2 2146.1 2154.4 2156.0 2168.9 2171.4 1855.3 2087.6 2171.3 2173.4 2181.3 2038.1 2058.5 2063.7 2065.3 2095.2 8040.2 8095.4 8099.4 8101.0 8109.0 4622.9 4746.4 4781.4 4781.8 4786.8 3005.1 3034.5 3089.6 3098.7 3121.1 1043.6 1044.0 1051.3 1052.1 1076.3 10381.9 10639.7 10690.6 11007.6 11263.7 4051.5 4098.9 4158.0 4190.1 4198.9 8873.9 8940.3 8944.7 8950.6 8975.1 4318.8 4725.1 4738.7 4770.7 4777.4 4338.2 4437.7 4451.8 4477.8 4495.7 3531.5 3565.3 3611.9 3620.4 3676.7 1063.1 1090.6 1096.2 1098.6 1109.7 973.3 977.1 983.5 986.1 1004.4 5408.8 5457.9 5589.4 5604.0 5652.3 455.6 461.9 476.4 478.8 479.0 3753.9 3820.3 3822.3 3864.6 3864.9 10063.3 10368.6 10563.8 10568.6 10585.0 10163.5 10354.6 10386.4 10512.9 10518.8 7488.7 7588.5 7632.7 7652.0 7849.6 5504.2 5542.2 5622.4 5622.7 5797.5 9218.1 9247.3 9255.8 9340.4 9371.6 8710.7 9376.4 9423.8 9469.2 9533.4 6685.2 6815.5 6868.7 6870.3 7172.1 7483.7 7650.5 7856.3 7895.2 8096.9 6981.8 7114.7 7199.3 7221.2 7236.3 7241.6 7293.2 7307.1 7317.3 7333.3 6620.4 6672.5 6696.2 6698.7 6699.5 4807.2 4856.1 4879.4 4938.4 4969.0 4958.3 5004.8 5009.8 5047.4 5077.6 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - PROCESS | 22089 | [#4] prototype.html Cycles:180 Average:4570.05 Median:5204.97 stddev:1330.00 (25.6%) stddev-sans-first:1294.95 17:27:11 INFO - PROCESS | 22089 | Values: 322.4 325.0 333.3 333.4 335.3 5205.0 5223.3 5264.0 5273.6 5295.2 5169.8 5174.0 5199.5 5238.5 5239.7 3893.7 3924.3 4088.2 4103.9 4116.8 3998.4 4069.0 4090.4 4106.6 4117.9 3894.8 4041.4 4056.5 4070.3 4094.7 3995.3 4077.8 4085.1 4102.3 4128.4 3596.7 3624.0 3628.5 3629.1 3633.0 4942.8 4961.6 4987.3 5006.1 5020.2 4523.3 4611.4 4622.2 4639.5 4647.9 5375.9 5412.8 5414.0 5419.3 5425.2 3932.2 3940.1 3942.5 3954.9 3966.2 5431.2 5703.6 5712.6 5734.2 5743.6 3938.0 3965.6 4030.7 4040.8 4064.6 4061.5 4064.5 4098.8 4103.4 4104.7 4373.3 4643.6 4664.1 4693.4 4698.9 5506.5 5529.7 5532.5 5534.3 5550.2 1378.5 1382.7 1383.8 1387.7 1389.3 912.3 961.8 978.7 1000.4 1001.6 5080.5 5100.6 5115.5 5200.3 5204.9 5419.3 5437.6 5501.8 5524.7 5531.3 4990.2 5071.9 5114.5 5147.9 5166.6 2858.4 2879.6 2883.7 2888.5 2888.6 5347.8 5583.6 5585.6 5586.4 5619.1 5505.3 5512.3 5517.6 5530.6 5609.8 5609.9 5633.9 5648.5 5652.2 5678.3 5325.7 5477.9 5479.5 5490.6 5498.1 5409.5 5436.5 5438.8 5452.4 5462.7 5495.9 5543.3 5575.8 5596.4 5603.0 3744.4 4016.8 4030.9 4040.9 4053.7 5614.6 5669.1 5672.6 5681.2 5682.4 5511.3 5546.7 5548.9 5553.7 5555.4 5283.8 5528.8 5529.0 5529.2 5544.7 5179.3 5220.5 5390.5 5423.4 5424.6 5531.4 5540.2 5554.8 5560.9 5563.0 5335.4 5346.9 5371.5 5372.5 5396.6 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - PROCESS | 22089 | [#5] yui.html Cycles:180 Average:15498.97 Median:27446.39 stddev:18987.06 (69.2%) stddev-sans-first:19007.97 17:27:11 INFO - PROCESS | 22089 | Values: 739.8 806.3 833.0 856.0 856.4 15026.6 15454.2 15457.3 15479.6 15495.8 14747.9 14805.3 14825.1 14835.9 14907.6 683.4 797.6 836.8 843.1 843.5 838.0 843.7 843.7 844.1 844.6 855.6 863.6 866.7 867.1 868.0 708.4 827.1 849.6 850.2 858.7 616.9 619.7 620.9 621.5 621.6 11795.1 11844.1 11847.9 11850.4 11868.0 11429.0 11621.8 11829.5 11953.2 12233.6 11197.4 11228.3 12427.3 12598.4 12647.2 4477.7 4503.1 4621.8 4653.9 4758.7 53503.7 53777.0 54888.7 55009.7 56086.7 10632.9 10719.4 10752.1 11513.0 11675.5 20370.6 20624.3 20640.2 20655.0 20664.4 8635.4 8796.6 8835.8 8900.9 9092.8 4859.2 4868.2 4874.5 4917.0 4960.8 3345.9 3437.7 3441.1 3442.3 3447.1 551.0 633.1 647.3 650.3 668.2 654.3 728.2 748.5 780.5 791.5 8787.5 9077.1 9145.5 9170.4 9195.1 633.5 668.7 750.5 756.2 783.6 4347.6 4429.7 4634.4 4647.8 4726.3 68534.7 70195.6 72720.0 73075.0 73145.6 61011.1 61245.0 61761.4 63656.4 64913.0 55532.9 55727.2 55838.0 55846.4 56120.7 8515.6 8587.7 8624.8 8695.6 8784.9 35232.6 35821.5 36391.0 36441.8 36444.8 46490.5 49932.0 50275.7 50427.2 51052.0 11407.4 11423.3 12116.9 12243.4 12534.4 12023.2 12116.1 13034.2 13315.8 13650.9 11403.4 11457.3 12008.1 12306.6 12593.1 11050.8 11086.3 11432.7 11518.2 11560.1 11033.0 11036.3 11206.6 11322.8 11991.4 9610.3 10015.5 10040.0 10152.4 10224.0 9740.0 9899.2 9939.4 9941.0 10116.8 17:27:11 INFO - PROCESS | 22089 | -------- Summary: end -------- 17:27:11 INFO - PROCESS | 22089 | 17:27:11 INFO - TEST-INFO | 22089: exit 0 17:27:11 INFO - TEST-OK | dromaeo_css | took 1112668ms 17:27:11 INFO - TEST-START | kraken 17:27:11 INFO - operating with platform_type : linux_ 17:27:11 INFO - Initialising browser for kraken test... 17:27:11 INFO - TEST-INFO | started process 22270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfNGgU/profile http://localhost:52005/getInfo.html) 17:27:15 INFO - PROCESS | 22270 | __metrics Screen width/height:1600/1200 17:27:15 INFO - PROCESS | 22270 | colorDepth:24 17:27:15 INFO - PROCESS | 22270 | Browser inner width/height: 1024/697 17:27:15 INFO - PROCESS | 22270 | __metrics 17:27:16 ERROR - PROCESS | 22270 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:27:17 INFO - TEST-INFO | 22270: exit 0 17:27:17 INFO - Browser initialized. 17:27:17 INFO - Running cycle 1/1 for kraken test... 17:27:17 INFO - TEST-INFO | started process 22350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfNGgU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:29 INFO - PROCESS | 22350 | RSS: Main: 152006656 17:27:29 INFO - PROCESS | 22350 | 17:27:31 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52005/tests/kraken/driver.html?testName=audio-beat-detection) 17:27:32 INFO - PROCESS | 22350 | RSS: Main: 208125952 17:27:32 INFO - PROCESS | 22350 | 17:27:35 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52005/tests/kraken/driver.html?testName=audio-dft) 17:27:35 INFO - PROCESS | 22350 | RSS: Main: 195915776 17:27:35 INFO - PROCESS | 22350 | 17:27:39 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52005/tests/kraken/driver.html?testName=audio-fft) 17:27:39 INFO - PROCESS | 22350 | RSS: Main: 265273344 17:27:39 INFO - PROCESS | 22350 | 17:27:41 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52005/tests/kraken/driver.html?testName=audio-oscillator) 17:27:42 INFO - PROCESS | 22350 | RSS: Main: 174235648 17:27:42 INFO - PROCESS | 22350 | 17:27:44 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:27:45 INFO - PROCESS | 22350 | RSS: Main: 178884608 17:27:45 INFO - PROCESS | 22350 | 17:27:48 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52005/tests/kraken/driver.html?testName=imaging-darkroom) 17:27:48 INFO - PROCESS | 22350 | RSS: Main: 214323200 17:27:48 INFO - PROCESS | 22350 | 17:27:51 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52005/tests/kraken/driver.html?testName=imaging-desaturate) 17:27:52 INFO - PROCESS | 22350 | RSS: Main: 214999040 17:27:52 INFO - PROCESS | 22350 | 17:27:55 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52005/tests/kraken/driver.html?testName=json-parse-financial) 17:27:55 INFO - PROCESS | 22350 | RSS: Main: 215474176 17:27:55 INFO - PROCESS | 22350 | 17:27:57 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:27:58 INFO - PROCESS | 22350 | RSS: Main: 203956224 17:27:58 INFO - PROCESS | 22350 | 17:27:59 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:00 INFO - PROCESS | 22350 | RSS: Main: 206880768 17:28:00 INFO - PROCESS | 22350 | 17:28:02 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:03 INFO - PROCESS | 22350 | RSS: Main: 214896640 17:28:03 INFO - PROCESS | 22350 | 17:28:05 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:06 INFO - PROCESS | 22350 | RSS: Main: 219627520 17:28:06 INFO - PROCESS | 22350 | 17:28:09 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:09 INFO - PROCESS | 22350 | RSS: Main: 217862144 17:28:09 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52005/tests/kraken/driver.html?testName=ai-astar) 17:28:11 INFO - PROCESS | 22350 | RSS: Main: 263479296 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | __start_tp_report 17:28:11 INFO - PROCESS | 22350 | _x_x_mozilla_page_load 17:28:11 INFO - PROCESS | 22350 | _x_x_mozilla_page_load_details 17:28:11 INFO - PROCESS | 22350 | |i|pagename|runs| 17:28:11 INFO - PROCESS | 22350 | |0;ai-astar;114;106;111;110;111;110;110;110;111;111 17:28:11 INFO - PROCESS | 22350 | |1;audio-beat-detection;160;124;152;186;129;165;150;126;185;128 17:28:11 INFO - PROCESS | 22350 | |2;audio-dft;159;159;160;160;160;163;160;159;161;162 17:28:11 INFO - PROCESS | 22350 | |3;audio-fft;75;75;75;122;77;75;75;74;149;75 17:28:11 INFO - PROCESS | 22350 | |4;audio-oscillator;92;92;117;91;92;92;128;91;91;121 17:28:11 INFO - PROCESS | 22350 | |5;imaging-gaussian-blur;117;117;116;116;117;117;116;117;117;117 17:28:11 INFO - PROCESS | 22350 | |6;imaging-darkroom;146;145;146;145;146;147;145;145;147;153 17:28:11 INFO - PROCESS | 22350 | |7;imaging-desaturate;95;94;95;95;94;95;94;95;94;95 17:28:11 INFO - PROCESS | 22350 | |8;json-parse-financial;56;57;57;57;57;58;58;75;56;55 17:28:11 INFO - PROCESS | 22350 | |9;json-stringify-tinderbox;59;60;60;59;60;59;59;59;59;60 17:28:11 INFO - PROCESS | 22350 | |10;stanford-crypto-aes;78;79;79;78;79;79;85;81;79;78 17:28:11 INFO - PROCESS | 22350 | |11;stanford-crypto-ccm;123;123;122;130;130;123;120;123;199;124 17:28:11 INFO - PROCESS | 22350 | |12;stanford-crypto-pbkdf2;171;164;167;168;168;166;164;169;164;167 17:28:11 INFO - PROCESS | 22350 | |13;stanford-crypto-sha256-iterative;69;70;63;62;63;63;63;63;63;61 17:28:11 INFO - PROCESS | 22350 | __end_tp_report 17:28:11 INFO - PROCESS | 22350 | __start_cc_report 17:28:11 INFO - PROCESS | 22350 | _x_x_mozilla_cycle_collect,1594 17:28:11 INFO - PROCESS | 22350 | __end_cc_report 17:28:11 INFO - PROCESS | 22350 | __startTimestamp1462667291623__endTimestamp 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | ------- Summary: start ------- 17:28:11 INFO - PROCESS | 22350 | Number of tests: 14 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.96 (1.8%) stddev-sans-first:1.58 17:28:11 INFO - PROCESS | 22350 | Values: 114.0 106.0 111.0 110.0 111.0 110.0 110.0 110.0 111.0 111.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:156.00 stddev:23.63 (15.1%) stddev-sans-first:24.81 17:28:11 INFO - PROCESS | 22350 | Values: 160.0 124.0 152.0 186.0 129.0 165.0 150.0 126.0 185.0 128.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 17:28:11 INFO - PROCESS | 22350 | Values: 159.0 159.0 160.0 160.0 160.0 163.0 160.0 159.0 161.0 162.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#3] audio-fft Cycles:10 Average:87.20 Median:75.00 stddev:26.25 (35.0%) stddev-sans-first:27.47 17:28:11 INFO - PROCESS | 22350 | Values: 75.0 75.0 75.0 122.0 77.0 75.0 75.0 74.0 149.0 75.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:91.50 stddev:14.94 (16.3%) stddev-sans-first:15.51 17:28:11 INFO - PROCESS | 22350 | Values: 92.0 92.0 117.0 91.0 92.0 92.0 128.0 91.0 91.0 121.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:28:11 INFO - PROCESS | 22350 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:2.42 (1.7%) stddev-sans-first:2.55 17:28:11 INFO - PROCESS | 22350 | Values: 146.0 145.0 146.0 145.0 146.0 147.0 145.0 145.0 147.0 153.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:28:11 INFO - PROCESS | 22350 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.00 stddev:5.83 (10.2%) stddev-sans-first:6.11 17:28:11 INFO - PROCESS | 22350 | Values: 56.0 57.0 57.0 57.0 57.0 58.0 58.0 75.0 56.0 55.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 17:28:11 INFO - PROCESS | 22350 | Values: 59.0 60.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.12 (2.7%) stddev-sans-first:2.18 17:28:11 INFO - PROCESS | 22350 | Values: 78.0 79.0 79.0 78.0 79.0 79.0 85.0 81.0 79.0 78.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:123.50 stddev:23.87 (19.3%) stddev-sans-first:25.11 17:28:11 INFO - PROCESS | 22350 | Values: 123.0 123.0 122.0 130.0 130.0 123.0 120.0 123.0 199.0 124.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.50 stddev:2.35 (1.4%) stddev-sans-first:1.94 17:28:11 INFO - PROCESS | 22350 | Values: 171.0 164.0 167.0 168.0 168.0 166.0 164.0 169.0 164.0 167.0 17:28:11 INFO - PROCESS | 22350 | 17:28:11 INFO - PROCESS | 22350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:63.00 stddev:2.98 (4.7%) stddev-sans-first:2.55 17:28:11 INFO - PROCESS | 22350 | Values: 69.0 70.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 61.0 17:28:11 INFO - PROCESS | 22350 | -------- Summary: end -------- 17:28:11 INFO - PROCESS | 22350 | 17:28:12 INFO - TEST-INFO | 22350: exit 0 17:28:12 INFO - TEST-OK | kraken | took 60946ms 17:28:12 INFO - SUITE-END | took 1173s 17:28:12 INFO - Completed test suite (00:19:33) 17:28:12 INFO - javascript benchmark 17:28:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.2880837407397, 3108.891188808391, 3131.5459258407523, 3146.1977195815093, 3173.7302329302006, 5253.264542963979, 5266.868328291795, 5292.603054770898, 5365.382980957191, 5393.973030134849, 5329.413764485904, 5341.412444631087, 5349.983503134402, 5373.382061062979, 5427.48438898305, 4795.688280261789, 4805.543473370024, 4914.557689807916, 4966.130927087764, 5025.798968041274, 4925.33507976424, 4934.40787105546, 4960.181570040939, 4988.42633097193, 4991.925121123186, 4737.644676649248, 4774.594159496447, 4797.520247975192, 4817.51824817519, 4843.273508973647, 4849.515048495157, 4852.951470485285, 4863.221884498464, 4903.950960490385, 4917.7786999585105, 4826.855194344175, 4858.076965376567, 4868.221084626478, 4873.244647079709, 4902.975485122587, 5139.023585518739, 5231.110711179109, 5273.446288139767, 5295.814646487393, 5307.681539107666, 5802.274715660543, 5841.795537156222, 5851.151583020481, 5859.589828711992, 5859.7656093756195, 5823.4467725566, 5848.093545500455, 5887.5584331174905, 5903.380145084747, 5906.0, 5236.947630523684, 5314.043472175007, 5358.062339090644, 5358.330208723948, 5427.914417116593, 5904.675242861684, 5912.024515954905, 5914.822555323261, 5917.023691091008, 5924.496417804448, 5522.282103326542, 5680.914786278209, 5691.743871525791, 5692.57305702074, 5694.886102277931, 5633.155026746021, 5702.914456283159, 5705.22979397776, 5712.971435142881, 5741.655500669973, 5716.514096301861, 5719.771209151588, 5720.628159169641, 5721.456461636138, 5722.942770572325, 5551.916721249185, 5580.86047848807, 5679.4320567943705, 5721.828345149652, 5742.0, 4267.8292868284925, 4277.251480990814, 4279.529251782302, 4311.48262208537, 4319.9784001080425, 3812.961870381316, 3819.541655001362, 3825.311443940062, 3858.2862170498547, 3862.092408284051, 5264.710440925785, 5340.519353258148, 5342.839714808562, 5372.5970552207955, 5377.569794416438, 5733.512651424676, 5769.68266745333, 5782.913256301074, 5784.71076446176, 5842.532597392198, 5374.978754036721, 5376.220448035013, 5384.003959267548, 5388.299521062315, 5396.163594642837, 4664.346991421204, 4688.296755486636, 4734.218853889139, 4783.904321913542, 4835.347228124158, 5885.26434195717, 5911.881762364728, 5914.378990206053, 5914.556408269397, 5949.881002380015, 5718.628289161191, 5728.0, 5730.770769169187, 5735.627184233012, 5736.311642602915, 5730.283714535683, 5881.235439392852, 5884.7940322088525, 5909.172715819703, 5948.196993405835, 5707.0, 5710.914336285042, 5711.114777209539, 5712.228849105318, 5720.027595308724, 5769.8557536061935, 5771.884562308815, 5796.971015144897, 5818.44724751148, 5829.6793676346515, 5376.462353764592, 5473.945260547343, 5492.423295554069, 5538.224648549287, 5599.132134519156, 5576.944230557642, 5581.972090139523, 5586.664800112007, 5588.720563971704, 5599.748011339418, 5269.657472264291, 5479.205515200353, 5479.890402192013, 5484.424135465878, 5532.6680399176175, 5556.361018482765, 5614.6069775116985, 5635.774569017193, 5659.575531835211, 5713.571482138773, 5540.335159780852, 5546.389897111395, 5552.361478430033, 5559.583031272751, 5591.384947655836], "value": 5269.053559104986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.5784095735378, 629.0972454527756, 660.6696651674163, 660.8083655739836, 666.9866602667945, 29882.701172988265, 42282.0, 42661.14677706448, 42682.57317426825, 47347.763261183645, 44013.77993110038, 44327.77836110823, 44442.555574444246, 44459.0, 44546.0, 8801.07588703185, 8940.597673104727, 8943.284537237038, 8944.597493112826, 8945.373823832335, 8786.780330491756, 8880.467171969702, 8901.287896968259, 8909.465432074096, 8911.242544383735, 8929.374943753939, 8951.776205594848, 8968.551572421386, 8974.41666291689, 8975.95512022439, 8857.911420885774, 8884.244839188677, 8884.600192991331, 8901.421407608485, 8904.154105360012, 8727.301815854717, 8784.077671844429, 8785.42894711848, 8785.648574057093, 8789.25291350236, 40569.0, 40807.7959610203, 40854.79572602118, 40990.38514422286, 41000.17999639991, 3584.8566057357675, 3750.8124593770476, 3763.7741735495956, 4128.525219599755, 4140.0, 32087.358252835045, 32187.51718724221, 32336.514952275735, 33089.0, 33265.0, 4189.874303770892, 4227.196832601827, 4241.87274381769, 4381.474223093217, 4428.800703968297, 293509.0, 293728.0, 294487.52756236296, 294996.0, 296037.0, 57152.714236428554, 57207.71396142992, 57637.423625764044, 57986.7100664494, 58056.709716451995, 54683.45316546863, 60421.0, 60618.0, 60677.39322606806, 62160.378396216365, 15499.612509687347, 16485.423010194587, 16513.422030229125, 16522.83477165237, 16528.6694266114, 12633.305168215653, 12708.903030999967, 12772.552960646519, 12787.488500460064, 12794.296313702649, 16117.435889743803, 17014.744778828328, 17458.127093645522, 17612.471625851245, 17717.29130834778, 6582.045603387482, 6753.534959739758, 6890.483213758988, 6906.585604863624, 6968.721251149897, 981.5386768218925, 1018.4449475036123, 1048.5438834107188, 1060.3743791163251, 1236.1779416687982, 31875.52186717201, 32540.186495337333, 32620.673793261765, 32672.836635816668, 33246.66753332484, 1133.2973556395089, 1148.2077366617007, 1161.4726634475637, 1176.65876895701, 1179.1215544419463, 17068.2319295632, 17211.741823872653, 17251.3962011329, 17275.0, 17372.0, 444954.0, 447368.0, 448361.0, 448513.0, 448974.0, 55592.0, 56632.433675662716, 56675.99999999918, 56727.0, 56883.14675279874, 1300.674831292177, 1378.4555100735154, 1398.825146856643, 1415.946877028313, 1423.1247782613618, 32115.19712007125, 33742.650293987965, 33812.323753525285, 33882.32235355328, 34162.31675366528, 48147.5185248143, 48578.75710621566, 48663.0, 48687.513124868296, 48725.26912096392, 336509.0, 337832.0, 338064.0, 338706.0, 339732.0, 40014.599854001084, 40875.18249634931, 41602.0, 41660.16679666329, 41673.0, 45993.77003114963, 46198.53801462077, 46550.30174547317, 47163.80933505076, 47415.28877066778, 39961.0, 40139.197216054934, 40672.79663601663, 40876.79561602292, 40911.0, 40437.59562404338, 40504.59495405008, 40585.0, 41007.38488922728, 41149.588504114574, 40071.39892901667, 40526.79736601298, 41343.96640084022, 41780.791096044326, 41808.58191418047, 35518.289634207686, 35923.281534369686, 36299.63700362963, 36758.44862327121, 36855.44716829196, 28091.859540702164, 28304.292392690346, 28440.85779571089, 28468.288292792848, 28479.857600711865], "value": 19963.20390768405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.53055160186784, 402.27188788293194, 402.3240955195272, 404.6378491250333, 416.58420740154367, 17703.203355848986, 19302.420927372164, 19426.708599371002, 19431.125599348026, 20465.283715069938, 19080.522986925334, 19553.51116222095, 19568.510787230327, 19599.314024009163, 19676.311329103486, 5459.535939445152, 5548.44515548445, 5693.259876216107, 5702.971485142589, 5710.600257981943, 5677.801276955307, 5682.119271512902, 5690.9146362804595, 5712.857178570527, 5714.77140914365, 5411.675299482024, 5600.467955544237, 5600.6079574429805, 5607.691576963265, 5611.298587676541, 5414.566834653218, 5459.645123066988, 5482.451754824526, 5513.7794488220425, 5523.834284971457, 4907.4356449008465, 5035.370578677665, 5051.191809310492, 5054.368203974504, 5064.746762661852, 22733.204337848263, 22764.203252886236, 22878.0, 23397.41506462335, 23446.413839653975, 2375.5367703297866, 2483.4908843687, 2622.409957759508, 2656.0836511403536, 2735.179446166142, 14060.156390616596, 14210.786838197435, 14217.857821421756, 14326.713465730627, 14521.300504419896, 1975.7332760077493, 2004.7393838801008, 2056.969145462819, 2064.576761763835, 2091.8326533877253, 76988.0, 78862.0, 78936.99999999943, 79287.60356198181, 79733.60133199296, 10570.735731606617, 10766.654168228972, 11216.887831121585, 11336.238779712541, 11470.38869822005, 15985.360585576447, 16005.279762410719, 16094.356225751073, 16104.19479026044, 16126.596835078983, 7766.184550622216, 7892.763217103496, 7932.246436588515, 8012.0, 8145.796355091052, 7548.508992032616, 7576.5832879191075, 7668.1181664109345, 7761.0, 7816.140224575406, 4846.200376937836, 4861.052094841542, 4863.975680121647, 4875.95124048762, 4936.851894443173, 1948.3959972408315, 1960.5784756277183, 1988.0, 2041.795820417976, 2050.8872012039483, 460.6084827896261, 463.82606522554045, 470.3744020452858, 901.963921443135, 1006.335818359879, 11384.943075284737, 12025.879741202476, 12030.578929737418, 12116.21244619097, 12238.449269782881, 473.9313046962701, 486.3361511536727, 488.25541049899186, 488.7043338779987, 496.7119070938847, 6467.223933127961, 6482.189726284215, 6498.285188629247, 6537.738490460423, 6549.181352330958, 358746.0, 361662.0, 363278.0, 470133.0, 488229.0, 97586.51206743921, 103154.0, 103514.0, 104714.4764276189, 105661.47169264258, 1115.141341167313, 1124.3310230412892, 1129.8531190945125, 1133.5805751871696, 1138.8177891537148, 17251.0, 17310.65378692394, 17868.910655446638, 17886.910565447088, 18118.81881181224, 37206.0, 38662.613373865905, 40520.0, 41331.586684133974, 43350.0, 53271.46728532665, 57229.713851430475, 57380.426195737506, 57839.710801445726, 58041.419585803604, 7549.245075492627, 7871.763847084597, 8508.957455212685, 8622.137786221328, 9090.318226133199, 13078.346082696018, 13406.597802065953, 13572.1856688599, 13646.522371716943, 13843.86156138466, 10906.018458338787, 11561.653150405502, 11737.35444550558, 12074.818877716665, 12089.516419343128, 10109.949450252701, 11278.774424511628, 12142.817857732318, 12182.512699491921, 12201.572944946884, 10864.239503234698, 11219.439028048402, 11494.252873563191, 11792.646220613395, 11907.404629768303, 7790.337821285254, 7817.570033647977, 7989.600519973862, 8025.398095143005, 8116.715914942949, 9396.248300135836, 10591.311564748266, 10638.308509946828, 10651.946740266249, 10897.78204435891], "value": 8728.536180569099, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.8301003879535, 1517.3778750712204, 1549.2563569486647, 1703.6507515959229, 1844.723291506273, 7659.234076592338, 7967.083785364692, 7975.760727178186, 8188.467749596272, 8193.918060819406, 7921.049474063106, 8078.71724489643, 8086.47437916535, 8093.028836539609, 8100.189981001897, 1865.291189348046, 2163.891805409731, 2217.756046834851, 2227.7438094619165, 2246.5731511012855, 2110.1981247126146, 2121.469632591852, 2123.5540536487356, 2125.2455378340696, 2129.2015494189677, 2146.0771868096713, 2154.429076294783, 2156.0, 2168.9240876569324, 2171.3703026122407, 1855.2578968412608, 2087.6242276390244, 2171.337741988693, 2173.3697227803996, 2181.334692918659, 2038.052305677852, 2058.464799152216, 2063.7007633893, 2065.308121779206, 2095.203822547422, 8040.195980401913, 8095.392845536609, 8099.352051835839, 8100.959495202486, 8108.959455202746, 4622.9075418491775, 4746.406699162605, 4781.402324709411, 4781.8087276508895, 4786.760661966888, 3005.143534092795, 3034.499307614241, 3089.629244490653, 3098.6746391629003, 3121.1416860363356, 1043.6190790361538, 1044.0499145777305, 1051.2588625019343, 1052.1162223732026, 1076.3488089705693, 10381.948090259575, 10639.734006649818, 10690.625828096057, 11007.559697612165, 11263.718407039807, 4051.513818341818, 4098.877033688994, 4158.0, 4190.1200747843295, 4198.85304014358, 8873.866891996626, 8940.284777217807, 8944.686935957341, 8950.597223124974, 8975.147361000694, 4318.848840290575, 4725.125851717443, 4738.739369334719, 4770.737609431515, 4777.402824646919, 4338.197433474754, 4437.667174961826, 4451.799669014902, 4477.753723545171, 4495.685302028826, 3531.4526248431534, 3565.3404120237838, 3611.909702257412, 3620.3845346291196, 3676.669099780979, 1063.1176123817213, 1090.5831382899225, 1096.1888202729922, 1098.5990113608475, 1109.6837401340579, 973.2603221551531, 977.1205914676848, 983.5426526665135, 986.0730912941812, 1004.4324956399611, 5408.756605952742, 5457.890842183214, 5589.413111623302, 5604.047311956977, 5652.349979752381, 455.6423207781875, 461.91916414627303, 476.4235275316836, 478.8252287914956, 478.9928151077667, 3753.9061523462133, 3820.255050265227, 3822.3310920588788, 3864.574896761354, 3864.9227015459533, 10063.345882517613, 10368.637097701545, 10563.788724225473, 10568.630097946689, 10585.0, 10163.4918254087, 10354.585816567404, 10386.37681739083, 10512.894871051192, 10518.842217366746, 7488.663010164556, 7588.468807183554, 7632.732854350183, 7652.0, 7849.568273745113, 5504.22940788298, 5542.224088627515, 5622.437756224344, 5622.746976385991, 5797.4782269595935, 9218.124278193562, 9247.289251488497, 9255.814883702153, 9340.439573625605, 9371.625134994523, 8710.651573936972, 9376.437413755197, 9423.764405889908, 9469.242460603273, 9533.427994320364, 6685.197776266879, 6815.488838337045, 6868.690908909211, 6870.31296870309, 7172.0676312079095, 7483.738069167553, 7650.502717323357, 7856.25365590268, 7895.171007044408, 8096.87854682192, 6981.790546283416, 7114.715411383694, 7199.280071992759, 7221.205667376689, 7236.276372362932, 7241.565506069653, 7293.197748247795, 7307.1231452226075, 7317.304856038668, 7333.266673332624, 6620.3710647488415, 6672.466202703869, 6696.1629796275465, 6698.7320507179165, 6699.497537684791, 4807.158747219153, 4856.077345304381, 4879.414470263449, 4938.407391113089, 4968.975155124202, 4958.256261560795, 5004.77478513475, 5009.849704508871, 5047.419546752024, 5077.5684066853255], "value": 4219.276205106925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.41803544602, 324.9642539320675, 333.28842920365014, 333.36826713378156, 335.34272825262485, 5205.0, 5223.268742376061, 5264.0, 5273.6308458407975, 5295.179247216678, 5169.767360468779, 5173.974130129344, 5199.532042116209, 5238.476152384759, 5239.659422137558, 3893.6885049196, 3924.2543916655886, 4088.1823635272917, 4103.938440923389, 4116.814743336557, 3998.3802510610903, 4068.9796551017203, 4090.365993271048, 4106.630403263705, 4117.8970525736795, 3894.805259737016, 4041.3937909313545, 4056.472658554384, 4070.328395814687, 4094.6928980326447, 3995.3407687731487, 4077.7553346799286, 4085.121698834735, 4102.343625020012, 4128.422020917059, 3596.6942809861193, 3623.981880090609, 3628.4738712886483, 3629.0947252692285, 3632.981835090834, 4942.802287908479, 4961.603071754251, 4987.276844857512, 5006.123928312531, 5020.246962955586, 4523.253663145577, 4611.432113081569, 4622.1911165546235, 4639.489656137822, 4647.930281045787, 5375.865603359947, 5412.783488660449, 5413.968177820433, 5419.268398766156, 5425.240466334716, 3932.1742434088874, 3940.089056807446, 3942.48747662802, 3954.920901581981, 3966.226585815767, 5431.185322201662, 5703.629264097862, 5712.600117991742, 5734.222391058785, 5743.62666426681, 3938.03518138058, 3965.6232657897453, 4030.6775457963295, 4040.7979601019833, 4064.552899181088, 4061.472008638858, 4064.532578753481, 4098.836046558164, 4103.420183229418, 4104.748051844216, 4373.278409062469, 4643.605293550086, 4664.137134630104, 4693.413323334583, 4698.929516057262, 5506.504414602705, 5529.682190685557, 5532.502074813206, 5534.335879694462, 5550.16747487872, 1378.5106287268077, 1382.7165431086603, 1383.7509248335195, 1387.653086728318, 1389.2775756606509, 912.2565109435789, 961.8220629183623, 978.6819283732673, 1000.4147573669485, 1001.5827603940488, 5080.49195080489, 5100.56645185156, 5115.462876397999, 5200.271961925334, 5204.947950520446, 5419.34967803866, 5437.619366644376, 5501.752421141058, 5524.674078221198, 5531.280933478622, 4990.201567749215, 5071.898562028812, 5114.491225088608, 5147.897042059213, 5166.560842328369, 2858.3997360554517, 2879.611252480888, 2883.6972117927735, 2888.465633857743, 2888.638920134983, 5347.8395648129845, 5583.637063590853, 5585.58108141891, 5586.357568879631, 5619.061423808861, 5505.348395481339, 5512.2558454608115, 5517.5585953123655, 5530.5852061095575, 5609.803656872072, 5609.887802243932, 5633.887322253532, 5648.519875810438, 5652.180433837153, 5678.346990096109, 5325.653832500875, 5477.945220547744, 5479.452054794648, 5490.5607551395, 5498.140966697215, 5409.540189083972, 5436.483534064258, 5438.782448702166, 5452.400235974119, 5462.726863656881, 5495.945040549704, 5543.2538750293525, 5575.832725018256, 5596.377050655265, 5603.0, 3744.400895856759, 4016.8393264269102, 4030.858919937788, 4040.91918161641, 4053.6959728021106, 5614.63504872182, 5669.092945128759, 5672.574556908331, 5681.2330335404195, 5682.403347648603, 5511.2994632630525, 5546.667199968015, 5548.944510554843, 5553.694546799965, 5555.3611334697025, 5283.784729512156, 5528.806491772769, 5529.0, 5529.198266251291, 5544.695041772741, 5179.30079439286, 5220.504052115043, 5390.460953904578, 5423.403425623257, 5424.620276580601, 5531.446855314436, 5540.168974653834, 5554.805716770752, 5560.91658625129, 5563.0, 5335.413104558573, 5346.893062138658, 5371.462853714597, 5372.489613486712, 5396.64921780083], "value": 4149.719353572891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7706710919615, 806.3388021822108, 832.9541875196862, 855.9529225892574, 856.4304737349664, 15026.624334391632, 15454.1500217488, 15457.30442130104, 15479.613009674764, 15495.83781216409, 14747.852521474782, 14805.333759980827, 14825.110493370405, 14835.92582037091, 14907.552773416788, 683.3508167241116, 797.6450479536609, 836.803351212466, 843.1147295339899, 843.5487014447272, 838.0, 843.6667516331046, 843.7342237195264, 844.0968164064423, 844.586152785137, 855.56366253211, 863.5552690364467, 866.7183165471215, 867.0549101479386, 867.9696210632629, 708.4084789201023, 827.0530242871878, 849.6346570974479, 850.196564246784, 858.7466697324304, 616.8951278282702, 619.7118339971935, 620.8758248350348, 621.5245337316957, 621.6052806467925, 11795.115366347558, 11844.111691623162, 11847.94076029623, 11850.407479625985, 11868.0, 11429.0, 11621.767564648744, 11829.467673954692, 11953.22304050234, 12233.632991010283, 11197.384143872085, 11228.270162439416, 12427.316497592628, 12598.433070511757, 12647.241165530098, 4477.686561940665, 4503.099380123988, 4621.792019359137, 4653.906921861578, 4758.666893317469, 53503.73248133734, 53777.0, 54888.72555637236, 55009.724951375385, 56086.71956640232, 10632.94683526593, 10719.410432426292, 10752.139828813677, 11513.0, 11675.532978680927, 20370.592588148153, 20624.27815026467, 20640.174393024412, 20655.0, 20664.380068597966, 8635.395522313504, 8796.648134074694, 8835.779105522284, 8900.910990890137, 9092.81814363709, 4859.246816743411, 4868.245421959602, 4874.488178741181, 4917.0, 4960.776765045582, 3345.8661653534073, 3437.724982001434, 3441.105312618737, 3442.294329662413, 3447.0865220716532, 550.9724513774376, 633.0693879996398, 647.3009150117862, 650.2814390098968, 668.2281964331205, 654.2606854254661, 728.1880703016099, 748.4723270094679, 780.5199802121655, 791.4934441957153, 8787.5166865823, 9077.137671921157, 9145.451272923512, 9170.44977301364, 9195.080491950885, 633.5311869216838, 668.7391917152314, 750.5009168902618, 756.2173150789017, 783.5572901310741, 4347.6304514116655, 4429.712068715523, 4634.397528321297, 4647.814087436533, 4726.314684370747, 68534.65732671304, 70195.64902175457, 72720.0, 73075.0, 73145.6342718283, 61011.08483372753, 61245.0, 61761.38238617646, 63656.36343636597, 64913.0, 55532.889342212926, 55727.164092538645, 55838.0, 55846.44153558413, 56120.719396402754, 8515.616797244264, 8587.742367728979, 8624.78438039054, 8695.565221739014, 8784.912150878665, 35232.64767352294, 35821.46267805933, 36391.0, 36441.81779091088, 36444.81777591201, 46490.53509464862, 49932.0, 50275.74862125666, 50427.243591345425, 51052.0, 11407.372594507382, 11423.257488263236, 12116.878831211576, 12243.387830608255, 12534.435950382436, 12023.21849079807, 12116.091293152873, 13034.217946923214, 13315.800262996256, 13650.93174534121, 11403.429828508708, 11457.312561246352, 12008.099392545419, 12306.630801075982, 12593.055520836157, 11050.778984420105, 11086.334819910831, 11432.657020289405, 11518.193726439069, 11560.13299002595, 11033.0, 11036.337819730841, 11206.551737930718, 11322.773544529227, 11991.400429978641, 9610.346840710623, 10015.499225038573, 10040.046195611405, 10152.39085654863, 10223.95520895809, 9740.0, 9899.208063355058, 9939.403635781877, 9941.0, 10116.797664046826], "value": 6812.100184182275, "unit": "score"}], "name": "dromaeo_css", "value": 6916.957175573195, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 152.0, 186.0, 129.0, 165.0, 150.0, 126.0, 185.0, 128.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 160.0, 160.0, 163.0, 160.0, 159.0, 161.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 122.0, 77.0, 75.0, 75.0, 74.0, 149.0, 75.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 117.0, 91.0, 92.0, 92.0, 128.0, 91.0, 91.0, 121.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 145.0, 145.0, 147.0, 153.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 57.0, 58.0, 58.0, 75.0, 56.0, 55.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 78.0, 79.0, 79.0, 85.0, 81.0, 79.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 122.0, 130.0, 130.0, 123.0, 120.0, 123.0, 199.0, 124.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 167.0, 168.0, 168.0, 166.0, 164.0, 169.0, 164.0, 167.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 61.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1526.9, "alertThreshold": 2.0}]} 17:28:12 INFO - Return code: 0 17:28:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:28:12 ERROR - # TBPL SUCCESS # 17:28:12 INFO - Running post-action listener: _resource_record_post_action 17:28:12 INFO - ##### 17:28:12 INFO - ##### Finished run-tests step (success) 17:28:12 INFO - ##### 17:28:12 INFO - Running post-run listener: _resource_record_post_run 17:28:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536821760; Read time: 12; Write time: 367620 17:28:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244785152; Read time: 0; Write time: 185184 17:28:14 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292036608; Read time: 12; Write time: 182436 17:28:14 INFO - Running post-run listener: _upload_blobber_files 17:28:14 INFO - Blob upload gear active. 17:28:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:28:14 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 17:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:28:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:28:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:28:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:15 INFO - (blobuploader) - INFO - Done attempting. 17:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:16 INFO - (blobuploader) - INFO - Done attempting. 17:28:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:16 INFO - Return code: 0 17:28:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8d78595c2e3ba26a9bc346470f72cb1a906b66a44c40820375cf82143586315b36c342b798439bf6566a18b6b392fb54d3038c08f79f7ff5a4a6c71f0a02901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89c88b493c3206f3c17da929fcd8e78b4ca1d6f2b3c4d7f3865e363af12aad69bd4fa8ad26ed6caee5ce9c12bd2ee690cd53b46747d3a10e46b0e92871dcaf13"} 17:28:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:16 INFO - Contents: 17:28:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8d78595c2e3ba26a9bc346470f72cb1a906b66a44c40820375cf82143586315b36c342b798439bf6566a18b6b392fb54d3038c08f79f7ff5a4a6c71f0a02901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89c88b493c3206f3c17da929fcd8e78b4ca1d6f2b3c4d7f3865e363af12aad69bd4fa8ad26ed6caee5ce9c12bd2ee690cd53b46747d3a10e46b0e92871dcaf13"} 17:28:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:16 INFO - Copying logs to upload dir... 17:28:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.242300 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-07 17:28:15.916668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 17:28:15.919879) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010 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/sha512/e8d78595c2e3ba26a9bc346470f72cb1a906b66a44c40820375cf82143586315b36c342b798439bf6566a18b6b392fb54d3038c08f79f7ff5a4a6c71f0a02901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89c88b493c3206f3c17da929fcd8e78b4ca1d6f2b3c4d7f3865e363af12aad69bd4fa8ad26ed6caee5ce9c12bd2ee690cd53b46747d3a10e46b0e92871dcaf13"} build_url:https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010962 build_url: 'https://queue.taskcluster.net/v1/task/Lv08ntNcRseD0fjW5bjuGA/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/sha512/e8d78595c2e3ba26a9bc346470f72cb1a906b66a44c40820375cf82143586315b36c342b798439bf6566a18b6b392fb54d3038c08f79f7ff5a4a6c71f0a02901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89c88b493c3206f3c17da929fcd8e78b4ca1d6f2b3c4d7f3865e363af12aad69bd4fa8ad26ed6caee5ce9c12bd2ee690cd53b46747d3a10e46b0e92871dcaf13"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 17:28:15.945285) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 17:28:15.945929) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1462656341.72869-1353052010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 17:28:16.030171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 17:28:16.030980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 17:28:16.031682) ========= ========= Total master_lag: 0.20 =========