builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1464969872.91 results: success (0) buildid: 20160603083311 builduid: 8077051f393c4a05963bea2a0cdf66ad revision: 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:32.911945) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:32.912447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:32.912740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:32.934078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:32.934429) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 09:04:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-06-03 09:04:32 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072378 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.022126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.022422) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015988 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.073010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.073354) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 --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 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 09:04:33,114 truncating revision to first 12 chars 2016-06-03 09:04:33,114 Setting DEBUG logging. 2016-06-03 09:04:33,114 attempt 1/10 2016-06-03 09:04:33,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e6dfa8fc2f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 09:04:33,398 unpacking tar archive at: fx-team-0e6dfa8fc2f4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.719528) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.719875) ========= script_repo_revision: 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.720403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.720720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:33.732212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-03 09:04:33.732720) ========= /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=aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:33 INFO - MultiFileLogger online at 20160603 09:04:33 in /builds/slave/test 09:04:33 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 09:04:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:33 INFO - {'append_to_log': False, 09:04:33 INFO - 'base_work_dir': '/builds/slave/test', 09:04:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:04:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:33 INFO - 'branch': 'Fx-Team-Non-PGO', 09:04:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:33 INFO - 'config_files': ('talos/linux_config.py',), 09:04:33 INFO - 'default_actions': ('clobber', 09:04:33 INFO - 'read-buildbot-config', 09:04:33 INFO - 'download-and-extract', 09:04:33 INFO - 'populate-webroot', 09:04:33 INFO - 'create-virtualenv', 09:04:33 INFO - 'install', 09:04:33 INFO - 'run-tests'), 09:04:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:33 INFO - 'download_minidump_stackwalk': True, 09:04:33 INFO - 'download_symbols': 'ondemand', 09:04:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:33 INFO - 'installer_path': 'installer.exe', 09:04:33 INFO - 'log_level': 'info', 09:04:33 INFO - 'log_name': 'talos', 09:04:33 INFO - 'log_to_console': True, 09:04:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:33 INFO - 'opt_config_files': (), 09:04:33 INFO - 'pip_index': False, 09:04:33 INFO - 'sps_profile': False, 09:04:33 INFO - 'sps_profile_interval': 0, 09:04:33 INFO - 'suite': 'dromaeojs', 09:04:33 INFO - 'system_bits': '32', 09:04:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:33 INFO - 'title': 'talos-linux64-ix-037', 09:04:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:33 INFO - 'use_talos_json': True, 09:04:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:33 INFO - 'work_dir': 'build'} 09:04:33 INFO - ##### 09:04:33 INFO - ##### Running clobber step. 09:04:33 INFO - ##### 09:04:33 INFO - Running pre-action listener: _resource_record_pre_action 09:04:33 INFO - Running main action method: clobber 09:04:33 INFO - rmtree: /builds/slave/test/build 09:04:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:34 INFO - Running post-action listener: _resource_record_post_action 09:04:34 INFO - ##### 09:04:34 INFO - ##### Finished clobber step (success) 09:04:34 INFO - ##### 09:04:34 INFO - ##### 09:04:34 INFO - ##### Running read-buildbot-config step. 09:04:34 INFO - ##### 09:04:34 INFO - Running pre-action listener: _resource_record_pre_action 09:04:34 INFO - Running main action method: read_buildbot_config 09:04:34 INFO - Using buildbot properties: 09:04:34 INFO - { 09:04:34 INFO - "project": "", 09:04:34 INFO - "product": "firefox", 09:04:34 INFO - "script_repo_revision": "production", 09:04:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:04:34 INFO - "repository": "", 09:04:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:04:34 INFO - "buildid": "20160603083311", 09:04:34 INFO - "pgo_build": "False", 09:04:34 INFO - "basedir": "/builds/slave/test", 09:04:34 INFO - "buildnumber": 1749, 09:04:34 INFO - "slavename": "talos-linux64-ix-037", 09:04:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:04:34 INFO - "platform": "ubuntu64_hw", 09:04:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:04:34 INFO - "branch": "fx-team", 09:04:34 INFO - "repo_path": "integration/fx-team", 09:04:34 INFO - "revision": "0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6", 09:04:34 INFO - "stage_platform": "linux64", 09:04:34 INFO - "builduid": "8077051f393c4a05963bea2a0cdf66ad", 09:04:34 INFO - "slavebuilddir": "test" 09:04:34 INFO - } 09:04:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:04:34 INFO - Running post-action listener: _resource_record_post_action 09:04:34 INFO - ##### 09:04:34 INFO - ##### Finished read-buildbot-config step (success) 09:04:34 INFO - ##### 09:04:34 INFO - ##### 09:04:34 INFO - ##### Running download-and-extract step. 09:04:34 INFO - ##### 09:04:34 INFO - Running pre-action listener: _resource_record_pre_action 09:04:34 INFO - Running main action method: download_and_extract 09:04:34 INFO - mkdir: /builds/slave/test/build/tests 09:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:34 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:34 INFO - Downloaded 1361 bytes. 09:04:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:34 INFO - Using the following test package requirements: 09:04:34 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:34 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:34 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:04:34 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:34 INFO - u'jsshell-linux-x86_64.zip'], 09:04:34 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:34 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:34 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:04:34 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:04:34 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:34 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:34 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:36 INFO - Downloaded 22868152 bytes. 09:04:36 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'] 09:04:36 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 09:04:37 INFO - Return code: 0 09:04:37 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 09:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:37 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:41 INFO - Downloaded 22868152 bytes. 09:04:41 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'] 09:04:41 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 09:04:42 INFO - Return code: 0 09:04: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')]} 09:04:42 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:43 INFO - Downloaded 10833369 bytes. 09:04:43 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'] 09:04:43 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 09:04:43 INFO - Return code: 0 09:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:43 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:04:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:45 INFO - Downloaded 55169581 bytes. 09:04:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:45 INFO - mkdir: /builds/slave/test/properties 09:04:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:45 INFO - Contents: 09:04:45 INFO - build_url:https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:45 INFO - Running post-action listener: _resource_record_post_action 09:04:45 INFO - Running post-action listener: set_extra_try_arguments 09:04:45 INFO - ##### 09:04:45 INFO - ##### Finished download-and-extract step (success) 09:04:45 INFO - ##### 09:04:45 INFO - ##### 09:04:45 INFO - ##### Running populate-webroot step. 09:04:45 INFO - ##### 09:04:45 INFO - Running pre-action listener: _resource_record_pre_action 09:04:45 INFO - Running main action method: populate_webroot 09:04:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:45 INFO - '--tppagecycles', 09:04:45 INFO - '7'], 09:04:45 INFO - 'tests': ['tsvgm']}}, 09:04:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:45 INFO - 'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:45 INFO - 'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['damp', 'tps']}, 09:04:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:45 INFO - 'tests': ['damp', 'tps']}, 09:04:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['dromaeo_dom']}, 09:04:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['a11yr', 09:04:45 INFO - 'ts_paint', 09:04:45 INFO - 'tpaint', 09:04:45 INFO - 'sessionrestore', 09:04:45 INFO - 'sessionrestore_no_auto_restore', 09:04:45 INFO - 'tabpaint']}, 09:04:45 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:45 INFO - 'ts_paint', 09:04:45 INFO - 'tpaint', 09:04:45 INFO - 'sessionrestore', 09:04:45 INFO - 'sessionrestore_no_auto_restore', 09:04:45 INFO - 'tabpaint']}, 09:04:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:45 INFO - 'ts_paint', 09:04:45 INFO - 'tpaint', 09:04:45 INFO - 'sessionrestore', 09:04:45 INFO - 'sessionrestore_no_auto_restore', 09:04:45 INFO - 'tabpaint']}, 09:04:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:45 INFO - 'ts_paint', 09:04:45 INFO - 'tpaint', 09:04:45 INFO - 'sessionrestore', 09:04:45 INFO - 'sessionrestore_no_auto_restore', 09:04:45 INFO - 'tabpaint']}, 09:04:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['a11yr', 09:04:45 INFO - 'ts_paint', 09:04:45 INFO - 'tpaint', 09:04:45 INFO - 'sessionrestore', 09:04:45 INFO - 'sessionrestore_no_auto_restore', 09:04:45 INFO - 'tabpaint']}, 09:04:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['a11yr', 09:04:45 INFO - 'ts_paint', 09:04:45 INFO - 'tpaint', 09:04:45 INFO - 'sessionrestore', 09:04:45 INFO - 'sessionrestore_no_auto_restore', 09:04:45 INFO - 'tabpaint']}, 09:04:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['tsvgx', 09:04:45 INFO - 'tsvgr_opacity', 09:04:45 INFO - 'tart', 09:04:45 INFO - 'tscrollx', 09:04:45 INFO - 'cart']}, 09:04:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:45 INFO - 'tsvgr_opacity', 09:04:45 INFO - 'tart', 09:04:45 INFO - 'tscrollx', 09:04:45 INFO - 'cart']}, 09:04:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:45 INFO - 'talos_options': ['--disable-e10s'], 09:04:45 INFO - 'tests': ['tp5o']}, 09:04:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:45 INFO - 'tests': ['tp5o']}, 09:04:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:45 INFO - 'talos_options': ['--disable-e10s', 09:04:45 INFO - '--xperf_path', 09:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:45 INFO - 'tests': ['tp5n']}, 09:04:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:45 INFO - 'talos_options': ['--xperf_path', 09:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:45 INFO - 'tests': ['tp5n']}}, 09:04:45 INFO - 'talos.zip': {'path': '', 09:04:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:45 INFO - Running post-action listener: _resource_record_post_action 09:04:45 INFO - ##### 09:04:45 INFO - ##### Finished populate-webroot step (success) 09:04:45 INFO - ##### 09:04:45 INFO - ##### 09:04:45 INFO - ##### Running create-virtualenv step. 09:04:45 INFO - ##### 09:04:45 INFO - Running pre-action listener: _resource_record_pre_action 09:04:45 INFO - Running main action method: create_virtualenv 09:04:45 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:45 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 09:04:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:46 INFO - Using real prefix '/usr' 09:04:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:46 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:48 INFO - Installing pip.................done. 09:04:48 INFO - Return code: 0 09:04:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 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 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:04:48 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 09:04:48 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 09:04:48 INFO - Using env: {'DISPLAY': ':0', 09:04:48 INFO - 'HOME': '/home/cltbld', 09:04:48 INFO - 'LANG': 'en_US.UTF-8', 09:04:48 INFO - 'LANGUAGE': 'en_US:en', 09:04:48 INFO - 'LOGNAME': 'cltbld', 09:04:48 INFO - 'MAIL': '/var/mail/cltbld', 09:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:48 INFO - 'MOZ_NO_REMOTE': '1', 09:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:48 INFO - 'NO_EM_RESTART': '1', 09:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:48 INFO - 'PWD': '/builds/slave/test', 09:04:48 INFO - 'SHELL': '/bin/bash', 09:04:48 INFO - 'SHLVL': '1', 09:04:48 INFO - 'TERM': 'linux', 09:04:48 INFO - 'TMOUT': '86400', 09:04:48 INFO - 'USER': 'cltbld', 09:04:48 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:48 INFO - '_': '/tools/buildbot/bin/python'} 09:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:48 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 09:04:48 INFO - Cleaning up... 09:04:48 INFO - Return code: 0 09:04:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:04:48 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>=3.1.1'] in /builds/slave/test/build 09:04:48 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>=3.1.1 09:04:48 INFO - Using env: {'DISPLAY': ':0', 09:04:48 INFO - 'HOME': '/home/cltbld', 09:04:48 INFO - 'LANG': 'en_US.UTF-8', 09:04:48 INFO - 'LANGUAGE': 'en_US:en', 09:04:48 INFO - 'LOGNAME': 'cltbld', 09:04:48 INFO - 'MAIL': '/var/mail/cltbld', 09:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:48 INFO - 'MOZ_NO_REMOTE': '1', 09:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:48 INFO - 'NO_EM_RESTART': '1', 09:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:48 INFO - 'PWD': '/builds/slave/test', 09:04:48 INFO - 'SHELL': '/bin/bash', 09:04:48 INFO - 'SHLVL': '1', 09:04:48 INFO - 'TERM': 'linux', 09:04:48 INFO - 'TMOUT': '86400', 09:04:48 INFO - 'USER': 'cltbld', 09:04:48 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:48 INFO - '_': '/tools/buildbot/bin/python'} 09:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:48 INFO - Downloading/unpacking psutil>=3.1.1 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:50 INFO - Installing collected packages: psutil 09:04:50 INFO - Running setup.py install for psutil 09:04:51 INFO - building 'psutil._psutil_linux' extension 09:04:51 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 09:04:51 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 09:04:51 INFO - building 'psutil._psutil_posix' extension 09:04:51 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 09:04:51 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 09:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:51 INFO - Successfully installed psutil 09:04:51 INFO - Cleaning up... 09:04:51 INFO - Return code: 0 09:04:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:51 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:04:51 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.3'] in /builds/slave/test/build 09:04:51 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.3 09:04:51 INFO - Using env: {'DISPLAY': ':0', 09:04:51 INFO - 'HOME': '/home/cltbld', 09:04:51 INFO - 'LANG': 'en_US.UTF-8', 09:04:51 INFO - 'LANGUAGE': 'en_US:en', 09:04:51 INFO - 'LOGNAME': 'cltbld', 09:04:51 INFO - 'MAIL': '/var/mail/cltbld', 09:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:51 INFO - 'MOZ_NO_REMOTE': '1', 09:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:51 INFO - 'NO_EM_RESTART': '1', 09:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:51 INFO - 'PWD': '/builds/slave/test', 09:04:51 INFO - 'SHELL': '/bin/bash', 09:04:51 INFO - 'SHLVL': '1', 09:04:51 INFO - 'TERM': 'linux', 09:04:51 INFO - 'TMOUT': '86400', 09:04:51 INFO - 'USER': 'cltbld', 09:04:51 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:51 INFO - '_': '/tools/buildbot/bin/python'} 09:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:04:53 INFO - Installing collected packages: mozsystemmonitor 09:04:53 INFO - Running setup.py install for mozsystemmonitor 09:04:53 INFO - Successfully installed mozsystemmonitor 09:04:53 INFO - Cleaning up... 09:04:53 INFO - Return code: 0 09:04:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:53 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:04:53 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==2.5.1'] in /builds/slave/test/build 09:04:53 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==2.5.1 09:04:53 INFO - Using env: {'DISPLAY': ':0', 09:04:53 INFO - 'HOME': '/home/cltbld', 09:04:53 INFO - 'LANG': 'en_US.UTF-8', 09:04:53 INFO - 'LANGUAGE': 'en_US:en', 09:04:53 INFO - 'LOGNAME': 'cltbld', 09:04:53 INFO - 'MAIL': '/var/mail/cltbld', 09:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:53 INFO - 'MOZ_NO_REMOTE': '1', 09:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:53 INFO - 'NO_EM_RESTART': '1', 09:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:53 INFO - 'PWD': '/builds/slave/test', 09:04:53 INFO - 'SHELL': '/bin/bash', 09:04:53 INFO - 'SHLVL': '1', 09:04:53 INFO - 'TERM': 'linux', 09:04:53 INFO - 'TMOUT': '86400', 09:04:53 INFO - 'USER': 'cltbld', 09:04:53 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:53 INFO - '_': '/tools/buildbot/bin/python'} 09:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:53 INFO - Downloading/unpacking jsonschema==2.5.1 09:04:53 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 09:04:53 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 09:04:53 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 09:04:53 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 09:04:53 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 09:04:53 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 09:04:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:04:55 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 09:04:55 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 09:04:55 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 09:04:55 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 09:04:55 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 09:04:55 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 09:04:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:56 INFO - warning: no files found matching '*.txt' 09:04:56 INFO - no previously-included directories found matching 'build' 09:04:56 INFO - no previously-included directories found matching 'dist' 09:04:56 INFO - no previously-included directories found matching '.git*' 09:04:56 INFO - Installing collected packages: jsonschema, functools32 09:04:56 INFO - Running setup.py install for functools32 09:04:56 INFO - warning: no files found matching '*.txt' 09:04:56 INFO - no previously-included directories found matching 'build' 09:04:56 INFO - no previously-included directories found matching 'dist' 09:04:56 INFO - no previously-included directories found matching '.git*' 09:04:56 INFO - Successfully installed jsonschema functools32 09:04:56 INFO - Cleaning up... 09:04:56 INFO - Return code: 0 09:04:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:04:56 INFO - Using env: {'DISPLAY': ':0', 09:04:56 INFO - 'HOME': '/home/cltbld', 09:04:56 INFO - 'LANG': 'en_US.UTF-8', 09:04:56 INFO - 'LANGUAGE': 'en_US:en', 09:04:56 INFO - 'LOGNAME': 'cltbld', 09:04:56 INFO - 'MAIL': '/var/mail/cltbld', 09:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:56 INFO - 'MOZ_NO_REMOTE': '1', 09:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:56 INFO - 'NO_EM_RESTART': '1', 09:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:56 INFO - 'PWD': '/builds/slave/test', 09:04:56 INFO - 'SHELL': '/bin/bash', 09:04:56 INFO - 'SHLVL': '1', 09:04:56 INFO - 'TERM': 'linux', 09:04:56 INFO - 'TMOUT': '86400', 09:04:56 INFO - 'USER': 'cltbld', 09:04:56 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:56 INFO - '_': '/tools/buildbot/bin/python'} 09:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:58 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 09:04:58 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 09:04:58 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 09:04:58 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 09:04:58 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 09:04:58 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 09:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:58 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 09:04:58 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 09:04:58 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 09:04:58 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 09:04:58 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 09:04:58 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 09:04:59 INFO - Downloading docopt-0.6.1.tar.gz 09:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:59 INFO - Running setup.py install for blobuploader 09:04:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:59 INFO - Running setup.py install for requests 09:04:59 INFO - Running setup.py install for docopt 09:04:59 INFO - Successfully installed blobuploader requests docopt 09:04:59 INFO - Cleaning up... 09:04:59 INFO - Return code: 0 09:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:59 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 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:04:59 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 09:04:59 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 09:04:59 INFO - Using env: {'DISPLAY': ':0', 09:04:59 INFO - 'HOME': '/home/cltbld', 09:04:59 INFO - 'LANG': 'en_US.UTF-8', 09:04:59 INFO - 'LANGUAGE': 'en_US:en', 09:04:59 INFO - 'LOGNAME': 'cltbld', 09:04:59 INFO - 'MAIL': '/var/mail/cltbld', 09:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:59 INFO - 'MOZ_NO_REMOTE': '1', 09:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:59 INFO - 'NO_EM_RESTART': '1', 09:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:59 INFO - 'PWD': '/builds/slave/test', 09:04:59 INFO - 'SHELL': '/bin/bash', 09:04:59 INFO - 'SHLVL': '1', 09:04:59 INFO - 'TERM': 'linux', 09:04:59 INFO - 'TMOUT': '86400', 09:04:59 INFO - 'USER': 'cltbld', 09:04:59 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:59 INFO - '_': '/tools/buildbot/bin/python'} 09:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:00 INFO - Running setup.py (path:/tmp/pip-A30Ndm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:00 INFO - Running setup.py (path:/tmp/pip-e1KtuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:00 INFO - Running setup.py (path:/tmp/pip-gmAEEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:00 INFO - Running setup.py (path:/tmp/pip-_BxbEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:00 INFO - Running setup.py (path:/tmp/pip-O59LSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:00 INFO - Running setup.py (path:/tmp/pip-Vd_wd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:00 INFO - Running setup.py (path:/tmp/pip-eiMMZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:00 INFO - Running setup.py (path:/tmp/pip-s2gRQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:00 INFO - Running setup.py (path:/tmp/pip-V6jDk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:00 INFO - Running setup.py (path:/tmp/pip-BexaBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:00 INFO - Running setup.py (path:/tmp/pip-VtTP39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:00 INFO - Running setup.py (path:/tmp/pip-BeUdL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:00 INFO - Running setup.py (path:/tmp/pip-03dNI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:00 INFO - Running setup.py (path:/tmp/pip-KY1Hg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:01 INFO - Running setup.py (path:/tmp/pip-Mg02M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:01 INFO - Running setup.py (path:/tmp/pip-tjWLGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:01 INFO - Running setup.py (path:/tmp/pip-FGRx4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:01 INFO - Running setup.py install for manifestparser 09:05:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:01 INFO - Running setup.py install for mozcrash 09:05:01 INFO - Running setup.py install for mozdebug 09:05:01 INFO - Running setup.py install for mozdevice 09:05:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:01 INFO - Running setup.py install for mozfile 09:05:01 INFO - Running setup.py install for mozhttpd 09:05:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:01 INFO - Running setup.py install for mozinfo 09:05:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:01 INFO - Running setup.py install for mozInstall 09:05:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Running setup.py install for mozleak 09:05:02 INFO - Running setup.py install for mozlog 09:05:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Running setup.py install for moznetwork 09:05:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Running setup.py install for mozprocess 09:05:02 INFO - Running setup.py install for mozprofile 09:05:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Running setup.py install for mozrunner 09:05:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:02 INFO - Running setup.py install for mozscreenshot 09:05:02 INFO - Running setup.py install for moztest 09:05:02 INFO - Running setup.py install for mozversion 09:05:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:03 INFO - Cleaning up... 09:05:03 INFO - Return code: 0 09:05:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:03 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')]} 09:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:03 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')]} 09:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:03 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 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:05:03 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 09:05:03 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 09:05:03 INFO - Using env: {'DISPLAY': ':0', 09:05:03 INFO - 'HOME': '/home/cltbld', 09:05:03 INFO - 'LANG': 'en_US.UTF-8', 09:05:03 INFO - 'LANGUAGE': 'en_US:en', 09:05:03 INFO - 'LOGNAME': 'cltbld', 09:05:03 INFO - 'MAIL': '/var/mail/cltbld', 09:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:03 INFO - 'MOZ_NO_REMOTE': '1', 09:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:03 INFO - 'NO_EM_RESTART': '1', 09:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:03 INFO - 'PWD': '/builds/slave/test', 09:05:03 INFO - 'SHELL': '/bin/bash', 09:05:03 INFO - 'SHLVL': '1', 09:05:03 INFO - 'TERM': 'linux', 09:05:03 INFO - 'TMOUT': '86400', 09:05:03 INFO - 'USER': 'cltbld', 09:05:03 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:03 INFO - '_': '/tools/buildbot/bin/python'} 09:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:03 INFO - Running setup.py (path:/tmp/pip-bNj5RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:03 INFO - Running setup.py (path:/tmp/pip-hLzfdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:03 INFO - Running setup.py (path:/tmp/pip-Rg3hIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:03 INFO - Running setup.py (path:/tmp/pip-exisWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:03 INFO - Running setup.py (path:/tmp/pip-DolAf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:03 INFO - Running setup.py (path:/tmp/pip-TA3nw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:03 INFO - Running setup.py (path:/tmp/pip-MZQ17p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:03 INFO - Running setup.py (path:/tmp/pip-OOpnLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:03 INFO - Running setup.py (path:/tmp/pip-sCvmSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:03 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:03 INFO - Running setup.py (path:/tmp/pip-bLax9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 09:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:03 INFO - Running setup.py (path:/tmp/pip-BS80UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:04 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)) 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:04 INFO - Running setup.py (path:/tmp/pip-BGQeBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:04 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)) 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:04 INFO - Running setup.py (path:/tmp/pip-RIOEMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:04 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)) 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:04 INFO - Running setup.py (path:/tmp/pip-DiMd3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:04 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)) 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:04 INFO - Running setup.py (path:/tmp/pip-629k65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:04 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)) 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:04 INFO - Running setup.py (path:/tmp/pip-68IOPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:04 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)) 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:04 INFO - Running setup.py (path:/tmp/pip-Ja9F5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:04 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)) 09:05:04 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)) 09:05:04 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)) 09:05:04 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)) 09:05:04 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)) 09:05:04 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)) 09:05:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:06 INFO - Downloading blessings-1.6.tar.gz 09:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:06 INFO - Installing collected packages: blessings 09:05:06 INFO - Running setup.py install for blessings 09:05:06 INFO - Successfully installed blessings 09:05:06 INFO - Cleaning up... 09:05:06 INFO - Return code: 0 09:05:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:06 INFO - Reading from file tmpfile_stdout 09:05:06 INFO - Current package versions: 09:05:06 INFO - argparse == 1.2.1 09:05:06 INFO - blessings == 1.6 09:05:06 INFO - blobuploader == 1.2.4 09:05:06 INFO - docopt == 0.6.1 09:05:06 INFO - functools32 == 3.2.3-2 09:05:06 INFO - jsonschema == 2.5.1 09:05:06 INFO - manifestparser == 1.1 09:05:06 INFO - mozInstall == 1.12 09:05:06 INFO - mozcrash == 0.17 09:05:06 INFO - mozdebug == 0.1 09:05:06 INFO - mozdevice == 0.48 09:05:06 INFO - mozfile == 1.2 09:05:06 INFO - mozhttpd == 0.7 09:05:06 INFO - mozinfo == 0.9 09:05:06 INFO - mozleak == 0.1 09:05:06 INFO - mozlog == 3.2 09:05:06 INFO - moznetwork == 0.27 09:05:06 INFO - mozprocess == 0.22 09:05:06 INFO - mozprofile == 0.28 09:05:06 INFO - mozrunner == 6.11 09:05:06 INFO - mozscreenshot == 0.1 09:05:06 INFO - mozsystemmonitor == 0.3 09:05:06 INFO - moztest == 0.7 09:05:06 INFO - mozversion == 1.4 09:05:06 INFO - psutil == 3.1.1 09:05:06 INFO - requests == 1.2.3 09:05:06 INFO - wsgiref == 0.1.2 09:05:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:06 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 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:05:06 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 09:05:06 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 09:05:06 INFO - Using env: {'DISPLAY': ':0', 09:05:06 INFO - 'HOME': '/home/cltbld', 09:05:06 INFO - 'LANG': 'en_US.UTF-8', 09:05:06 INFO - 'LANGUAGE': 'en_US:en', 09:05:06 INFO - 'LOGNAME': 'cltbld', 09:05:06 INFO - 'MAIL': '/var/mail/cltbld', 09:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:06 INFO - 'MOZ_NO_REMOTE': '1', 09:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:06 INFO - 'NO_EM_RESTART': '1', 09:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:06 INFO - 'PWD': '/builds/slave/test', 09:05:06 INFO - 'SHELL': '/bin/bash', 09:05:06 INFO - 'SHLVL': '1', 09:05:06 INFO - 'TERM': 'linux', 09:05:06 INFO - 'TMOUT': '86400', 09:05:06 INFO - 'USER': 'cltbld', 09:05:06 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:06 INFO - '_': '/tools/buildbot/bin/python'} 09:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 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)) 09:05:07 INFO - Cleaning up... 09:05:07 INFO - Return code: 0 09:05:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:07 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')]} 09:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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')]} 09:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:05:07 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 09:05:07 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 09:05:07 INFO - Using env: {'DISPLAY': ':0', 09:05:07 INFO - 'HOME': '/home/cltbld', 09:05:07 INFO - 'LANG': 'en_US.UTF-8', 09:05:07 INFO - 'LANGUAGE': 'en_US:en', 09:05:07 INFO - 'LOGNAME': 'cltbld', 09:05:07 INFO - 'MAIL': '/var/mail/cltbld', 09:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:07 INFO - 'MOZ_NO_REMOTE': '1', 09:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:07 INFO - 'NO_EM_RESTART': '1', 09:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:07 INFO - 'PWD': '/builds/slave/test', 09:05:07 INFO - 'SHELL': '/bin/bash', 09:05:07 INFO - 'SHLVL': '1', 09:05:07 INFO - 'TERM': 'linux', 09:05:07 INFO - 'TMOUT': '86400', 09:05:07 INFO - 'USER': 'cltbld', 09:05:07 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:07 INFO - '_': '/tools/buildbot/bin/python'} 09:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:07 INFO - Cleaning up... 09:05:07 INFO - Return code: 0 09:05:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:05:07 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')]} 09:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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')]} 09:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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 0x7f89660d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', '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 09:05:07 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 09:05:07 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 09:05:07 INFO - Using env: {'DISPLAY': ':0', 09:05:07 INFO - 'HOME': '/home/cltbld', 09:05:07 INFO - 'LANG': 'en_US.UTF-8', 09:05:07 INFO - 'LANGUAGE': 'en_US:en', 09:05:07 INFO - 'LOGNAME': 'cltbld', 09:05:07 INFO - 'MAIL': '/var/mail/cltbld', 09:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:07 INFO - 'MOZ_NO_REMOTE': '1', 09:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:07 INFO - 'NO_EM_RESTART': '1', 09:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:07 INFO - 'PWD': '/builds/slave/test', 09:05:07 INFO - 'SHELL': '/bin/bash', 09:05:07 INFO - 'SHLVL': '1', 09:05:07 INFO - 'TERM': 'linux', 09:05:07 INFO - 'TMOUT': '86400', 09:05:07 INFO - 'USER': 'cltbld', 09:05:07 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:07 INFO - '_': '/tools/buildbot/bin/python'} 09:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:07 INFO - Downloading/unpacking flake8 09:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:05:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:05:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:10 INFO - no previously-included directories found matching 'docs/_build' 09:05:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:05:10 INFO - Running setup.py install for pep8 09:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:10 INFO - no previously-included directories found matching 'docs/_build' 09:05:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:05:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:05:10 INFO - Cleaning up... 09:05:10 INFO - Return code: 0 09:05:10 INFO - Running post-action listener: _resource_record_post_action 09:05:10 INFO - Running post-action listener: _start_resource_monitoring 09:05:10 INFO - Starting resource monitoring. 09:05:10 INFO - ##### 09:05:10 INFO - ##### Finished create-virtualenv step (success) 09:05:10 INFO - ##### 09:05:10 INFO - ##### 09:05:10 INFO - ##### Running install step. 09:05:10 INFO - ##### 09:05:10 INFO - Running pre-action listener: _resource_record_pre_action 09:05:10 INFO - Running main action method: install 09:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:10 INFO - Reading from file tmpfile_stdout 09:05:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:10 INFO - Reading from file tmpfile_stdout 09:05:10 INFO - Output received: 09:05:10 INFO - Usage: mozinstall [options] installer 09:05:10 INFO - Options: 09:05:10 INFO - -h, --help show this help message and exit 09:05:10 INFO - -d DEST, --destination=DEST 09:05:10 INFO - Directory to install application into. [default: 09:05:10 INFO - "/builds/slave/test"] 09:05:10 INFO - --app=APP Application being installed. [default: firefox] 09:05:10 INFO - mkdir: /builds/slave/test/build/application 09:05:10 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'] 09:05:10 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 09:05:26 INFO - Reading from file tmpfile_stdout 09:05:26 INFO - Output received: 09:05:26 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:26 INFO - Running post-action listener: _resource_record_post_action 09:05:26 INFO - ##### 09:05:26 INFO - ##### Finished install step (success) 09:05:26 INFO - ##### 09:05:26 INFO - ##### 09:05:26 INFO - ##### Running run-tests step. 09:05:26 INFO - ##### 09:05:26 INFO - Running pre-action listener: _resource_record_pre_action 09:05:26 INFO - Running main action method: run_tests 09:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:26 INFO - Python 2.7.3 09:05:26 INFO - Return code: 0 09:05:26 INFO - grabbing minidump binary from tooltool 09:05: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')]} 09:05:26 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18001c0>, '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 0x18010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:26 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 09:05:26 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 09:05:26 INFO - Calling ['/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'] with output_timeout 600 09:05:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:26 INFO - Return code: 0 09:05:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:05:27 INFO - Return code: 0 09:05:27 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/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:05:27 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/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:05:27 INFO - Using env: {'DISPLAY': ':0', 09:05:27 INFO - 'HOME': '/home/cltbld', 09:05:27 INFO - 'LANG': 'en_US.UTF-8', 09:05:27 INFO - 'LANGUAGE': 'en_US:en', 09:05:27 INFO - 'LOGNAME': 'cltbld', 09:05:27 INFO - 'MAIL': '/var/mail/cltbld', 09:05:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:27 INFO - 'MOZ_NO_REMOTE': '1', 09:05:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:27 INFO - 'NO_EM_RESTART': '1', 09:05:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:27 INFO - 'PWD': '/builds/slave/test', 09:05:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:27 INFO - 'SHELL': '/bin/bash', 09:05:27 INFO - 'SHLVL': '1', 09:05:27 INFO - 'TERM': 'linux', 09:05:27 INFO - 'TMOUT': '86400', 09:05:27 INFO - 'USER': 'cltbld', 09:05:27 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854', 09:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:27 INFO - '_': '/tools/buildbot/bin/python'} 09:05:27 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/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:05:27 INFO - mozversion application_buildid: 20160603083311 09:05:27 INFO - mozversion application_changeset: 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 09:05:27 INFO - mozversion application_display_name: Nightly 09:05:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:27 INFO - mozversion application_name: Firefox 09:05:27 INFO - mozversion application_remotingname: firefox 09:05:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:05:27 INFO - mozversion application_vendor: Mozilla 09:05:27 INFO - mozversion application_version: 49.0a1 09:05:27 INFO - mozversion platform_buildid: 20160603083311 09:05:27 INFO - mozversion platform_changeset: 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 09:05:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:05:27 INFO - mozversion platform_version: 49.0a1 09:05:27 INFO - using testdate: 1464969927 09:05:27 INFO - actual date: 1464969927 09:05:27 INFO - starting webserver on 'localhost:34411' 09:05:27 INFO - SUITE-START | Running 2 tests 09:05:27 INFO - TEST-START | dromaeo_css 09:05:27 INFO - operating with platform_type : linux_ 09:05:27 INFO - Initialising browser for dromaeo_css test... 09:05:27 INFO - TEST-INFO | started process 6054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLVHL3l/profile http://localhost:34411/getInfo.html) 09:05:32 INFO - PROCESS | 6054 | __metrics Screen width/height:1600/1200 09:05:32 INFO - PROCESS | 6054 | colorDepth:24 09:05:32 INFO - PROCESS | 6054 | Browser inner width/height: 1024/697 09:05:32 INFO - PROCESS | 6054 | __metrics 09:05:33 ERROR - PROCESS | 6054 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:05:34 INFO - TEST-INFO | 6054: exit 0 09:05:34 INFO - Browser initialized. 09:05:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:34 INFO - TEST-INFO | started process 6136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLVHL3l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:46 INFO - PROCESS | 6136 | RSS: Main: 158146560 09:05:46 INFO - PROCESS | 6136 | 09:06:37 INFO - PROCESS | 6136 | 1464969997852 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] 09:08:49 INFO - PROCESS | 6136 | Cycle 1(1): loaded http://localhost:34411/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34411/tests/dromaeo/cssquery-ext.html) 09:08:50 INFO - PROCESS | 6136 | RSS: Main: 271155200 09:08:50 INFO - PROCESS | 6136 | 09:11:53 INFO - PROCESS | 6136 | Cycle 1(1): loaded http://localhost:34411/tests/dromaeo/cssquery-ext.html (next: http://localhost:34411/tests/dromaeo/cssquery-jquery.html) 09:11:53 INFO - PROCESS | 6136 | RSS: Main: 242073600 09:11:53 INFO - PROCESS | 6136 | 09:14:55 INFO - PROCESS | 6136 | Cycle 1(1): loaded http://localhost:34411/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34411/tests/dromaeo/cssquery-mootools.html) 09:14:56 INFO - PROCESS | 6136 | RSS: Main: 245743616 09:14:56 INFO - PROCESS | 6136 | 09:17:58 INFO - PROCESS | 6136 | Cycle 1(1): loaded http://localhost:34411/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34411/tests/dromaeo/cssquery-prototype.html) 09:17:59 INFO - PROCESS | 6136 | RSS: Main: 242565120 09:17:59 INFO - PROCESS | 6136 | 09:21:02 INFO - PROCESS | 6136 | Cycle 1(1): loaded http://localhost:34411/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34411/tests/dromaeo/cssquery-yui.html) 09:21:02 INFO - PROCESS | 6136 | RSS: Main: 214904832 09:21:02 INFO - PROCESS | 6136 | 09:24:05 INFO - PROCESS | 6136 | Cycle 1(1): loaded http://localhost:34411/tests/dromaeo/cssquery-yui.html (next: http://localhost:34411/tests/dromaeo/cssquery-dojo.html) 09:24:06 INFO - PROCESS | 6136 | RSS: Main: 294129664 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - PROCESS | 6136 | __start_tp_report 09:24:06 INFO - PROCESS | 6136 | _x_x_mozilla_page_load 09:24:06 INFO - PROCESS | 6136 | _x_x_mozilla_page_load_details 09:24:06 INFO - PROCESS | 6136 | |i|pagename|runs| 09:24:06 INFO - PROCESS | 6136 | |0;dojo.html;2667.9866600666996;2705.2290097322266;2727.5226835303815;2738.397552538441;2744.807863449559;4565.520620334867;4611.746353950532;4708.882277943053;4786.377770889784;4841.322214889914;4685.180093483644;4700.318453824202;4759.928601070987;4821.083994041139;4834.468208497063;4328.264195086843;4342.630876375511;4346.065595896882;4383.057642606839;4476.37330773692;4381.474223093233;4431.246688063037;4435.246008178601;4438.97780511097;4488.528704486031;4293.463317085364;4388.539203383662;4407.184670835905;4435.090806384684;4440.511543730203;4291.0774183550375;4304.9139017219795;4310.31035034393;4318.762468064255;4326.891827704332;4277.230098582254;4320.848770293056;4340.587644173798;4354.7604881731495;4393.868183954486;4491.663125265618;4684.601808846252;4697.906041879143;4704.082703872747;4714.363560919301;5017.64876458648;5060.898782024376;5077.5684066854365;5138.794448222066;5160.071187186305;5155.484451554852;5157.7936882524655;5158.148905430599;5158.380994280673;5164.92252616211;4633.119707255678;4720.834770783006;4791.161546729309;4803.975980120077;4848.345473361122;5145.691258524501;5207.6875387476875;5271.499207575274;5273.789048438096;5293.788248470095;5006.123928312531;5021.949780502148;5059.721715305694;5059.822906198339;5074.13739664258;4954.083494553519;5038.571721403721;5093.108705976513;5103.362079740033;5107.897842043212;5026.145555255615;5041.899162016739;5053.545180933734;5056.241563765391;5097.566706829887;5022.171341728647;5044.319016932741;5047.192449208183;5059.671121377099;5086.669366491166;4191.8532851350055;4227.260229459832;4229.703920725519;4262.083652014831;4317.481902171759;3718.4794128821986;3736.0099573613015;3741.8877433677035;3766.3408903441787;3797.696184305249;4360.607545320873;4365.650747940157;4367.323064924942;4412.536683648235;4419.337099435046;4983.775730092155;5107.540321371094;5116.513931176607;5160.251763494272;5169.508896654812;4412.735235885857;4438.223310920576;4471.552844715502;4479.955200448019;4489.191945449785;4641.953580464152;4645.605123564467;4649.023705021916;4653.744044077541;4695.060987802453;4646.1869172895285;4789.856304310876;4817.494163112823;4871.658983871095;4873.853784386474;5157.200633901752;5162.174052151638;5177.171652535576;5177.197534382177;5189.636725429335;4810.6151507878585;4831.0820944020525;4833.73414462208;4860.3753972854265;4882.60939124862;4916.06594746997;4978.8257410990445;5021.246812978083;5029.4216165140015;5130.025295193901;5105.566026887756;5131.666441681279;5134.8973020540125;5135.7432128394175;5170.5346518813485;4979.626528010342;4980;4981.37732783402;4982.850514484571;4986.700797952134;4835.854924352275;4836.782344794563;4842.394700662418;4868.732219727949;4894.143524883202;4764.78558464863;4803.351547541037;4861.854144375674;4867.9269810952155;4869.147899117569;4867.9269810952155;4934.580560652241;4947.480514546065;4985.077760614298;5001.799928002984;4767.594754445772;4852.80588776445;4885.804567817389;4942.406911170682;4942.6293028023765 09:24:06 INFO - PROCESS | 6136 | |1;ext.html;544.6949708163429;590.9054551271797;593.7654626422564;598.6647477412648;610.590904094257;27318;40397;41067.79466102669;41131.794341028326;41236.38145427821;41038.794806026;41609.79195104028;41633.58366416342;41658;41774.58225417745;7757.806054848617;7961.920380796176;7963.96018019912;7965.084015338252;7968.362530997535;7756.224377562226;7882.921170788305;7885.093214280345;7887.329576985963;7894.960525197366;7943.324817390529;7997.2402621751135;7998.360131189491;7998.960005199966;8001.479903806234;7881.054273487161;7913.525188488709;7930.682772689114;7936.44444888858;7941.483803552751;7607.505512141693;7666.9616651916385;7667.8849817252785;7668.65491052904;7676.53940763556;37704.24591508154;38208.80895595504;38251.80874095612;38283;38318.61681383178;3136.341368312657;3197.600299962505;3234.886778962725;3477.8608855645743;3660.963390366089;29241.41517169666;29669.145166924583;29734.553981690293;30155.69844301551;30559.541606875915;3160.225744692542;3204.439223135942;3227.6772322767533;3239.271163988084;3291.8847840325475;177995;178421;178704;179335;179670;31980.520292195637;51760.48239517632;52053.7397313011;52074.47925520772;52261;32930.17674558155;34773.82613086919;34778.652213478046;34781.30437391238;34854.30291394158;12157.939210304068;12174.878251217375;12205.02359811213;12228.144029917998;12231.388430578436;10321.84517232242;10398.636047738293;10418.68743937683;10423.374597524022;10433.113185379176;7951.522908625385;7993.240642138988;8008.079070906804;8017.599120043975;8098.31164351025;3122.87508499662;3123;3137.184332073677;3147.8583463744185;3217.7747557671205;871.5424402188902;916.4684482999844;924.9815003699888;927.967521136757;931.9906800931903;25849.741502585108;27231.002554278275;27250.45499090007;27552.586711199347;27748.445031099265;945.4705364995624;948.6110694615174;961.053362437998;992.811365840488;1015.5480811039164;14648.121112733057;14656.120632762068;14829.66533012034;15037.699246015238;15085.396584136732;376985;378899;379665;379797;379896;50525.49474505281;51000.48999510032;51135.488645113815;51155.232671509955;51353.48646513487;1085.3108276244484;1172.513406936129;1181.6573193773709;1192.958246461387;1212.7331986962854;28587.42825143527;29067.85466072656;29090.854545727136;29558.55662165112;29574;37358.25283494369;37361.43957840689;37462;37570.624293757806;37635.43546846745;273450;281381;281519;281756;281818;23298.767012330336;24470.265892023268;24935.501289973738;25439.74560254374;25575.23274301774;42432.5756742441;42546.5745342555;42839.35740963826;42952.140957181306;43510.78244608756;36156.81921590375;36576.81711591425;36680.633193668786;36941.815290923376;37525;33842.830785845916;36412.635873640924;36703.449448258834;36753.448698269014;36961.26077478489;35489.82255088708;35552;35847.46228806622;36248;36526.817365913;32288.515672264464;33789;33792.83103584466;33794.15514612154;33830.8308458466;23807.285781426584;24431.045516359005;24510.75489245085;24691.259262222164;24884.626730598695 09:24:06 INFO - PROCESS | 6136 | |2;jquery.html;366.2967103161929;370.35927844828444;380.5604526771579;381.71180758527305;396.0139253259383;15659.451919182831;16555.337786488526;16815;16953.237104330303;17049.999999999985;14129.081609695362;14618.322136916164;14878.628034299149;14888.553343399715;14905.701885962275;5002.474740152277;5267.52592266696;5272.973635131819;5274.05067087924;5274.182501712241;3786.848526058968;3977.1846771411792;3982.0443093657605;4029.53660329063;5124.974375128119;3786.2806066847347;4012.2376748417705;6107.114468402101;6108.3280839107665;6124;6029.54778391618;6083;6084.908726369108;6110.663913484756;6124.112003759452;5158.561522270612;5258.368995720538;5272.604554658416;5273.129933560957;5277.920831187535;15498.147601881892;18432.907835460872;18861;19277.61444771111;20028.098735556934;1927.171316333976;1988.62216178927;2022.7774944756065;2070.4202823209525;2133.4133113393787;12228.694282642917;12937.935310323483;13005.674858128528;13160.802587961092;13421.798673019815;1688.645384469263;1736.270766278166;1785.3483478530243;1808.2947650416347;1840.843528300096;64607.3539264606;67365;68519.65740171316;69108.3089169107;69270.65364673195;9335.533223338805;9385.67150149755;9694.46680432583;9715;9800.36297640651;13342.13276137048;13478.123921945042;13480.191188528719;13502.932485337511;13512.256825874474;7115.5730656160795;7218.386437152901;7235.674394652253;7357.632118394059;7362.595057271795;6585.440237579859;6594.439472644783;6674.43267322283;6687.665616719145;6756.662166891636;6175.876482470326;6182.598131121463;6245.6252624842655;6248.218972628421;6279.748810047547;1644.9342026318814;1795.8832675876026;1801.2164708351909;1804.3129673755082;1834.3121329501437;811.7848770075934;823.9011318641682;841.4656692999866;904.4076130134772;949.6248981652209;16176.676466470604;16202.513924582281;16487.670246595;16769.161541922855;16940.407085752187;921.2721949659827;942.8727121838601;962.2294977241909;963.691618682015;991.0881988570533;9043.59303831329;9834.950825245971;9884.703458896245;10212.744681383025;10225.233107516966;388598;388722;392335;396629;401315;75667.62166189133;76514.23485765183;77408.61295693486;77663.61168194123;77850.22149778543;953.4184147669915;959.5394210778866;964.2671569607149;978.3151793744407;984.9359791613522;11490.425478726198;15629.531114066596;15721.371145154066;15820.367185312458;16159;30507.423886417215;33101.8553237442;34735.30529389449;36228.27543449169;36992.63007369892;47631.28553071638;48662.756686217755;49179.754101229264;49531.25703114528;49977.75011124921;7621.31408173267;7637.541747495168;7840.3335716464735;7878.015248093989;7925.881111783213;11482.425878706199;11555.653330400102;11850.111241656738;12011.219270747373;12260.570880019157;9796.265280103878;9884.654037108667;10445.373277603368;10450.581976720847;10496.160307175254;10150.593976240867;10417.062464378243;10421.322614030063;10434.895651043696;10542.789144216918;10007.749806254902;10224.23318251149;10352.068313851789;10516.985529185667;10716.892831071902;7857.607119643881;7872.17342179063;7873.330766884879;7921.32668723165;8051.758447246592;7925;9327.393719408217;10618.628348007782;10737.731556710833;10842.566297348018 09:24:06 INFO - PROCESS | 6136 | |3;mootools.html;1290.3032362524236;1400.7268582626386;1431.3630434456663;1531.4486784757485;1729.3687803951555;6574.211094668641;7513.849723005536;7712.845743085135;7714.190010048948;7961.562114083723;7686.192949740281;7834.05991281047;7835.92164078359;7845.646945887449;7848.529088254709;1848.7689038870142;2078.4388215181966;2096.454921720356;2137.5511142659984;2141.0365335598963;2177.17267438374;2200.7799220078023;2201.636729939558;2204.1403852497538;2204.382772823612;2055.4142069510194;2070.27540360874;2105.515731381783;2107.1044805957486;2107.7681455039933;1752.8071912089724;1980.4454752669203;2029.6752519596794;2090.4042347930917;2091.215794077221;2117.5658989907033;2133.615949129156;2133.690614860852;2136.060133541237;2136.42316574524;7691.769246922545;7725.806854828618;7753.457257991943;7757.689692412297;7759.689612415496;4321.891952701176;4461.353103799931;4463;4463.665225108098;4464.553544645542;2676.1436340371088;2917.985410072957;2921.9269518262;2931.106012666136;2935.9706402935913;817.7464985854344;845.2308399356617;875.4878396138266;882.9823403531958;886.3751055505853;10464.686059418229;10492.475376231157;10505.4222017789;10508.737281567946;10519.579216831318;4083.612056854594;4187.937180942288;4277.593628605277;4288.978555107267;4291.249031419489;9185.40294880844;9220.308476864262;9223.44659320443;9248.16766491019;9255.629774809067;4535.29702896045;4536.251518499411;4536.705114167635;4542.88642783933;4543.34121552373;3554.306910152547;3916.7845768483007;4013.418054382098;4016.819243134066;4088.4276201331836;3601.567811862541;3635.618260082706;3707.629237076325;3723.497327860758;3739.8878033659034;1122.4331712485307;1143.5825923537848;1151.78691941991;1153.7807816514835;1159.756451145269;733.4719002318323;779.8518281526492;797.9785874081185;815.9143289954588;857.8498762716499;5035.219540971156;5212.8957420851375;5270.367555893317;5313.1764576490705;5315.495027972336;381.7518612901636;384.51167017887684;385.4276399546671;392.65250253525267;399.57445320733325;3533.94699079514;3565.554305711786;3605.2969670914445;3616.8372423241017;3648.434492653643;9185.540722963826;9600.32797704154;9607.327487075978;9618.807623847484;9626.90373096274;9460.195883349854;9474.952625236967;9514.857277140849;9515.191208747334;9528.761780955532;7252.456065795086;7323.340899319087;7334.083239595051;7342.082239720142;7344.192138864721;5132.178851383761;5160.793568257228;5253.632245742914;5298.496642818926;5321.388040375252;8824.735257942271;8829.426087304304;8842.557872106498;8894.066123056986;8936.151065648754;8545.957270213608;8876.733697989072;8890.066543013148;8900.73297801067;8911;5769.07694768835;6231.158793562992;6383.202099737533;6424.646644434601;6532;7495.063117110361;7558.811029724301;7629.885551716618;7635.694572217049;7636.80907977305;6638.435732962752;6851.2806155354965;6851.3491218334175;6955.408790252885;7001.124859392576;6753.966230168818;6764.763233286812;6799.626020568719;6862.3137686230975;6929.0299358090915;6181.690915454299;6184.81445556634;6266.874662506815;6267.435930766253;6276.1213430118905;4474.530174331649;4477.529859364719;4508.391367165522;4579.816807327803;4607.032523170172;4302.247106756243;4342.956570434255;4367.170237654836;4382.474103107647;4462.375267462623 09:24:06 INFO - PROCESS | 6136 | |4;prototype.html;294.254065942835;294.8422593912257;297.71716868974465;301.16426915310024;301.51004617496574;4744.027474367755;4748.145333839908;4758.619310455164;4768.78540465679;4792.688475249106;4647.163510568096;4655.883602909929;4670.136024835408;4692.882677933053;4696.17816882046;3539.92920141597;3652.2878038782446;3653.799041052741;3735.2529494101154;3768.1144930941205;3671.3942199537046;3732.365497865356;3735.4957080794015;3746.793926334064;3753.680937120348;3673.210259794144;3692.6861216796606;3693.3536631089587;3698.981505092471;3702.481652568629;3485.2158264390437;3585.784852908821;3706;3712.535933008374;3762.5673047599603;3297.450198406769;3312.3209742003073;3313.4698448248164;3315.303786204876;3316;4519.638428925678;4539.977300113512;4545.431821022372;4570.680052396334;4578.153041687298;4047.7571345719352;4239.533651298355;4294.720843145185;4295.763732994684;4302.526722060571;4939.185034469308;4941.950580494221;4958.355413796219;4965.677230979974;4969.503049695038;3625.583057948343;3643.143861192618;3645.6354364563595;3649.160693040589;3679.742418030739;5003.4746351633285;5196.974015129938;5202.661826981234;5234.345706786652;5252.606054545886;3674.9816250918575;3677.42999835026;3704.203596226824;3707.94438083429;3723.7207209458857;3732.0669832541867;3739.5699494558476;3743.756655817363;3798.164403831153;3806.1055651921774;4295.269804133305;4299;4309.784510774449;4318.395424640553;4318.632916202095;4799.352087468147;4929.482404347564;4978.452370239271;4979.153543897546;5072.492750724972;1307.522754194731;1317.1241124652;1319.940602672882;1323.5169163255343;1324.8675132486674;848.855694531931;851.9275861551838;872.829798189347;893.5755516129916;921.6728061538191;4355.651547876162;4363.650907927358;4372.650187984954;4374.212641724456;4380.408644832971;5065.442801291855;5071.974640126776;5084.161113416319;5093.439721630618;5097.847064588068;4227.746335219835;4362.258416069276;4381.430414046217;4390.626796722315;4393.879560711998;2724.209979106037;2746.7665248454105;2746.7939904506843;2749;2752.8210666306627;4873.415190177201;4879.536444037811;4889.217725164028;4893.877653058702;4921.532454416824;4990.900181996412;5288.550473209743;5306.540701307172;5327.493888080626;5335.279737235501;4847.80608775652;4853.4418541867435;4865.9756701216265;4885.340479035356;4907.454151942198;5160.432352441153;5185.611079169002;5205.568468670995;5242.97761936434;5245.7114858683135;4884.902301954012;5098.158803797481;5102.591792656653;5119.6416250862085;5148.382194136728;4922.360093187863;4939.925901111558;4942.579880710036;4944.653874228769;4960.454350021422;3663.377225871555;3679.2273622539565;3698.6116457771545;3700.1489657379493;3700.5374328208973;4935.383077115361;5186.910748742806;5285.973570132125;5290.9735451322495;5292.655977361459;4990.575801056805;5000.7999680013845;5026.74866256693;5033.823816166417;5044.344235249394;5027.994401119864;5052.747362631781;5057.443681195139;5059.519345662156;5061.924071138862;4778.235482322812;4903.4992154001;4933.432655244549;4951.455339912534;4966.379202599675;4817.710937343771;4892.752348151199;5043.87390315245;5064.924026139537;5068.847934561969;4888.095702295087;4890.657653964188;4896.653420309443;4896.975515122402;4914.606831453547 09:24:06 INFO - PROCESS | 6136 | |5;yui.html;646.5829539946737;651.9022146677999;654.6203202142758;682.5870348439195;746.0376114811892;12298.877011229884;12582.622521324352;12647.873521264808;12803.935980320086;12876.42056107475;11862.940685296562;12575.999999999976;12609.4325755341;12613.810792838114;12620.116591838574;632.2192092765431;790.766723816474;792.9524228546305;794.5272562825139;797.1470526536608;772.6909236305466;798.9520628762293;799.4284086877881;808.1918081918081;808.9271965523102;839.7606682095604;839.8194388206534;841.5455653946862;841.9031811341682;842.8946381702287;655.3217419970356;814.1980149552686;833.5040650812757;837.5812093953024;838.0697425857294;610.5756499233034;613.0161091448206;613.5919613457046;614.7448808744366;614.8401415631923;12175.208611440228;12204.816927746091;12207.816882746765;12223.69440763979;12225.938870305681;12622.68443288916;13215.735685286241;13261.535846245431;13282.468701251939;13458.663533411744;11019.118470522339;11052.336859788438;11359.772804543863;11398;11751.764964700744;3850.568402982271;3873.341531939577;3961.4453976443033;4006.278869803434;4007;59999;60586;60604.69697651572;60679.69660151715;60731.69634151801;10198.18414526836;10241.436720980417;10320.896791031993;10568.577256909792;10655.680329590125;18317.17572709231;18352.449426517225;18415.72376414355;18431.26274949014;18453;6357.523185761086;6366.427021568081;6777.695003724844;6854.2117656470145;6943.479239057091;3257.153140183569;3518.7712798668003;3654.5979942206336;3690.907727306785;3797.4303854421505;2947.985260073686;3094.009916826639;3100.860461279203;3105.4720697481484;3116.25209949615;509.2920840032358;516.1741214057478;521.5644936478008;530.3238371076831;530.9601779866525;559.960802743804;571.7370009795541;582.7202942587497;589.5725598940819;605.3915814606293;7418.998435211285;7459.254074592497;7517.586532740752;7561.584112873845;7820.413468989848;565.8217661436635;585.5932118990944;587.7913340763968;588.1648059755158;590.9172715819789;3395.2530443302435;3440.2259491614186;3497.8251087445524;3514.7012503937453;3573.94639080414;53433.73283133637;55226.72386638122;55581.166282505794;55735.72132139313;93794;51115.74442127765;51703;72122;73203.26796732072;76215;70006.64996674984;70826.64586677137;71008.64495677591;71587;72959.27040729525;8684.652613895627;8893.64425422976;8968.282537397123;8990;9049.366544342096;32220.83889580537;32270.19324516906;39995.80002099971;41804.1639167221;42969;55292.723536383666;60270.39729602648;60771.834394077;61263;61289;10913.126949844152;10922.94538527334;10926.125909927028;11041.889581104086;11422.885771142182;12463.79119839939;12519.123661343618;12948.287844168284;12963.805542916674;13116.344182791014;11882.643520694393;12184.634460966185;12337.136400452242;12408.503659853866;12502.43739031764;11943.81260225849;12213.633590992284;12483.188592741442;12589.87410125887;12630.747385052431;12077.27536347822;12091.637250882488;12219.205751626116;12292.262464252173;12339.814902776645;10272.178225741773;10529.526171322463;10547.472626368804;10602;10677.679669609925;9951.353162044445;10727.517261723086;10749.301295415773;10819.18856085781;10828.133749300194 09:24:06 INFO - PROCESS | 6136 | __end_tp_report 09:24:06 INFO - PROCESS | 6136 | __start_cc_report 09:24:06 INFO - PROCESS | 6136 | _x_x_mozilla_cycle_collect,1020 09:24:06 INFO - PROCESS | 6136 | __end_cc_report 09:24:06 INFO - PROCESS | 6136 | __startTimestamp1464971046056__endTimestamp 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - PROCESS | 6136 | ------- Summary: start ------- 09:24:06 INFO - PROCESS | 6136 | Number of tests: 6 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - PROCESS | 6136 | [#0] dojo.html Cycles:165 Average:4703.57 Median:4835.85 stddev:491.13 (10.2%) stddev-sans-first:465.96 09:24:06 INFO - PROCESS | 6136 | Values: 2668.0 2705.2 2727.5 2738.4 2744.8 4565.5 4611.7 4708.9 4786.4 4841.3 4685.2 4700.3 4759.9 4821.1 4834.5 4328.3 4342.6 4346.1 4383.1 4476.4 4381.5 4431.2 4435.2 4439.0 4488.5 4293.5 4388.5 4407.2 4435.1 4440.5 4291.1 4304.9 4310.3 4318.8 4326.9 4277.2 4320.8 4340.6 4354.8 4393.9 4491.7 4684.6 4697.9 4704.1 4714.4 5017.6 5060.9 5077.6 5138.8 5160.1 5155.5 5157.8 5158.1 5158.4 5164.9 4633.1 4720.8 4791.2 4804.0 4848.3 5145.7 5207.7 5271.5 5273.8 5293.8 5006.1 5021.9 5059.7 5059.8 5074.1 4954.1 5038.6 5093.1 5103.4 5107.9 5026.1 5041.9 5053.5 5056.2 5097.6 5022.2 5044.3 5047.2 5059.7 5086.7 4191.9 4227.3 4229.7 4262.1 4317.5 3718.5 3736.0 3741.9 3766.3 3797.7 4360.6 4365.7 4367.3 4412.5 4419.3 4983.8 5107.5 5116.5 5160.3 5169.5 4412.7 4438.2 4471.6 4480.0 4489.2 4642.0 4645.6 4649.0 4653.7 4695.1 4646.2 4789.9 4817.5 4871.7 4873.9 5157.2 5162.2 5177.2 5177.2 5189.6 4810.6 4831.1 4833.7 4860.4 4882.6 4916.1 4978.8 5021.2 5029.4 5130.0 5105.6 5131.7 5134.9 5135.7 5170.5 4979.6 4980.0 4981.4 4982.9 4986.7 4835.9 4836.8 4842.4 4868.7 4894.1 4764.8 4803.4 4861.9 4867.9 4869.1 4867.9 4934.6 4947.5 4985.1 5001.8 4767.6 4852.8 4885.8 4942.4 4942.6 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - PROCESS | 6136 | [#1] ext.html Cycles:180 Average:42930.63 Median:20118.89 stddev:76851.05 (382.0%) stddev-sans-first:77000.75 09:24:06 INFO - PROCESS | 6136 | Values: 544.7 590.9 593.8 598.7 610.6 27318.0 40397.0 41067.8 41131.8 41236.4 41038.8 41609.8 41633.6 41658.0 41774.6 7757.8 7961.9 7964.0 7965.1 7968.4 7756.2 7882.9 7885.1 7887.3 7895.0 7943.3 7997.2 7998.4 7999.0 8001.5 7881.1 7913.5 7930.7 7936.4 7941.5 7607.5 7667.0 7667.9 7668.7 7676.5 37704.2 38208.8 38251.8 38283.0 38318.6 3136.3 3197.6 3234.9 3477.9 3661.0 29241.4 29669.1 29734.6 30155.7 30559.5 3160.2 3204.4 3227.7 3239.3 3291.9 177995.0 178421.0 178704.0 179335.0 179670.0 31980.5 51760.5 52053.7 52074.5 52261.0 32930.2 34773.8 34778.7 34781.3 34854.3 12157.9 12174.9 12205.0 12228.1 12231.4 10321.8 10398.6 10418.7 10423.4 10433.1 7951.5 7993.2 8008.1 8017.6 8098.3 3122.9 3123.0 3137.2 3147.9 3217.8 871.5 916.5 925.0 928.0 932.0 25849.7 27231.0 27250.5 27552.6 27748.4 945.5 948.6 961.1 992.8 1015.5 14648.1 14656.1 14829.7 15037.7 15085.4 376985.0 378899.0 379665.0 379797.0 379896.0 50525.5 51000.5 51135.5 51155.2 51353.5 1085.3 1172.5 1181.7 1193.0 1212.7 28587.4 29067.9 29090.9 29558.6 29574.0 37358.3 37361.4 37462.0 37570.6 37635.4 273450.0 281381.0 281519.0 281756.0 281818.0 23298.8 24470.3 24935.5 25439.7 25575.2 42432.6 42546.6 42839.4 42952.1 43510.8 36156.8 36576.8 36680.6 36941.8 37525.0 33842.8 36412.6 36703.4 36753.4 36961.3 35489.8 35552.0 35847.5 36248.0 36526.8 32288.5 33789.0 33792.8 33794.2 33830.8 23807.3 24431.0 24510.8 24691.3 24884.6 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - PROCESS | 6136 | [#2] jquery.html Cycles:180 Average:24219.31 Median:3997.14 stddev:64884.71 (1623.3%) stddev-sans-first:65042.01 09:24:06 INFO - PROCESS | 6136 | Values: 366.3 370.4 380.6 381.7 396.0 15659.5 16555.3 16815.0 16953.2 17050.0 14129.1 14618.3 14878.6 14888.6 14905.7 5002.5 5267.5 5273.0 5274.1 5274.2 3786.8 3977.2 3982.0 4029.5 5125.0 3786.3 4012.2 6107.1 6108.3 6124.0 6029.5 6083.0 6084.9 6110.7 6124.1 5158.6 5258.4 5272.6 5273.1 5277.9 15498.1 18432.9 18861.0 19277.6 20028.1 1927.2 1988.6 2022.8 2070.4 2133.4 12228.7 12937.9 13005.7 13160.8 13421.8 1688.6 1736.3 1785.3 1808.3 1840.8 64607.4 67365.0 68519.7 69108.3 69270.7 9335.5 9385.7 9694.5 9715.0 9800.4 13342.1 13478.1 13480.2 13502.9 13512.3 7115.6 7218.4 7235.7 7357.6 7362.6 6585.4 6594.4 6674.4 6687.7 6756.7 6175.9 6182.6 6245.6 6248.2 6279.7 1644.9 1795.9 1801.2 1804.3 1834.3 811.8 823.9 841.5 904.4 949.6 16176.7 16202.5 16487.7 16769.2 16940.4 921.3 942.9 962.2 963.7 991.1 9043.6 9835.0 9884.7 10212.7 10225.2 388598.0 388722.0 392335.0 396629.0 401315.0 75667.6 76514.2 77408.6 77663.6 77850.2 953.4 959.5 964.3 978.3 984.9 11490.4 15629.5 15721.4 15820.4 16159.0 30507.4 33101.9 34735.3 36228.3 36992.6 47631.3 48662.8 49179.8 49531.3 49977.8 7621.3 7637.5 7840.3 7878.0 7925.9 11482.4 11555.7 11850.1 12011.2 12260.6 9796.3 9884.7 10445.4 10450.6 10496.2 10150.6 10417.1 10421.3 10434.9 10542.8 10007.7 10224.2 10352.1 10517.0 10716.9 7857.6 7872.2 7873.3 7921.3 8051.8 7925.0 9327.4 10618.6 10737.7 10842.6 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - PROCESS | 6136 | [#3] mootools.html Cycles:180 Average:5065.32 Median:5083.70 stddev:2891.08 (56.9%) stddev-sans-first:2885.27 09:24:06 INFO - PROCESS | 6136 | Values: 1290.3 1400.7 1431.4 1531.4 1729.4 6574.2 7513.8 7712.8 7714.2 7961.6 7686.2 7834.1 7835.9 7845.6 7848.5 1848.8 2078.4 2096.5 2137.6 2141.0 2177.2 2200.8 2201.6 2204.1 2204.4 2055.4 2070.3 2105.5 2107.1 2107.8 1752.8 1980.4 2029.7 2090.4 2091.2 2117.6 2133.6 2133.7 2136.1 2136.4 7691.8 7725.8 7753.5 7757.7 7759.7 4321.9 4461.4 4463.0 4463.7 4464.6 2676.1 2918.0 2921.9 2931.1 2936.0 817.7 845.2 875.5 883.0 886.4 10464.7 10492.5 10505.4 10508.7 10519.6 4083.6 4187.9 4277.6 4289.0 4291.2 9185.4 9220.3 9223.4 9248.2 9255.6 4535.3 4536.3 4536.7 4542.9 4543.3 3554.3 3916.8 4013.4 4016.8 4088.4 3601.6 3635.6 3707.6 3723.5 3739.9 1122.4 1143.6 1151.8 1153.8 1159.8 733.5 779.9 798.0 815.9 857.8 5035.2 5212.9 5270.4 5313.2 5315.5 381.8 384.5 385.4 392.7 399.6 3533.9 3565.6 3605.3 3616.8 3648.4 9185.5 9600.3 9607.3 9618.8 9626.9 9460.2 9475.0 9514.9 9515.2 9528.8 7252.5 7323.3 7334.1 7342.1 7344.2 5132.2 5160.8 5253.6 5298.5 5321.4 8824.7 8829.4 8842.6 8894.1 8936.2 8546.0 8876.7 8890.1 8900.7 8911.0 5769.1 6231.2 6383.2 6424.6 6532.0 7495.1 7558.8 7629.9 7635.7 7636.8 6638.4 6851.3 6851.3 6955.4 7001.1 6754.0 6764.8 6799.6 6862.3 6929.0 6181.7 6184.8 6266.9 6267.4 6276.1 4474.5 4477.5 4508.4 4579.8 4607.0 4302.2 4343.0 4367.2 4382.5 4462.4 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - PROCESS | 6136 | [#4] prototype.html Cycles:180 Average:4160.86 Median:4746.09 stddev:1199.93 (25.3%) stddev-sans-first:1167.67 09:24:06 INFO - PROCESS | 6136 | Values: 294.3 294.8 297.7 301.2 301.5 4744.0 4748.1 4758.6 4768.8 4792.7 4647.2 4655.9 4670.1 4692.9 4696.2 3539.9 3652.3 3653.8 3735.3 3768.1 3671.4 3732.4 3735.5 3746.8 3753.7 3673.2 3692.7 3693.4 3699.0 3702.5 3485.2 3585.8 3706.0 3712.5 3762.6 3297.5 3312.3 3313.5 3315.3 3316.0 4519.6 4540.0 4545.4 4570.7 4578.2 4047.8 4239.5 4294.7 4295.8 4302.5 4939.2 4942.0 4958.4 4965.7 4969.5 3625.6 3643.1 3645.6 3649.2 3679.7 5003.5 5197.0 5202.7 5234.3 5252.6 3675.0 3677.4 3704.2 3707.9 3723.7 3732.1 3739.6 3743.8 3798.2 3806.1 4295.3 4299.0 4309.8 4318.4 4318.6 4799.4 4929.5 4978.5 4979.2 5072.5 1307.5 1317.1 1319.9 1323.5 1324.9 848.9 851.9 872.8 893.6 921.7 4355.7 4363.7 4372.7 4374.2 4380.4 5065.4 5072.0 5084.2 5093.4 5097.8 4227.7 4362.3 4381.4 4390.6 4393.9 2724.2 2746.8 2746.8 2749.0 2752.8 4873.4 4879.5 4889.2 4893.9 4921.5 4990.9 5288.6 5306.5 5327.5 5335.3 4847.8 4853.4 4866.0 4885.3 4907.5 5160.4 5185.6 5205.6 5243.0 5245.7 4884.9 5098.2 5102.6 5119.6 5148.4 4922.4 4939.9 4942.6 4944.7 4960.5 3663.4 3679.2 3698.6 3700.1 3700.5 4935.4 5186.9 5286.0 5291.0 5292.7 4990.6 5000.8 5026.7 5033.8 5044.3 5028.0 5052.7 5057.4 5059.5 5061.9 4778.2 4903.5 4933.4 4951.5 4966.4 4817.7 4892.8 5043.9 5064.9 5068.8 4888.1 4890.7 4896.7 4897.0 4914.6 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - PROCESS | 6136 | [#5] yui.html Cycles:180 Average:15912.47 Median:4006.64 stddev:20862.89 (520.7%) stddev-sans-first:20889.93 09:24:06 INFO - PROCESS | 6136 | Values: 646.6 651.9 654.6 682.6 746.0 12298.9 12582.6 12647.9 12803.9 12876.4 11862.9 12576.0 12609.4 12613.8 12620.1 632.2 790.8 793.0 794.5 797.1 772.7 799.0 799.4 808.2 808.9 839.8 839.8 841.5 841.9 842.9 655.3 814.2 833.5 837.6 838.1 610.6 613.0 613.6 614.7 614.8 12175.2 12204.8 12207.8 12223.7 12225.9 12622.7 13215.7 13261.5 13282.5 13458.7 11019.1 11052.3 11359.8 11398.0 11751.8 3850.6 3873.3 3961.4 4006.3 4007.0 59999.0 60586.0 60604.7 60679.7 60731.7 10198.2 10241.4 10320.9 10568.6 10655.7 18317.2 18352.4 18415.7 18431.3 18453.0 6357.5 6366.4 6777.7 6854.2 6943.5 3257.2 3518.8 3654.6 3690.9 3797.4 2948.0 3094.0 3100.9 3105.5 3116.3 509.3 516.2 521.6 530.3 531.0 560.0 571.7 582.7 589.6 605.4 7419.0 7459.3 7517.6 7561.6 7820.4 565.8 585.6 587.8 588.2 590.9 3395.3 3440.2 3497.8 3514.7 3573.9 53433.7 55226.7 55581.2 55735.7 93794.0 51115.7 51703.0 72122.0 73203.3 76215.0 70006.6 70826.6 71008.6 71587.0 72959.3 8684.7 8893.6 8968.3 8990.0 9049.4 32220.8 32270.2 39995.8 41804.2 42969.0 55292.7 60270.4 60771.8 61263.0 61289.0 10913.1 10922.9 10926.1 11041.9 11422.9 12463.8 12519.1 12948.3 12963.8 13116.3 11882.6 12184.6 12337.1 12408.5 12502.4 11943.8 12213.6 12483.2 12589.9 12630.7 12077.3 12091.6 12219.2 12292.3 12339.8 10272.2 10529.5 10547.5 10602.0 10677.7 9951.4 10727.5 10749.3 10819.2 10828.1 09:24:06 INFO - PROCESS | 6136 | -------- Summary: end -------- 09:24:06 INFO - PROCESS | 6136 | 09:24:06 INFO - TEST-INFO | 6136: exit 0 09:24:06 INFO - TEST-OK | dromaeo_css | took 1119018ms 09:24:06 INFO - TEST-START | kraken 09:24:06 INFO - operating with platform_type : linux_ 09:24:06 INFO - Initialising browser for kraken test... 09:24:06 INFO - TEST-INFO | started process 6317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnUdcDA/profile http://localhost:34411/getInfo.html) 09:24:11 INFO - PROCESS | 6317 | __metrics Screen width/height:1600/1200 09:24:11 INFO - PROCESS | 6317 | colorDepth:24 09:24:11 INFO - PROCESS | 6317 | Browser inner width/height: 1024/697 09:24:11 INFO - PROCESS | 6317 | __metrics 09:24:12 ERROR - PROCESS | 6317 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:24:13 INFO - TEST-INFO | 6317: exit 0 09:24:13 INFO - Browser initialized. 09:24:13 INFO - Running cycle 1/1 for kraken test... 09:24:13 INFO - TEST-INFO | started process 6396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnUdcDA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:25 INFO - PROCESS | 6396 | RSS: Main: 158023680 09:24:25 INFO - PROCESS | 6396 | 09:24:27 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34411/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:28 INFO - PROCESS | 6396 | RSS: Main: 216424448 09:24:28 INFO - PROCESS | 6396 | 09:24:31 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34411/tests/kraken/driver.html?testName=audio-dft) 09:24:32 INFO - PROCESS | 6396 | RSS: Main: 203571200 09:24:32 INFO - PROCESS | 6396 | 09:24:35 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34411/tests/kraken/driver.html?testName=audio-fft) 09:24:36 INFO - PROCESS | 6396 | RSS: Main: 270835712 09:24:36 INFO - PROCESS | 6396 | 09:24:38 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34411/tests/kraken/driver.html?testName=audio-oscillator) 09:24:38 INFO - PROCESS | 6396 | RSS: Main: 180895744 09:24:38 INFO - PROCESS | 6396 | 09:24:41 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34411/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:41 INFO - PROCESS | 6396 | RSS: Main: 185434112 09:24:41 INFO - PROCESS | 6396 | 09:24:44 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34411/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:45 INFO - PROCESS | 6396 | RSS: Main: 221687808 09:24:45 INFO - PROCESS | 6396 | 09:24:49 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34411/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:49 INFO - PROCESS | 6396 | RSS: Main: 221786112 09:24:49 INFO - PROCESS | 6396 | 09:24:52 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34411/tests/kraken/driver.html?testName=json-parse-financial) 09:24:53 INFO - PROCESS | 6396 | RSS: Main: 222212096 09:24:53 INFO - PROCESS | 6396 | 09:24:54 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34411/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:55 INFO - PROCESS | 6396 | RSS: Main: 204533760 09:24:55 INFO - PROCESS | 6396 | 09:24:57 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34411/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:57 INFO - PROCESS | 6396 | RSS: Main: 210141184 09:24:57 INFO - PROCESS | 6396 | 09:25:00 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34411/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:00 INFO - PROCESS | 6396 | RSS: Main: 217747456 09:25:00 INFO - PROCESS | 6396 | 09:25:03 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:04 INFO - PROCESS | 6396 | RSS: Main: 222711808 09:25:04 INFO - PROCESS | 6396 | 09:25:07 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:07 INFO - PROCESS | 6396 | RSS: Main: 223457280 09:25:07 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:34411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34411/tests/kraken/driver.html?testName=ai-astar) 09:25:09 INFO - PROCESS | 6396 | RSS: Main: 265973760 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | __start_tp_report 09:25:09 INFO - PROCESS | 6396 | _x_x_mozilla_page_load 09:25:09 INFO - PROCESS | 6396 | _x_x_mozilla_page_load_details 09:25:09 INFO - PROCESS | 6396 | |i|pagename|runs| 09:25:09 INFO - PROCESS | 6396 | |0;ai-astar;113;107;112;113;111;112;112;112;111;111 09:25:09 INFO - PROCESS | 6396 | |1;audio-beat-detection;167;132;130;181;129;130;152;133;182;134 09:25:09 INFO - PROCESS | 6396 | |2;audio-dft;163;162;160;159;160;162;163;160;160;161 09:25:09 INFO - PROCESS | 6396 | |3;audio-fft;76;74;75;122;76;75;74;75;98;76 09:25:09 INFO - PROCESS | 6396 | |4;audio-oscillator;86;87;119;87;86;87;117;86;90;130 09:25:09 INFO - PROCESS | 6396 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 09:25:09 INFO - PROCESS | 6396 | |6;imaging-darkroom;146;145;145;146;146;146;145;146;146;146 09:25:09 INFO - PROCESS | 6396 | |7;imaging-desaturate;95;94;94;94;95;94;94;95;95;95 09:25:09 INFO - PROCESS | 6396 | |8;json-parse-financial;63;64;63;64;65;64;63;64;66;65 09:25:09 INFO - PROCESS | 6396 | |9;json-stringify-tinderbox;65;66;65;64;65;65;65;70;65;66 09:25:09 INFO - PROCESS | 6396 | |10;stanford-crypto-aes;82;89;86;82;85;88;90;84;117;88 09:25:09 INFO - PROCESS | 6396 | |11;stanford-crypto-ccm;144;141;129;132;138;131;133;139;135;134 09:25:09 INFO - PROCESS | 6396 | |12;stanford-crypto-pbkdf2;166;168;164;176;170;171;167;166;170;164 09:25:09 INFO - PROCESS | 6396 | |13;stanford-crypto-sha256-iterative;68;66;66;65;65;66;66;66;66;67 09:25:09 INFO - PROCESS | 6396 | __end_tp_report 09:25:09 INFO - PROCESS | 6396 | __start_cc_report 09:25:09 INFO - PROCESS | 6396 | _x_x_mozilla_cycle_collect,1892 09:25:09 INFO - PROCESS | 6396 | __end_cc_report 09:25:09 INFO - PROCESS | 6396 | __startTimestamp1464971109781__endTimestamp 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | ------- Summary: start ------- 09:25:09 INFO - PROCESS | 6396 | Number of tests: 14 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:1.71 (1.5%) stddev-sans-first:1.72 09:25:09 INFO - PROCESS | 6396 | Values: 113.0 107.0 112.0 113.0 111.0 112.0 112.0 112.0 111.0 111.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:143.00 stddev:21.85 (15.3%) stddev-sans-first:21.95 09:25:09 INFO - PROCESS | 6396 | Values: 167.0 132.0 130.0 181.0 129.0 130.0 152.0 133.0 182.0 134.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.41 (0.9%) stddev-sans-first:1.30 09:25:09 INFO - PROCESS | 6396 | Values: 163.0 162.0 160.0 159.0 160.0 162.0 163.0 160.0 160.0 161.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:15.77 (20.9%) stddev-sans-first:16.57 09:25:09 INFO - PROCESS | 6396 | Values: 76.0 74.0 75.0 122.0 76.0 75.0 74.0 75.0 98.0 76.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:86.50 stddev:17.26 (20.0%) stddev-sans-first:17.80 09:25:09 INFO - PROCESS | 6396 | Values: 86.0 87.0 119.0 87.0 86.0 87.0 117.0 86.0 90.0 130.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 09:25:09 INFO - PROCESS | 6396 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:25:09 INFO - PROCESS | 6396 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:25:09 INFO - PROCESS | 6396 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 09:25:09 INFO - PROCESS | 6396 | Values: 63.0 64.0 63.0 64.0 65.0 64.0 63.0 64.0 66.0 65.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.00 stddev:1.65 (2.5%) stddev-sans-first:1.73 09:25:09 INFO - PROCESS | 6396 | Values: 65.0 66.0 65.0 64.0 65.0 65.0 65.0 70.0 65.0 66.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:87.00 stddev:10.19 (11.7%) stddev-sans-first:10.48 09:25:09 INFO - PROCESS | 6396 | Values: 82.0 89.0 86.0 82.0 85.0 88.0 90.0 84.0 117.0 88.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:136.50 stddev:4.77 (3.5%) stddev-sans-first:3.97 09:25:09 INFO - PROCESS | 6396 | Values: 144.0 141.0 129.0 132.0 138.0 131.0 133.0 139.0 135.0 134.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:169.00 stddev:3.68 (2.2%) stddev-sans-first:3.81 09:25:09 INFO - PROCESS | 6396 | Values: 166.0 168.0 164.0 176.0 170.0 171.0 167.0 166.0 170.0 164.0 09:25:09 INFO - PROCESS | 6396 | 09:25:09 INFO - PROCESS | 6396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.60 09:25:09 INFO - PROCESS | 6396 | Values: 68.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 67.0 09:25:09 INFO - PROCESS | 6396 | -------- Summary: end -------- 09:25:09 INFO - PROCESS | 6396 | 09:25:10 INFO - TEST-INFO | 6396: exit 0 09:25:10 INFO - TEST-OK | kraken | took 64037ms 09:25:10 INFO - SUITE-END | took 1183s 09:25:10 INFO - Completed test suite (00:19:43) 09:25:10 INFO - javascript benchmark 09:25:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2667.9866600666996, 2705.2290097322266, 2727.5226835303815, 2738.397552538441, 2744.807863449559, 4565.520620334867, 4611.746353950532, 4708.882277943053, 4786.377770889784, 4841.322214889914, 4685.180093483644, 4700.318453824202, 4759.928601070987, 4821.083994041139, 4834.468208497063, 4328.264195086843, 4342.630876375511, 4346.065595896882, 4383.057642606839, 4476.37330773692, 4381.474223093233, 4431.246688063037, 4435.246008178601, 4438.97780511097, 4488.528704486031, 4293.463317085364, 4388.539203383662, 4407.184670835905, 4435.090806384684, 4440.511543730203, 4291.0774183550375, 4304.9139017219795, 4310.31035034393, 4318.762468064255, 4326.891827704332, 4277.230098582254, 4320.848770293056, 4340.587644173798, 4354.7604881731495, 4393.868183954486, 4491.663125265618, 4684.601808846252, 4697.906041879143, 4704.082703872747, 4714.363560919301, 5017.64876458648, 5060.898782024376, 5077.5684066854365, 5138.794448222066, 5160.071187186305, 5155.484451554852, 5157.7936882524655, 5158.148905430599, 5158.380994280673, 5164.92252616211, 4633.119707255678, 4720.834770783006, 4791.161546729309, 4803.975980120077, 4848.345473361122, 5145.691258524501, 5207.6875387476875, 5271.499207575274, 5273.789048438096, 5293.788248470095, 5006.123928312531, 5021.949780502148, 5059.721715305694, 5059.822906198339, 5074.13739664258, 4954.083494553519, 5038.571721403721, 5093.108705976513, 5103.362079740033, 5107.897842043212, 5026.145555255615, 5041.899162016739, 5053.545180933734, 5056.241563765391, 5097.566706829887, 5022.171341728647, 5044.319016932741, 5047.192449208183, 5059.671121377099, 5086.669366491166, 4191.8532851350055, 4227.260229459832, 4229.703920725519, 4262.083652014831, 4317.481902171759, 3718.4794128821986, 3736.0099573613015, 3741.8877433677035, 3766.3408903441787, 3797.696184305249, 4360.607545320873, 4365.650747940157, 4367.323064924942, 4412.536683648235, 4419.337099435046, 4983.775730092155, 5107.540321371094, 5116.513931176607, 5160.251763494272, 5169.508896654812, 4412.735235885857, 4438.223310920576, 4471.552844715502, 4479.955200448019, 4489.191945449785, 4641.953580464152, 4645.605123564467, 4649.023705021916, 4653.744044077541, 4695.060987802453, 4646.1869172895285, 4789.856304310876, 4817.494163112823, 4871.658983871095, 4873.853784386474, 5157.200633901752, 5162.174052151638, 5177.171652535576, 5177.197534382177, 5189.636725429335, 4810.6151507878585, 4831.0820944020525, 4833.73414462208, 4860.3753972854265, 4882.60939124862, 4916.06594746997, 4978.8257410990445, 5021.246812978083, 5029.4216165140015, 5130.025295193901, 5105.566026887756, 5131.666441681279, 5134.8973020540125, 5135.7432128394175, 5170.5346518813485, 4979.626528010342, 4980.0, 4981.37732783402, 4982.850514484571, 4986.700797952134, 4835.854924352275, 4836.782344794563, 4842.394700662418, 4868.732219727949, 4894.143524883202, 4764.78558464863, 4803.351547541037, 4861.854144375674, 4867.9269810952155, 4869.147899117569, 4867.9269810952155, 4934.580560652241, 4947.480514546065, 4985.077760614298, 5001.799928002984, 4767.594754445772, 4852.80588776445, 4885.804567817389, 4942.406911170682, 4942.6293028023765], "value": 4672.845672737765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.6949708163429, 590.9054551271797, 593.7654626422564, 598.6647477412648, 610.590904094257, 27318.0, 40397.0, 41067.79466102669, 41131.794341028326, 41236.38145427821, 41038.794806026, 41609.79195104028, 41633.58366416342, 41658.0, 41774.58225417745, 7757.806054848617, 7961.920380796176, 7963.96018019912, 7965.084015338252, 7968.362530997535, 7756.224377562226, 7882.921170788305, 7885.093214280345, 7887.329576985963, 7894.960525197366, 7943.324817390529, 7997.2402621751135, 7998.360131189491, 7998.960005199966, 8001.479903806234, 7881.054273487161, 7913.525188488709, 7930.682772689114, 7936.44444888858, 7941.483803552751, 7607.505512141693, 7666.9616651916385, 7667.8849817252785, 7668.65491052904, 7676.53940763556, 37704.24591508154, 38208.80895595504, 38251.80874095612, 38283.0, 38318.61681383178, 3136.341368312657, 3197.600299962505, 3234.886778962725, 3477.8608855645743, 3660.963390366089, 29241.41517169666, 29669.145166924583, 29734.553981690293, 30155.69844301551, 30559.541606875915, 3160.225744692542, 3204.439223135942, 3227.6772322767533, 3239.271163988084, 3291.8847840325475, 177995.0, 178421.0, 178704.0, 179335.0, 179670.0, 31980.520292195637, 51760.48239517632, 52053.7397313011, 52074.47925520772, 52261.0, 32930.17674558155, 34773.82613086919, 34778.652213478046, 34781.30437391238, 34854.30291394158, 12157.939210304068, 12174.878251217375, 12205.02359811213, 12228.144029917998, 12231.388430578436, 10321.84517232242, 10398.636047738293, 10418.68743937683, 10423.374597524022, 10433.113185379176, 7951.522908625385, 7993.240642138988, 8008.079070906804, 8017.599120043975, 8098.31164351025, 3122.87508499662, 3123.0, 3137.184332073677, 3147.8583463744185, 3217.7747557671205, 871.5424402188902, 916.4684482999844, 924.9815003699888, 927.967521136757, 931.9906800931903, 25849.741502585108, 27231.002554278275, 27250.45499090007, 27552.586711199347, 27748.445031099265, 945.4705364995624, 948.6110694615174, 961.053362437998, 992.811365840488, 1015.5480811039164, 14648.121112733057, 14656.120632762068, 14829.66533012034, 15037.699246015238, 15085.396584136732, 376985.0, 378899.0, 379665.0, 379797.0, 379896.0, 50525.49474505281, 51000.48999510032, 51135.488645113815, 51155.232671509955, 51353.48646513487, 1085.3108276244484, 1172.513406936129, 1181.6573193773709, 1192.958246461387, 1212.7331986962854, 28587.42825143527, 29067.85466072656, 29090.854545727136, 29558.55662165112, 29574.0, 37358.25283494369, 37361.43957840689, 37462.0, 37570.624293757806, 37635.43546846745, 273450.0, 281381.0, 281519.0, 281756.0, 281818.0, 23298.767012330336, 24470.265892023268, 24935.501289973738, 25439.74560254374, 25575.23274301774, 42432.5756742441, 42546.5745342555, 42839.35740963826, 42952.140957181306, 43510.78244608756, 36156.81921590375, 36576.81711591425, 36680.633193668786, 36941.815290923376, 37525.0, 33842.830785845916, 36412.635873640924, 36703.449448258834, 36753.448698269014, 36961.26077478489, 35489.82255088708, 35552.0, 35847.46228806622, 36248.0, 36526.817365913, 32288.515672264464, 33789.0, 33792.83103584466, 33794.15514612154, 33830.8308458466, 23807.285781426584, 24431.045516359005, 24510.75489245085, 24691.259262222164, 24884.626730598695], "value": 16187.06168595527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.2967103161929, 370.35927844828444, 380.5604526771579, 381.71180758527305, 396.0139253259383, 15659.451919182831, 16555.337786488526, 16815.0, 16953.237104330303, 17049.999999999985, 14129.081609695362, 14618.322136916164, 14878.628034299149, 14888.553343399715, 14905.701885962275, 5002.474740152277, 5267.52592266696, 5272.973635131819, 5274.05067087924, 5274.182501712241, 3786.848526058968, 3977.1846771411792, 3982.0443093657605, 4029.53660329063, 5124.974375128119, 3786.2806066847347, 4012.2376748417705, 6107.114468402101, 6108.3280839107665, 6124.0, 6029.54778391618, 6083.0, 6084.908726369108, 6110.663913484756, 6124.112003759452, 5158.561522270612, 5258.368995720538, 5272.604554658416, 5273.129933560957, 5277.920831187535, 15498.147601881892, 18432.907835460872, 18861.0, 19277.61444771111, 20028.098735556934, 1927.171316333976, 1988.62216178927, 2022.7774944756065, 2070.4202823209525, 2133.4133113393787, 12228.694282642917, 12937.935310323483, 13005.674858128528, 13160.802587961092, 13421.798673019815, 1688.645384469263, 1736.270766278166, 1785.3483478530243, 1808.2947650416347, 1840.843528300096, 64607.3539264606, 67365.0, 68519.65740171316, 69108.3089169107, 69270.65364673195, 9335.533223338805, 9385.67150149755, 9694.46680432583, 9715.0, 9800.36297640651, 13342.13276137048, 13478.123921945042, 13480.191188528719, 13502.932485337511, 13512.256825874474, 7115.5730656160795, 7218.386437152901, 7235.674394652253, 7357.632118394059, 7362.595057271795, 6585.440237579859, 6594.439472644783, 6674.43267322283, 6687.665616719145, 6756.662166891636, 6175.876482470326, 6182.598131121463, 6245.6252624842655, 6248.218972628421, 6279.748810047547, 1644.9342026318814, 1795.8832675876026, 1801.2164708351909, 1804.3129673755082, 1834.3121329501437, 811.7848770075934, 823.9011318641682, 841.4656692999866, 904.4076130134772, 949.6248981652209, 16176.676466470604, 16202.513924582281, 16487.670246595, 16769.161541922855, 16940.407085752187, 921.2721949659827, 942.8727121838601, 962.2294977241909, 963.691618682015, 991.0881988570533, 9043.59303831329, 9834.950825245971, 9884.703458896245, 10212.744681383025, 10225.233107516966, 388598.0, 388722.0, 392335.0, 396629.0, 401315.0, 75667.62166189133, 76514.23485765183, 77408.61295693486, 77663.61168194123, 77850.22149778543, 953.4184147669915, 959.5394210778866, 964.2671569607149, 978.3151793744407, 984.9359791613522, 11490.425478726198, 15629.531114066596, 15721.371145154066, 15820.367185312458, 16159.0, 30507.423886417215, 33101.8553237442, 34735.30529389449, 36228.27543449169, 36992.63007369892, 47631.28553071638, 48662.756686217755, 49179.754101229264, 49531.25703114528, 49977.75011124921, 7621.31408173267, 7637.541747495168, 7840.3335716464735, 7878.015248093989, 7925.881111783213, 11482.425878706199, 11555.653330400102, 11850.111241656738, 12011.219270747373, 12260.570880019157, 9796.265280103878, 9884.654037108667, 10445.373277603368, 10450.581976720847, 10496.160307175254, 10150.593976240867, 10417.062464378243, 10421.322614030063, 10434.895651043696, 10542.789144216918, 10007.749806254902, 10224.23318251149, 10352.068313851789, 10516.985529185667, 10716.892831071902, 7857.607119643881, 7872.17342179063, 7873.330766884879, 7921.32668723165, 8051.758447246592, 7925.0, 9327.393719408217, 10618.628348007782, 10737.731556710833, 10842.566297348018], "value": 8269.513159565155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.3032362524236, 1400.7268582626386, 1431.3630434456663, 1531.4486784757485, 1729.3687803951555, 6574.211094668641, 7513.849723005536, 7712.845743085135, 7714.190010048948, 7961.562114083723, 7686.192949740281, 7834.05991281047, 7835.92164078359, 7845.646945887449, 7848.529088254709, 1848.7689038870142, 2078.4388215181966, 2096.454921720356, 2137.5511142659984, 2141.0365335598963, 2177.17267438374, 2200.7799220078023, 2201.636729939558, 2204.1403852497538, 2204.382772823612, 2055.4142069510194, 2070.27540360874, 2105.515731381783, 2107.1044805957486, 2107.7681455039933, 1752.8071912089724, 1980.4454752669203, 2029.6752519596794, 2090.4042347930917, 2091.215794077221, 2117.5658989907033, 2133.615949129156, 2133.690614860852, 2136.060133541237, 2136.42316574524, 7691.769246922545, 7725.806854828618, 7753.457257991943, 7757.689692412297, 7759.689612415496, 4321.891952701176, 4461.353103799931, 4463.0, 4463.665225108098, 4464.553544645542, 2676.1436340371088, 2917.985410072957, 2921.9269518262, 2931.106012666136, 2935.9706402935913, 817.7464985854344, 845.2308399356617, 875.4878396138266, 882.9823403531958, 886.3751055505853, 10464.686059418229, 10492.475376231157, 10505.4222017789, 10508.737281567946, 10519.579216831318, 4083.612056854594, 4187.937180942288, 4277.593628605277, 4288.978555107267, 4291.249031419489, 9185.40294880844, 9220.308476864262, 9223.44659320443, 9248.16766491019, 9255.629774809067, 4535.29702896045, 4536.251518499411, 4536.705114167635, 4542.88642783933, 4543.34121552373, 3554.306910152547, 3916.7845768483007, 4013.418054382098, 4016.819243134066, 4088.4276201331836, 3601.567811862541, 3635.618260082706, 3707.629237076325, 3723.497327860758, 3739.8878033659034, 1122.4331712485307, 1143.5825923537848, 1151.78691941991, 1153.7807816514835, 1159.756451145269, 733.4719002318323, 779.8518281526492, 797.9785874081185, 815.9143289954588, 857.8498762716499, 5035.219540971156, 5212.8957420851375, 5270.367555893317, 5313.1764576490705, 5315.495027972336, 381.7518612901636, 384.51167017887684, 385.4276399546671, 392.65250253525267, 399.57445320733325, 3533.94699079514, 3565.554305711786, 3605.2969670914445, 3616.8372423241017, 3648.434492653643, 9185.540722963826, 9600.32797704154, 9607.327487075978, 9618.807623847484, 9626.90373096274, 9460.195883349854, 9474.952625236967, 9514.857277140849, 9515.191208747334, 9528.761780955532, 7252.456065795086, 7323.340899319087, 7334.083239595051, 7342.082239720142, 7344.192138864721, 5132.178851383761, 5160.793568257228, 5253.632245742914, 5298.496642818926, 5321.388040375252, 8824.735257942271, 8829.426087304304, 8842.557872106498, 8894.066123056986, 8936.151065648754, 8545.957270213608, 8876.733697989072, 8890.066543013148, 8900.73297801067, 8911.0, 5769.07694768835, 6231.158793562992, 6383.202099737533, 6424.646644434601, 6532.0, 7495.063117110361, 7558.811029724301, 7629.885551716618, 7635.694572217049, 7636.80907977305, 6638.435732962752, 6851.2806155354965, 6851.3491218334175, 6955.408790252885, 7001.124859392576, 6753.966230168818, 6764.763233286812, 6799.626020568719, 6862.3137686230975, 6929.0299358090915, 6181.690915454299, 6184.81445556634, 6266.874662506815, 6267.435930766253, 6276.1213430118905, 4474.530174331649, 4477.529859364719, 4508.391367165522, 4579.816807327803, 4607.032523170172, 4302.247106756243, 4342.956570434255, 4367.170237654836, 4382.474103107647, 4462.375267462623], "value": 3980.2110367925534, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.254065942835, 294.8422593912257, 297.71716868974465, 301.16426915310024, 301.51004617496574, 4744.027474367755, 4748.145333839908, 4758.619310455164, 4768.78540465679, 4792.688475249106, 4647.163510568096, 4655.883602909929, 4670.136024835408, 4692.882677933053, 4696.17816882046, 3539.92920141597, 3652.2878038782446, 3653.799041052741, 3735.2529494101154, 3768.1144930941205, 3671.3942199537046, 3732.365497865356, 3735.4957080794015, 3746.793926334064, 3753.680937120348, 3673.210259794144, 3692.6861216796606, 3693.3536631089587, 3698.981505092471, 3702.481652568629, 3485.2158264390437, 3585.784852908821, 3706.0, 3712.535933008374, 3762.5673047599603, 3297.450198406769, 3312.3209742003073, 3313.4698448248164, 3315.303786204876, 3316.0, 4519.638428925678, 4539.977300113512, 4545.431821022372, 4570.680052396334, 4578.153041687298, 4047.7571345719352, 4239.533651298355, 4294.720843145185, 4295.763732994684, 4302.526722060571, 4939.185034469308, 4941.950580494221, 4958.355413796219, 4965.677230979974, 4969.503049695038, 3625.583057948343, 3643.143861192618, 3645.6354364563595, 3649.160693040589, 3679.742418030739, 5003.4746351633285, 5196.974015129938, 5202.661826981234, 5234.345706786652, 5252.606054545886, 3674.9816250918575, 3677.42999835026, 3704.203596226824, 3707.94438083429, 3723.7207209458857, 3732.0669832541867, 3739.5699494558476, 3743.756655817363, 3798.164403831153, 3806.1055651921774, 4295.269804133305, 4299.0, 4309.784510774449, 4318.395424640553, 4318.632916202095, 4799.352087468147, 4929.482404347564, 4978.452370239271, 4979.153543897546, 5072.492750724972, 1307.522754194731, 1317.1241124652, 1319.940602672882, 1323.5169163255343, 1324.8675132486674, 848.855694531931, 851.9275861551838, 872.829798189347, 893.5755516129916, 921.6728061538191, 4355.651547876162, 4363.650907927358, 4372.650187984954, 4374.212641724456, 4380.408644832971, 5065.442801291855, 5071.974640126776, 5084.161113416319, 5093.439721630618, 5097.847064588068, 4227.746335219835, 4362.258416069276, 4381.430414046217, 4390.626796722315, 4393.879560711998, 2724.209979106037, 2746.7665248454105, 2746.7939904506843, 2749.0, 2752.8210666306627, 4873.415190177201, 4879.536444037811, 4889.217725164028, 4893.877653058702, 4921.532454416824, 4990.900181996412, 5288.550473209743, 5306.540701307172, 5327.493888080626, 5335.279737235501, 4847.80608775652, 4853.4418541867435, 4865.9756701216265, 4885.340479035356, 4907.454151942198, 5160.432352441153, 5185.611079169002, 5205.568468670995, 5242.97761936434, 5245.7114858683135, 4884.902301954012, 5098.158803797481, 5102.591792656653, 5119.6416250862085, 5148.382194136728, 4922.360093187863, 4939.925901111558, 4942.579880710036, 4944.653874228769, 4960.454350021422, 3663.377225871555, 3679.2273622539565, 3698.6116457771545, 3700.1489657379493, 3700.5374328208973, 4935.383077115361, 5186.910748742806, 5285.973570132125, 5290.9735451322495, 5292.655977361459, 4990.575801056805, 5000.7999680013845, 5026.74866256693, 5033.823816166417, 5044.344235249394, 5027.994401119864, 5052.747362631781, 5057.443681195139, 5059.519345662156, 5061.924071138862, 4778.235482322812, 4903.4992154001, 4933.432655244549, 4951.455339912534, 4966.379202599675, 4817.710937343771, 4892.752348151199, 5043.87390315245, 5064.924026139537, 5068.847934561969, 4888.095702295087, 4890.657653964188, 4896.653420309443, 4896.975515122402, 4914.606831453547], "value": 3782.9881113337688, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.5829539946737, 651.9022146677999, 654.6203202142758, 682.5870348439195, 746.0376114811892, 12298.877011229884, 12582.622521324352, 12647.873521264808, 12803.935980320086, 12876.42056107475, 11862.940685296562, 12575.999999999976, 12609.4325755341, 12613.810792838114, 12620.116591838574, 632.2192092765431, 790.766723816474, 792.9524228546305, 794.5272562825139, 797.1470526536608, 772.6909236305466, 798.9520628762293, 799.4284086877881, 808.1918081918081, 808.9271965523102, 839.7606682095604, 839.8194388206534, 841.5455653946862, 841.9031811341682, 842.8946381702287, 655.3217419970356, 814.1980149552686, 833.5040650812757, 837.5812093953024, 838.0697425857294, 610.5756499233034, 613.0161091448206, 613.5919613457046, 614.7448808744366, 614.8401415631923, 12175.208611440228, 12204.816927746091, 12207.816882746765, 12223.69440763979, 12225.938870305681, 12622.68443288916, 13215.735685286241, 13261.535846245431, 13282.468701251939, 13458.663533411744, 11019.118470522339, 11052.336859788438, 11359.772804543863, 11398.0, 11751.764964700744, 3850.568402982271, 3873.341531939577, 3961.4453976443033, 4006.278869803434, 4007.0, 59999.0, 60586.0, 60604.69697651572, 60679.69660151715, 60731.69634151801, 10198.18414526836, 10241.436720980417, 10320.896791031993, 10568.577256909792, 10655.680329590125, 18317.17572709231, 18352.449426517225, 18415.72376414355, 18431.26274949014, 18453.0, 6357.523185761086, 6366.427021568081, 6777.695003724844, 6854.2117656470145, 6943.479239057091, 3257.153140183569, 3518.7712798668003, 3654.5979942206336, 3690.907727306785, 3797.4303854421505, 2947.985260073686, 3094.009916826639, 3100.860461279203, 3105.4720697481484, 3116.25209949615, 509.2920840032358, 516.1741214057478, 521.5644936478008, 530.3238371076831, 530.9601779866525, 559.960802743804, 571.7370009795541, 582.7202942587497, 589.5725598940819, 605.3915814606293, 7418.998435211285, 7459.254074592497, 7517.586532740752, 7561.584112873845, 7820.413468989848, 565.8217661436635, 585.5932118990944, 587.7913340763968, 588.1648059755158, 590.9172715819789, 3395.2530443302435, 3440.2259491614186, 3497.8251087445524, 3514.7012503937453, 3573.94639080414, 53433.73283133637, 55226.72386638122, 55581.166282505794, 55735.72132139313, 93794.0, 51115.74442127765, 51703.0, 72122.0, 73203.26796732072, 76215.0, 70006.64996674984, 70826.64586677137, 71008.64495677591, 71587.0, 72959.27040729525, 8684.652613895627, 8893.64425422976, 8968.282537397123, 8990.0, 9049.366544342096, 32220.83889580537, 32270.19324516906, 39995.80002099971, 41804.1639167221, 42969.0, 55292.723536383666, 60270.39729602648, 60771.834394077, 61263.0, 61289.0, 10913.126949844152, 10922.94538527334, 10926.125909927028, 11041.889581104086, 11422.885771142182, 12463.79119839939, 12519.123661343618, 12948.287844168284, 12963.805542916674, 13116.344182791014, 11882.643520694393, 12184.634460966185, 12337.136400452242, 12408.503659853866, 12502.43739031764, 11943.81260225849, 12213.633590992284, 12483.188592741442, 12589.87410125887, 12630.747385052431, 12077.27536347822, 12091.637250882488, 12219.205751626116, 12292.262464252173, 12339.814902776645, 10272.178225741773, 10529.526171322463, 10547.472626368804, 10602.0, 10677.679669609925, 9951.353162044445, 10727.517261723086, 10749.301295415773, 10819.18856085781, 10828.133749300194], "value": 6438.1941301607385, "unit": "score"}], "name": "dromaeo_css", "value": 6268.020540639766, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 113.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 132.0, 130.0, 181.0, 129.0, 130.0, 152.0, 133.0, 182.0, 134.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 159.0, 160.0, 162.0, 163.0, 160.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 122.0, 76.0, 75.0, 74.0, 75.0, 98.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 119.0, 87.0, 86.0, 87.0, 117.0, 86.0, 90.0, 130.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 63.0, 64.0, 66.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 70.0, 65.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 89.0, 86.0, 82.0, 85.0, 88.0, 90.0, 84.0, 117.0, 88.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 129.0, 132.0, 138.0, 131.0, 133.0, 139.0, 135.0, 134.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 164.0, 176.0, 170.0, 171.0, 167.0, 166.0, 170.0, 164.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1544.7999999999997, "alertThreshold": 2.0}]} 09:25:11 INFO - Return code: 0 09:25:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:11 ERROR - # TBPL SUCCESS # 09:25:11 INFO - Running post-action listener: _resource_record_post_action 09:25:11 INFO - ##### 09:25:11 INFO - ##### Finished run-tests step (success) 09:25:11 INFO - ##### 09:25:11 INFO - Running post-run listener: _resource_record_post_run 09:25:11 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532410368; Read time: 16; Write time: 438444 09:25:11 INFO - TinderboxPrint: CPU usage
13.1% 09:25:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:25:11 INFO - TinderboxPrint: I/O write bytes / time
532,410,368 / 438,444 09:25:11 INFO - TinderboxPrint: CPU idle
8,324.0 (86.9%) 09:25:11 INFO - TinderboxPrint: CPU user
1,211.8 (12.6%) 09:25:11 INFO - TinderboxPrint: Swap in / out
0 / 0 09:25:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 246898688; Read time: 0; Write time: 224244 09:25:11 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285511680; Read time: 16; Write time: 214200 09:25:11 INFO - Running post-run listener: _upload_blobber_files 09:25:11 INFO - Blob upload gear active. 09:25:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:11 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 09:25:11 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'] 09:25:11 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 09:25:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:25:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:25:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:16 INFO - (blobuploader) - INFO - Done attempting. 09:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:25:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:17 INFO - (blobuploader) - INFO - Done attempting. 09:25:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:25:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:18 INFO - (blobuploader) - INFO - Done attempting. 09:25:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:18 INFO - Return code: 0 09:25:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:25:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afce408f22525a5e26d7d71c3bf19e065bd315136d65805526e5aa057691c0ec1e7898c0fb39c6d8e59fa3b270f5a54717621014e28f1177b49f97d836431acb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89da245aa16d0c40d2233406f3f92284680e1ba87fcb48247112f248c9b98c6cf80c1e9ebc25157958fce22257594fc33c64a4f67701a610556a87f27f459481", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4046f12e186f375e24d6ca3c56cf6537d899afcd951f52833dacf47a2cbeab265971ba3dee96a32fcd70490ba29dae89674e18f9755430046df810b323d1046"} 09:25:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:25:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:25:18 INFO - Contents: 09:25:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afce408f22525a5e26d7d71c3bf19e065bd315136d65805526e5aa057691c0ec1e7898c0fb39c6d8e59fa3b270f5a54717621014e28f1177b49f97d836431acb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89da245aa16d0c40d2233406f3f92284680e1ba87fcb48247112f248c9b98c6cf80c1e9ebc25157958fce22257594fc33c64a4f67701a610556a87f27f459481", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4046f12e186f375e24d6ca3c56cf6537d899afcd951f52833dacf47a2cbeab265971ba3dee96a32fcd70490ba29dae89674e18f9755430046df810b323d1046"} 09:25:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:25:18 INFO - Copying logs to upload dir... 09:25:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:25:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.904301 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-03 09:25:18.656341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 09:25:18.659979) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854 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/afce408f22525a5e26d7d71c3bf19e065bd315136d65805526e5aa057691c0ec1e7898c0fb39c6d8e59fa3b270f5a54717621014e28f1177b49f97d836431acb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89da245aa16d0c40d2233406f3f92284680e1ba87fcb48247112f248c9b98c6cf80c1e9ebc25157958fce22257594fc33c64a4f67701a610556a87f27f459481", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4046f12e186f375e24d6ca3c56cf6537d899afcd951f52833dacf47a2cbeab265971ba3dee96a32fcd70490ba29dae89674e18f9755430046df810b323d1046"} build_url:https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/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/afce408f22525a5e26d7d71c3bf19e065bd315136d65805526e5aa057691c0ec1e7898c0fb39c6d8e59fa3b270f5a54717621014e28f1177b49f97d836431acb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89da245aa16d0c40d2233406f3f92284680e1ba87fcb48247112f248c9b98c6cf80c1e9ebc25157958fce22257594fc33c64a4f67701a610556a87f27f459481", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4046f12e186f375e24d6ca3c56cf6537d899afcd951f52833dacf47a2cbeab265971ba3dee96a32fcd70490ba29dae89674e18f9755430046df810b323d1046"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 09:25:18.688687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:25:18.689016) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1464967347.656735-1210350854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:25:18.776189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 09:25:18.776807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 09:25:18.777311) ========= ========= Total master_lag: 0.18 =========