builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1462872971.32 results: success (0) buildid: 20160510020804 builduid: 64befc246da6415a9dd45bab51ba0d11 revision: b041ad17b6c87ddf64db984292e95a777fb9959f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:11.321532) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:11.322619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:11.323350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:11.339417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:11.340142) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 02:36:11-- 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% 220M=0s 2016-05-10 02:36:11 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:11.469913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:11.470267) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019421 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:11.519569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 02:36:11.519971) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b041ad17b6c87ddf64db984292e95a777fb9959f --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 b041ad17b6c87ddf64db984292e95a777fb9959f --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=a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 02:36:11,861 truncating revision to first 12 chars 2016-05-10 02:36:11,861 Setting DEBUG logging. 2016-05-10 02:36:11,862 attempt 1/10 2016-05-10 02:36:11,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b041ad17b6c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 02:36:13,145 unpacking tar archive at: fx-team-b041ad17b6c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.554367 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 02:36:13.087534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:13.087955) ========= script_repo_revision: b041ad17b6c87ddf64db984292e95a777fb9959f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:13.088368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:13.088670) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 02:36:13.099009) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-10 02:36:13.099318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:36:13 INFO - MultiFileLogger online at 20160510 02:36:13 in /builds/slave/test 02:36:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:36:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:36:13 INFO - {'append_to_log': False, 02:36:13 INFO - 'base_work_dir': '/builds/slave/test', 02:36:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:36:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:36:13 INFO - 'branch': 'Fx-Team-Non-PGO', 02:36:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:36:13 INFO - 'config_files': ('talos/linux_config.py',), 02:36:13 INFO - 'default_actions': ('clobber', 02:36:13 INFO - 'read-buildbot-config', 02:36:13 INFO - 'download-and-extract', 02:36:13 INFO - 'populate-webroot', 02:36:13 INFO - 'create-virtualenv', 02:36:13 INFO - 'install', 02:36:13 INFO - 'run-tests'), 02:36:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:36:13 INFO - 'download_minidump_stackwalk': True, 02:36:13 INFO - 'download_symbols': 'ondemand', 02:36:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:36:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:36:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:36:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:36:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:36:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:36:13 INFO - 'installer_path': 'installer.exe', 02:36:13 INFO - 'log_level': 'info', 02:36:13 INFO - 'log_name': 'talos', 02:36:13 INFO - 'log_to_console': True, 02:36:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:36:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:36:13 INFO - 'opt_config_files': (), 02:36:13 INFO - 'pip_index': False, 02:36:13 INFO - 'sps_profile': False, 02:36:13 INFO - 'sps_profile_interval': 0, 02:36:13 INFO - 'suite': 'dromaeojs', 02:36:13 INFO - 'system_bits': '32', 02:36:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:36:13 INFO - 'title': 'talos-linux64-ix-002', 02:36:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:36:13 INFO - 'use_talos_json': True, 02:36:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:36:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:36:13 INFO - 'work_dir': 'build'} 02:36:13 INFO - ##### 02:36:13 INFO - ##### Running clobber step. 02:36:13 INFO - ##### 02:36:13 INFO - Running pre-action listener: _resource_record_pre_action 02:36:13 INFO - Running main action method: clobber 02:36:13 INFO - rmtree: /builds/slave/test/build 02:36:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:36:14 INFO - Running post-action listener: _resource_record_post_action 02:36:14 INFO - ##### 02:36:14 INFO - ##### Finished clobber step (success) 02:36:14 INFO - ##### 02:36:14 INFO - ##### 02:36:14 INFO - ##### Running read-buildbot-config step. 02:36:14 INFO - ##### 02:36:14 INFO - Running pre-action listener: _resource_record_pre_action 02:36:14 INFO - Running main action method: read_buildbot_config 02:36:14 INFO - Using buildbot properties: 02:36:14 INFO - { 02:36:14 INFO - "project": "", 02:36:14 INFO - "product": "firefox", 02:36:14 INFO - "script_repo_revision": "production", 02:36:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:36:14 INFO - "repository": "", 02:36:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:36:14 INFO - "buildid": "20160510020804", 02:36:14 INFO - "pgo_build": "False", 02:36:14 INFO - "basedir": "/builds/slave/test", 02:36:14 INFO - "buildnumber": 2945, 02:36:14 INFO - "slavename": "talos-linux64-ix-002", 02:36:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:36:14 INFO - "platform": "ubuntu64_hw", 02:36:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:36:14 INFO - "branch": "fx-team", 02:36:14 INFO - "repo_path": "integration/fx-team", 02:36:14 INFO - "revision": "b041ad17b6c87ddf64db984292e95a777fb9959f", 02:36:14 INFO - "stage_platform": "linux64", 02:36:14 INFO - "builduid": "64befc246da6415a9dd45bab51ba0d11", 02:36:14 INFO - "slavebuilddir": "test" 02:36:14 INFO - } 02:36:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:36:14 INFO - Running post-action listener: _resource_record_post_action 02:36:14 INFO - ##### 02:36:14 INFO - ##### Finished read-buildbot-config step (success) 02:36:14 INFO - ##### 02:36:14 INFO - ##### 02:36:14 INFO - ##### Running download-and-extract step. 02:36:14 INFO - ##### 02:36:14 INFO - Running pre-action listener: _resource_record_pre_action 02:36:14 INFO - Running main action method: download_and_extract 02:36:14 INFO - mkdir: /builds/slave/test/build/tests 02:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:14 INFO - https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:36:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:36:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:36:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:15 INFO - Downloaded 1361 bytes. 02:36:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:36:15 INFO - Using the following test package requirements: 02:36:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:36:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:36:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:36:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:15 INFO - u'jsshell-linux-x86_64.zip'], 02:36:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:36:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:36:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:36:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:36:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:36:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:36:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:36: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')]} 02:36:15 INFO - https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:36:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:36:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:36:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:16 INFO - Downloaded 22323319 bytes. 02:36:16 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'] 02:36:16 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 02:36:17 INFO - Return code: 0 02:36:17 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 02:36: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')]} 02:36:17 INFO - https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:36:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:36:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:36:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:18 INFO - Downloaded 22323319 bytes. 02:36:18 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'] 02:36:18 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 02:36:19 INFO - Return code: 0 02:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:19 INFO - https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:36:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:36:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:36:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:20 INFO - Downloaded 10840152 bytes. 02:36:20 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'] 02:36:20 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 02:36:21 INFO - Return code: 0 02:36:21 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')]} 02:36:21 INFO - https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:36:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:36:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:36:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Di-Itjb9TN-ZphtdxJiiTA/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 02:36:23 INFO - Downloaded 54859270 bytes. 02:36:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:36:23 INFO - mkdir: /builds/slave/test/properties 02:36:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:36:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:36:23 INFO - Contents: 02:36:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:36:23 INFO - Running post-action listener: _resource_record_post_action 02:36:23 INFO - Running post-action listener: set_extra_try_arguments 02:36:23 INFO - ##### 02:36:23 INFO - ##### Finished download-and-extract step (success) 02:36:23 INFO - ##### 02:36:23 INFO - ##### 02:36:23 INFO - ##### Running populate-webroot step. 02:36:23 INFO - ##### 02:36:23 INFO - Running pre-action listener: _resource_record_pre_action 02:36:23 INFO - Running main action method: populate_webroot 02:36:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:36:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:36:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:36:23 INFO - '--tppagecycles', 02:36:23 INFO - '7'], 02:36:23 INFO - 'tests': ['tsvgm']}}, 02:36:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:36:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:36:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:36:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:36:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:23 INFO - 'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:23 INFO - 'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['damp', 'tps']}, 02:36:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:23 INFO - 'tests': ['damp', 'tps']}, 02:36:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['dromaeo_dom']}, 02:36:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:36:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['a11yr', 02:36:23 INFO - 'ts_paint', 02:36:23 INFO - 'tpaint', 02:36:23 INFO - 'sessionrestore', 02:36:23 INFO - 'sessionrestore_no_auto_restore', 02:36:23 INFO - 'tabpaint']}, 02:36:23 INFO - 'other-e10s': {'tests': ['a11yr', 02:36:23 INFO - 'ts_paint', 02:36:23 INFO - 'tpaint', 02:36:23 INFO - 'sessionrestore', 02:36:23 INFO - 'sessionrestore_no_auto_restore', 02:36:23 INFO - 'tabpaint']}, 02:36:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:36:23 INFO - 'ts_paint', 02:36:23 INFO - 'tpaint', 02:36:23 INFO - 'sessionrestore', 02:36:23 INFO - 'sessionrestore_no_auto_restore', 02:36:23 INFO - 'tabpaint']}, 02:36:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:36:23 INFO - 'ts_paint', 02:36:23 INFO - 'tpaint', 02:36:23 INFO - 'sessionrestore', 02:36:23 INFO - 'sessionrestore_no_auto_restore', 02:36:23 INFO - 'tabpaint']}, 02:36:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['a11yr', 02:36:23 INFO - 'ts_paint', 02:36:23 INFO - 'tpaint', 02:36:23 INFO - 'sessionrestore', 02:36:23 INFO - 'sessionrestore_no_auto_restore', 02:36:23 INFO - 'tabpaint']}, 02:36:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['a11yr', 02:36:23 INFO - 'ts_paint', 02:36:23 INFO - 'tpaint', 02:36:23 INFO - 'sessionrestore', 02:36:23 INFO - 'sessionrestore_no_auto_restore', 02:36:23 INFO - 'tabpaint']}, 02:36:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['tsvgx', 02:36:23 INFO - 'tsvgr_opacity', 02:36:23 INFO - 'tart', 02:36:23 INFO - 'tscrollx', 02:36:23 INFO - 'cart']}, 02:36:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:36:23 INFO - 'tsvgr_opacity', 02:36:23 INFO - 'tart', 02:36:23 INFO - 'tscrollx', 02:36:23 INFO - 'cart']}, 02:36:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:23 INFO - 'talos_options': ['--disable-e10s'], 02:36:23 INFO - 'tests': ['tp5o']}, 02:36:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:23 INFO - 'tests': ['tp5o']}, 02:36:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:23 INFO - 'talos_options': ['--disable-e10s', 02:36:23 INFO - '--xperf_path', 02:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:23 INFO - 'tests': ['tp5n']}, 02:36:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:23 INFO - 'talos_options': ['--xperf_path', 02:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:23 INFO - 'tests': ['tp5n']}}, 02:36:23 INFO - 'talos.zip': {'path': '', 02:36:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:36:23 INFO - Running post-action listener: _resource_record_post_action 02:36:23 INFO - ##### 02:36:23 INFO - ##### Finished populate-webroot step (success) 02:36:23 INFO - ##### 02:36:23 INFO - ##### 02:36:23 INFO - ##### Running create-virtualenv step. 02:36:23 INFO - ##### 02:36:23 INFO - Running pre-action listener: _resource_record_pre_action 02:36:23 INFO - Running main action method: create_virtualenv 02:36:23 INFO - Creating virtualenv /builds/slave/test/build/venv 02:36:23 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 02:36:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:36:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:36:24 INFO - Using real prefix '/usr' 02:36:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:36:24 INFO - Installing distribute.............................................................................................................................................................................................done. 02:36:26 INFO - Installing pip.................done. 02:36:26 INFO - Return code: 0 02:36:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:36:26 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')]} 02:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:26 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')]} 02:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:26 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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:26 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 02:36:26 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 02:36:26 INFO - Using env: {'DISPLAY': ':0', 02:36:26 INFO - 'HOME': '/home/cltbld', 02:36:26 INFO - 'LANG': 'en_US.UTF-8', 02:36:26 INFO - 'LANGUAGE': 'en_US:en', 02:36:26 INFO - 'LOGNAME': 'cltbld', 02:36:26 INFO - 'MAIL': '/var/mail/cltbld', 02:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:26 INFO - 'MOZ_NO_REMOTE': '1', 02:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:26 INFO - 'NO_EM_RESTART': '1', 02:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:26 INFO - 'PWD': '/builds/slave/test', 02:36:26 INFO - 'SHELL': '/bin/bash', 02:36:26 INFO - 'SHLVL': '1', 02:36:26 INFO - 'TERM': 'linux', 02:36:26 INFO - 'TMOUT': '86400', 02:36:26 INFO - 'USER': 'cltbld', 02:36:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:26 INFO - '_': '/tools/buildbot/bin/python'} 02:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:26 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 02:36:26 INFO - Cleaning up... 02:36:26 INFO - Return code: 0 02:36:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:36:26 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')]} 02:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:26 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')]} 02:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:26 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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:26 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 02:36:26 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 02:36:26 INFO - Using env: {'DISPLAY': ':0', 02:36:26 INFO - 'HOME': '/home/cltbld', 02:36:26 INFO - 'LANG': 'en_US.UTF-8', 02:36:26 INFO - 'LANGUAGE': 'en_US:en', 02:36:26 INFO - 'LOGNAME': 'cltbld', 02:36:26 INFO - 'MAIL': '/var/mail/cltbld', 02:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:26 INFO - 'MOZ_NO_REMOTE': '1', 02:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:26 INFO - 'NO_EM_RESTART': '1', 02:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:26 INFO - 'PWD': '/builds/slave/test', 02:36:26 INFO - 'SHELL': '/bin/bash', 02:36:26 INFO - 'SHLVL': '1', 02:36:26 INFO - 'TERM': 'linux', 02:36:26 INFO - 'TMOUT': '86400', 02:36:26 INFO - 'USER': 'cltbld', 02:36:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:26 INFO - '_': '/tools/buildbot/bin/python'} 02:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:26 INFO - Downloading/unpacking psutil>=0.7.1 02:36:26 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 02:36:26 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 02:36:26 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 02:36:26 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 02:36:26 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 02:36:26 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 02:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:36:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:28 INFO - Installing collected packages: psutil 02:36:28 INFO - Running setup.py install for psutil 02:36:28 INFO - building 'psutil._psutil_linux' extension 02:36:28 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 02:36:29 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 02:36:29 INFO - building 'psutil._psutil_posix' extension 02:36:29 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 02:36:29 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 02:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:29 INFO - Successfully installed psutil 02:36:29 INFO - Cleaning up... 02:36:29 INFO - Return code: 0 02:36:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:36:29 INFO - Using env: {'DISPLAY': ':0', 02:36:29 INFO - 'HOME': '/home/cltbld', 02:36:29 INFO - 'LANG': 'en_US.UTF-8', 02:36:29 INFO - 'LANGUAGE': 'en_US:en', 02:36:29 INFO - 'LOGNAME': 'cltbld', 02:36:29 INFO - 'MAIL': '/var/mail/cltbld', 02:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:29 INFO - 'MOZ_NO_REMOTE': '1', 02:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:29 INFO - 'NO_EM_RESTART': '1', 02:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:29 INFO - 'PWD': '/builds/slave/test', 02:36:29 INFO - 'SHELL': '/bin/bash', 02:36:29 INFO - 'SHLVL': '1', 02:36:29 INFO - 'TERM': 'linux', 02:36:29 INFO - 'TMOUT': '86400', 02:36:29 INFO - 'USER': 'cltbld', 02:36:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:29 INFO - '_': '/tools/buildbot/bin/python'} 02:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:36:29 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 02:36:29 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 02:36:29 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 02:36:29 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 02:36:29 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 02:36:29 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 02:36:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:36:31 INFO - Installing collected packages: mozsystemmonitor 02:36:31 INFO - Running setup.py install for mozsystemmonitor 02:36:31 INFO - Successfully installed mozsystemmonitor 02:36:31 INFO - Cleaning up... 02:36:31 INFO - Return code: 0 02:36:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:31 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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:31 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 02:36:31 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 02:36:31 INFO - Using env: {'DISPLAY': ':0', 02:36:31 INFO - 'HOME': '/home/cltbld', 02:36:31 INFO - 'LANG': 'en_US.UTF-8', 02:36:31 INFO - 'LANGUAGE': 'en_US:en', 02:36:31 INFO - 'LOGNAME': 'cltbld', 02:36:31 INFO - 'MAIL': '/var/mail/cltbld', 02:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:31 INFO - 'MOZ_NO_REMOTE': '1', 02:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:31 INFO - 'NO_EM_RESTART': '1', 02:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:31 INFO - 'PWD': '/builds/slave/test', 02:36:31 INFO - 'SHELL': '/bin/bash', 02:36:31 INFO - 'SHLVL': '1', 02:36:31 INFO - 'TERM': 'linux', 02:36:31 INFO - 'TMOUT': '86400', 02:36:31 INFO - 'USER': 'cltbld', 02:36:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:31 INFO - '_': '/tools/buildbot/bin/python'} 02:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:31 INFO - Downloading/unpacking blobuploader==1.2.4 02:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36:34 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 02:36:34 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 02:36:34 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 02:36:34 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 02:36:34 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 02:36:34 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 02:36:34 INFO - Downloading docopt-0.6.1.tar.gz 02:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:34 INFO - Running setup.py install for blobuploader 02:36:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:34 INFO - Running setup.py install for requests 02:36:35 INFO - Running setup.py install for docopt 02:36:35 INFO - Successfully installed blobuploader requests docopt 02:36:35 INFO - Cleaning up... 02:36:35 INFO - Return code: 0 02:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:35 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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:35 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 02:36:35 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 02:36:35 INFO - Using env: {'DISPLAY': ':0', 02:36:35 INFO - 'HOME': '/home/cltbld', 02:36:35 INFO - 'LANG': 'en_US.UTF-8', 02:36:35 INFO - 'LANGUAGE': 'en_US:en', 02:36:35 INFO - 'LOGNAME': 'cltbld', 02:36:35 INFO - 'MAIL': '/var/mail/cltbld', 02:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:35 INFO - 'MOZ_NO_REMOTE': '1', 02:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:35 INFO - 'NO_EM_RESTART': '1', 02:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:35 INFO - 'PWD': '/builds/slave/test', 02:36:35 INFO - 'SHELL': '/bin/bash', 02:36:35 INFO - 'SHLVL': '1', 02:36:35 INFO - 'TERM': 'linux', 02:36:35 INFO - 'TMOUT': '86400', 02:36:35 INFO - 'USER': 'cltbld', 02:36:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:35 INFO - '_': '/tools/buildbot/bin/python'} 02:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:35 INFO - Running setup.py (path:/tmp/pip-r8jcU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:35 INFO - Running setup.py (path:/tmp/pip-N77C1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:35 INFO - Running setup.py (path:/tmp/pip-XQ2n3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:35 INFO - Running setup.py (path:/tmp/pip-Ox9_14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:35 INFO - Running setup.py (path:/tmp/pip-sIE_CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:35 INFO - Running setup.py (path:/tmp/pip-RRxG2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:35 INFO - Running setup.py (path:/tmp/pip-SSoFRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:35 INFO - Running setup.py (path:/tmp/pip-jGkCYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:35 INFO - Running setup.py (path:/tmp/pip-yliu_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:36 INFO - Running setup.py (path:/tmp/pip-I77YuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:36 INFO - Running setup.py (path:/tmp/pip-U9xe8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:36 INFO - Running setup.py (path:/tmp/pip-y5VHb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:36 INFO - Running setup.py (path:/tmp/pip-T6wGmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:36 INFO - Running setup.py (path:/tmp/pip-bItG0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:36 INFO - Running setup.py (path:/tmp/pip-anP8cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:36 INFO - Running setup.py (path:/tmp/pip-jDH7ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:36 INFO - Running setup.py (path:/tmp/pip-6Qr6ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:36 INFO - Running setup.py install for manifestparser 02:36:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:36 INFO - Running setup.py install for mozcrash 02:36:36 INFO - Running setup.py install for mozdebug 02:36:36 INFO - Running setup.py install for mozdevice 02:36:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Running setup.py install for mozfile 02:36:37 INFO - Running setup.py install for mozhttpd 02:36:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Running setup.py install for mozinfo 02:36:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Running setup.py install for mozInstall 02:36:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Running setup.py install for mozleak 02:36:37 INFO - Running setup.py install for mozlog 02:36:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Running setup.py install for moznetwork 02:36:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Running setup.py install for mozprocess 02:36:37 INFO - Running setup.py install for mozprofile 02:36:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:37 INFO - Running setup.py install for mozrunner 02:36:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:38 INFO - Running setup.py install for mozscreenshot 02:36:38 INFO - Running setup.py install for moztest 02:36:38 INFO - Running setup.py install for mozversion 02:36:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:38 INFO - Cleaning up... 02:36:38 INFO - Return code: 0 02:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:38 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')]} 02:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:38 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')]} 02:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:38 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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:38 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 02:36:38 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 02:36:38 INFO - Using env: {'DISPLAY': ':0', 02:36:38 INFO - 'HOME': '/home/cltbld', 02:36:38 INFO - 'LANG': 'en_US.UTF-8', 02:36:38 INFO - 'LANGUAGE': 'en_US:en', 02:36:38 INFO - 'LOGNAME': 'cltbld', 02:36:38 INFO - 'MAIL': '/var/mail/cltbld', 02:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:38 INFO - 'MOZ_NO_REMOTE': '1', 02:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:38 INFO - 'NO_EM_RESTART': '1', 02:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:38 INFO - 'PWD': '/builds/slave/test', 02:36:38 INFO - 'SHELL': '/bin/bash', 02:36:38 INFO - 'SHLVL': '1', 02:36:38 INFO - 'TERM': 'linux', 02:36:38 INFO - 'TMOUT': '86400', 02:36:38 INFO - 'USER': 'cltbld', 02:36:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:38 INFO - '_': '/tools/buildbot/bin/python'} 02:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:38 INFO - Running setup.py (path:/tmp/pip-S_OU8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:38 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)) 02:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:38 INFO - Running setup.py (path:/tmp/pip-4LLrDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:38 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)) 02:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:38 INFO - Running setup.py (path:/tmp/pip-lRojOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:38 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)) 02:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:38 INFO - Running setup.py (path:/tmp/pip-UqwHe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:38 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)) 02:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:38 INFO - Running setup.py (path:/tmp/pip-6eVkmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:39 INFO - Running setup.py (path:/tmp/pip-iRdCvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:39 INFO - Running setup.py (path:/tmp/pip-FMbasa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:39 INFO - Running setup.py (path:/tmp/pip-SOIAox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:39 INFO - Running setup.py (path:/tmp/pip-tyvfW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:39 INFO - Running setup.py (path:/tmp/pip-53Fklh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:39 INFO - Running setup.py (path:/tmp/pip-pfpMlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:39 INFO - Running setup.py (path:/tmp/pip-Emg72a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:39 INFO - Running setup.py (path:/tmp/pip-_uhqP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:39 INFO - Running setup.py (path:/tmp/pip-WA8yJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:39 INFO - Running setup.py (path:/tmp/pip-DQmLUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:39 INFO - Running setup.py (path:/tmp/pip-OlkZqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:39 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)) 02:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:39 INFO - Running setup.py (path:/tmp/pip-A0TRFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:39 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)) 02:36:39 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)) 02:36:39 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)) 02:36:39 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)) 02:36:39 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)) 02:36:39 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)) 02:36:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36:39 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 02:36:39 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 02:36:39 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 02:36:39 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 02:36:39 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 02:36:39 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 02:36:41 INFO - Downloading blessings-1.6.tar.gz 02:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:36:41 INFO - Installing collected packages: blessings 02:36:41 INFO - Running setup.py install for blessings 02:36:41 INFO - Successfully installed blessings 02:36:41 INFO - Cleaning up... 02:36:41 INFO - Return code: 0 02:36:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:36:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:42 INFO - Reading from file tmpfile_stdout 02:36:42 INFO - Current package versions: 02:36:42 INFO - argparse == 1.2.1 02:36:42 INFO - blessings == 1.6 02:36:42 INFO - blobuploader == 1.2.4 02:36:42 INFO - docopt == 0.6.1 02:36:42 INFO - manifestparser == 1.1 02:36:42 INFO - mozInstall == 1.12 02:36:42 INFO - mozcrash == 0.17 02:36:42 INFO - mozdebug == 0.1 02:36:42 INFO - mozdevice == 0.48 02:36:42 INFO - mozfile == 1.2 02:36:42 INFO - mozhttpd == 0.7 02:36:42 INFO - mozinfo == 0.9 02:36:42 INFO - mozleak == 0.1 02:36:42 INFO - mozlog == 3.1 02:36:42 INFO - moznetwork == 0.27 02:36:42 INFO - mozprocess == 0.22 02:36:42 INFO - mozprofile == 0.28 02:36:42 INFO - mozrunner == 6.11 02:36:42 INFO - mozscreenshot == 0.1 02:36:42 INFO - mozsystemmonitor == 0.0 02:36:42 INFO - moztest == 0.7 02:36:42 INFO - mozversion == 1.4 02:36:42 INFO - psutil == 3.1.1 02:36:42 INFO - requests == 1.2.3 02:36:42 INFO - wsgiref == 0.1.2 02:36:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:42 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')]} 02:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:42 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')]} 02:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:42 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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:42 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 02:36:42 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 02:36:42 INFO - Using env: {'DISPLAY': ':0', 02:36:42 INFO - 'HOME': '/home/cltbld', 02:36:42 INFO - 'LANG': 'en_US.UTF-8', 02:36:42 INFO - 'LANGUAGE': 'en_US:en', 02:36:42 INFO - 'LOGNAME': 'cltbld', 02:36:42 INFO - 'MAIL': '/var/mail/cltbld', 02:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:42 INFO - 'MOZ_NO_REMOTE': '1', 02:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:42 INFO - 'NO_EM_RESTART': '1', 02:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:42 INFO - 'PWD': '/builds/slave/test', 02:36:42 INFO - 'SHELL': '/bin/bash', 02:36:42 INFO - 'SHLVL': '1', 02:36:42 INFO - 'TERM': 'linux', 02:36:42 INFO - 'TMOUT': '86400', 02:36:42 INFO - 'USER': 'cltbld', 02:36:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:42 INFO - '_': '/tools/buildbot/bin/python'} 02:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 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)) 02:36:42 INFO - Cleaning up... 02:36:42 INFO - Return code: 0 02:36:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:36:42 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')]} 02:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:42 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')]} 02:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:42 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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:42 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 02:36:42 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 02:36:42 INFO - Using env: {'DISPLAY': ':0', 02:36:42 INFO - 'HOME': '/home/cltbld', 02:36:42 INFO - 'LANG': 'en_US.UTF-8', 02:36:42 INFO - 'LANGUAGE': 'en_US:en', 02:36:42 INFO - 'LOGNAME': 'cltbld', 02:36:42 INFO - 'MAIL': '/var/mail/cltbld', 02:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:42 INFO - 'MOZ_NO_REMOTE': '1', 02:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:42 INFO - 'NO_EM_RESTART': '1', 02:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:42 INFO - 'PWD': '/builds/slave/test', 02:36:42 INFO - 'SHELL': '/bin/bash', 02:36:42 INFO - 'SHLVL': '1', 02:36:42 INFO - 'TERM': 'linux', 02:36:42 INFO - 'TMOUT': '86400', 02:36:42 INFO - 'USER': 'cltbld', 02:36:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:42 INFO - '_': '/tools/buildbot/bin/python'} 02:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:42 INFO - Downloading/unpacking jsonschema 02:36:42 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 02:36:42 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 02:36:42 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 02:36:42 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 02:36:42 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 02:36:42 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 02:36:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:36:44 INFO - Downloading/unpacking functools32 (from jsonschema) 02:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:44 INFO - Downloading functools32-3.2.3-2.tar.gz 02:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:36:44 INFO - warning: no files found matching '*.txt' 02:36:44 INFO - no previously-included directories found matching 'build' 02:36:44 INFO - no previously-included directories found matching 'dist' 02:36:44 INFO - no previously-included directories found matching '.git*' 02:36:44 INFO - Installing collected packages: jsonschema, functools32 02:36:44 INFO - Running setup.py install for functools32 02:36:44 INFO - warning: no files found matching '*.txt' 02:36:44 INFO - no previously-included directories found matching 'build' 02:36:44 INFO - no previously-included directories found matching 'dist' 02:36:44 INFO - no previously-included directories found matching '.git*' 02:36:44 INFO - Successfully installed jsonschema functools32 02:36:44 INFO - Cleaning up... 02:36:45 INFO - Return code: 0 02:36:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:36:45 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')]} 02:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:45 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')]} 02:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:45 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 0x7f2011e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a358e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', '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 02:36:45 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 02:36:45 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 02:36:45 INFO - Using env: {'DISPLAY': ':0', 02:36:45 INFO - 'HOME': '/home/cltbld', 02:36:45 INFO - 'LANG': 'en_US.UTF-8', 02:36:45 INFO - 'LANGUAGE': 'en_US:en', 02:36:45 INFO - 'LOGNAME': 'cltbld', 02:36:45 INFO - 'MAIL': '/var/mail/cltbld', 02:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:45 INFO - 'MOZ_NO_REMOTE': '1', 02:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:45 INFO - 'NO_EM_RESTART': '1', 02:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:45 INFO - 'PWD': '/builds/slave/test', 02:36:45 INFO - 'SHELL': '/bin/bash', 02:36:45 INFO - 'SHLVL': '1', 02:36:45 INFO - 'TERM': 'linux', 02:36:45 INFO - 'TMOUT': '86400', 02:36:45 INFO - 'USER': 'cltbld', 02:36:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:45 INFO - '_': '/tools/buildbot/bin/python'} 02:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:45 INFO - Downloading/unpacking flake8 02:36:45 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 02:36:45 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 02:36:45 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 02:36:45 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 02:36:45 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 02:36:45 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 02:36:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:36:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:36:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 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 02:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:36:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:36:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:36:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:36:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:36:47 INFO - no previously-included directories found matching 'docs/_build' 02:36:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:36:47 INFO - Running setup.py install for pep8 02:36:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:36:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:36:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:36:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:36:47 INFO - no previously-included directories found matching 'docs/_build' 02:36:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:36:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:36:47 INFO - Cleaning up... 02:36:48 INFO - Return code: 0 02:36:48 INFO - Running post-action listener: _resource_record_post_action 02:36:48 INFO - Running post-action listener: _start_resource_monitoring 02:36:48 INFO - Starting resource monitoring. 02:36:48 INFO - ##### 02:36:48 INFO - ##### Finished create-virtualenv step (success) 02:36:48 INFO - ##### 02:36:48 INFO - ##### 02:36:48 INFO - ##### Running install step. 02:36:48 INFO - ##### 02:36:48 INFO - Running pre-action listener: _resource_record_pre_action 02:36:48 INFO - Running main action method: install 02:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:48 INFO - Reading from file tmpfile_stdout 02:36:48 INFO - Detecting whether we're running mozinstall >=1.0... 02:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:36:48 INFO - Reading from file tmpfile_stdout 02:36:48 INFO - Output received: 02:36:48 INFO - Usage: mozinstall [options] installer 02:36:48 INFO - Options: 02:36:48 INFO - -h, --help show this help message and exit 02:36:48 INFO - -d DEST, --destination=DEST 02:36:48 INFO - Directory to install application into. [default: 02:36:48 INFO - "/builds/slave/test"] 02:36:48 INFO - --app=APP Application being installed. [default: firefox] 02:36:48 INFO - mkdir: /builds/slave/test/build/application 02:36:48 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'] 02:36:48 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 02:37:04 INFO - Reading from file tmpfile_stdout 02:37:04 INFO - Output received: 02:37:04 INFO - /builds/slave/test/build/application/firefox/firefox 02:37:04 INFO - Running post-action listener: _resource_record_post_action 02:37:04 INFO - ##### 02:37:04 INFO - ##### Finished install step (success) 02:37:04 INFO - ##### 02:37:04 INFO - ##### 02:37:04 INFO - ##### Running run-tests step. 02:37:04 INFO - ##### 02:37:04 INFO - Running pre-action listener: _resource_record_pre_action 02:37:04 INFO - Running main action method: run_tests 02:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:37:04 INFO - Python 2.7.3 02:37:04 INFO - Return code: 0 02:37:04 INFO - grabbing minidump binary from tooltool 02:37: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')]} 02:37:04 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 0x1ac4b20>, '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 0x1ac5a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:37:04 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 02:37:04 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 02:37:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:37:04 INFO - Return code: 0 02:37:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:37:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:37:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:37:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:37:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:37:05 INFO - Return code: 0 02:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 02:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 02:37:05 INFO - Using env: {'DISPLAY': ':0', 02:37:05 INFO - 'HOME': '/home/cltbld', 02:37:05 INFO - 'LANG': 'en_US.UTF-8', 02:37:05 INFO - 'LANGUAGE': 'en_US:en', 02:37:05 INFO - 'LOGNAME': 'cltbld', 02:37:05 INFO - 'MAIL': '/var/mail/cltbld', 02:37:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:37:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:05 INFO - 'MOZ_NO_REMOTE': '1', 02:37:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:05 INFO - 'NO_EM_RESTART': '1', 02:37:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:05 INFO - 'PWD': '/builds/slave/test', 02:37:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:37:05 INFO - 'SHELL': '/bin/bash', 02:37:05 INFO - 'SHLVL': '1', 02:37:05 INFO - 'TERM': 'linux', 02:37:05 INFO - 'TMOUT': '86400', 02:37:05 INFO - 'USER': 'cltbld', 02:37:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641', 02:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:05 INFO - '_': '/tools/buildbot/bin/python'} 02:37:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 02:37:05 INFO - mozversion application_buildid: 20160510020804 02:37:05 INFO - mozversion application_changeset: b041ad17b6c87ddf64db984292e95a777fb9959f 02:37:05 INFO - mozversion application_display_name: Nightly 02:37:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:37:05 INFO - mozversion application_name: Firefox 02:37:05 INFO - mozversion application_remotingname: firefox 02:37:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:37:05 INFO - mozversion application_vendor: Mozilla 02:37:05 INFO - mozversion application_version: 49.0a1 02:37:05 INFO - mozversion platform_buildid: 20160510020804 02:37:05 INFO - mozversion platform_changeset: b041ad17b6c87ddf64db984292e95a777fb9959f 02:37:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:37:05 INFO - mozversion platform_version: 49.0a1 02:37:05 INFO - using testdate: 1462873025 02:37:05 INFO - actual date: 1462873025 02:37:05 INFO - starting webserver on 'localhost:32894' 02:37:05 INFO - SUITE-START | Running 2 tests 02:37:05 INFO - TEST-START | dromaeo_css 02:37:05 INFO - operating with platform_type : linux_ 02:37:05 INFO - Initialising browser for dromaeo_css test... 02:37:05 INFO - TEST-INFO | started process 32437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdpd7k6/profile http://localhost:32894/getInfo.html) 02:37:09 INFO - PROCESS | 32437 | __metrics Screen width/height:1600/1200 02:37:09 INFO - PROCESS | 32437 | colorDepth:24 02:37:09 INFO - PROCESS | 32437 | Browser inner width/height: 1024/697 02:37:09 INFO - PROCESS | 32437 | __metrics 02:37:10 ERROR - PROCESS | 32437 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:37:11 INFO - TEST-INFO | 32437: exit 0 02:37:11 INFO - Browser initialized. 02:37:11 INFO - Running cycle 1/1 for dromaeo_css test... 02:37:11 INFO - TEST-INFO | started process 32515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdpd7k6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:23 INFO - PROCESS | 32515 | RSS: Main: 154054656 02:37:23 INFO - PROCESS | 32515 | 02:38:15 INFO - PROCESS | 32515 | 1462873095156 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] 02:40:26 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:32894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32894/tests/dromaeo/cssquery-ext.html) 02:40:27 INFO - PROCESS | 32515 | RSS: Main: 232042496 02:40:27 INFO - PROCESS | 32515 | 02:43:30 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:32894/tests/dromaeo/cssquery-ext.html (next: http://localhost:32894/tests/dromaeo/cssquery-jquery.html) 02:43:30 INFO - PROCESS | 32515 | RSS: Main: 237338624 02:43:30 INFO - PROCESS | 32515 | 02:46:33 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:32894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32894/tests/dromaeo/cssquery-mootools.html) 02:46:33 INFO - PROCESS | 32515 | RSS: Main: 235827200 02:46:33 INFO - PROCESS | 32515 | 02:49:35 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:32894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32894/tests/dromaeo/cssquery-prototype.html) 02:49:36 INFO - PROCESS | 32515 | RSS: Main: 230510592 02:49:36 INFO - PROCESS | 32515 | 02:52:39 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:32894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32894/tests/dromaeo/cssquery-yui.html) 02:52:40 INFO - PROCESS | 32515 | RSS: Main: 210415616 02:52:40 INFO - PROCESS | 32515 | 02:55:42 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:32894/tests/dromaeo/cssquery-yui.html (next: http://localhost:32894/tests/dromaeo/cssquery-dojo.html) 02:55:43 INFO - PROCESS | 32515 | RSS: Main: 281432064 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - PROCESS | 32515 | __start_tp_report 02:55:43 INFO - PROCESS | 32515 | _x_x_mozilla_page_load 02:55:43 INFO - PROCESS | 32515 | _x_x_mozilla_page_load_details 02:55:43 INFO - PROCESS | 32515 | |i|pagename|runs| 02:55:43 INFO - PROCESS | 32515 | |0;dojo.html;2644.986775066124;2660.8935642574297;2693.6228927950083;2701.500222458844;2706.4722379136065;4570.382998295229;4627.722336659803;4655.185342565051;4718.882027949303;4742.359781429506;4692;4706.082313948781;4762.97618511907;4814.783334749936;4816;4289.742615443076;4331.805068771897;4391.319345501436;4416.712913660618;4510.323451482271;4411.360352748849;4450.132224216279;4462.486814016397;4472.396226509429;4497.887552811173;4244.320908654616;4274.166537525184;4293.935590966138;4304.569543045702;4313.762743049131;4315.30955047194;4316.136772645484;4361.4112094867105;4376.5623437656295;4385.079133381993;4327.913441731179;4341.196878577473;4342.457192850894;4366.432363792718;4382.9342559861625;4486.7083639563325;4576.954230457686;4626.606738427237;4637.095766325568;4673.836415725467;5052.343195384577;5078.949210507884;5093.032323858455;5121.923171152435;5126.051680439131;4870.293807397908;5092.694438333712;5095.464976177485;5145.2024936134585;5153.6392452528335;4759.143354196243;4807.927881081787;4822;4873.805047798049;4878.658493905393;5219.034478621391;5316;5318.97340513295;5319.7340132993195;5319.8138065168305;4742.715437073786;4955.6531042826655;4979.726115063634;4980.402351717817;5004.574611158019;5075.695458272516;5084.771185296597;5105.8723531912;5139.254808052886;5157.381114266312;5060.645754797129;5061.266116413173;5065.39215294167;5066.594672426197;5120.743962801845;4834.468208497063;4956.925646115311;5072.949270507322;5081.110805609078;5084.542391184811;4297.226499230169;4309.353596960418;4314.633256173198;4356.934645980313;4366.126774645084;3756.1736417988;3775.188334508094;3782.130110074698;3817.61823817616;3825.0628595993603;4214.662826973835;4250.447441832542;4256.2551553478015;4304.5910638489295;4310.288802347577;5046.84859454217;5054.166062599704;5056.924146137811;5109.156989096758;5109.9744501277255;4261.424707664488;4314.525402205755;4316.093620339701;4334.371516130143;4365.454318210223;4449.933251001173;4585.426821647294;4596.494385617646;4597.655175861823;4602.539746025438;4793.568578827852;4796.8081276748535;4815.2054910939305;4815.22956327;4866.878328041898;5141.331626888481;5142.76857541404;5145.099607568735;5146.536811686817;5187.766550505161;4672.159011377985;4777.259524773665;4806.639502037291;4812.25410061441;4822.7829747662145;5047.899042019212;5073.822416215415;5075.213341932006;5075.543201111917;5120.436751957356;5095.184770436712;5101.107306221471;5101.387833460009;5105.183170692671;5152.892128192457;4700.8119675213975;4899.191633380595;4945.703257804544;4962.801487940586;4983.8504844854715;4975.875603109951;4979.402471703419;4979.925301120558;4994.450610432922;5035.7985680572365;4910.165271903857;4924.8276310328965;4924.926126108039;4972.602191824718;4975.328330675313;4746.976265118652;4900.362952816111;4925;4928.556429921325;4951.084049450863;4835.178019736723;4841.394825646794;4859.538343857328;4866.586340160984;4911.582515486224 02:55:43 INFO - PROCESS | 32515 | |1;ext.html;562.2241306996344;585.3297973819977;586.2818047891334;594.9643021418713;603.0772917436321;26926.730732692668;27348.589771153423;29472;29488.85255573722;41246.79376603113;42070.36894446578;42476;42631.934201644974;42742.14515709684;42818.143637127236;7883.251091146346;8019.759407217793;8026.197380261986;8029.237222463857;8030.317423019051;7788.649510772028;7899.368050555941;7910.090339610961;7914.445988780788;7917.089534703497;7885.29032387085;7896.526208427484;7918.2477664621765;7940.1265860755275;7940.325072368855;7857.489263197874;7897.407694422941;7914.208579142098;7917.049954005527;7917.960410197912;7863.449558530848;7920.881186782203;7937.920620793776;7940.563269020202;7943.602819858984;38007;38251.23497530034;38308;38315;38336;3203.535487354344;3324.883629072995;3376.6623337666283;3418.025862629139;3738.906527336811;27498.45003099947;29036.564451533242;29502;29890.701092989228;30328.393432131455;3144.261098641817;3145.3866496033284;3161.0761531982316;3212.6787321267684;3220.243242837931;233968;234826.82586587127;234970.99999999828;235790;237386;30408.54387184194;54860.451395485536;55220;55235.44764552303;55251.72374138184;36121;36154.45768313477;36374;36380.27239455196;36402.45396319057;13315.46738130464;13502.729945401234;13506;13513.662158446117;13517.256550889599;10983.670489885317;11040.447977601088;11072.723181920517;11084.667459976214;11089.168312376443;8313;8413.242808147295;8475.067742548315;8494.70268540598;8534.103919088531;3277.524758909945;3280.5899262592175;3299.2081900343746;3305.752068594865;3332.500124981272;903.2051794420998;946.4368700623119;963.1764841060932;968.4576637083256;1043.6816770884802;28145.859270703517;29089.41821163607;29245.707542924723;29860.253493662396;29865.253368665522;877.3858299190592;1007.0684616729642;1012.2003617142375;1024.4365598920565;1061.2518174686827;15258.923705381623;15657.530274091796;15727.44953926607;15737.44918927832;15863.682726345409;360381;364791;366387;366688;366787;51374.48625513697;51402.48597514052;51444.74277628588;51689.224661630105;51944;1146.3523109443138;1244.9377531123407;1267.7401132767761;1290.425760536571;1291.2381694800113;28627.856860715565;30143;30240.54639180458;30252.24369390783;30359.544606830474;43095;43284;43556.56443435525;43592.56407435885;43724.78137609291;287740;288003;290559;290755;293081;23898.64152037686;25744.485110298065;26941.59587606148;27048.72951270462;28294;42291.788541057096;42759;43016.784916075216;43176.56823431851;43441.78279108584;36434.8178259107;37493.625063749016;37799.24401512009;37838.810805945795;38088.61911380962;36647.985534610765;36786;36918.63081369152;37132.62867371292;37820.24359512849;36365.27269454649;36996.26007479889;37212.627873720914;37827.24345513129;37874.242515148995;31291.687083128876;33490.83254583712;33737.3252534943;33902.8304858484;34006.65993340134;25231.87384063068;25794.871025644752;25917.74082259153;25975.740242598087;26363 02:55:43 INFO - PROCESS | 32515 | |2;jquery.html;367.23798118903267;372.2071986668396;376.8925856131002;384.7460675953871;390.7011136480591;16346.509604711848;17854.28582856684;18110.81889181108;18116.456506304832;18333.17500712468;16932.492025239233;17002.3199072037;17748.29006839728;17826;17889.28442862284;5108.719020453874;5155.948440515603;5169.534741873231;5179.844604661847;5205.895882082356;3678.558572971234;3780.7353485256044;5215.660982036175;5394.32570928634;6023.3976602339635;5925.970370148143;6076.118962750398;6088.512918966494;6099.57302988791;6108.419700128481;5873.7944171954205;6020.789272375468;6081;6090.086487026937;6098.08528720691;5219.765110570033;5245.842624721265;5247.396549396792;5251.527362537352;5258.158694608883;20896.686549701768;21084.578308433745;21190.258340958146;21208.5758284835;21629.134834606597;2051.7640471345835;2059.2148374669864;2139.0907866446387;2142.4858034071867;2553.3871870750886;12802.42389092493;13120;13303.534376296782;13499.325033748371;13859.099158554662;1753.3162066793961;1753.570375258057;1759.9296028158985;1808.5117018405087;1842.9354972575895;70802.64598676974;71750.64124679343;71861.64069179673;72020.63989680017;72821.2717872825;9430.858537121949;9462.763430914281;9616.711498655051;9940.204783617293;9980.750481238027;12949;12981.41583628739;12982.740345193231;13094.279814610098;13100.213987160801;7223.349898509159;7348.191698913115;7360.411167106618;7444.218357072537;7511.661975211128;7063.788086357417;7078.787636370917;7080.893786593205;7199.1001124859395;7216.711331546784;6221.595596286227;6226.470749986212;6255.874882502325;6278.937210627835;6475.902861457082;1744.459217642535;1772.8581713462893;1811.3388613156367;1828.5245836082715;1851.287254407063;894.0344428017726;896.3411892259185;921.5208091792231;937.66712816949;995.5022488755623;16431.342746290014;17181.484555463358;17560.736588951175;17657.735133973;17930.282788688568;925.227435091706;942.1803031362758;969.8302797010494;985.9852102218329;1010.4493051287067;9989.200863930868;10001.34991225568;10272.743181420525;10285.897141028494;10323.32898361604;393042;401183;402317;420477;430544;48529;48928.510714893106;57635.711821441466;82863;86642;895.9059298773795;947.8672985781996;949.2263804998904;991.6529214774771;1003.6386900715737;14901.701965960838;15399.230038497806;15709;15960.441384551485;16112.67774644524;36369.81815090908;36854.26291474209;37904.810475947445;38230.61769382271;38585;48132.18678132159;48493.75753121212;48783.75608122079;49217.75391123021;49614.75192624014;6863.965680171567;7204.171520275026;7299;7354.411647068115;7835.333996610352;8578.313734901069;10804.351738895692;11215.49530271156;11387.43062846871;11425.2002359834;10303.639372621923;10357.482125893826;10439.478026098514;10477.633282835064;10776.784464310513;7613.08642962848;7613.885791713018;7731.149573547018;10266.384016959006;10536.15710743154;7660;7726.536407815549;7936.603169841369;7961.601919903866;8096.4616722822475;10916.727081823017;10917.508712107816;11261.774764504828;11586.594469193538;11922.880771192524;10817.188710846875;10914.890851091388;10976.670699879016;11068.501917413896;11142.83285750698 02:55:43 INFO - PROCESS | 32515 | |3;mootools.html;1188.809790433531;1438.3167995202277;1476.3208923895006;1579.6998570271649;1759.9120043997798;6763.594184348943;7143.107111611049;7155.821104472391;7291.927080729191;7309.561426314425;7070.2576229495935;7250.52871563348;7258.673359698813;7260.382867456273;7268.3458488736005;2179.585878683049;2208.8564243324213;2209.712737344143;2210.3148024112497;2212.3362991102686;2121.4908421978766;2171.0447403142643;2203.283932721864;2206.7462241842154;2208.3374987503767;2174.673798930165;2177.9564408711817;2197.143114185469;2197.1870407949;2217.5343177932655;2077.3144862195513;2086.5931143427038;2091.874487530753;2095.256184054669;2095.319021318078;2068.3588087692865;2083.19796878203;2096.7483901931714;2100.0654708654656;2100.2334148035857;7061.082059332305;7207.45944054198;7252.166000909858;7259.201487836333;7286.96356518214;4340.305551111838;4434.977825110854;4462.8884277892985;4474.82100715971;4476.820927162909;2847.501687204731;2869.8995535156378;2889.0032938636136;2901.347196880706;2934.7065293470696;933.355984370782;935.9391639543476;966.1449617088857;967.1102585621245;976.0581039297113;9297.256219502424;9318.254539636813;9356.4386136832;9410.482423466707;9512;3866.4007078902814;3954.8022598870516;3969.940450893181;3983.7211395202057;4021.2761702893176;7503.812404689817;7587.810304742426;7596.050493688289;7597.886031709529;7615.086189657277;4396.054848207651;4406.647468202536;4411.801468933906;4422.447194100738;4436.3123715824095;3580.8925732228076;3981.3828856527284;4078.3066878630702;4130.256553820281;4134.91730165395;3293.4565796643765;3299.802011879247;3343.4483310253536;3344.3311337732553;3423.3666771647327;998.7752755629925;1027.2552399510296;1028.454918892988;1036.098594223031;1040.8334666453331;854.5300084953251;868.444195714743;871;880.5773228850188;886.8004698942686;5075.5178258065425;5094.5160209780015;5102.464241254689;5131.61512886535;5410.83767486976;864.8918885139358;910.5720311453606;918.136951265808;924.4360939826701;936.4334577580602;3543.326767914088;3643.544556930384;3657;3690.0774806298427;3697.7982155799473;8547.615357308936;8868.068852770495;8946.373753837299;8949.418287811402;8971.685990990283;8742.912570874338;8800.955995219983;8814.162654547808;8845.115488451233;8890.06654301302;6579.868402632016;6893.586384816927;6973.12835895513;7007.929920700728;7062.0466237057335;4773.856784296477;5003.724795136157;5032.119379108714;5058.266551350107;5069.949300506948;7973.72091976778;8187.959060204899;8375.95812020936;8436.704715334934;8451.66193352259;8440.66237350499;8449.87325190135;8463.069062403007;8469.237768600855;8574.3997920145;5510.834674959758;5877.206577112206;6020.096985452217;6089.208402907594;6116.724747386467;6897.103376561015;7068.858622827617;7120.750773722895;7129.4652901031595;7133.108361454818;6383.489320854414;6549.329920870147;6583.242927063449;6597.340265973365;6616.040674102324;6238.937610624017;6378.52161087911;6497.675116244074;6508;6563.3764792344655;6127.724252408563;6153;6167.259928808572;6168.722407491584;6184.412480814315;4434.024920944987;4447.310666846644;4479.440069991251;4521.3444050611815;4627.514111018295;4590.931136032896;4662.487126416024;4736.981548966989;4763.904721905612;4793.185158523129 02:55:43 INFO - PROCESS | 32515 | |4;prototype.html;309.1976321445848;310.4210647143079;312.5483676088052;315.20568168216084;316.65959093973976;4734.763261836907;4759;4785.665003449752;4799.1841386964215;4813.665372294435;4698.308608900793;4714.175019371605;4750.714957102577;4757.096151731177;4766.189747742884;3567.714582833367;3697.7411581189326;3711.3876210425246;3776.546814382278;3780.092777733352;3756.793376364299;3774.3583590789494;3776.4901738265257;3783.3000894834404;3791.4691943127846;3598.85604575818;3754.9061273468246;3755.3991361382186;3762.6425489578446;3780.3006443807985;3651.525301710774;3754.436834474823;3780.3573392523335;3800.498802972838;3801.6768574671323;3374.4600863861665;3374.9493757593655;3387.6442973487674;3397.4394224952853;3399.7450191235757;4550.340200670884;4559.065391594715;4560.966956973609;4562.338460923148;4568.497465278817;4084.346504559256;4254.893627659302;4273.632437619963;4320.416743739586;4321.438213032317;4976.129177393977;4981.327520784684;4988.700677959334;4990.476000020019;5007.9499205008215;3587.551556055493;3598.802065886375;3600.6399360064047;3609.4224924012033;3610.711143108545;4963.90072198554;5197.740112994373;5208.583313334924;5217.556507696889;5217.608679349064;3620.7646502977223;3632.54593175853;3652.7990960497427;3653.397189463762;3662.8168591570316;3700.1489657378415;3702.740808143404;3703.5740889798017;3704.277665855186;3708.9072773180887;4213.304804707189;4214.346776249687;4238;4239.936400953989;4245.8513952011535;4879.438864530624;4986.950130498722;4999.825111054434;5004.299398084271;5037.622178336566;1225.3566877389442;1228.2569045727384;1238.6160290310033;1243.502598960405;1254.347739175642;812.34200297759;842.6123982967781;859.1923591823665;859.3898332184094;860.7503823891127;4168.7290326128705;4180.916381672349;4219.156168766259;4223.345381465878;4229.238737027303;4949.356583644103;4949.950500494949;4951.356323677899;4956.479569645136;4957.479464656231;4165.416841642173;4231.915361692749;4242.703010789277;4251.44731184944;4255.893602659959;2684.2752456836547;2700.7839372850126;2703.189043287006;2703.2295795698133;2707.458508298348;4779.354787103766;4807.6394270429855;4808.687435316693;4825.324454576362;4829.66192366531;4935;5186.029308862608;5191.351081114861;5197.350331208599;5229.215617657382;4752.7385993769985;4778.689385189951;4790.257510085942;4795.688280261772;4805.399325084364;5069.92395114081;5076;5083.796648134034;5089.160288552347;5095.337606111182;4813.566778989908;4988.184039210079;4995.875103122451;5000.349954505891;5093.847184584469;4845.394325709286;4894.140226713968;4895.143349913822;4899.828506002273;4904.8773780655765;3542.8228588570983;3570;3581.7850928944345;3596.5144705465473;3601.369760291886;5039.496050394931;5138.948610513847;5169.302144210484;5191;5210.166373380241;4979.452260251442;5014.623903207347;5015.724135172601;5021.49785021495;5032.672876263031;5008.173651347487;5014.373203349582;5024.145895197752;5060.924086138637;5073.568746656428;4774.522547745198;4931.605471562195;4959.603231741524;4990.575801056805;4991.80032798684;4841.8547443576745;4925.285833554186;5035.496450354935;5043.924341134959;5059.418166910705;4946.169917130685;4947.158982972831;4954.3311652926395;4961.578265847444;4981.352424184833 02:55:43 INFO - PROCESS | 32515 | |5;yui.html;692.6294432478624;803.7829785957795;812.5815205169339;820.278155223404;822.4900561651775;10926.781464370717;11325.830112548318;11327.150463715214;11345.716357091076;11379.715507112316;12086.274823510596;12357.505699771998;12397.44211510482;12465.439055242514;12518.374081295922;865.5369377383086;884.2174675412274;884.7566919097235;885.2519620920312;885.4377470306338;867.9566021698921;880.1814312689196;881.0528681667201;881.8853549038616;882.5587206396801;917.3257655623112;918.485648037098;918.5085979001236;919.0396036142214;919.31511024287;897.6319708919311;906.8730377747121;910.6721580231144;911.5943405184695;912.1927094521363;669.8358902068976;669.9196096468406;669.9899501507481;670.0016974707651;670.1756839087949;10515.842262365994;10549.894501054969;10578.153747700166;10580.259381843274;10647.733806654818;9986.300958932878;10122.746931326703;10139.695809125738;10149.949250253701;10590.470476476145;8662.740117796477;8707.608157632922;8844.73465796027;8853.380263381567;8932.240759535447;3325.700686938187;3344.147242453183;3350.078728349699;3402.727781777452;3447.87932422364;34782.65217347819;34916.301673966635;35746.64253357459;38601.227975440335;43242.783786080865;9476.85784713216;9512.714618561455;9612.231021518262;9614.855777163348;9654.806903861883;17200.569985750208;17213.311467541407;17217.13914304305;17275.74086388705;17277.56806079833;5577.470140336662;6056.303525094582;6382.5851319665;6411.871762564722;6551.213854337415;3578.3916734155255;3634.83643236055;3670.7981061041364;3672.59601443841;3706.944395834065;2793.594928735322;2883.1206482022767;2898.9565156522667;2911.344947386821;2914.227729651644;561.9550435965112;589.8466398736274;594.4441946779775;601.7202001069523;606.7997560804923;593.6438137117694;604.4167378479788;610.0970563565947;631.6873147791872;640.2509064394669;7538.133114691881;7662;7686.730964416219;7898.249666281809;7996.360291176692;607.9726412311456;625.6558892609047;639.5107742576932;640.8782331357028;644.887144749667;3797.6012518685693;3801.7338786284695;3834.2906562286066;3846.1538461538416;3911;55202.17196742052;55475;55826.441735582936;56213;56256.15615765767;50601.74699126481;50750.238746418836;51170;51785;51815.22277165845;34873;39688.80155599261;43149;43183.78408108002;43510.78244608756;7463.776086717407;7704.075510938723;7760.262775036363;7765.7670269892;7910.920890791019;28808;29056.418871622027;29252.414951701274;29505.11484655464;29665;37748.62251377561;37800.81099594484;38336;38541;38788.6121138785;9968.202543796624;10478.266521343738;10588.947055264674;10631.840522392326;10697.358158510515;11286.20996530235;11396.373199473777;11655.358955257543;11829.17195796286;11964.646514914502;10426;10701.385384765339;10819.56721731122;11060.336379817236;11064;11182.440877956233;11327;11694.415279236175;11729.706757331134;11846.881531184923;10689.198310126616;10722.946385268024;11037.11703063737;11069.114470842153;11378;8711.390202686005;8822.33832462555;9111.407758495676;9435.38669986476;9447.716568502956;9342.95328523353;9403.576839042396;9408.294377921546;9414.2468602513;9438.292128090283 02:55:43 INFO - PROCESS | 32515 | __end_tp_report 02:55:43 INFO - PROCESS | 32515 | __start_cc_report 02:55:43 INFO - PROCESS | 32515 | _x_x_mozilla_cycle_collect,1044 02:55:43 INFO - PROCESS | 32515 | __end_cc_report 02:55:43 INFO - PROCESS | 32515 | __startTimestamp1462874143047__endTimestamp 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - PROCESS | 32515 | ------- Summary: start ------- 02:55:43 INFO - PROCESS | 32515 | Number of tests: 6 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - PROCESS | 32515 | [#0] dojo.html Cycles:165 Average:4691.83 Median:4816.00 stddev:497.21 (10.3%) stddev-sans-first:472.10 02:55:43 INFO - PROCESS | 32515 | Values: 2645.0 2660.9 2693.6 2701.5 2706.5 4570.4 4627.7 4655.2 4718.9 4742.4 4692.0 4706.1 4763.0 4814.8 4816.0 4289.7 4331.8 4391.3 4416.7 4510.3 4411.4 4450.1 4462.5 4472.4 4497.9 4244.3 4274.2 4293.9 4304.6 4313.8 4315.3 4316.1 4361.4 4376.6 4385.1 4327.9 4341.2 4342.5 4366.4 4382.9 4486.7 4577.0 4626.6 4637.1 4673.8 5052.3 5078.9 5093.0 5121.9 5126.1 4870.3 5092.7 5095.5 5145.2 5153.6 4759.1 4807.9 4822.0 4873.8 4878.7 5219.0 5316.0 5319.0 5319.7 5319.8 4742.7 4955.7 4979.7 4980.4 5004.6 5075.7 5084.8 5105.9 5139.3 5157.4 5060.6 5061.3 5065.4 5066.6 5120.7 4834.5 4956.9 5072.9 5081.1 5084.5 4297.2 4309.4 4314.6 4356.9 4366.1 3756.2 3775.2 3782.1 3817.6 3825.1 4214.7 4250.4 4256.3 4304.6 4310.3 5046.8 5054.2 5056.9 5109.2 5110.0 4261.4 4314.5 4316.1 4334.4 4365.5 4449.9 4585.4 4596.5 4597.7 4602.5 4793.6 4796.8 4815.2 4815.2 4866.9 5141.3 5142.8 5145.1 5146.5 5187.8 4672.2 4777.3 4806.6 4812.3 4822.8 5047.9 5073.8 5075.2 5075.5 5120.4 5095.2 5101.1 5101.4 5105.2 5152.9 4700.8 4899.2 4945.7 4962.8 4983.9 4975.9 4979.4 4979.9 4994.5 5035.8 4910.2 4924.8 4924.9 4972.6 4975.3 4747.0 4900.4 4925.0 4928.6 4951.1 4835.2 4841.4 4859.5 4866.6 4911.6 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - PROCESS | 32515 | [#1] ext.html Cycles:180 Average:44840.82 Median:36418.64 stddev:79310.20 (217.8%) stddev-sans-first:79463.01 02:55:43 INFO - PROCESS | 32515 | Values: 562.2 585.3 586.3 595.0 603.1 26926.7 27348.6 29472.0 29488.9 41246.8 42070.4 42476.0 42631.9 42742.1 42818.1 7883.3 8019.8 8026.2 8029.2 8030.3 7788.6 7899.4 7910.1 7914.4 7917.1 7885.3 7896.5 7918.2 7940.1 7940.3 7857.5 7897.4 7914.2 7917.0 7918.0 7863.4 7920.9 7937.9 7940.6 7943.6 38007.0 38251.2 38308.0 38315.0 38336.0 3203.5 3324.9 3376.7 3418.0 3738.9 27498.5 29036.6 29502.0 29890.7 30328.4 3144.3 3145.4 3161.1 3212.7 3220.2 233968.0 234826.8 234971.0 235790.0 237386.0 30408.5 54860.5 55220.0 55235.4 55251.7 36121.0 36154.5 36374.0 36380.3 36402.5 13315.5 13502.7 13506.0 13513.7 13517.3 10983.7 11040.4 11072.7 11084.7 11089.2 8313.0 8413.2 8475.1 8494.7 8534.1 3277.5 3280.6 3299.2 3305.8 3332.5 903.2 946.4 963.2 968.5 1043.7 28145.9 29089.4 29245.7 29860.3 29865.3 877.4 1007.1 1012.2 1024.4 1061.3 15258.9 15657.5 15727.4 15737.4 15863.7 360381.0 364791.0 366387.0 366688.0 366787.0 51374.5 51402.5 51444.7 51689.2 51944.0 1146.4 1244.9 1267.7 1290.4 1291.2 28627.9 30143.0 30240.5 30252.2 30359.5 43095.0 43284.0 43556.6 43592.6 43724.8 287740.0 288003.0 290559.0 290755.0 293081.0 23898.6 25744.5 26941.6 27048.7 28294.0 42291.8 42759.0 43016.8 43176.6 43441.8 36434.8 37493.6 37799.2 37838.8 38088.6 36648.0 36786.0 36918.6 37132.6 37820.2 36365.3 36996.3 37212.6 37827.2 37874.2 31291.7 33490.8 33737.3 33902.8 34006.7 25231.9 25794.9 25917.7 25975.7 26363.0 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - PROCESS | 32515 | [#2] jquery.html Cycles:180 Average:24801.22 Median:401750.00 stddev:67339.51 (16.8%) stddev-sans-first:67503.42 02:55:43 INFO - PROCESS | 32515 | Values: 367.2 372.2 376.9 384.7 390.7 16346.5 17854.3 18110.8 18116.5 18333.2 16932.5 17002.3 17748.3 17826.0 17889.3 5108.7 5155.9 5169.5 5179.8 5205.9 3678.6 3780.7 5215.7 5394.3 6023.4 5926.0 6076.1 6088.5 6099.6 6108.4 5873.8 6020.8 6081.0 6090.1 6098.1 5219.8 5245.8 5247.4 5251.5 5258.2 20896.7 21084.6 21190.3 21208.6 21629.1 2051.8 2059.2 2139.1 2142.5 2553.4 12802.4 13120.0 13303.5 13499.3 13859.1 1753.3 1753.6 1759.9 1808.5 1842.9 70802.6 71750.6 71861.6 72020.6 72821.3 9430.9 9462.8 9616.7 9940.2 9980.8 12949.0 12981.4 12982.7 13094.3 13100.2 7223.3 7348.2 7360.4 7444.2 7511.7 7063.8 7078.8 7080.9 7199.1 7216.7 6221.6 6226.5 6255.9 6278.9 6475.9 1744.5 1772.9 1811.3 1828.5 1851.3 894.0 896.3 921.5 937.7 995.5 16431.3 17181.5 17560.7 17657.7 17930.3 925.2 942.2 969.8 986.0 1010.4 9989.2 10001.3 10272.7 10285.9 10323.3 393042.0 401183.0 402317.0 420477.0 430544.0 48529.0 48928.5 57635.7 82863.0 86642.0 895.9 947.9 949.2 991.7 1003.6 14901.7 15399.2 15709.0 15960.4 16112.7 36369.8 36854.3 37904.8 38230.6 38585.0 48132.2 48493.8 48783.8 49217.8 49614.8 6864.0 7204.2 7299.0 7354.4 7835.3 8578.3 10804.4 11215.5 11387.4 11425.2 10303.6 10357.5 10439.5 10477.6 10776.8 7613.1 7613.9 7731.1 10266.4 10536.2 7660.0 7726.5 7936.6 7961.6 8096.5 10916.7 10917.5 11261.8 11586.6 11922.9 10817.2 10914.9 10976.7 11068.5 11142.8 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - PROCESS | 32515 | [#3] mootools.html Cycles:180 Average:4834.69 Median:5948.65 stddev:2575.68 (43.3%) stddev-sans-first:2568.33 02:55:43 INFO - PROCESS | 32515 | Values: 1188.8 1438.3 1476.3 1579.7 1759.9 6763.6 7143.1 7155.8 7291.9 7309.6 7070.3 7250.5 7258.7 7260.4 7268.3 2179.6 2208.9 2209.7 2210.3 2212.3 2121.5 2171.0 2203.3 2206.7 2208.3 2174.7 2178.0 2197.1 2197.2 2217.5 2077.3 2086.6 2091.9 2095.3 2095.3 2068.4 2083.2 2096.7 2100.1 2100.2 7061.1 7207.5 7252.2 7259.2 7287.0 4340.3 4435.0 4462.9 4474.8 4476.8 2847.5 2869.9 2889.0 2901.3 2934.7 933.4 935.9 966.1 967.1 976.1 9297.3 9318.3 9356.4 9410.5 9512.0 3866.4 3954.8 3969.9 3983.7 4021.3 7503.8 7587.8 7596.1 7597.9 7615.1 4396.1 4406.6 4411.8 4422.4 4436.3 3580.9 3981.4 4078.3 4130.3 4134.9 3293.5 3299.8 3343.4 3344.3 3423.4 998.8 1027.3 1028.5 1036.1 1040.8 854.5 868.4 871.0 880.6 886.8 5075.5 5094.5 5102.5 5131.6 5410.8 864.9 910.6 918.1 924.4 936.4 3543.3 3643.5 3657.0 3690.1 3697.8 8547.6 8868.1 8946.4 8949.4 8971.7 8742.9 8801.0 8814.2 8845.1 8890.1 6579.9 6893.6 6973.1 7007.9 7062.0 4773.9 5003.7 5032.1 5058.3 5069.9 7973.7 8188.0 8376.0 8436.7 8451.7 8440.7 8449.9 8463.1 8469.2 8574.4 5510.8 5877.2 6020.1 6089.2 6116.7 6897.1 7068.9 7120.8 7129.5 7133.1 6383.5 6549.3 6583.2 6597.3 6616.0 6238.9 6378.5 6497.7 6508.0 6563.4 6127.7 6153.0 6167.3 6168.7 6184.4 4434.0 4447.3 4479.4 4521.3 4627.5 4590.9 4662.5 4737.0 4763.9 4793.2 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - PROCESS | 32515 | [#4] prototype.html Cycles:180 Average:4133.85 Median:4758.05 stddev:1193.90 (25.1%) stddev-sans-first:1162.23 02:55:43 INFO - PROCESS | 32515 | Values: 309.2 310.4 312.5 315.2 316.7 4734.8 4759.0 4785.7 4799.2 4813.7 4698.3 4714.2 4750.7 4757.1 4766.2 3567.7 3697.7 3711.4 3776.5 3780.1 3756.8 3774.4 3776.5 3783.3 3791.5 3598.9 3754.9 3755.4 3762.6 3780.3 3651.5 3754.4 3780.4 3800.5 3801.7 3374.5 3374.9 3387.6 3397.4 3399.7 4550.3 4559.1 4561.0 4562.3 4568.5 4084.3 4254.9 4273.6 4320.4 4321.4 4976.1 4981.3 4988.7 4990.5 5007.9 3587.6 3598.8 3600.6 3609.4 3610.7 4963.9 5197.7 5208.6 5217.6 5217.6 3620.8 3632.5 3652.8 3653.4 3662.8 3700.1 3702.7 3703.6 3704.3 3708.9 4213.3 4214.3 4238.0 4239.9 4245.9 4879.4 4987.0 4999.8 5004.3 5037.6 1225.4 1228.3 1238.6 1243.5 1254.3 812.3 842.6 859.2 859.4 860.8 4168.7 4180.9 4219.2 4223.3 4229.2 4949.4 4950.0 4951.4 4956.5 4957.5 4165.4 4231.9 4242.7 4251.4 4255.9 2684.3 2700.8 2703.2 2703.2 2707.5 4779.4 4807.6 4808.7 4825.3 4829.7 4935.0 5186.0 5191.4 5197.4 5229.2 4752.7 4778.7 4790.3 4795.7 4805.4 5069.9 5076.0 5083.8 5089.2 5095.3 4813.6 4988.2 4995.9 5000.3 5093.8 4845.4 4894.1 4895.1 4899.8 4904.9 3542.8 3570.0 3581.8 3596.5 3601.4 5039.5 5138.9 5169.3 5191.0 5210.2 4979.5 5014.6 5015.7 5021.5 5032.7 5008.2 5014.4 5024.1 5060.9 5073.6 4774.5 4931.6 4959.6 4990.6 4991.8 4841.9 4925.3 5035.5 5043.9 5059.4 4946.2 4947.2 4954.3 4961.6 4981.4 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - PROCESS | 32515 | [#5] yui.html Cycles:180 Average:12475.76 Median:51477.50 stddev:14483.22 (28.1%) stddev-sans-first:14496.82 02:55:43 INFO - PROCESS | 32515 | Values: 692.6 803.8 812.6 820.3 822.5 10926.8 11325.8 11327.2 11345.7 11379.7 12086.3 12357.5 12397.4 12465.4 12518.4 865.5 884.2 884.8 885.3 885.4 868.0 880.2 881.1 881.9 882.6 917.3 918.5 918.5 919.0 919.3 897.6 906.9 910.7 911.6 912.2 669.8 669.9 670.0 670.0 670.2 10515.8 10549.9 10578.2 10580.3 10647.7 9986.3 10122.7 10139.7 10149.9 10590.5 8662.7 8707.6 8844.7 8853.4 8932.2 3325.7 3344.1 3350.1 3402.7 3447.9 34782.7 34916.3 35746.6 38601.2 43242.8 9476.9 9512.7 9612.2 9614.9 9654.8 17200.6 17213.3 17217.1 17275.7 17277.6 5577.5 6056.3 6382.6 6411.9 6551.2 3578.4 3634.8 3670.8 3672.6 3706.9 2793.6 2883.1 2899.0 2911.3 2914.2 562.0 589.8 594.4 601.7 606.8 593.6 604.4 610.1 631.7 640.3 7538.1 7662.0 7686.7 7898.2 7996.4 608.0 625.7 639.5 640.9 644.9 3797.6 3801.7 3834.3 3846.2 3911.0 55202.2 55475.0 55826.4 56213.0 56256.2 50601.7 50750.2 51170.0 51785.0 51815.2 34873.0 39688.8 43149.0 43183.8 43510.8 7463.8 7704.1 7760.3 7765.8 7910.9 28808.0 29056.4 29252.4 29505.1 29665.0 37748.6 37800.8 38336.0 38541.0 38788.6 9968.2 10478.3 10588.9 10631.8 10697.4 11286.2 11396.4 11655.4 11829.2 11964.6 10426.0 10701.4 10819.6 11060.3 11064.0 11182.4 11327.0 11694.4 11729.7 11846.9 10689.2 10722.9 11037.1 11069.1 11378.0 8711.4 8822.3 9111.4 9435.4 9447.7 9343.0 9403.6 9408.3 9414.2 9438.3 02:55:43 INFO - PROCESS | 32515 | -------- Summary: end -------- 02:55:43 INFO - PROCESS | 32515 | 02:55:43 INFO - TEST-INFO | 32515: exit 0 02:55:43 INFO - TEST-OK | dromaeo_css | took 1118455ms 02:55:43 INFO - TEST-START | kraken 02:55:43 INFO - operating with platform_type : linux_ 02:55:43 INFO - Initialising browser for kraken test... 02:55:43 INFO - TEST-INFO | started process 32690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjM3Qnw/profile http://localhost:32894/getInfo.html) 02:55:48 INFO - PROCESS | 32690 | __metrics Screen width/height:1600/1200 02:55:48 INFO - PROCESS | 32690 | colorDepth:24 02:55:48 INFO - PROCESS | 32690 | Browser inner width/height: 1024/697 02:55:48 INFO - PROCESS | 32690 | __metrics 02:55:49 ERROR - PROCESS | 32690 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:55:50 INFO - TEST-INFO | 32690: exit 0 02:55:50 INFO - Browser initialized. 02:55:50 INFO - Running cycle 1/1 for kraken test... 02:55:50 INFO - TEST-INFO | started process 303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjM3Qnw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:02 INFO - PROCESS | 303 | RSS: Main: 153882624 02:56:02 INFO - PROCESS | 303 | 02:56:04 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32894/tests/kraken/driver.html?testName=audio-beat-detection) 02:56:05 INFO - PROCESS | 303 | RSS: Main: 209502208 02:56:05 INFO - PROCESS | 303 | 02:56:08 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32894/tests/kraken/driver.html?testName=audio-dft) 02:56:09 INFO - PROCESS | 303 | RSS: Main: 197038080 02:56:09 INFO - PROCESS | 303 | 02:56:12 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32894/tests/kraken/driver.html?testName=audio-fft) 02:56:13 INFO - PROCESS | 303 | RSS: Main: 265969664 02:56:13 INFO - PROCESS | 303 | 02:56:15 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32894/tests/kraken/driver.html?testName=audio-oscillator) 02:56:16 INFO - PROCESS | 303 | RSS: Main: 174710784 02:56:16 INFO - PROCESS | 303 | 02:56:18 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:56:19 INFO - PROCESS | 303 | RSS: Main: 179113984 02:56:19 INFO - PROCESS | 303 | 02:56:22 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32894/tests/kraken/driver.html?testName=imaging-darkroom) 02:56:23 INFO - PROCESS | 303 | RSS: Main: 215531520 02:56:23 INFO - PROCESS | 303 | 02:56:26 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32894/tests/kraken/driver.html?testName=imaging-desaturate) 02:56:27 INFO - PROCESS | 303 | RSS: Main: 214204416 02:56:27 INFO - PROCESS | 303 | 02:56:30 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32894/tests/kraken/driver.html?testName=json-parse-financial) 02:56:31 INFO - PROCESS | 303 | RSS: Main: 214712320 02:56:31 INFO - PROCESS | 303 | 02:56:32 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:56:33 INFO - PROCESS | 303 | RSS: Main: 203603968 02:56:33 INFO - PROCESS | 303 | 02:56:35 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32894/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:56:35 INFO - PROCESS | 303 | RSS: Main: 206884864 02:56:35 INFO - PROCESS | 303 | 02:56:38 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:56:38 INFO - PROCESS | 303 | RSS: Main: 215412736 02:56:38 INFO - PROCESS | 303 | 02:56:41 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:56:42 INFO - PROCESS | 303 | RSS: Main: 224239616 02:56:42 INFO - PROCESS | 303 | 02:56:45 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:56:45 INFO - PROCESS | 303 | RSS: Main: 220270592 02:56:45 INFO - PROCESS | 303 | 02:56:47 INFO - PROCESS | 303 | Cycle 1(1): loaded http://localhost:32894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32894/tests/kraken/driver.html?testName=ai-astar) 02:56:48 INFO - PROCESS | 303 | RSS: Main: 266838016 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | __start_tp_report 02:56:48 INFO - PROCESS | 303 | _x_x_mozilla_page_load 02:56:48 INFO - PROCESS | 303 | _x_x_mozilla_page_load_details 02:56:48 INFO - PROCESS | 303 | |i|pagename|runs| 02:56:48 INFO - PROCESS | 303 | |0;ai-astar;114;111;114;114;113;115;114;113;115;114 02:56:48 INFO - PROCESS | 303 | |1;audio-beat-detection;161;131;153;206;138;155;160;133;192;133 02:56:48 INFO - PROCESS | 303 | |2;audio-dft;160;160;162;161;161;161;161;162;160;159 02:56:48 INFO - PROCESS | 303 | |3;audio-fft;76;76;75;152;77;75;76;75;127;75 02:56:48 INFO - PROCESS | 303 | |4;audio-oscillator;103;92;147;92;93;92;129;92;92;117 02:56:48 INFO - PROCESS | 303 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;117;117;117 02:56:48 INFO - PROCESS | 303 | |6;imaging-darkroom;145;146;146;146;145;145;145;146;145;146 02:56:48 INFO - PROCESS | 303 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 02:56:48 INFO - PROCESS | 303 | |8;json-parse-financial;67;67;65;64;65;66;67;118;64;64 02:56:48 INFO - PROCESS | 303 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;65;65;64 02:56:48 INFO - PROCESS | 303 | |10;stanford-crypto-aes;83;82;82;80;85;83;80;83;82;83 02:56:48 INFO - PROCESS | 303 | |11;stanford-crypto-ccm;140;131;132;132;129;129;137;133;195;134 02:56:48 INFO - PROCESS | 303 | |12;stanford-crypto-pbkdf2;172;174;188;173;174;173;173;174;174;169 02:56:48 INFO - PROCESS | 303 | |13;stanford-crypto-sha256-iterative;67;69;70;71;66;69;66;66;65;67 02:56:48 INFO - PROCESS | 303 | __end_tp_report 02:56:48 INFO - PROCESS | 303 | __start_cc_report 02:56:48 INFO - PROCESS | 303 | _x_x_mozilla_cycle_collect,2108 02:56:48 INFO - PROCESS | 303 | __end_cc_report 02:56:48 INFO - PROCESS | 303 | __startTimestamp1462874208070__endTimestamp 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | ------- Summary: start ------- 02:56:48 INFO - PROCESS | 303 | Number of tests: 14 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 02:56:48 INFO - PROCESS | 303 | Values: 114.0 111.0 114.0 114.0 113.0 115.0 114.0 113.0 115.0 114.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:157.50 stddev:25.50 (16.2%) stddev-sans-first:26.99 02:56:48 INFO - PROCESS | 303 | Values: 161.0 131.0 153.0 206.0 138.0 155.0 160.0 133.0 192.0 133.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 02:56:48 INFO - PROCESS | 303 | Values: 160.0 160.0 162.0 161.0 161.0 161.0 161.0 162.0 160.0 159.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#3] audio-fft Cycles:10 Average:88.40 Median:75.50 stddev:27.58 (36.5%) stddev-sans-first:28.88 02:56:48 INFO - PROCESS | 303 | Values: 76.0 76.0 75.0 152.0 77.0 75.0 76.0 75.0 127.0 75.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:19.66 (21.4%) stddev-sans-first:20.84 02:56:48 INFO - PROCESS | 303 | Values: 103.0 92.0 147.0 92.0 93.0 92.0 129.0 92.0 92.0 117.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:56:48 INFO - PROCESS | 303 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:56:48 INFO - PROCESS | 303 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 02:56:48 INFO - PROCESS | 303 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:65.50 stddev:16.67 (25.4%) stddev-sans-first:17.62 02:56:48 INFO - PROCESS | 303 | Values: 67.0 67.0 65.0 64.0 65.0 66.0 67.0 118.0 64.0 64.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 02:56:48 INFO - PROCESS | 303 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 65.0 64.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:1.49 (1.8%) stddev-sans-first:1.56 02:56:48 INFO - PROCESS | 303 | Values: 83.0 82.0 82.0 80.0 85.0 83.0 80.0 83.0 82.0 83.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:133.50 stddev:19.90 (14.9%) stddev-sans-first:21.10 02:56:48 INFO - PROCESS | 303 | Values: 140.0 131.0 132.0 132.0 129.0 129.0 137.0 133.0 195.0 134.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:174.00 stddev:5.02 (2.9%) stddev-sans-first:5.24 02:56:48 INFO - PROCESS | 303 | Values: 172.0 174.0 188.0 173.0 174.0 173.0 173.0 174.0 174.0 169.0 02:56:48 INFO - PROCESS | 303 | 02:56:48 INFO - PROCESS | 303 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:2.01 (3.0%) stddev-sans-first:2.12 02:56:48 INFO - PROCESS | 303 | Values: 67.0 69.0 70.0 71.0 66.0 69.0 66.0 66.0 65.0 67.0 02:56:48 INFO - PROCESS | 303 | -------- Summary: end -------- 02:56:48 INFO - PROCESS | 303 | 02:56:49 INFO - TEST-INFO | 303: exit 0 02:56:49 INFO - TEST-OK | kraken | took 65437ms 02:56:49 INFO - SUITE-END | took 1183s 02:56:49 INFO - Completed test suite (00:19:44) 02:56:49 INFO - javascript benchmark 02:56:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.986775066124, 2660.8935642574297, 2693.6228927950083, 2701.500222458844, 2706.4722379136065, 4570.382998295229, 4627.722336659803, 4655.185342565051, 4718.882027949303, 4742.359781429506, 4692.0, 4706.082313948781, 4762.97618511907, 4814.783334749936, 4816.0, 4289.742615443076, 4331.805068771897, 4391.319345501436, 4416.712913660618, 4510.323451482271, 4411.360352748849, 4450.132224216279, 4462.486814016397, 4472.396226509429, 4497.887552811173, 4244.320908654616, 4274.166537525184, 4293.935590966138, 4304.569543045702, 4313.762743049131, 4315.30955047194, 4316.136772645484, 4361.4112094867105, 4376.5623437656295, 4385.079133381993, 4327.913441731179, 4341.196878577473, 4342.457192850894, 4366.432363792718, 4382.9342559861625, 4486.7083639563325, 4576.954230457686, 4626.606738427237, 4637.095766325568, 4673.836415725467, 5052.343195384577, 5078.949210507884, 5093.032323858455, 5121.923171152435, 5126.051680439131, 4870.293807397908, 5092.694438333712, 5095.464976177485, 5145.2024936134585, 5153.6392452528335, 4759.143354196243, 4807.927881081787, 4822.0, 4873.805047798049, 4878.658493905393, 5219.034478621391, 5316.0, 5318.97340513295, 5319.7340132993195, 5319.8138065168305, 4742.715437073786, 4955.6531042826655, 4979.726115063634, 4980.402351717817, 5004.574611158019, 5075.695458272516, 5084.771185296597, 5105.8723531912, 5139.254808052886, 5157.381114266312, 5060.645754797129, 5061.266116413173, 5065.39215294167, 5066.594672426197, 5120.743962801845, 4834.468208497063, 4956.925646115311, 5072.949270507322, 5081.110805609078, 5084.542391184811, 4297.226499230169, 4309.353596960418, 4314.633256173198, 4356.934645980313, 4366.126774645084, 3756.1736417988, 3775.188334508094, 3782.130110074698, 3817.61823817616, 3825.0628595993603, 4214.662826973835, 4250.447441832542, 4256.2551553478015, 4304.5910638489295, 4310.288802347577, 5046.84859454217, 5054.166062599704, 5056.924146137811, 5109.156989096758, 5109.9744501277255, 4261.424707664488, 4314.525402205755, 4316.093620339701, 4334.371516130143, 4365.454318210223, 4449.933251001173, 4585.426821647294, 4596.494385617646, 4597.655175861823, 4602.539746025438, 4793.568578827852, 4796.8081276748535, 4815.2054910939305, 4815.22956327, 4866.878328041898, 5141.331626888481, 5142.76857541404, 5145.099607568735, 5146.536811686817, 5187.766550505161, 4672.159011377985, 4777.259524773665, 4806.639502037291, 4812.25410061441, 4822.7829747662145, 5047.899042019212, 5073.822416215415, 5075.213341932006, 5075.543201111917, 5120.436751957356, 5095.184770436712, 5101.107306221471, 5101.387833460009, 5105.183170692671, 5152.892128192457, 4700.8119675213975, 4899.191633380595, 4945.703257804544, 4962.801487940586, 4983.8504844854715, 4975.875603109951, 4979.402471703419, 4979.925301120558, 4994.450610432922, 5035.7985680572365, 4910.165271903857, 4924.8276310328965, 4924.926126108039, 4972.602191824718, 4975.328330675313, 4746.976265118652, 4900.362952816111, 4925.0, 4928.556429921325, 4951.084049450863, 4835.178019736723, 4841.394825646794, 4859.538343857328, 4866.586340160984, 4911.582515486224], "value": 4660.2688233536965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2241306996344, 585.3297973819977, 586.2818047891334, 594.9643021418713, 603.0772917436321, 26926.730732692668, 27348.589771153423, 29472.0, 29488.85255573722, 41246.79376603113, 42070.36894446578, 42476.0, 42631.934201644974, 42742.14515709684, 42818.143637127236, 7883.251091146346, 8019.759407217793, 8026.197380261986, 8029.237222463857, 8030.317423019051, 7788.649510772028, 7899.368050555941, 7910.090339610961, 7914.445988780788, 7917.089534703497, 7885.29032387085, 7896.526208427484, 7918.2477664621765, 7940.1265860755275, 7940.325072368855, 7857.489263197874, 7897.407694422941, 7914.208579142098, 7917.049954005527, 7917.960410197912, 7863.449558530848, 7920.881186782203, 7937.920620793776, 7940.563269020202, 7943.602819858984, 38007.0, 38251.23497530034, 38308.0, 38315.0, 38336.0, 3203.535487354344, 3324.883629072995, 3376.6623337666283, 3418.025862629139, 3738.906527336811, 27498.45003099947, 29036.564451533242, 29502.0, 29890.701092989228, 30328.393432131455, 3144.261098641817, 3145.3866496033284, 3161.0761531982316, 3212.6787321267684, 3220.243242837931, 233968.0, 234826.82586587127, 234970.99999999828, 235790.0, 237386.0, 30408.54387184194, 54860.451395485536, 55220.0, 55235.44764552303, 55251.72374138184, 36121.0, 36154.45768313477, 36374.0, 36380.27239455196, 36402.45396319057, 13315.46738130464, 13502.729945401234, 13506.0, 13513.662158446117, 13517.256550889599, 10983.670489885317, 11040.447977601088, 11072.723181920517, 11084.667459976214, 11089.168312376443, 8313.0, 8413.242808147295, 8475.067742548315, 8494.70268540598, 8534.103919088531, 3277.524758909945, 3280.5899262592175, 3299.2081900343746, 3305.752068594865, 3332.500124981272, 903.2051794420998, 946.4368700623119, 963.1764841060932, 968.4576637083256, 1043.6816770884802, 28145.859270703517, 29089.41821163607, 29245.707542924723, 29860.253493662396, 29865.253368665522, 877.3858299190592, 1007.0684616729642, 1012.2003617142375, 1024.4365598920565, 1061.2518174686827, 15258.923705381623, 15657.530274091796, 15727.44953926607, 15737.44918927832, 15863.682726345409, 360381.0, 364791.0, 366387.0, 366688.0, 366787.0, 51374.48625513697, 51402.48597514052, 51444.74277628588, 51689.224661630105, 51944.0, 1146.3523109443138, 1244.9377531123407, 1267.7401132767761, 1290.425760536571, 1291.2381694800113, 28627.856860715565, 30143.0, 30240.54639180458, 30252.24369390783, 30359.544606830474, 43095.0, 43284.0, 43556.56443435525, 43592.56407435885, 43724.78137609291, 287740.0, 288003.0, 290559.0, 290755.0, 293081.0, 23898.64152037686, 25744.485110298065, 26941.59587606148, 27048.72951270462, 28294.0, 42291.788541057096, 42759.0, 43016.784916075216, 43176.56823431851, 43441.78279108584, 36434.8178259107, 37493.625063749016, 37799.24401512009, 37838.810805945795, 38088.61911380962, 36647.985534610765, 36786.0, 36918.63081369152, 37132.62867371292, 37820.24359512849, 36365.27269454649, 36996.26007479889, 37212.627873720914, 37827.24345513129, 37874.242515148995, 31291.687083128876, 33490.83254583712, 33737.3252534943, 33902.8304858484, 34006.65993340134, 25231.87384063068, 25794.871025644752, 25917.74082259153, 25975.740242598087, 26363.0], "value": 16693.997376133728, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.23798118903267, 372.2071986668396, 376.8925856131002, 384.7460675953871, 390.7011136480591, 16346.509604711848, 17854.28582856684, 18110.81889181108, 18116.456506304832, 18333.17500712468, 16932.492025239233, 17002.3199072037, 17748.29006839728, 17826.0, 17889.28442862284, 5108.719020453874, 5155.948440515603, 5169.534741873231, 5179.844604661847, 5205.895882082356, 3678.558572971234, 3780.7353485256044, 5215.660982036175, 5394.32570928634, 6023.3976602339635, 5925.970370148143, 6076.118962750398, 6088.512918966494, 6099.57302988791, 6108.419700128481, 5873.7944171954205, 6020.789272375468, 6081.0, 6090.086487026937, 6098.08528720691, 5219.765110570033, 5245.842624721265, 5247.396549396792, 5251.527362537352, 5258.158694608883, 20896.686549701768, 21084.578308433745, 21190.258340958146, 21208.5758284835, 21629.134834606597, 2051.7640471345835, 2059.2148374669864, 2139.0907866446387, 2142.4858034071867, 2553.3871870750886, 12802.42389092493, 13120.0, 13303.534376296782, 13499.325033748371, 13859.099158554662, 1753.3162066793961, 1753.570375258057, 1759.9296028158985, 1808.5117018405087, 1842.9354972575895, 70802.64598676974, 71750.64124679343, 71861.64069179673, 72020.63989680017, 72821.2717872825, 9430.858537121949, 9462.763430914281, 9616.711498655051, 9940.204783617293, 9980.750481238027, 12949.0, 12981.41583628739, 12982.740345193231, 13094.279814610098, 13100.213987160801, 7223.349898509159, 7348.191698913115, 7360.411167106618, 7444.218357072537, 7511.661975211128, 7063.788086357417, 7078.787636370917, 7080.893786593205, 7199.1001124859395, 7216.711331546784, 6221.595596286227, 6226.470749986212, 6255.874882502325, 6278.937210627835, 6475.902861457082, 1744.459217642535, 1772.8581713462893, 1811.3388613156367, 1828.5245836082715, 1851.287254407063, 894.0344428017726, 896.3411892259185, 921.5208091792231, 937.66712816949, 995.5022488755623, 16431.342746290014, 17181.484555463358, 17560.736588951175, 17657.735133973, 17930.282788688568, 925.227435091706, 942.1803031362758, 969.8302797010494, 985.9852102218329, 1010.4493051287067, 9989.200863930868, 10001.34991225568, 10272.743181420525, 10285.897141028494, 10323.32898361604, 393042.0, 401183.0, 402317.0, 420477.0, 430544.0, 48529.0, 48928.510714893106, 57635.711821441466, 82863.0, 86642.0, 895.9059298773795, 947.8672985781996, 949.2263804998904, 991.6529214774771, 1003.6386900715737, 14901.701965960838, 15399.230038497806, 15709.0, 15960.441384551485, 16112.67774644524, 36369.81815090908, 36854.26291474209, 37904.810475947445, 38230.61769382271, 38585.0, 48132.18678132159, 48493.75753121212, 48783.75608122079, 49217.75391123021, 49614.75192624014, 6863.965680171567, 7204.171520275026, 7299.0, 7354.411647068115, 7835.333996610352, 8578.313734901069, 10804.351738895692, 11215.49530271156, 11387.43062846871, 11425.2002359834, 10303.639372621923, 10357.482125893826, 10439.478026098514, 10477.633282835064, 10776.784464310513, 7613.08642962848, 7613.885791713018, 7731.149573547018, 10266.384016959006, 10536.15710743154, 7660.0, 7726.536407815549, 7936.603169841369, 7961.601919903866, 8096.4616722822475, 10916.727081823017, 10917.508712107816, 11261.774764504828, 11586.594469193538, 11922.880771192524, 10817.188710846875, 10914.890851091388, 10976.670699879016, 11068.501917413896, 11142.83285750698], "value": 8486.95691416828, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1188.809790433531, 1438.3167995202277, 1476.3208923895006, 1579.6998570271649, 1759.9120043997798, 6763.594184348943, 7143.107111611049, 7155.821104472391, 7291.927080729191, 7309.561426314425, 7070.2576229495935, 7250.52871563348, 7258.673359698813, 7260.382867456273, 7268.3458488736005, 2179.585878683049, 2208.8564243324213, 2209.712737344143, 2210.3148024112497, 2212.3362991102686, 2121.4908421978766, 2171.0447403142643, 2203.283932721864, 2206.7462241842154, 2208.3374987503767, 2174.673798930165, 2177.9564408711817, 2197.143114185469, 2197.1870407949, 2217.5343177932655, 2077.3144862195513, 2086.5931143427038, 2091.874487530753, 2095.256184054669, 2095.319021318078, 2068.3588087692865, 2083.19796878203, 2096.7483901931714, 2100.0654708654656, 2100.2334148035857, 7061.082059332305, 7207.45944054198, 7252.166000909858, 7259.201487836333, 7286.96356518214, 4340.305551111838, 4434.977825110854, 4462.8884277892985, 4474.82100715971, 4476.820927162909, 2847.501687204731, 2869.8995535156378, 2889.0032938636136, 2901.347196880706, 2934.7065293470696, 933.355984370782, 935.9391639543476, 966.1449617088857, 967.1102585621245, 976.0581039297113, 9297.256219502424, 9318.254539636813, 9356.4386136832, 9410.482423466707, 9512.0, 3866.4007078902814, 3954.8022598870516, 3969.940450893181, 3983.7211395202057, 4021.2761702893176, 7503.812404689817, 7587.810304742426, 7596.050493688289, 7597.886031709529, 7615.086189657277, 4396.054848207651, 4406.647468202536, 4411.801468933906, 4422.447194100738, 4436.3123715824095, 3580.8925732228076, 3981.3828856527284, 4078.3066878630702, 4130.256553820281, 4134.91730165395, 3293.4565796643765, 3299.802011879247, 3343.4483310253536, 3344.3311337732553, 3423.3666771647327, 998.7752755629925, 1027.2552399510296, 1028.454918892988, 1036.098594223031, 1040.8334666453331, 854.5300084953251, 868.444195714743, 871.0, 880.5773228850188, 886.8004698942686, 5075.5178258065425, 5094.5160209780015, 5102.464241254689, 5131.61512886535, 5410.83767486976, 864.8918885139358, 910.5720311453606, 918.136951265808, 924.4360939826701, 936.4334577580602, 3543.326767914088, 3643.544556930384, 3657.0, 3690.0774806298427, 3697.7982155799473, 8547.615357308936, 8868.068852770495, 8946.373753837299, 8949.418287811402, 8971.685990990283, 8742.912570874338, 8800.955995219983, 8814.162654547808, 8845.115488451233, 8890.06654301302, 6579.868402632016, 6893.586384816927, 6973.12835895513, 7007.929920700728, 7062.0466237057335, 4773.856784296477, 5003.724795136157, 5032.119379108714, 5058.266551350107, 5069.949300506948, 7973.72091976778, 8187.959060204899, 8375.95812020936, 8436.704715334934, 8451.66193352259, 8440.66237350499, 8449.87325190135, 8463.069062403007, 8469.237768600855, 8574.3997920145, 5510.834674959758, 5877.206577112206, 6020.096985452217, 6089.208402907594, 6116.724747386467, 6897.103376561015, 7068.858622827617, 7120.750773722895, 7129.4652901031595, 7133.108361454818, 6383.489320854414, 6549.329920870147, 6583.242927063449, 6597.340265973365, 6616.040674102324, 6238.937610624017, 6378.52161087911, 6497.675116244074, 6508.0, 6563.3764792344655, 6127.724252408563, 6153.0, 6167.259928808572, 6168.722407491584, 6184.412480814315, 4434.024920944987, 4447.310666846644, 4479.440069991251, 4521.3444050611815, 4627.514111018295, 4590.931136032896, 4662.487126416024, 4736.981548966989, 4763.904721905612, 4793.185158523129], "value": 3965.5011985735046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.1976321445848, 310.4210647143079, 312.5483676088052, 315.20568168216084, 316.65959093973976, 4734.763261836907, 4759.0, 4785.665003449752, 4799.1841386964215, 4813.665372294435, 4698.308608900793, 4714.175019371605, 4750.714957102577, 4757.096151731177, 4766.189747742884, 3567.714582833367, 3697.7411581189326, 3711.3876210425246, 3776.546814382278, 3780.092777733352, 3756.793376364299, 3774.3583590789494, 3776.4901738265257, 3783.3000894834404, 3791.4691943127846, 3598.85604575818, 3754.9061273468246, 3755.3991361382186, 3762.6425489578446, 3780.3006443807985, 3651.525301710774, 3754.436834474823, 3780.3573392523335, 3800.498802972838, 3801.6768574671323, 3374.4600863861665, 3374.9493757593655, 3387.6442973487674, 3397.4394224952853, 3399.7450191235757, 4550.340200670884, 4559.065391594715, 4560.966956973609, 4562.338460923148, 4568.497465278817, 4084.346504559256, 4254.893627659302, 4273.632437619963, 4320.416743739586, 4321.438213032317, 4976.129177393977, 4981.327520784684, 4988.700677959334, 4990.476000020019, 5007.9499205008215, 3587.551556055493, 3598.802065886375, 3600.6399360064047, 3609.4224924012033, 3610.711143108545, 4963.90072198554, 5197.740112994373, 5208.583313334924, 5217.556507696889, 5217.608679349064, 3620.7646502977223, 3632.54593175853, 3652.7990960497427, 3653.397189463762, 3662.8168591570316, 3700.1489657378415, 3702.740808143404, 3703.5740889798017, 3704.277665855186, 3708.9072773180887, 4213.304804707189, 4214.346776249687, 4238.0, 4239.936400953989, 4245.8513952011535, 4879.438864530624, 4986.950130498722, 4999.825111054434, 5004.299398084271, 5037.622178336566, 1225.3566877389442, 1228.2569045727384, 1238.6160290310033, 1243.502598960405, 1254.347739175642, 812.34200297759, 842.6123982967781, 859.1923591823665, 859.3898332184094, 860.7503823891127, 4168.7290326128705, 4180.916381672349, 4219.156168766259, 4223.345381465878, 4229.238737027303, 4949.356583644103, 4949.950500494949, 4951.356323677899, 4956.479569645136, 4957.479464656231, 4165.416841642173, 4231.915361692749, 4242.703010789277, 4251.44731184944, 4255.893602659959, 2684.2752456836547, 2700.7839372850126, 2703.189043287006, 2703.2295795698133, 2707.458508298348, 4779.354787103766, 4807.6394270429855, 4808.687435316693, 4825.324454576362, 4829.66192366531, 4935.0, 5186.029308862608, 5191.351081114861, 5197.350331208599, 5229.215617657382, 4752.7385993769985, 4778.689385189951, 4790.257510085942, 4795.688280261772, 4805.399325084364, 5069.92395114081, 5076.0, 5083.796648134034, 5089.160288552347, 5095.337606111182, 4813.566778989908, 4988.184039210079, 4995.875103122451, 5000.349954505891, 5093.847184584469, 4845.394325709286, 4894.140226713968, 4895.143349913822, 4899.828506002273, 4904.8773780655765, 3542.8228588570983, 3570.0, 3581.7850928944345, 3596.5144705465473, 3601.369760291886, 5039.496050394931, 5138.948610513847, 5169.302144210484, 5191.0, 5210.166373380241, 4979.452260251442, 5014.623903207347, 5015.724135172601, 5021.49785021495, 5032.672876263031, 5008.173651347487, 5014.373203349582, 5024.145895197752, 5060.924086138637, 5073.568746656428, 4774.522547745198, 4931.605471562195, 4959.603231741524, 4990.575801056805, 4991.80032798684, 4841.8547443576745, 4925.285833554186, 5035.496450354935, 5043.924341134959, 5059.418166910705, 4946.169917130685, 4947.158982972831, 4954.3311652926395, 4961.578265847444, 4981.352424184833], "value": 3758.027193889621, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.6294432478624, 803.7829785957795, 812.5815205169339, 820.278155223404, 822.4900561651775, 10926.781464370717, 11325.830112548318, 11327.150463715214, 11345.716357091076, 11379.715507112316, 12086.274823510596, 12357.505699771998, 12397.44211510482, 12465.439055242514, 12518.374081295922, 865.5369377383086, 884.2174675412274, 884.7566919097235, 885.2519620920312, 885.4377470306338, 867.9566021698921, 880.1814312689196, 881.0528681667201, 881.8853549038616, 882.5587206396801, 917.3257655623112, 918.485648037098, 918.5085979001236, 919.0396036142214, 919.31511024287, 897.6319708919311, 906.8730377747121, 910.6721580231144, 911.5943405184695, 912.1927094521363, 669.8358902068976, 669.9196096468406, 669.9899501507481, 670.0016974707651, 670.1756839087949, 10515.842262365994, 10549.894501054969, 10578.153747700166, 10580.259381843274, 10647.733806654818, 9986.300958932878, 10122.746931326703, 10139.695809125738, 10149.949250253701, 10590.470476476145, 8662.740117796477, 8707.608157632922, 8844.73465796027, 8853.380263381567, 8932.240759535447, 3325.700686938187, 3344.147242453183, 3350.078728349699, 3402.727781777452, 3447.87932422364, 34782.65217347819, 34916.301673966635, 35746.64253357459, 38601.227975440335, 43242.783786080865, 9476.85784713216, 9512.714618561455, 9612.231021518262, 9614.855777163348, 9654.806903861883, 17200.569985750208, 17213.311467541407, 17217.13914304305, 17275.74086388705, 17277.56806079833, 5577.470140336662, 6056.303525094582, 6382.5851319665, 6411.871762564722, 6551.213854337415, 3578.3916734155255, 3634.83643236055, 3670.7981061041364, 3672.59601443841, 3706.944395834065, 2793.594928735322, 2883.1206482022767, 2898.9565156522667, 2911.344947386821, 2914.227729651644, 561.9550435965112, 589.8466398736274, 594.4441946779775, 601.7202001069523, 606.7997560804923, 593.6438137117694, 604.4167378479788, 610.0970563565947, 631.6873147791872, 640.2509064394669, 7538.133114691881, 7662.0, 7686.730964416219, 7898.249666281809, 7996.360291176692, 607.9726412311456, 625.6558892609047, 639.5107742576932, 640.8782331357028, 644.887144749667, 3797.6012518685693, 3801.7338786284695, 3834.2906562286066, 3846.1538461538416, 3911.0, 55202.17196742052, 55475.0, 55826.441735582936, 56213.0, 56256.15615765767, 50601.74699126481, 50750.238746418836, 51170.0, 51785.0, 51815.22277165845, 34873.0, 39688.80155599261, 43149.0, 43183.78408108002, 43510.78244608756, 7463.776086717407, 7704.075510938723, 7760.262775036363, 7765.7670269892, 7910.920890791019, 28808.0, 29056.418871622027, 29252.414951701274, 29505.11484655464, 29665.0, 37748.62251377561, 37800.81099594484, 38336.0, 38541.0, 38788.6121138785, 9968.202543796624, 10478.266521343738, 10588.947055264674, 10631.840522392326, 10697.358158510515, 11286.20996530235, 11396.373199473777, 11655.358955257543, 11829.17195796286, 11964.646514914502, 10426.0, 10701.385384765339, 10819.56721731122, 11060.336379817236, 11064.0, 11182.440877956233, 11327.0, 11694.415279236175, 11729.706757331134, 11846.881531184923, 10689.198310126616, 10722.946385268024, 11037.11703063737, 11069.114470842153, 11378.0, 8711.390202686005, 8822.33832462555, 9111.407758495676, 9435.38669986476, 9447.716568502956, 9342.95328523353, 9403.576839042396, 9408.294377921546, 9414.2468602513, 9438.292128090283], "value": 5913.778492192112, "unit": "score"}], "name": "dromaeo_css", "value": 6225.1445934349995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 114.0, 114.0, 113.0, 115.0, 114.0, 113.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 131.0, 153.0, 206.0, 138.0, 155.0, 160.0, 133.0, 192.0, 133.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 152.0, 77.0, 75.0, 76.0, 75.0, 127.0, 75.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 92.0, 147.0, 92.0, 93.0, 92.0, 129.0, 92.0, 92.0, 117.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 64.0, 65.0, 66.0, 67.0, 118.0, 64.0, 64.0], "value": 70.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 80.0, 85.0, 83.0, 80.0, 83.0, 82.0, 83.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 131.0, 132.0, 132.0, 129.0, 129.0, 137.0, 133.0, 195.0, 134.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 188.0, 173.0, 174.0, 173.0, 173.0, 174.0, 174.0, 169.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 71.0, 66.0, 69.0, 66.0, 66.0, 65.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1579.4, "alertThreshold": 2.0}]} 02:56:49 INFO - Return code: 0 02:56:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:56:49 ERROR - # TBPL SUCCESS # 02:56:49 INFO - Running post-action listener: _resource_record_post_action 02:56:49 INFO - ##### 02:56:49 INFO - ##### Finished run-tests step (success) 02:56:49 INFO - ##### 02:56:49 INFO - Running post-run listener: _resource_record_post_run 02:56:50 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 542629888; Read time: 16; Write time: 457908 02:56:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249131008; Read time: 0; Write time: 277056 02:56:50 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293498880; Read time: 16; Write time: 180852 02:56:50 INFO - Running post-run listener: _upload_blobber_files 02:56:50 INFO - Blob upload gear active. 02:56:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:56:50 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 02:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:56:51 INFO - (blobuploader) - INFO - Open directory for files ... 02:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:52 INFO - (blobuploader) - INFO - Done attempting. 02:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:56:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:53 INFO - (blobuploader) - INFO - Done attempting. 02:56:53 INFO - (blobuploader) - INFO - Iteration through files over. 02:56:53 INFO - Return code: 0 02:56:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:56:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:56:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59cf04ae7b26faa6961dd1db581d2c08949ec1d8975d80fdf390257541c2f8c6f25187f5749f9f409758bb033fc3c5b9f39fd01f746480011f130d1383d911da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73d25015d5f2421261eaa67dacfc79128b6422fe0b10f92a58bf1404222828dfc76a594e8024a5f351f03892684dcd378e1446930cab941b5f4adbd5b583725f"} 02:56:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:56:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:56:53 INFO - Contents: 02:56:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59cf04ae7b26faa6961dd1db581d2c08949ec1d8975d80fdf390257541c2f8c6f25187f5749f9f409758bb033fc3c5b9f39fd01f746480011f130d1383d911da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73d25015d5f2421261eaa67dacfc79128b6422fe0b10f92a58bf1404222828dfc76a594e8024a5f351f03892684dcd378e1446930cab941b5f4adbd5b583725f"} 02:56:53 INFO - Running post-run listener: copy_logs_to_upload_dir 02:56:53 INFO - Copying logs to upload dir... 02:56:53 INFO - mkdir: /builds/slave/test/build/upload/logs 02:56:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.030983 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-10 02:56:53.171920) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 02:56:53.175215) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59cf04ae7b26faa6961dd1db581d2c08949ec1d8975d80fdf390257541c2f8c6f25187f5749f9f409758bb033fc3c5b9f39fd01f746480011f130d1383d911da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73d25015d5f2421261eaa67dacfc79128b6422fe0b10f92a58bf1404222828dfc76a594e8024a5f351f03892684dcd378e1446930cab941b5f4adbd5b583725f"} build_url:https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/Di-Itjb9TN-ZphtdxJiiTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59cf04ae7b26faa6961dd1db581d2c08949ec1d8975d80fdf390257541c2f8c6f25187f5749f9f409758bb033fc3c5b9f39fd01f746480011f130d1383d911da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73d25015d5f2421261eaa67dacfc79128b6422fe0b10f92a58bf1404222828dfc76a594e8024a5f351f03892684dcd378e1446930cab941b5f4adbd5b583725f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 02:56:53.199962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:56:53.200298) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462872971.8965-2932641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:56:53.282594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 02:56:53.282943) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 02:56:53.283254) ========= ========= Total master_lag: 0.19 =========