builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1465102217.88 results: success (0) buildid: 20160604212243 builduid: 9b16b8fed769429fb58518fc1f4b5769 revision: 0ac19ca034d9097ded455362e46b56017f3a64a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:17.878159) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:17.878586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:17.878857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:17.937761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:17.938174) ========= 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=7de08804244eb36560b44971000001c3-1465101535.678350-418856284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 21:50:18-- 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% 112M=0s 2016-06-04 21:50:18 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.075915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.076239) ========= 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=7de08804244eb36560b44971000001c3-1465101535.678350-418856284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022275 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.128272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.128610) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ac19ca034d9097ded455362e46b56017f3a64a4 --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 0ac19ca034d9097ded455362e46b56017f3a64a4 --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=7de08804244eb36560b44971000001c3-1465101535.678350-418856284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 21:50:18,473 truncating revision to first 12 chars 2016-06-04 21:50:18,473 Setting DEBUG logging. 2016-06-04 21:50:18,473 attempt 1/10 2016-06-04 21:50:18,473 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ac19ca034d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 21:50:18,879 unpacking tar archive at: fx-team-0ac19ca034d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.896654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.896944) ========= script_repo_revision: 0ac19ca034d9097ded455362e46b56017f3a64a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.897326) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.897616) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 21:50:18.915703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-04 21:50:18.915972) ========= /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=7de08804244eb36560b44971000001c3-1465101535.678350-418856284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:50:19 INFO - MultiFileLogger online at 20160604 21:50:19 in /builds/slave/test 21:50:19 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 21:50:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:50:19 INFO - {'append_to_log': False, 21:50:19 INFO - 'base_work_dir': '/builds/slave/test', 21:50:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:50:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:50:19 INFO - 'branch': 'Fx-Team-Non-PGO', 21:50:19 INFO - 'buildbot_json_path': 'buildprops.json', 21:50:19 INFO - 'config_files': ('talos/linux_config.py',), 21:50:19 INFO - 'default_actions': ('clobber', 21:50:19 INFO - 'read-buildbot-config', 21:50:19 INFO - 'download-and-extract', 21:50:19 INFO - 'populate-webroot', 21:50:19 INFO - 'create-virtualenv', 21:50:19 INFO - 'install', 21:50:19 INFO - 'run-tests'), 21:50:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:50:19 INFO - 'download_minidump_stackwalk': True, 21:50:19 INFO - 'download_symbols': 'ondemand', 21:50:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:50:19 INFO - 'tooltool.py': '/tools/tooltool.py', 21:50:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:50:19 INFO - '/tools/misc-python/virtualenv.py')}, 21:50:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:50:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:50:19 INFO - 'installer_path': 'installer.exe', 21:50:19 INFO - 'log_level': 'info', 21:50:19 INFO - 'log_name': 'talos', 21:50:19 INFO - 'log_to_console': True, 21:50:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:50:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:50:19 INFO - 'opt_config_files': (), 21:50:19 INFO - 'pip_index': False, 21:50:19 INFO - 'sps_profile': False, 21:50:19 INFO - 'sps_profile_interval': 0, 21:50:19 INFO - 'suite': 'dromaeojs', 21:50:19 INFO - 'system_bits': '32', 21:50:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:50:19 INFO - 'title': 'talos-linux64-ix-003', 21:50:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:50:19 INFO - 'use_talos_json': True, 21:50:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:50:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:50:19 INFO - 'work_dir': 'build'} 21:50:19 INFO - ##### 21:50:19 INFO - ##### Running clobber step. 21:50:19 INFO - ##### 21:50:19 INFO - Running pre-action listener: _resource_record_pre_action 21:50:19 INFO - Running main action method: clobber 21:50:19 INFO - rmtree: /builds/slave/test/build 21:50:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:50:20 INFO - Running post-action listener: _resource_record_post_action 21:50:20 INFO - ##### 21:50:20 INFO - ##### Finished clobber step (success) 21:50:20 INFO - ##### 21:50:20 INFO - ##### 21:50:20 INFO - ##### Running read-buildbot-config step. 21:50:20 INFO - ##### 21:50:20 INFO - Running pre-action listener: _resource_record_pre_action 21:50:20 INFO - Running main action method: read_buildbot_config 21:50:20 INFO - Using buildbot properties: 21:50:20 INFO - { 21:50:20 INFO - "project": "", 21:50:20 INFO - "product": "firefox", 21:50:20 INFO - "script_repo_revision": "production", 21:50:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:50:20 INFO - "repository": "", 21:50:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:50:20 INFO - "buildid": "20160604212243", 21:50:20 INFO - "pgo_build": "False", 21:50:20 INFO - "basedir": "/builds/slave/test", 21:50:20 INFO - "buildnumber": 1817, 21:50:20 INFO - "slavename": "talos-linux64-ix-003", 21:50:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:50:20 INFO - "platform": "ubuntu64_hw", 21:50:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:50:20 INFO - "branch": "fx-team", 21:50:20 INFO - "repo_path": "integration/fx-team", 21:50:20 INFO - "revision": "0ac19ca034d9097ded455362e46b56017f3a64a4", 21:50:20 INFO - "stage_platform": "linux64", 21:50:20 INFO - "builduid": "9b16b8fed769429fb58518fc1f4b5769", 21:50:20 INFO - "slavebuilddir": "test" 21:50:20 INFO - } 21:50:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:50:20 INFO - Running post-action listener: _resource_record_post_action 21:50:20 INFO - ##### 21:50:20 INFO - ##### Finished read-buildbot-config step (success) 21:50:20 INFO - ##### 21:50:20 INFO - ##### 21:50:20 INFO - ##### Running download-and-extract step. 21:50:20 INFO - ##### 21:50:20 INFO - Running pre-action listener: _resource_record_pre_action 21:50:20 INFO - Running main action method: download_and_extract 21:50:20 INFO - mkdir: /builds/slave/test/build/tests 21:50:20 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')]} 21:50:20 INFO - https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:50:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:50:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:50:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:25 INFO - Downloaded 1361 bytes. 21:50:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:50:25 INFO - Using the following test package requirements: 21:50:25 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:50:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:50:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:50:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:25 INFO - u'jsshell-linux-x86_64.zip'], 21:50:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:50:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:50:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:50:25 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:50:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:50:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:50:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:50:25 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')]} 21:50:25 INFO - https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:50:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:50:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:50:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:26 INFO - Downloaded 22868152 bytes. 21:50:26 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'] 21:50:26 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 21:50:27 INFO - Return code: 0 21:50:27 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 21:50:27 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')]} 21:50:27 INFO - https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:37 INFO - Downloaded 22868152 bytes. 21:50:37 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'] 21:50:37 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 21:50:38 INFO - Return code: 0 21:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:38 INFO - https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:50:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:50:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:50:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:39 INFO - Downloaded 10833369 bytes. 21:50:39 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'] 21:50:39 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 21:50:39 INFO - Return code: 0 21:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:39 INFO - https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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 21:50:41 INFO - Downloaded 55182174 bytes. 21:50:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:50:41 INFO - mkdir: /builds/slave/test/properties 21:50:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:50:41 INFO - Writing to file /builds/slave/test/properties/build_url 21:50:41 INFO - Contents: 21:50:41 INFO - build_url:https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:50:42 INFO - Running post-action listener: _resource_record_post_action 21:50:42 INFO - Running post-action listener: set_extra_try_arguments 21:50:42 INFO - ##### 21:50:42 INFO - ##### Finished download-and-extract step (success) 21:50:42 INFO - ##### 21:50:42 INFO - ##### 21:50:42 INFO - ##### Running populate-webroot step. 21:50:42 INFO - ##### 21:50:42 INFO - Running pre-action listener: _resource_record_pre_action 21:50:42 INFO - Running main action method: populate_webroot 21:50:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:50:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:50:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:50:42 INFO - '--tppagecycles', 21:50:42 INFO - '7'], 21:50:42 INFO - 'tests': ['tsvgm']}}, 21:50:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:50:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:50:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:50:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:50:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:42 INFO - 'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:42 INFO - 'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['damp', 'tps']}, 21:50:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:42 INFO - 'tests': ['damp', 'tps']}, 21:50:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['dromaeo_dom']}, 21:50:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:50:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['a11yr', 21:50:42 INFO - 'ts_paint', 21:50:42 INFO - 'tpaint', 21:50:42 INFO - 'sessionrestore', 21:50:42 INFO - 'sessionrestore_no_auto_restore', 21:50:42 INFO - 'tabpaint']}, 21:50:42 INFO - 'other-e10s': {'tests': ['a11yr', 21:50:42 INFO - 'ts_paint', 21:50:42 INFO - 'tpaint', 21:50:42 INFO - 'sessionrestore', 21:50:42 INFO - 'sessionrestore_no_auto_restore', 21:50:42 INFO - 'tabpaint']}, 21:50:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:50:42 INFO - 'ts_paint', 21:50:42 INFO - 'tpaint', 21:50:42 INFO - 'sessionrestore', 21:50:42 INFO - 'sessionrestore_no_auto_restore', 21:50:42 INFO - 'tabpaint']}, 21:50:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:50:42 INFO - 'ts_paint', 21:50:42 INFO - 'tpaint', 21:50:42 INFO - 'sessionrestore', 21:50:42 INFO - 'sessionrestore_no_auto_restore', 21:50:42 INFO - 'tabpaint']}, 21:50:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['a11yr', 21:50:42 INFO - 'ts_paint', 21:50:42 INFO - 'tpaint', 21:50:42 INFO - 'sessionrestore', 21:50:42 INFO - 'sessionrestore_no_auto_restore', 21:50:42 INFO - 'tabpaint']}, 21:50:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['a11yr', 21:50:42 INFO - 'ts_paint', 21:50:42 INFO - 'tpaint', 21:50:42 INFO - 'sessionrestore', 21:50:42 INFO - 'sessionrestore_no_auto_restore', 21:50:42 INFO - 'tabpaint']}, 21:50:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['tsvgx', 21:50:42 INFO - 'tsvgr_opacity', 21:50:42 INFO - 'tart', 21:50:42 INFO - 'tscrollx', 21:50:42 INFO - 'cart']}, 21:50:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:50:42 INFO - 'tsvgr_opacity', 21:50:42 INFO - 'tart', 21:50:42 INFO - 'tscrollx', 21:50:42 INFO - 'cart']}, 21:50:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:42 INFO - 'talos_options': ['--disable-e10s'], 21:50:42 INFO - 'tests': ['tp5o']}, 21:50:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:42 INFO - 'tests': ['tp5o']}, 21:50:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:42 INFO - 'talos_options': ['--disable-e10s', 21:50:42 INFO - '--xperf_path', 21:50:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:42 INFO - 'tests': ['tp5n']}, 21:50:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:42 INFO - 'talos_options': ['--xperf_path', 21:50:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:42 INFO - 'tests': ['tp5n']}}, 21:50:42 INFO - 'talos.zip': {'path': '', 21:50:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:50:42 INFO - Running post-action listener: _resource_record_post_action 21:50:42 INFO - ##### 21:50:42 INFO - ##### Finished populate-webroot step (success) 21:50:42 INFO - ##### 21:50:42 INFO - ##### 21:50:42 INFO - ##### Running create-virtualenv step. 21:50:42 INFO - ##### 21:50:42 INFO - Running pre-action listener: _resource_record_pre_action 21:50:42 INFO - Running main action method: create_virtualenv 21:50:42 INFO - Creating virtualenv /builds/slave/test/build/venv 21:50:42 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 21:50:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:50:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:50:42 INFO - Using real prefix '/usr' 21:50:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:50:42 INFO - Installing distribute.............................................................................................................................................................................................done. 21:50:44 INFO - Installing pip.................done. 21:50:44 INFO - Return code: 0 21:50:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:50:44 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')]} 21:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:44 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')]} 21:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:44 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:50:44 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 21:50:44 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 21:50:44 INFO - Using env: {'DISPLAY': ':0', 21:50:44 INFO - 'HOME': '/home/cltbld', 21:50:44 INFO - 'LANG': 'en_US.UTF-8', 21:50:44 INFO - 'LANGUAGE': 'en_US:en', 21:50:44 INFO - 'LOGNAME': 'cltbld', 21:50:44 INFO - 'MAIL': '/var/mail/cltbld', 21:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:44 INFO - 'MOZ_NO_REMOTE': '1', 21:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:44 INFO - 'NO_EM_RESTART': '1', 21:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:44 INFO - 'PWD': '/builds/slave/test', 21:50:44 INFO - 'SHELL': '/bin/bash', 21:50:44 INFO - 'SHLVL': '1', 21:50:44 INFO - 'TERM': 'linux', 21:50:44 INFO - 'TMOUT': '86400', 21:50:44 INFO - 'USER': 'cltbld', 21:50:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:44 INFO - '_': '/tools/buildbot/bin/python'} 21:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:44 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 21:50:44 INFO - Cleaning up... 21:50:44 INFO - Return code: 0 21:50:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:50:44 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')]} 21:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:44 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')]} 21:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:44 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:50:44 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 21:50:44 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 21:50:44 INFO - Using env: {'DISPLAY': ':0', 21:50:44 INFO - 'HOME': '/home/cltbld', 21:50:44 INFO - 'LANG': 'en_US.UTF-8', 21:50:44 INFO - 'LANGUAGE': 'en_US:en', 21:50:44 INFO - 'LOGNAME': 'cltbld', 21:50:44 INFO - 'MAIL': '/var/mail/cltbld', 21:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:44 INFO - 'MOZ_NO_REMOTE': '1', 21:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:44 INFO - 'NO_EM_RESTART': '1', 21:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:45 INFO - 'PWD': '/builds/slave/test', 21:50:45 INFO - 'SHELL': '/bin/bash', 21:50:45 INFO - 'SHLVL': '1', 21:50:45 INFO - 'TERM': 'linux', 21:50:45 INFO - 'TMOUT': '86400', 21:50:45 INFO - 'USER': 'cltbld', 21:50:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:45 INFO - '_': '/tools/buildbot/bin/python'} 21:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:45 INFO - Downloading/unpacking psutil>=3.1.1 21:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:50:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:47 INFO - Installing collected packages: psutil 21:50:47 INFO - Running setup.py install for psutil 21:50:47 INFO - building 'psutil._psutil_linux' extension 21:50:47 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 21:50:47 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 21:50:47 INFO - building 'psutil._psutil_posix' extension 21:50:47 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 21:50:47 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 21:50:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:47 INFO - Successfully installed psutil 21:50:47 INFO - Cleaning up... 21:50:47 INFO - Return code: 0 21:50:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:50:47 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')]} 21:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:47 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')]} 21:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:47 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:50:47 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 21:50:47 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 21:50:47 INFO - Using env: {'DISPLAY': ':0', 21:50:47 INFO - 'HOME': '/home/cltbld', 21:50:47 INFO - 'LANG': 'en_US.UTF-8', 21:50:47 INFO - 'LANGUAGE': 'en_US:en', 21:50:47 INFO - 'LOGNAME': 'cltbld', 21:50:47 INFO - 'MAIL': '/var/mail/cltbld', 21:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:47 INFO - 'MOZ_NO_REMOTE': '1', 21:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:47 INFO - 'NO_EM_RESTART': '1', 21:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:47 INFO - 'PWD': '/builds/slave/test', 21:50:47 INFO - 'SHELL': '/bin/bash', 21:50:47 INFO - 'SHLVL': '1', 21:50:47 INFO - 'TERM': 'linux', 21:50:47 INFO - 'TMOUT': '86400', 21:50:47 INFO - 'USER': 'cltbld', 21:50:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:47 INFO - '_': '/tools/buildbot/bin/python'} 21:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:50:49 INFO - Installing collected packages: mozsystemmonitor 21:50:49 INFO - Running setup.py install for mozsystemmonitor 21:50:49 INFO - Successfully installed mozsystemmonitor 21:50:49 INFO - Cleaning up... 21:50:50 INFO - Return code: 0 21:50:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:50 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:50:50 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 21:50:50 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 21:50:50 INFO - Using env: {'DISPLAY': ':0', 21:50:50 INFO - 'HOME': '/home/cltbld', 21:50:50 INFO - 'LANG': 'en_US.UTF-8', 21:50:50 INFO - 'LANGUAGE': 'en_US:en', 21:50:50 INFO - 'LOGNAME': 'cltbld', 21:50:50 INFO - 'MAIL': '/var/mail/cltbld', 21:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:50 INFO - 'MOZ_NO_REMOTE': '1', 21:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:50 INFO - 'NO_EM_RESTART': '1', 21:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:50 INFO - 'PWD': '/builds/slave/test', 21:50:50 INFO - 'SHELL': '/bin/bash', 21:50:50 INFO - 'SHLVL': '1', 21:50:50 INFO - 'TERM': 'linux', 21:50:50 INFO - 'TMOUT': '86400', 21:50:50 INFO - 'USER': 'cltbld', 21:50:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:50 INFO - '_': '/tools/buildbot/bin/python'} 21:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:50 INFO - Downloading/unpacking jsonschema==2.5.1 21:50:50 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 21:50:50 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 21:50:50 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 21:50:50 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 21:50:50 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 21:50:50 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 21:50:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:50:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:50:52 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 21:50:52 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 21:50:52 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 21:50:52 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 21:50:52 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 21:50:52 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 21:50:52 INFO - Downloading functools32-3.2.3-2.tar.gz 21:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:50:52 INFO - warning: no files found matching '*.txt' 21:50:52 INFO - no previously-included directories found matching 'build' 21:50:52 INFO - no previously-included directories found matching 'dist' 21:50:52 INFO - no previously-included directories found matching '.git*' 21:50:52 INFO - Installing collected packages: jsonschema, functools32 21:50:52 INFO - Running setup.py install for functools32 21:50:52 INFO - warning: no files found matching '*.txt' 21:50:52 INFO - no previously-included directories found matching 'build' 21:50:52 INFO - no previously-included directories found matching 'dist' 21:50:52 INFO - no previously-included directories found matching '.git*' 21:50:52 INFO - Successfully installed jsonschema functools32 21:50:52 INFO - Cleaning up... 21:50:52 INFO - Return code: 0 21:50:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:52 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:50:52 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 21:50:52 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 21:50:52 INFO - Using env: {'DISPLAY': ':0', 21:50:52 INFO - 'HOME': '/home/cltbld', 21:50:52 INFO - 'LANG': 'en_US.UTF-8', 21:50:52 INFO - 'LANGUAGE': 'en_US:en', 21:50:52 INFO - 'LOGNAME': 'cltbld', 21:50:52 INFO - 'MAIL': '/var/mail/cltbld', 21:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:52 INFO - 'MOZ_NO_REMOTE': '1', 21:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:52 INFO - 'NO_EM_RESTART': '1', 21:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:52 INFO - 'PWD': '/builds/slave/test', 21:50:52 INFO - 'SHELL': '/bin/bash', 21:50:52 INFO - 'SHLVL': '1', 21:50:52 INFO - 'TERM': 'linux', 21:50:52 INFO - 'TMOUT': '86400', 21:50:52 INFO - 'USER': 'cltbld', 21:50:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:52 INFO - '_': '/tools/buildbot/bin/python'} 21:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:50:52 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 21:50:52 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 21:50:52 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 21:50:52 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 21:50:52 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 21:50:52 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 21:50:54 INFO - Downloading blobuploader-1.2.4.tar.gz 21:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:50:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:50:54 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 21:50:54 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 21:50:54 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 21:50:54 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 21:50:54 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 21:50:54 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 21:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:50:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:50: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 21:50: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 21:50: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 21:50: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 21:50: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 21:50: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 21:50:55 INFO - Downloading docopt-0.6.1.tar.gz 21:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:50:55 INFO - Installing collected packages: blobuploader, requests, docopt 21:50:55 INFO - Running setup.py install for blobuploader 21:50:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:50:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:50:55 INFO - Running setup.py install for requests 21:50:55 INFO - Running setup.py install for docopt 21:50:56 INFO - Successfully installed blobuploader requests docopt 21:50:56 INFO - Cleaning up... 21:50:56 INFO - Return code: 0 21:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:50: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')]} 21:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50: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')]} 21:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:56 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:50:56 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 21:50:56 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 21:50:56 INFO - Using env: {'DISPLAY': ':0', 21:50:56 INFO - 'HOME': '/home/cltbld', 21:50:56 INFO - 'LANG': 'en_US.UTF-8', 21:50:56 INFO - 'LANGUAGE': 'en_US:en', 21:50:56 INFO - 'LOGNAME': 'cltbld', 21:50:56 INFO - 'MAIL': '/var/mail/cltbld', 21:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:56 INFO - 'MOZ_NO_REMOTE': '1', 21:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:56 INFO - 'NO_EM_RESTART': '1', 21:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:56 INFO - 'PWD': '/builds/slave/test', 21:50:56 INFO - 'SHELL': '/bin/bash', 21:50:56 INFO - 'SHLVL': '1', 21:50:56 INFO - 'TERM': 'linux', 21:50:56 INFO - 'TMOUT': '86400', 21:50:56 INFO - 'USER': 'cltbld', 21:50:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:56 INFO - '_': '/tools/buildbot/bin/python'} 21:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:50:56 INFO - Running setup.py (path:/tmp/pip-l81udd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:50:56 INFO - Running setup.py (path:/tmp/pip-Ekg26u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:50:56 INFO - Running setup.py (path:/tmp/pip-lDN_sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:50:56 INFO - Running setup.py (path:/tmp/pip-CxcvKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:50:56 INFO - Running setup.py (path:/tmp/pip-RSSYfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:50:56 INFO - Running setup.py (path:/tmp/pip-MsbsTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:50:56 INFO - Running setup.py (path:/tmp/pip-AfBVg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:50:56 INFO - Running setup.py (path:/tmp/pip-dr1fNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:50:56 INFO - Running setup.py (path:/tmp/pip-wA2RbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:50:56 INFO - Running setup.py (path:/tmp/pip-Gzrlju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:50:57 INFO - Running setup.py (path:/tmp/pip-O1rWGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:50:57 INFO - Running setup.py (path:/tmp/pip-MJBrCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:50:57 INFO - Running setup.py (path:/tmp/pip-8uEMjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:50:57 INFO - Running setup.py (path:/tmp/pip-cfMsJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:50:57 INFO - Running setup.py (path:/tmp/pip-MUM5np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:50:57 INFO - Running setup.py (path:/tmp/pip-A18dtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:50:57 INFO - Running setup.py (path:/tmp/pip-6eDj39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:50:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:50:57 INFO - Running setup.py install for manifestparser 21:50:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:50:57 INFO - Running setup.py install for mozcrash 21:50:57 INFO - Running setup.py install for mozdebug 21:50:57 INFO - Running setup.py install for mozdevice 21:50:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:50:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:50:57 INFO - Running setup.py install for mozfile 21:50:58 INFO - Running setup.py install for mozhttpd 21:50:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Running setup.py install for mozinfo 21:50:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Running setup.py install for mozInstall 21:50:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Running setup.py install for mozleak 21:50:58 INFO - Running setup.py install for mozlog 21:50:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Running setup.py install for moznetwork 21:50:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Running setup.py install for mozprocess 21:50:58 INFO - Running setup.py install for mozprofile 21:50:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:50:58 INFO - Running setup.py install for mozrunner 21:50:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:50:59 INFO - Running setup.py install for mozscreenshot 21:50:59 INFO - Running setup.py install for moztest 21:50:59 INFO - Running setup.py install for mozversion 21:50:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:50:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:50:59 INFO - Cleaning up... 21:50:59 INFO - Return code: 0 21:50:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:50: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')]} 21:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50: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')]} 21:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:59 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:50:59 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 21:50:59 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 21:50:59 INFO - Using env: {'DISPLAY': ':0', 21:50:59 INFO - 'HOME': '/home/cltbld', 21:50:59 INFO - 'LANG': 'en_US.UTF-8', 21:50:59 INFO - 'LANGUAGE': 'en_US:en', 21:50:59 INFO - 'LOGNAME': 'cltbld', 21:50:59 INFO - 'MAIL': '/var/mail/cltbld', 21:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:59 INFO - 'MOZ_NO_REMOTE': '1', 21:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:59 INFO - 'NO_EM_RESTART': '1', 21:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:59 INFO - 'PWD': '/builds/slave/test', 21:50:59 INFO - 'SHELL': '/bin/bash', 21:50:59 INFO - 'SHLVL': '1', 21:50:59 INFO - 'TERM': 'linux', 21:50:59 INFO - 'TMOUT': '86400', 21:50:59 INFO - 'USER': 'cltbld', 21:50:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:59 INFO - '_': '/tools/buildbot/bin/python'} 21:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:50:59 INFO - Running setup.py (path:/tmp/pip-xiGf28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:50:59 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)) 21:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:50:59 INFO - Running setup.py (path:/tmp/pip-3s83Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:50:59 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)) 21:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:50:59 INFO - Running setup.py (path:/tmp/pip-pBFGmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:50:59 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)) 21:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:50:59 INFO - Running setup.py (path:/tmp/pip-Jjx7Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:50:59 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)) 21:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:50:59 INFO - Running setup.py (path:/tmp/pip-_ZFNXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:51:00 INFO - Running setup.py (path:/tmp/pip-8tQ4Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:51:00 INFO - Running setup.py (path:/tmp/pip-Tf5xVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:51:00 INFO - Running setup.py (path:/tmp/pip-3DJlwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:51:00 INFO - Running setup.py (path:/tmp/pip-1exKwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:51:00 INFO - Running setup.py (path:/tmp/pip-yCJAat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:51:00 INFO - Running setup.py (path:/tmp/pip-oGKX1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:51:00 INFO - Running setup.py (path:/tmp/pip-DpK2Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:51:00 INFO - Running setup.py (path:/tmp/pip-68mkAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:51:00 INFO - Running setup.py (path:/tmp/pip-SczkFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:00 INFO - Running setup.py (path:/tmp/pip-7j8Frd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:51:00 INFO - Running setup.py (path:/tmp/pip-lvVy98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:51:00 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)) 21:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:51:00 INFO - Running setup.py (path:/tmp/pip-we5oZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:51:00 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)) 21:51:00 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)) 21:51:00 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)) 21:51:00 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)) 21:51:00 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)) 21:51:00 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)) 21:51:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:02 INFO - Downloading blessings-1.6.tar.gz 21:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:51:02 INFO - Installing collected packages: blessings 21:51:02 INFO - Running setup.py install for blessings 21:51:02 INFO - Successfully installed blessings 21:51:02 INFO - Cleaning up... 21:51:03 INFO - Return code: 0 21:51:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:51:03 INFO - Reading from file tmpfile_stdout 21:51:03 INFO - Current package versions: 21:51:03 INFO - argparse == 1.2.1 21:51:03 INFO - blessings == 1.6 21:51:03 INFO - blobuploader == 1.2.4 21:51:03 INFO - docopt == 0.6.1 21:51:03 INFO - functools32 == 3.2.3-2 21:51:03 INFO - jsonschema == 2.5.1 21:51:03 INFO - manifestparser == 1.1 21:51:03 INFO - mozInstall == 1.12 21:51:03 INFO - mozcrash == 0.17 21:51:03 INFO - mozdebug == 0.1 21:51:03 INFO - mozdevice == 0.48 21:51:03 INFO - mozfile == 1.2 21:51:03 INFO - mozhttpd == 0.7 21:51:03 INFO - mozinfo == 0.9 21:51:03 INFO - mozleak == 0.1 21:51:03 INFO - mozlog == 3.2 21:51:03 INFO - moznetwork == 0.27 21:51:03 INFO - mozprocess == 0.22 21:51:03 INFO - mozprofile == 0.28 21:51:03 INFO - mozrunner == 6.11 21:51:03 INFO - mozscreenshot == 0.1 21:51:03 INFO - mozsystemmonitor == 0.3 21:51:03 INFO - moztest == 0.7 21:51:03 INFO - mozversion == 1.4 21:51:03 INFO - psutil == 3.1.1 21:51:03 INFO - requests == 1.2.3 21:51:03 INFO - wsgiref == 0.1.2 21:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51: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')]} 21:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51: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')]} 21:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:03 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:51:03 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 21:51:03 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 21:51:03 INFO - Using env: {'DISPLAY': ':0', 21:51:03 INFO - 'HOME': '/home/cltbld', 21:51:03 INFO - 'LANG': 'en_US.UTF-8', 21:51:03 INFO - 'LANGUAGE': 'en_US:en', 21:51:03 INFO - 'LOGNAME': 'cltbld', 21:51:03 INFO - 'MAIL': '/var/mail/cltbld', 21:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:03 INFO - 'MOZ_NO_REMOTE': '1', 21:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:03 INFO - 'NO_EM_RESTART': '1', 21:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:03 INFO - 'PWD': '/builds/slave/test', 21:51:03 INFO - 'SHELL': '/bin/bash', 21:51:03 INFO - 'SHLVL': '1', 21:51:03 INFO - 'TERM': 'linux', 21:51:03 INFO - 'TMOUT': '86400', 21:51:03 INFO - 'USER': 'cltbld', 21:51:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:03 INFO - '_': '/tools/buildbot/bin/python'} 21:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 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)) 21:51:03 INFO - Cleaning up... 21:51:03 INFO - Return code: 0 21:51:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:51: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')]} 21:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51: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')]} 21:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:03 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:51:03 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 21:51:03 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 21:51:03 INFO - Using env: {'DISPLAY': ':0', 21:51:03 INFO - 'HOME': '/home/cltbld', 21:51:03 INFO - 'LANG': 'en_US.UTF-8', 21:51:03 INFO - 'LANGUAGE': 'en_US:en', 21:51:03 INFO - 'LOGNAME': 'cltbld', 21:51:03 INFO - 'MAIL': '/var/mail/cltbld', 21:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:03 INFO - 'MOZ_NO_REMOTE': '1', 21:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:03 INFO - 'NO_EM_RESTART': '1', 21:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:03 INFO - 'PWD': '/builds/slave/test', 21:51:03 INFO - 'SHELL': '/bin/bash', 21:51:03 INFO - 'SHLVL': '1', 21:51:03 INFO - 'TERM': 'linux', 21:51:03 INFO - 'TMOUT': '86400', 21:51:03 INFO - 'USER': 'cltbld', 21:51:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:03 INFO - '_': '/tools/buildbot/bin/python'} 21:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:51:03 INFO - Cleaning up... 21:51:03 INFO - Return code: 0 21:51:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:51: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')]} 21:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51: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')]} 21:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:03 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 0x7f784f302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, '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': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', '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 21:51:03 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 21:51:03 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 21:51:03 INFO - Using env: {'DISPLAY': ':0', 21:51:03 INFO - 'HOME': '/home/cltbld', 21:51:03 INFO - 'LANG': 'en_US.UTF-8', 21:51:03 INFO - 'LANGUAGE': 'en_US:en', 21:51:03 INFO - 'LOGNAME': 'cltbld', 21:51:03 INFO - 'MAIL': '/var/mail/cltbld', 21:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:03 INFO - 'MOZ_NO_REMOTE': '1', 21:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:03 INFO - 'NO_EM_RESTART': '1', 21:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:03 INFO - 'PWD': '/builds/slave/test', 21:51:03 INFO - 'SHELL': '/bin/bash', 21:51:03 INFO - 'SHLVL': '1', 21:51:03 INFO - 'TERM': 'linux', 21:51:03 INFO - 'TMOUT': '86400', 21:51:03 INFO - 'USER': 'cltbld', 21:51:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:03 INFO - '_': '/tools/buildbot/bin/python'} 21:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:03 INFO - Downloading/unpacking flake8 21:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:51:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:51:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:51:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:51:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:51:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:51:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:51:06 INFO - no previously-included directories found matching 'docs/_build' 21:51:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:51:06 INFO - Running setup.py install for pep8 21:51:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:51:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:51:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:51:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:51:06 INFO - no previously-included directories found matching 'docs/_build' 21:51:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:51:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:51:06 INFO - Cleaning up... 21:51:06 INFO - Return code: 0 21:51:06 INFO - Running post-action listener: _resource_record_post_action 21:51:06 INFO - Running post-action listener: _start_resource_monitoring 21:51:06 INFO - Starting resource monitoring. 21:51:06 INFO - ##### 21:51:06 INFO - ##### Finished create-virtualenv step (success) 21:51:06 INFO - ##### 21:51:06 INFO - ##### 21:51:06 INFO - ##### Running install step. 21:51:06 INFO - ##### 21:51:06 INFO - Running pre-action listener: _resource_record_pre_action 21:51:06 INFO - Running main action method: install 21:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:51:06 INFO - Reading from file tmpfile_stdout 21:51:06 INFO - Detecting whether we're running mozinstall >=1.0... 21:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:51:07 INFO - Reading from file tmpfile_stdout 21:51:07 INFO - Output received: 21:51:07 INFO - Usage: mozinstall [options] installer 21:51:07 INFO - Options: 21:51:07 INFO - -h, --help show this help message and exit 21:51:07 INFO - -d DEST, --destination=DEST 21:51:07 INFO - Directory to install application into. [default: 21:51:07 INFO - "/builds/slave/test"] 21:51:07 INFO - --app=APP Application being installed. [default: firefox] 21:51:07 INFO - mkdir: /builds/slave/test/build/application 21:51:07 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'] 21:51:07 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 21:51:22 INFO - Reading from file tmpfile_stdout 21:51:22 INFO - Output received: 21:51:22 INFO - /builds/slave/test/build/application/firefox/firefox 21:51:22 INFO - Running post-action listener: _resource_record_post_action 21:51:22 INFO - ##### 21:51:22 INFO - ##### Finished install step (success) 21:51:22 INFO - ##### 21:51:22 INFO - ##### 21:51:22 INFO - ##### Running run-tests step. 21:51:22 INFO - ##### 21:51:22 INFO - Running pre-action listener: _resource_record_pre_action 21:51:22 INFO - Running main action method: run_tests 21:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:51:22 INFO - Python 2.7.3 21:51:22 INFO - Return code: 0 21:51:22 INFO - grabbing minidump binary from tooltool 21:51:22 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')]} 21:51:22 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 0x2b561c0>, '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 0x2b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:51:22 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 21:51:22 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 21:51:22 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 21:51:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:51:23 INFO - Return code: 0 21:51:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:51:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:51:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:51:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:51:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:51:23 INFO - Return code: 0 21:51:23 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/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 21:51:23 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/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 21:51:23 INFO - Using env: {'DISPLAY': ':0', 21:51:23 INFO - 'HOME': '/home/cltbld', 21:51:23 INFO - 'LANG': 'en_US.UTF-8', 21:51:23 INFO - 'LANGUAGE': 'en_US:en', 21:51:23 INFO - 'LOGNAME': 'cltbld', 21:51:23 INFO - 'MAIL': '/var/mail/cltbld', 21:51:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:51:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:23 INFO - 'MOZ_NO_REMOTE': '1', 21:51:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:23 INFO - 'NO_EM_RESTART': '1', 21:51:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:23 INFO - 'PWD': '/builds/slave/test', 21:51:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:51:23 INFO - 'SHELL': '/bin/bash', 21:51:23 INFO - 'SHLVL': '1', 21:51:23 INFO - 'TERM': 'linux', 21:51:23 INFO - 'TMOUT': '86400', 21:51:23 INFO - 'USER': 'cltbld', 21:51:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465101535.678350-418856284', 21:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:23 INFO - '_': '/tools/buildbot/bin/python'} 21:51:23 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/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 21:51:24 INFO - mozversion application_buildid: 20160604212243 21:51:24 INFO - mozversion application_changeset: 0ac19ca034d9097ded455362e46b56017f3a64a4 21:51:24 INFO - mozversion application_display_name: Nightly 21:51:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:51:24 INFO - mozversion application_name: Firefox 21:51:24 INFO - mozversion application_remotingname: firefox 21:51:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:51:24 INFO - mozversion application_vendor: Mozilla 21:51:24 INFO - mozversion application_version: 49.0a1 21:51:24 INFO - mozversion platform_buildid: 20160604212243 21:51:24 INFO - mozversion platform_changeset: 0ac19ca034d9097ded455362e46b56017f3a64a4 21:51:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:51:24 INFO - mozversion platform_version: 49.0a1 21:51:24 INFO - using testdate: 1465102284 21:51:24 INFO - actual date: 1465102284 21:51:24 INFO - starting webserver on 'localhost:33299' 21:51:24 INFO - SUITE-START | Running 2 tests 21:51:24 INFO - TEST-START | dromaeo_css 21:51:24 INFO - operating with platform_type : linux_ 21:51:24 INFO - Initialising browser for dromaeo_css test... 21:51:24 INFO - TEST-INFO | started process 2117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFn_vD/profile http://localhost:33299/getInfo.html) 21:51:28 INFO - PROCESS | 2117 | __metrics Screen width/height:1600/1200 21:51:28 INFO - PROCESS | 2117 | colorDepth:24 21:51:28 INFO - PROCESS | 2117 | Browser inner width/height: 1024/697 21:51:28 INFO - PROCESS | 2117 | __metrics 21:51:29 ERROR - PROCESS | 2117 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:51:30 INFO - TEST-INFO | 2117: exit 0 21:51:30 INFO - Browser initialized. 21:51:30 INFO - Running cycle 1/1 for dromaeo_css test... 21:51:30 INFO - TEST-INFO | started process 2200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFn_vD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:51:42 INFO - PROCESS | 2200 | RSS: Main: 157396992 21:51:42 INFO - PROCESS | 2200 | 21:52:33 INFO - PROCESS | 2200 | 1465102353835 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] 21:54:46 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:33299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33299/tests/dromaeo/cssquery-ext.html) 21:54:47 INFO - PROCESS | 2200 | RSS: Main: 253837312 21:54:47 INFO - PROCESS | 2200 | 21:57:49 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:33299/tests/dromaeo/cssquery-ext.html (next: http://localhost:33299/tests/dromaeo/cssquery-jquery.html) 21:57:50 INFO - PROCESS | 2200 | RSS: Main: 236838912 21:57:50 INFO - PROCESS | 2200 | 22:00:52 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:33299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33299/tests/dromaeo/cssquery-mootools.html) 22:00:53 INFO - PROCESS | 2200 | RSS: Main: 237830144 22:00:53 INFO - PROCESS | 2200 | 22:03:55 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:33299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33299/tests/dromaeo/cssquery-prototype.html) 22:03:56 INFO - PROCESS | 2200 | RSS: Main: 235450368 22:03:56 INFO - PROCESS | 2200 | 22:06:59 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:33299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33299/tests/dromaeo/cssquery-yui.html) 22:06:59 INFO - PROCESS | 2200 | RSS: Main: 227794944 22:06:59 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:33299/tests/dromaeo/cssquery-yui.html (next: http://localhost:33299/tests/dromaeo/cssquery-dojo.html) 22:10:02 INFO - PROCESS | 2200 | RSS: Main: 277721088 22:10:02 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | __start_tp_report 22:10:02 INFO - PROCESS | 2200 | _x_x_mozilla_page_load 22:10:02 INFO - PROCESS | 2200 | _x_x_mozilla_page_load_details 22:10:02 INFO - PROCESS | 2200 | |i|pagename|runs| 22:10:02 INFO - PROCESS | 2200 | |0;dojo.html;2674.0908091248975;2684.677838659361;2717.334253107989;2721.863906804659;2741.3420779013045;4546.590806827385;4565.817367305303;4613.815447382105;4621.861344159681;4649.697769644975;4668.649851261152;4669.766511674411;4691.460482044566;4710.788014539346;4736.952630473695;4290.442242508485;4293.742375457467;4373.890652733675;4394.121175764852;4414.139242847646;4354.608085272325;4398.9340159897465;4445.84439544616;4468.932966005513;4469.173202957447;4388.341748737683;4429.579189976947;4443.15580039793;4472.865814025585;4491.438570178728;4264.147170565868;4288.935665965013;4294.527601963813;4294.634956028742;4350.934735978963;4250.744955302692;4258.872233832959;4267.829286828523;4302.247106756305;4305.547917468652;4570.908581828345;4624.982503849148;4625.444946606395;4686.95313046872;4691.366665500182;4872.707637541759;5037.345145131109;5067.163917953533;5085.567726743231;5092.8217512387255;5049.394072711261;5077.771500282459;5090.872728181788;5173.224016397533;5173.508516690908;4760.285957106393;4792.568668819753;4803;4805.447373552016;4821.951780482221;5015.974920125449;5161.432242453402;5289.761960711778;5313.44208858072;5323.148296272578;4989.950100499022;4991.775370108354;5047.671901326402;5065.037642847848;5080.161773307437;5099.464556221544;5106.591472682177;5112.284280200774;5116.386033675983;5129.333186685782;4833.734144622009;4915.877103072452;4967.503249675004;5002.124628190052;5010.398752149766;4967.155583550805;4969.950300497021;4994.825181118644;5009.7244651544515;5016.147254966664;4217.4306468626955;4229.45017147775;4233.364995250676;4272.209641216385;4275.03811642378;3636.4545318201954;3657.4696668982847;3726.9813650932115;3728;3817.923641527154;4330.17726631939;4334.024844410045;4346.282863327516;4361.433013708261;4383.561643835655;5102.897942041212;5107.080725469451;5108.872278193001;5109.693418394908;5157.58739300855;4292.227399068135;4315.050688848449;4362.149380870763;4364.563543645673;4411.205982923105;4540.750258735801;4553.043860789205;4556.430446194226;4590.9540904591195;4609.032103258353;4785.377900872864;4791.784369703441;4796.040791841576;4800.1119792837735;4843.152448321459;4927.679700819435;5037.899242015066;5041.269015992734;5100.515451032146;5110.207917772751;4765.166095933268;4794.880127996828;4796.160671882476;4836.492168322276;4846.684965477232;5011.443688137165;5014.247862820606;5015.147424937696;5016.974915125401;5019.447860735243;4945.208766597471;5046;5062.82280120194;5065.8733531662;5084.847454576368;4936.2102063669645;4945.67853089548;4958.033183529177;4964.032013757283;5012.097822392005;4942.4316203637045;4949.133901567283;4954.752262386938;4955.529224723646;5010.248462730619;4745.217039188496;4787.736674482798;4834.854954351375;4852.029594081268;4925.852224433273;4997.400311962588;4998.1253280676465;4999.250112483157;5003.149464590955;5021.924671130009;4681.063787242633;4852.393450818648;4856.538628830255;4857.6599638025;4895.7062576245535 22:10:02 INFO - PROCESS | 2200 | |1;ext.html;563.5519761789377;595.4938302442923;605.8394525450757;610.0270069239562;631.0628716356213;27197.18408447745;40032.19935601286;40919.18161636769;41066.794666026704;45172.3224151638;41867.16265674685;42180;42559.574404255945;42581.36127958083;42582.36126458098;7377.704891804321;7592.924070759277;7605.125410577799;7712.267334603203;7914.3668506519625;9672.854907176397;9977.102060814525;9986.800263994715;10325.948370258138;10334.534945927451;10081.143102836268;10196.94901525495;10198.133158681521;10198.592056317739;10200.744981375488;7364.815879603053;9819.705408837746;9969.601215951354;10062;10096.242781791321;9871.654492092814;9981.950090249502;9991.250656200815;10005.249606279558;10010.949945250228;36656.45015324745;36995.630043699486;37084.62915370866;37195.442068369;37202.44196337057;2965.940681186364;3078.122735020531;3136.4354416205074;3347.196672798535;3737.3085979093685;28317.85841070802;28403.289917752016;28452;28463;29195.56206656902;3276.1973316537365;3341.7827841190247;3372.780769249991;3396.490526421032;3440.9655903440894;260032;260814.69592652106;260818;261344;261365;51348.74325628348;52162.478375216524;52244;52335.21497177545;52344;29454.263643409085;29907.25231869177;30040.54939175914;30064.84967575148;30074.699253007628;13417.530386436623;13442.798358024638;13445.126066805626;13457.461701531829;13464.25946572948;9345.15893569582;10290.331128476626;10709.732256693489;10736.838947415796;10770.407627580558;18668.719969200472;18696.252149914122;18724.81275187231;18765.81234187668;18788.342408015655;7126.251743566851;7172.888202328648;7195.172555156119;7246.420286377077;7407.66665500043;834.3033566971646;899.7845095726542;915.9129882661136;923.7136487688838;1003.1222680154865;26907.327316816845;26913;27589;27606.171814845588;27657.723422765917;949.349695458613;973.8490533967247;1040.095117247984;1054.488573042074;1064.180580952662;14423;14840.406383744745;14840.62898427548;15051.924740376227;15063.397464101314;422576;425102;426198;426608;427130;49783;50427.495725043016;50436.49563504318;50466.495335046915;50468.74765626222;1086.8858769829212;1137.4938152522213;1186.5075993462617;1197.0961923747516;1199.7840388730112;27693.72306276992;28926.855365723877;29231.70768292375;29251.26871828136;29802.85098574493;46802;48203;48247.27629085637;53113.7344313276;53139.734301328244;359936;365673;365781;367462;555558;37429.251414971004;38481.42277865778;38680.2263954725;41908.37137443002;43010;42718.57281427146;43053.78473107614;43334.34998475089;43689.78155109204;44134.55865441304;35695.82152089223;37366;37544;37575.81212093922;37625;35998.46002309915;36948.63051369559;37080.25839483249;37396.06509837167;37530.812345938095;35681.28637427289;36944.44583331306;37101.814490927376;37200.44199336958;37234.44148337723;32335.191620209684;32982.5052624206;33524;33537.49693754547;33604.663953360156;24768.50462990766;24783.87608061948;24936;24967.12615058464;25061.749382505943 22:10:02 INFO - PROCESS | 2200 | |2;jquery.html;377.09309111586646;378.41534828689674;380.1124374585345;384.7902892923357;392.47408472646646;13743.106698064632;14637.634059148526;14876.107433553982;17125.400610978617;17497.212625431854;14995;15087.39650413982;15098.622534436645;15100;15202.391904323842;4427.535108813585;4746.979399429122;4750.334953106568;4806.495317991613;4810.374651295327;3519.296140771843;3704.2221133561984;4698.718076915379;5195.766190521416;5463.2078348639425;5535.197396377523;5537.003339398927;5546.528545073674;5550.91673624896;5556.222128901957;5347.385050719139;5465.207544905987;5531.557475401978;5540.058190107691;5544.91682624761;3387.8814241501427;4954.405471343462;5275.235090911835;5275.947240527622;5333.706646134461;12072.09459290548;12166.57416990401;12247.816282755677;12386.81419778704;12409.131360804748;1856.4894653970132;1897.7343171955938;1912.8278454938984;2012.838972882166;2216.822654187661;8972.282217422657;9313.30150238728;9741.074597913186;12491.312977786218;12737.172083814616;1562.203276329069;1566.6240102375461;1568.9450869219636;1605.727026405514;1623.861971732404;63450;65624.3437565623;67730;68285.3171468289;68635.65682171607;9894.60421583143;10030.247731420173;10231.43727095002;10565.788684226272;11003.119750420108;14042.789358159636;14048.367823447968;14192.64518387028;14231.78652320216;14256.42974281017;6806.7957961261245;6978.860422791516;7092.574445533284;7335.229800870939;7396.55620662762;6478.740850366027;6650;6832.077669514552;6921.688524016431;6984.965075174591;4416.470023597189;4447.777611119431;4489.9551004490195;4565.817367305337;4578.992621623238;1637.4841924793652;1763.1096296370508;1814;1874.6344462829618;1904.7238150468381;796.5738329993426;887.0508555845183;897.3001059173724;938.7746940734311;956.3305686019675;16024.519264422086;16137.112458814878;16287.185640717917;16331.346746130259;16724.331026759035;860.8665656823202;861.8233262181237;868.913108689126;874.33113668044;875.1729615513278;8849.51327676971;9384.812303753886;9460.290478214161;9484.146426821619;9622.422654640744;352401;370862;385218;399085;400791;69310;70805.64597177083;71662;72935.27064729285;72984;891.8439273127177;893.65147592439;909.2453263791037;919.7700574856286;920.6087412849379;14590.292301440415;14608.70782584321;14639.121652700873;14743.778843317144;14892.702145957237;31932.361352773278;32202.19494512656;33970.32059358848;34223.31553368869;34847.65152348444;47932.760336198095;48826.511734882195;49062.50937490579;49077;49651.25523117084;7652.7704168875025;7761.534307941542;7784.494007889469;7834.529928204326;7933.761987140395;8524.659013639384;11169.72075698114;11650.242734222249;11672.941635291769;11724.824127637921;5601.327840659147;5777.537796976148;9649.614015439303;10055.69832905014;10260.281780275309;9311.813763724553;9759.9024009759;10150.593976241164;10269.845952310572;10332.53503592325;9935.15551178129;10287.331323463952;10299.639512617323;10351.585936562453;10616.097631701392;6561.212654481493;6937.06349642812;7696.114946780968;7873.1733168016535;8034.276915077671;9369;10066.094051535105;10066.647667331608;10108.747281318027;10483.895161048293 22:10:02 INFO - PROCESS | 2200 | |3;mootools.html;1292.5669900583305;1370.8149399831022;1448.1600671610468;1513.909165450073;1805.1154934082294;6737.629430381327;7459.1049074111115;7734.187910269425;7772.028496437945;7954.2841144297;7692.192319806423;7833.37333013359;7838.568878711669;7854.960725196366;7857.6856925722905;1862.236483041953;2067.4934641012896;2140.411386868608;2149.5378493623866;2180.563887222554;2151.8493705440546;2171.5114099327684;2171.9782802171935;2175.3365223606793;2175.445261458326;2145.9141634334687;2162.2540223622823;2162.37291185556;2179;2181.3892110209167;1780.287884846059;2044.7444069491314;2050.1184490669007;2115.3125234298914;2119.9576008479744;2104.4738815296178;2110.6833974903734;2116.502621883856;2126.479012641897;2127.712758777561;7693.49992250502;7739.57432341221;7745.2185997220395;7772.222777722239;7772.7668169954995;4339.305711086211;4444.133393988173;4456.2201614717615;4459;4460.93308600368;2810.2693299742214;2904.782141339408;2987.327851233477;3009.1123118680043;3009.5184770436626;887.9112088791134;888.1296329597031;896.7175339767953;1582.754673025683;1648.3736180251547;10568.682939511827;10681.145508359312;10695;10736.248462607698;10737.51681174349;4069.694772891986;4090;4146.1914926589625;4181.414601955728;4184.66522678185;8501;8548.059713431518;8558.786030349167;8559.95720021396;8565.528895910784;4470.240059189946;4470.307102399133;4471.5081341052455;4473.306637471197;4477.507474177838;3567.554055743032;3964.484616999772;4103.466549348565;4109.075458021921;4155.605217504332;3310.486874534451;3342.5320455136302;3398.8300584970652;3434.553508043988;3455.274392377579;970.737900766789;990.9256805739599;991.1723710701644;992.6674564021134;1002.5338217728792;742.4357488308924;859.8237361340911;878.0999475537498;890.576975936438;899.7525680437932;4926.9014619707405;5245.082110630625;5304.416514183436;5344.225087362311;5382.973085134549;376.61397068005516;381.19187322875683;402.4647219198459;406.38229890566174;408.8569000849738;3589.2283159120916;3591.245838373971;3601.2797440512004;3626.111602657313;3688.797116158637;9361;9638.518074096268;9705.805883882284;9735.610575577039;9747.415155090575;9552.235821134293;9624.181944534654;9636.903630963741;9639.373440726331;9665.420074795535;6748.325167483213;7009.334113259232;7015.438764898898;7129.073220481304;7308.392153726172;5526.392096869422;5662.462066103713;5710.486056254957;5794.913076303775;5808.128780682931;8619.439736417113;8950.104989500998;9006.324525660733;9042.864357034781;9049.54752262371;8992.46045237288;9021.864672029793;9049.819003620023;9083.091690830865;9088.454692718458;6055.515558755201;6152.107944347955;6278.246610406781;6381.138546296191;6393.520485963664;7433.516821406807;7480.4015678746655;7505.437092217996;7556.433267505069;7560.206178351194;6217.347178546188;6426.164598602152;6460.45086167681;6523.18460192476;6534;6180.721867515883;6265.592736472115;6353.8729225416155;6385.45723613498;6467.676616169078;6129.325774164749;6159.907601385893;6200.937990620036;6201.069839524108;6211.3478084800445;4446.799894004842;4553.453585569753;4584.724916505021;4708.858734237979;4733.786979585858;4578.748168850745;4606.792694328697;4638.605718513964;4655.511171327097;4699.600533954652 22:10:02 INFO - PROCESS | 2200 | |4;prototype.html;292.06684642566995;294.76271601360907;302.24438902743134;304.4580646449321;305.2201624848514;4848.66661668041;4877.561119469756;4886.462489126197;4893.140606569503;4917.877053073675;4818.710877347362;4832.565069143777;4853.927191092128;4862.416510018794;4873.683210591309;3619.7647152935106;3730.0674831292176;3733.682636975847;3760.3043436964113;3763.7553559018575;3674.1549443627982;3728.459373390857;3786.185970016446;3804.4293355996547;3817.9045523861846;3708.6662200401956;3739.5138631977807;3748.3815170496973;3775.206776781021;3780.395136778116;3570.107473131717;3743.850245990157;3762.360398732195;3783.6405541473514;3789.5073640426845;3286.145602143436;3292.6213485449002;3295.785773924711;3296.8516416761304;3300.785448945811;4645.674802763808;4666.390095417076;4687.468766865888;4707;4728.976355118237;4096.365063415175;4255.957440425587;4257.297545904953;4269.487661480611;4269.701120921537;5062.443131255559;5065;5073.543381095719;5080.110980578384;5091.79632814687;3608.82713118235;3623.1884057971015;3630.3646861799343;3630.438911268154;3638.2905333459985;5170.353705786777;5282.630215884889;5334.653247538898;5387.865303367447;5393.352797664266;3665.90022993101;3677.871274505433;3681.650243226889;3685.2997930393676;3693.9472250408503;3746.688658969339;3748.793816340073;3751.7186211033736;3754.511913451234;3761.097336639242;4255.680823938155;4266.360045993064;4274.187904298174;4311.103114629615;4321.595481468536;4885.877853053631;5092.567131793765;5099.87250318745;5112.233165025276;5145.434002259748;1276.8467783865995;1287.6909541709922;1291.593148158327;1292.7091404433927;1296.3971753134838;767.7658314214107;803.8472690188845;807.0597753617088;810.4812919731377;813.1096449387911;4405.537418571068;4477.843275485342;4504.495504495504;4515.909681806345;4519.706219095749;5243.475652434726;5256;5260.789568417221;5276.366835979707;5291.735413229323;4467.7319360838455;4469.329600559942;4476.4180656514445;4491.30384790358;4498.122866041091;2638.8680565971626;2832.626176304491;2845.701201373867;2849.4586028654903;2861.0401874715885;4986.628677113823;5013;5013.649044566845;5022.824201152942;5028.572571331478;5227.477252274818;5407.783688652488;5412.675239485643;5416.160495123262;5444.564434845203;4963.131451995814;4977.626677999092;4978;5001.924971125436;5006.299118123466;5277.182036784305;5296.496832800878;5304.655197412156;5314.707691077027;5314.787408503771;5028.164719877292;5165.612579056661;5175.171972484384;5196.714180720097;5214.374275086862;4927.260910863399;4940.086084074458;4971.304017437634;4980.352554167935;4988.351514303117;3349.91127883434;3408.471686888536;3424.4692072728767;3424.7602667814012;3438.8452519636176;4460.397846290709;4748.246017310021;4754.809807607657;4758.619310455225;4773.856784296477;4574.954250457586;4591.885202869955;4592.931106033346;4638.049199914077;4661.790219440201;4644.790984405642;4652.627789776742;4656.3713898623255;4663.650226232979;4671.953280467152;4276.861569215393;4557.430321209848;4562.5665561771575;4568.314752787109;4573.474050484104;4730.526947305242;4870.220764677634;4966.180580204225;4985.401751789664;4993.900121997613;4852.393450818648;4871.488493708252;4921.188003979447;4955.900881982412;4992.550670439678 22:10:02 INFO - PROCESS | 2200 | |5;yui.html;587.519160912232;594.0762114911314;622.9719662615182;634.7175506899432;701.1516065560671;11579.53681852726;12239.755204895897;12248.877511224886;12259.325737084457;12265.141440099196;12172.330521821295;12280.078994075458;12356.629301120958;12749.681257968556;12774.93612531936;640.9198850143732;784.8430313937207;800.93592512599;801.3749275565068;807.2331285278979;800.0998876264202;810.1857633078747;810.4043528006911;810.5055915891302;811.0267678785451;837.0917554453425;837.7319257837495;838.174398217755;838.1995194589183;838.5304229631396;659.5548005096589;809.8056466448069;830.7217082277444;831.3889291370838;840.1304649687605;616.257409821169;617.6355949989528;617.7467238432221;617.7590739611555;618.057462369885;11870.821937670942;11874.821877671842;11899.524019039314;11902.583409580624;11903.821442678367;12242.877571224262;12591.37043147848;12679.873201267961;12905.806412903814;13150;9690.224782017422;9871.568622549761;9917.404955702608;10788.136949044057;11268.549258029669;2737.54830452975;2875.5399136138117;4231.576842315774;4233.576642335773;4241.066965267636;59529;60239.39760602426;60771.39228607702;60856.69571652158;60911.69544152295;9856.704298871045;9889.851652225223;10015.599376025024;10192.439415832201;10308.175345972304;15701.685966280611;15725.606859828596;15730.921345393428;15800.60498487547;15835.762463563056;6559.573627714183;6701.430378417792;6775.559588626724;6831.351021652935;6885.931140688529;3667.8716244931297;3765.6234376562675;3773.094457330221;3785.5268091488565;3794.2601192767697;3027.9545806812916;3124.0940127363265;3125.0312403155094;3126.5935428394164;3128.03031060372;530.482779290189;534.9625526213127;543.2584522127347;543.8450041738085;549.7581064331681;502.4272329544322;535.2052202479315;557.9776808927678;597.2027343496394;622.116594435893;7976.680932762741;8390.412671112963;8436.704715335056;8437.957810211032;8607.698730544402;526.7919171927067;559.5831105826186;625.1810128731377;628.1927722876082;655.5804285257439;3750.549934007882;3866.8066596670055;3902.7345961678066;3903.941440878389;3995.1610161866333;69125.65437172783;72350.63824680843;72364.63817680984;82685;83247;62453.687731561055;73553.26446735571;76904.61547692226;77671.61164194143;80378.19621803708;46848.29727554089;64733.35266647273;71874.64062679654;72514.99999999894;74856.62571687215;8321.464498072777;8883.822323553364;9077.319201059814;9108.544572771467;9122.908770912207;31319.21701957469;34027.829860850536;35406;37885.242295154494;41819.790901046516;56114;61532;62090.68954655198;62130;62619.373806261356;11089.27919685218;11255.718607034889;11387.544498219979;11504.827427588425;12006.21959572625;12519.56181533642;12622.87377126217;12672.556460523838;12740.808887866875;12747;12056.819147712617;12254.693632659255;12559.246445213317;12719.173253738478;13083.084184107021;12040.879591203975;12132.514699412277;12155.635330940086;12297.56958506448;12987.610371688865;10354.430506322225;10460;11041.44792760375;11562.884371156517;11901.940490297493;9713.417194968324;10007.09936105754;10315.27793054479;10380.48097595102;10629.309094908805;10311.175105991653;10598.31110977784;10623.89376106229;10670.253082284165;10975.28660637056 22:10:02 INFO - PROCESS | 2200 | __end_tp_report 22:10:02 INFO - PROCESS | 2200 | __start_cc_report 22:10:02 INFO - PROCESS | 2200 | _x_x_mozilla_cycle_collect,928 22:10:02 INFO - PROCESS | 2200 | __end_cc_report 22:10:02 INFO - PROCESS | 2200 | __startTimestamp1465103402809__endTimestamp 22:10:02 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | ------- Summary: start ------- 22:10:02 INFO - PROCESS | 2200 | Number of tests: 6 22:10:02 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | [#0] dojo.html Cycles:165 Average:4676.84 Median:4803.00 stddev:489.43 (10.2%) stddev-sans-first:465.03 22:10:02 INFO - PROCESS | 2200 | Values: 2674.1 2684.7 2717.3 2721.9 2741.3 4546.6 4565.8 4613.8 4621.9 4649.7 4668.6 4669.8 4691.5 4710.8 4737.0 4290.4 4293.7 4373.9 4394.1 4414.1 4354.6 4398.9 4445.8 4468.9 4469.2 4388.3 4429.6 4443.2 4472.9 4491.4 4264.1 4288.9 4294.5 4294.6 4350.9 4250.7 4258.9 4267.8 4302.2 4305.5 4570.9 4625.0 4625.4 4687.0 4691.4 4872.7 5037.3 5067.2 5085.6 5092.8 5049.4 5077.8 5090.9 5173.2 5173.5 4760.3 4792.6 4803.0 4805.4 4822.0 5016.0 5161.4 5289.8 5313.4 5323.1 4990.0 4991.8 5047.7 5065.0 5080.2 5099.5 5106.6 5112.3 5116.4 5129.3 4833.7 4915.9 4967.5 5002.1 5010.4 4967.2 4970.0 4994.8 5009.7 5016.1 4217.4 4229.5 4233.4 4272.2 4275.0 3636.5 3657.5 3727.0 3728.0 3817.9 4330.2 4334.0 4346.3 4361.4 4383.6 5102.9 5107.1 5108.9 5109.7 5157.6 4292.2 4315.1 4362.1 4364.6 4411.2 4540.8 4553.0 4556.4 4591.0 4609.0 4785.4 4791.8 4796.0 4800.1 4843.2 4927.7 5037.9 5041.3 5100.5 5110.2 4765.2 4794.9 4796.2 4836.5 4846.7 5011.4 5014.2 5015.1 5017.0 5019.4 4945.2 5046.0 5062.8 5065.9 5084.8 4936.2 4945.7 4958.0 4964.0 5012.1 4942.4 4949.1 4954.8 4955.5 5010.2 4745.2 4787.7 4834.9 4852.0 4925.9 4997.4 4998.1 4999.3 5003.1 5021.9 4681.1 4852.4 4856.5 4857.7 4895.7 22:10:02 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | [#1] ext.html Cycles:180 Average:51367.98 Median:202059.23 stddev:98697.99 (48.8%) stddev-sans-first:98901.15 22:10:02 INFO - PROCESS | 2200 | Values: 563.6 595.5 605.8 610.0 631.1 27197.2 40032.2 40919.2 41066.8 45172.3 41867.2 42180.0 42559.6 42581.4 42582.4 7377.7 7592.9 7605.1 7712.3 7914.4 9672.9 9977.1 9986.8 10325.9 10334.5 10081.1 10196.9 10198.1 10198.6 10200.7 7364.8 9819.7 9969.6 10062.0 10096.2 9871.7 9982.0 9991.3 10005.2 10010.9 36656.5 36995.6 37084.6 37195.4 37202.4 2965.9 3078.1 3136.4 3347.2 3737.3 28317.9 28403.3 28452.0 28463.0 29195.6 3276.2 3341.8 3372.8 3396.5 3441.0 260032.0 260814.7 260818.0 261344.0 261365.0 51348.7 52162.5 52244.0 52335.2 52344.0 29454.3 29907.3 30040.5 30064.8 30074.7 13417.5 13442.8 13445.1 13457.5 13464.3 9345.2 10290.3 10709.7 10736.8 10770.4 18668.7 18696.3 18724.8 18765.8 18788.3 7126.3 7172.9 7195.2 7246.4 7407.7 834.3 899.8 915.9 923.7 1003.1 26907.3 26913.0 27589.0 27606.2 27657.7 949.3 973.8 1040.1 1054.5 1064.2 14423.0 14840.4 14840.6 15051.9 15063.4 422576.0 425102.0 426198.0 426608.0 427130.0 49783.0 50427.5 50436.5 50466.5 50468.7 1086.9 1137.5 1186.5 1197.1 1199.8 27693.7 28926.9 29231.7 29251.3 29802.9 46802.0 48203.0 48247.3 53113.7 53139.7 359936.0 365673.0 365781.0 367462.0 555558.0 37429.3 38481.4 38680.2 41908.4 43010.0 42718.6 43053.8 43334.3 43689.8 44134.6 35695.8 37366.0 37544.0 37575.8 37625.0 35998.5 36948.6 37080.3 37396.1 37530.8 35681.3 36944.4 37101.8 37200.4 37234.4 32335.2 32982.5 33524.0 33537.5 33604.7 24768.5 24783.9 24936.0 24967.1 25061.7 22:10:02 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | [#2] jquery.html Cycles:180 Average:23260.07 Median:4572.40 stddev:63003.68 (1377.9%) stddev-sans-first:63156.99 22:10:02 INFO - PROCESS | 2200 | Values: 377.1 378.4 380.1 384.8 392.5 13743.1 14637.6 14876.1 17125.4 17497.2 14995.0 15087.4 15098.6 15100.0 15202.4 4427.5 4747.0 4750.3 4806.5 4810.4 3519.3 3704.2 4698.7 5195.8 5463.2 5535.2 5537.0 5546.5 5550.9 5556.2 5347.4 5465.2 5531.6 5540.1 5544.9 3387.9 4954.4 5275.2 5275.9 5333.7 12072.1 12166.6 12247.8 12386.8 12409.1 1856.5 1897.7 1912.8 2012.8 2216.8 8972.3 9313.3 9741.1 12491.3 12737.2 1562.2 1566.6 1568.9 1605.7 1623.9 63450.0 65624.3 67730.0 68285.3 68635.7 9894.6 10030.2 10231.4 10565.8 11003.1 14042.8 14048.4 14192.6 14231.8 14256.4 6806.8 6978.9 7092.6 7335.2 7396.6 6478.7 6650.0 6832.1 6921.7 6985.0 4416.5 4447.8 4490.0 4565.8 4579.0 1637.5 1763.1 1814.0 1874.6 1904.7 796.6 887.1 897.3 938.8 956.3 16024.5 16137.1 16287.2 16331.3 16724.3 860.9 861.8 868.9 874.3 875.2 8849.5 9384.8 9460.3 9484.1 9622.4 352401.0 370862.0 385218.0 399085.0 400791.0 69310.0 70805.6 71662.0 72935.3 72984.0 891.8 893.7 909.2 919.8 920.6 14590.3 14608.7 14639.1 14743.8 14892.7 31932.4 32202.2 33970.3 34223.3 34847.7 47932.8 48826.5 49062.5 49077.0 49651.3 7652.8 7761.5 7784.5 7834.5 7933.8 8524.7 11169.7 11650.2 11672.9 11724.8 5601.3 5777.5 9649.6 10055.7 10260.3 9311.8 9759.9 10150.6 10269.8 10332.5 9935.2 10287.3 10299.6 10351.6 10616.1 6561.2 6937.1 7696.1 7873.2 8034.3 9369.0 10066.1 10066.6 10108.7 10483.9 22:10:02 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | [#3] mootools.html Cycles:180 Average:5053.40 Median:5324.32 stddev:2867.47 (53.9%) stddev-sans-first:2861.59 22:10:02 INFO - PROCESS | 2200 | Values: 1292.6 1370.8 1448.2 1513.9 1805.1 6737.6 7459.1 7734.2 7772.0 7954.3 7692.2 7833.4 7838.6 7855.0 7857.7 1862.2 2067.5 2140.4 2149.5 2180.6 2151.8 2171.5 2172.0 2175.3 2175.4 2145.9 2162.3 2162.4 2179.0 2181.4 1780.3 2044.7 2050.1 2115.3 2120.0 2104.5 2110.7 2116.5 2126.5 2127.7 7693.5 7739.6 7745.2 7772.2 7772.8 4339.3 4444.1 4456.2 4459.0 4460.9 2810.3 2904.8 2987.3 3009.1 3009.5 887.9 888.1 896.7 1582.8 1648.4 10568.7 10681.1 10695.0 10736.2 10737.5 4069.7 4090.0 4146.2 4181.4 4184.7 8501.0 8548.1 8558.8 8560.0 8565.5 4470.2 4470.3 4471.5 4473.3 4477.5 3567.6 3964.5 4103.5 4109.1 4155.6 3310.5 3342.5 3398.8 3434.6 3455.3 970.7 990.9 991.2 992.7 1002.5 742.4 859.8 878.1 890.6 899.8 4926.9 5245.1 5304.4 5344.2 5383.0 376.6 381.2 402.5 406.4 408.9 3589.2 3591.2 3601.3 3626.1 3688.8 9361.0 9638.5 9705.8 9735.6 9747.4 9552.2 9624.2 9636.9 9639.4 9665.4 6748.3 7009.3 7015.4 7129.1 7308.4 5526.4 5662.5 5710.5 5794.9 5808.1 8619.4 8950.1 9006.3 9042.9 9049.5 8992.5 9021.9 9049.8 9083.1 9088.5 6055.5 6152.1 6278.2 6381.1 6393.5 7433.5 7480.4 7505.4 7556.4 7560.2 6217.3 6426.2 6460.5 6523.2 6534.0 6180.7 6265.6 6353.9 6385.5 6467.7 6129.3 6159.9 6200.9 6201.1 6211.3 4446.8 4553.5 4584.7 4708.9 4733.8 4578.7 4606.8 4638.6 4655.5 4699.6 22:10:02 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | [#4] prototype.html Cycles:180 Average:4156.90 Median:4645.23 stddev:1212.35 (26.1%) stddev-sans-first:1180.54 22:10:02 INFO - PROCESS | 2200 | Values: 292.1 294.8 302.2 304.5 305.2 4848.7 4877.6 4886.5 4893.1 4917.9 4818.7 4832.6 4853.9 4862.4 4873.7 3619.8 3730.1 3733.7 3760.3 3763.8 3674.2 3728.5 3786.2 3804.4 3817.9 3708.7 3739.5 3748.4 3775.2 3780.4 3570.1 3743.9 3762.4 3783.6 3789.5 3286.1 3292.6 3295.8 3296.9 3300.8 4645.7 4666.4 4687.5 4707.0 4729.0 4096.4 4256.0 4257.3 4269.5 4269.7 5062.4 5065.0 5073.5 5080.1 5091.8 3608.8 3623.2 3630.4 3630.4 3638.3 5170.4 5282.6 5334.7 5387.9 5393.4 3665.9 3677.9 3681.7 3685.3 3693.9 3746.7 3748.8 3751.7 3754.5 3761.1 4255.7 4266.4 4274.2 4311.1 4321.6 4885.9 5092.6 5099.9 5112.2 5145.4 1276.8 1287.7 1291.6 1292.7 1296.4 767.8 803.8 807.1 810.5 813.1 4405.5 4477.8 4504.5 4515.9 4519.7 5243.5 5256.0 5260.8 5276.4 5291.7 4467.7 4469.3 4476.4 4491.3 4498.1 2638.9 2832.6 2845.7 2849.5 2861.0 4986.6 5013.0 5013.6 5022.8 5028.6 5227.5 5407.8 5412.7 5416.2 5444.6 4963.1 4977.6 4978.0 5001.9 5006.3 5277.2 5296.5 5304.7 5314.7 5314.8 5028.2 5165.6 5175.2 5196.7 5214.4 4927.3 4940.1 4971.3 4980.4 4988.4 3349.9 3408.5 3424.5 3424.8 3438.8 4460.4 4748.2 4754.8 4758.6 4773.9 4575.0 4591.9 4592.9 4638.0 4661.8 4644.8 4652.6 4656.4 4663.7 4672.0 4276.9 4557.4 4562.6 4568.3 4573.5 4730.5 4870.2 4966.2 4985.4 4993.9 4852.4 4871.5 4921.2 4955.9 4992.6 22:10:02 INFO - PROCESS | 2200 | 22:10:02 INFO - PROCESS | 2200 | [#5] yui.html Cycles:180 Average:16237.15 Median:514.61 stddev:21969.09 (4269.1%) stddev-sans-first:21999.29 22:10:02 INFO - PROCESS | 2200 | Values: 587.5 594.1 623.0 634.7 701.2 11579.5 12239.8 12248.9 12259.3 12265.1 12172.3 12280.1 12356.6 12749.7 12774.9 640.9 784.8 800.9 801.4 807.2 800.1 810.2 810.4 810.5 811.0 837.1 837.7 838.2 838.2 838.5 659.6 809.8 830.7 831.4 840.1 616.3 617.6 617.7 617.8 618.1 11870.8 11874.8 11899.5 11902.6 11903.8 12242.9 12591.4 12679.9 12905.8 13150.0 9690.2 9871.6 9917.4 10788.1 11268.5 2737.5 2875.5 4231.6 4233.6 4241.1 59529.0 60239.4 60771.4 60856.7 60911.7 9856.7 9889.9 10015.6 10192.4 10308.2 15701.7 15725.6 15730.9 15800.6 15835.8 6559.6 6701.4 6775.6 6831.4 6885.9 3667.9 3765.6 3773.1 3785.5 3794.3 3028.0 3124.1 3125.0 3126.6 3128.0 530.5 535.0 543.3 543.8 549.8 502.4 535.2 558.0 597.2 622.1 7976.7 8390.4 8436.7 8438.0 8607.7 526.8 559.6 625.2 628.2 655.6 3750.5 3866.8 3902.7 3903.9 3995.2 69125.7 72350.6 72364.6 82685.0 83247.0 62453.7 73553.3 76904.6 77671.6 80378.2 46848.3 64733.4 71874.6 72515.0 74856.6 8321.5 8883.8 9077.3 9108.5 9122.9 31319.2 34027.8 35406.0 37885.2 41819.8 56114.0 61532.0 62090.7 62130.0 62619.4 11089.3 11255.7 11387.5 11504.8 12006.2 12519.6 12622.9 12672.6 12740.8 12747.0 12056.8 12254.7 12559.2 12719.2 13083.1 12040.9 12132.5 12155.6 12297.6 12987.6 10354.4 10460.0 11041.4 11562.9 11901.9 9713.4 10007.1 10315.3 10380.5 10629.3 10311.2 10598.3 10623.9 10670.3 10975.3 22:10:02 INFO - PROCESS | 2200 | -------- Summary: end -------- 22:10:02 INFO - PROCESS | 2200 | 22:10:03 INFO - TEST-INFO | 2200: exit 0 22:10:03 INFO - TEST-OK | dromaeo_css | took 1119365ms 22:10:03 INFO - TEST-START | kraken 22:10:03 INFO - operating with platform_type : linux_ 22:10:03 INFO - Initialising browser for kraken test... 22:10:03 INFO - TEST-INFO | started process 2457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX5_2IO/profile http://localhost:33299/getInfo.html) 22:10:07 INFO - PROCESS | 2457 | __metrics Screen width/height:1600/1200 22:10:07 INFO - PROCESS | 2457 | colorDepth:24 22:10:07 INFO - PROCESS | 2457 | Browser inner width/height: 1024/697 22:10:07 INFO - PROCESS | 2457 | __metrics 22:10:08 ERROR - PROCESS | 2457 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:10:09 INFO - TEST-INFO | 2457: exit 0 22:10:09 INFO - Browser initialized. 22:10:09 INFO - Running cycle 1/1 for kraken test... 22:10:09 INFO - TEST-INFO | started process 2555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX5_2IO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:10:21 INFO - PROCESS | 2555 | RSS: Main: 157503488 22:10:21 INFO - PROCESS | 2555 | 22:10:24 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33299/tests/kraken/driver.html?testName=audio-beat-detection) 22:10:25 INFO - PROCESS | 2555 | RSS: Main: 214945792 22:10:25 INFO - PROCESS | 2555 | 22:10:28 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33299/tests/kraken/driver.html?testName=audio-dft) 22:10:28 INFO - PROCESS | 2555 | RSS: Main: 201719808 22:10:28 INFO - PROCESS | 2555 | 22:10:32 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33299/tests/kraken/driver.html?testName=audio-fft) 22:10:32 INFO - PROCESS | 2555 | RSS: Main: 270385152 22:10:32 INFO - PROCESS | 2555 | 22:10:34 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33299/tests/kraken/driver.html?testName=audio-oscillator) 22:10:35 INFO - PROCESS | 2555 | RSS: Main: 180322304 22:10:35 INFO - PROCESS | 2555 | 22:10:37 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:10:38 INFO - PROCESS | 2555 | RSS: Main: 184573952 22:10:38 INFO - PROCESS | 2555 | 22:10:41 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33299/tests/kraken/driver.html?testName=imaging-darkroom) 22:10:42 INFO - PROCESS | 2555 | RSS: Main: 220925952 22:10:42 INFO - PROCESS | 2555 | 22:10:45 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33299/tests/kraken/driver.html?testName=imaging-desaturate) 22:10:46 INFO - PROCESS | 2555 | RSS: Main: 216457216 22:10:46 INFO - PROCESS | 2555 | 22:10:49 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33299/tests/kraken/driver.html?testName=json-parse-financial) 22:10:49 INFO - PROCESS | 2555 | RSS: Main: 219131904 22:10:49 INFO - PROCESS | 2555 | 22:10:51 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:10:52 INFO - PROCESS | 2555 | RSS: Main: 207577088 22:10:52 INFO - PROCESS | 2555 | 22:10:53 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33299/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:10:54 INFO - PROCESS | 2555 | RSS: Main: 209993728 22:10:54 INFO - PROCESS | 2555 | 22:10:56 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:10:57 INFO - PROCESS | 2555 | RSS: Main: 216825856 22:10:57 INFO - PROCESS | 2555 | 22:11:00 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:11:00 INFO - PROCESS | 2555 | RSS: Main: 224907264 22:11:00 INFO - PROCESS | 2555 | 22:11:03 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:11:04 INFO - PROCESS | 2555 | RSS: Main: 225308672 22:11:04 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | Cycle 1(1): loaded http://localhost:33299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33299/tests/kraken/driver.html?testName=ai-astar) 22:11:06 INFO - PROCESS | 2555 | RSS: Main: 267018240 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | __start_tp_report 22:11:06 INFO - PROCESS | 2555 | _x_x_mozilla_page_load 22:11:06 INFO - PROCESS | 2555 | _x_x_mozilla_page_load_details 22:11:06 INFO - PROCESS | 2555 | |i|pagename|runs| 22:11:06 INFO - PROCESS | 2555 | |0;ai-astar;111;109;113;111;111;113;112;112;115;114 22:11:06 INFO - PROCESS | 2555 | |1;audio-beat-detection;154;130;134;181;130;135;156;130;163;134 22:11:06 INFO - PROCESS | 2555 | |2;audio-dft;162;160;161;161;162;162;163;161;162;162 22:11:06 INFO - PROCESS | 2555 | |3;audio-fft;76;74;76;116;76;76;75;76;100;74 22:11:06 INFO - PROCESS | 2555 | |4;audio-oscillator;86;87;117;86;86;87;121;86;86;125 22:11:06 INFO - PROCESS | 2555 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;117;122;116 22:11:06 INFO - PROCESS | 2555 | |6;imaging-darkroom;145;145;145;146;146;145;146;145;146;146 22:11:06 INFO - PROCESS | 2555 | |7;imaging-desaturate;95;94;94;95;95;95;95;94;94;95 22:11:06 INFO - PROCESS | 2555 | |8;json-parse-financial;63;64;64;64;77;64;64;64;65;64 22:11:06 INFO - PROCESS | 2555 | |9;json-stringify-tinderbox;66;66;65;65;66;66;66;66;65;66 22:11:06 INFO - PROCESS | 2555 | |10;stanford-crypto-aes;85;90;82;83;85;84;85;84;114;85 22:11:06 INFO - PROCESS | 2555 | |11;stanford-crypto-ccm;134;139;147;131;132;129;131;134;153;142 22:11:06 INFO - PROCESS | 2555 | |12;stanford-crypto-pbkdf2;172;171;168;169;171;167;167;171;171;167 22:11:06 INFO - PROCESS | 2555 | |13;stanford-crypto-sha256-iterative;68;70;68;66;71;67;66;66;69;67 22:11:06 INFO - PROCESS | 2555 | __end_tp_report 22:11:06 INFO - PROCESS | 2555 | __start_cc_report 22:11:06 INFO - PROCESS | 2555 | _x_x_mozilla_cycle_collect,1893 22:11:06 INFO - PROCESS | 2555 | __end_cc_report 22:11:06 INFO - PROCESS | 2555 | __startTimestamp1465103466451__endTimestamp 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | ------- Summary: start ------- 22:11:06 INFO - PROCESS | 2555 | Number of tests: 14 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.73 (1.5%) stddev-sans-first:1.79 22:11:06 INFO - PROCESS | 2555 | Values: 111.0 109.0 113.0 111.0 111.0 113.0 112.0 112.0 115.0 114.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:144.50 stddev:17.76 (12.3%) stddev-sans-first:18.51 22:11:06 INFO - PROCESS | 2555 | Values: 154.0 130.0 134.0 181.0 130.0 135.0 156.0 130.0 163.0 134.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 22:11:06 INFO - PROCESS | 2555 | Values: 162.0 160.0 161.0 161.0 162.0 162.0 163.0 161.0 162.0 162.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:14.29 (18.8%) stddev-sans-first:14.99 22:11:06 INFO - PROCESS | 2555 | Values: 76.0 74.0 76.0 116.0 76.0 76.0 75.0 76.0 100.0 74.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:86.00 stddev:16.88 (19.6%) stddev-sans-first:17.45 22:11:06 INFO - PROCESS | 2555 | Values: 86.0 87.0 117.0 86.0 86.0 87.0 121.0 86.0 86.0 125.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:1.79 (1.5%) stddev-sans-first:1.86 22:11:06 INFO - PROCESS | 2555 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 122.0 116.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:11:06 INFO - PROCESS | 2555 | Values: 145.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:11:06 INFO - PROCESS | 2555 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:64.00 stddev:4.14 (6.5%) stddev-sans-first:4.30 22:11:06 INFO - PROCESS | 2555 | Values: 63.0 64.0 64.0 64.0 77.0 64.0 64.0 64.0 65.0 64.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 22:11:06 INFO - PROCESS | 2555 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 65.0 66.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:85.00 stddev:9.48 (11.1%) stddev-sans-first:10.00 22:11:06 INFO - PROCESS | 2555 | Values: 85.0 90.0 82.0 83.0 85.0 84.0 85.0 84.0 114.0 85.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.50 stddev:7.91 (5.8%) stddev-sans-first:8.31 22:11:06 INFO - PROCESS | 2555 | Values: 134.0 139.0 147.0 131.0 132.0 129.0 131.0 134.0 153.0 142.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:171.00 stddev:2.01 (1.2%) stddev-sans-first:1.90 22:11:06 INFO - PROCESS | 2555 | Values: 172.0 171.0 168.0 169.0 171.0 167.0 167.0 171.0 171.0 167.0 22:11:06 INFO - PROCESS | 2555 | 22:11:06 INFO - PROCESS | 2555 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.75 (2.6%) stddev-sans-first:1.86 22:11:06 INFO - PROCESS | 2555 | Values: 68.0 70.0 68.0 66.0 71.0 67.0 66.0 66.0 69.0 67.0 22:11:06 INFO - PROCESS | 2555 | -------- Summary: end -------- 22:11:06 INFO - PROCESS | 2555 | 22:11:07 INFO - TEST-INFO | 2555: exit 0 22:11:07 INFO - TEST-OK | kraken | took 63962ms 22:11:07 INFO - SUITE-END | took 1183s 22:11:07 INFO - Completed test suite (00:19:43) 22:11:07 INFO - javascript benchmark 22:11:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.0908091248975, 2684.677838659361, 2717.334253107989, 2721.863906804659, 2741.3420779013045, 4546.590806827385, 4565.817367305303, 4613.815447382105, 4621.861344159681, 4649.697769644975, 4668.649851261152, 4669.766511674411, 4691.460482044566, 4710.788014539346, 4736.952630473695, 4290.442242508485, 4293.742375457467, 4373.890652733675, 4394.121175764852, 4414.139242847646, 4354.608085272325, 4398.9340159897465, 4445.84439544616, 4468.932966005513, 4469.173202957447, 4388.341748737683, 4429.579189976947, 4443.15580039793, 4472.865814025585, 4491.438570178728, 4264.147170565868, 4288.935665965013, 4294.527601963813, 4294.634956028742, 4350.934735978963, 4250.744955302692, 4258.872233832959, 4267.829286828523, 4302.247106756305, 4305.547917468652, 4570.908581828345, 4624.982503849148, 4625.444946606395, 4686.95313046872, 4691.366665500182, 4872.707637541759, 5037.345145131109, 5067.163917953533, 5085.567726743231, 5092.8217512387255, 5049.394072711261, 5077.771500282459, 5090.872728181788, 5173.224016397533, 5173.508516690908, 4760.285957106393, 4792.568668819753, 4803.0, 4805.447373552016, 4821.951780482221, 5015.974920125449, 5161.432242453402, 5289.761960711778, 5313.44208858072, 5323.148296272578, 4989.950100499022, 4991.775370108354, 5047.671901326402, 5065.037642847848, 5080.161773307437, 5099.464556221544, 5106.591472682177, 5112.284280200774, 5116.386033675983, 5129.333186685782, 4833.734144622009, 4915.877103072452, 4967.503249675004, 5002.124628190052, 5010.398752149766, 4967.155583550805, 4969.950300497021, 4994.825181118644, 5009.7244651544515, 5016.147254966664, 4217.4306468626955, 4229.45017147775, 4233.364995250676, 4272.209641216385, 4275.03811642378, 3636.4545318201954, 3657.4696668982847, 3726.9813650932115, 3728.0, 3817.923641527154, 4330.17726631939, 4334.024844410045, 4346.282863327516, 4361.433013708261, 4383.561643835655, 5102.897942041212, 5107.080725469451, 5108.872278193001, 5109.693418394908, 5157.58739300855, 4292.227399068135, 4315.050688848449, 4362.149380870763, 4364.563543645673, 4411.205982923105, 4540.750258735801, 4553.043860789205, 4556.430446194226, 4590.9540904591195, 4609.032103258353, 4785.377900872864, 4791.784369703441, 4796.040791841576, 4800.1119792837735, 4843.152448321459, 4927.679700819435, 5037.899242015066, 5041.269015992734, 5100.515451032146, 5110.207917772751, 4765.166095933268, 4794.880127996828, 4796.160671882476, 4836.492168322276, 4846.684965477232, 5011.443688137165, 5014.247862820606, 5015.147424937696, 5016.974915125401, 5019.447860735243, 4945.208766597471, 5046.0, 5062.82280120194, 5065.8733531662, 5084.847454576368, 4936.2102063669645, 4945.67853089548, 4958.033183529177, 4964.032013757283, 5012.097822392005, 4942.4316203637045, 4949.133901567283, 4954.752262386938, 4955.529224723646, 5010.248462730619, 4745.217039188496, 4787.736674482798, 4834.854954351375, 4852.029594081268, 4925.852224433273, 4997.400311962588, 4998.1253280676465, 4999.250112483157, 5003.149464590955, 5021.924671130009, 4681.063787242633, 4852.393450818648, 4856.538628830255, 4857.6599638025, 4895.7062576245535], "value": 4646.188512048113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5519761789377, 595.4938302442923, 605.8394525450757, 610.0270069239562, 631.0628716356213, 27197.18408447745, 40032.19935601286, 40919.18161636769, 41066.794666026704, 45172.3224151638, 41867.16265674685, 42180.0, 42559.574404255945, 42581.36127958083, 42582.36126458098, 7377.704891804321, 7592.924070759277, 7605.125410577799, 7712.267334603203, 7914.3668506519625, 9672.854907176397, 9977.102060814525, 9986.800263994715, 10325.948370258138, 10334.534945927451, 10081.143102836268, 10196.94901525495, 10198.133158681521, 10198.592056317739, 10200.744981375488, 7364.815879603053, 9819.705408837746, 9969.601215951354, 10062.0, 10096.242781791321, 9871.654492092814, 9981.950090249502, 9991.250656200815, 10005.249606279558, 10010.949945250228, 36656.45015324745, 36995.630043699486, 37084.62915370866, 37195.442068369, 37202.44196337057, 2965.940681186364, 3078.122735020531, 3136.4354416205074, 3347.196672798535, 3737.3085979093685, 28317.85841070802, 28403.289917752016, 28452.0, 28463.0, 29195.56206656902, 3276.1973316537365, 3341.7827841190247, 3372.780769249991, 3396.490526421032, 3440.9655903440894, 260032.0, 260814.69592652106, 260818.0, 261344.0, 261365.0, 51348.74325628348, 52162.478375216524, 52244.0, 52335.21497177545, 52344.0, 29454.263643409085, 29907.25231869177, 30040.54939175914, 30064.84967575148, 30074.699253007628, 13417.530386436623, 13442.798358024638, 13445.126066805626, 13457.461701531829, 13464.25946572948, 9345.15893569582, 10290.331128476626, 10709.732256693489, 10736.838947415796, 10770.407627580558, 18668.719969200472, 18696.252149914122, 18724.81275187231, 18765.81234187668, 18788.342408015655, 7126.251743566851, 7172.888202328648, 7195.172555156119, 7246.420286377077, 7407.66665500043, 834.3033566971646, 899.7845095726542, 915.9129882661136, 923.7136487688838, 1003.1222680154865, 26907.327316816845, 26913.0, 27589.0, 27606.171814845588, 27657.723422765917, 949.349695458613, 973.8490533967247, 1040.095117247984, 1054.488573042074, 1064.180580952662, 14423.0, 14840.406383744745, 14840.62898427548, 15051.924740376227, 15063.397464101314, 422576.0, 425102.0, 426198.0, 426608.0, 427130.0, 49783.0, 50427.495725043016, 50436.49563504318, 50466.495335046915, 50468.74765626222, 1086.8858769829212, 1137.4938152522213, 1186.5075993462617, 1197.0961923747516, 1199.7840388730112, 27693.72306276992, 28926.855365723877, 29231.70768292375, 29251.26871828136, 29802.85098574493, 46802.0, 48203.0, 48247.27629085637, 53113.7344313276, 53139.734301328244, 359936.0, 365673.0, 365781.0, 367462.0, 555558.0, 37429.251414971004, 38481.42277865778, 38680.2263954725, 41908.37137443002, 43010.0, 42718.57281427146, 43053.78473107614, 43334.34998475089, 43689.78155109204, 44134.55865441304, 35695.82152089223, 37366.0, 37544.0, 37575.81212093922, 37625.0, 35998.46002309915, 36948.63051369559, 37080.25839483249, 37396.06509837167, 37530.812345938095, 35681.28637427289, 36944.44583331306, 37101.814490927376, 37200.44199336958, 37234.44148337723, 32335.191620209684, 32982.5052624206, 33524.0, 33537.49693754547, 33604.663953360156, 24768.50462990766, 24783.87608061948, 24936.0, 24967.12615058464, 25061.749382505943], "value": 18258.172905222178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.09309111586646, 378.41534828689674, 380.1124374585345, 384.7902892923357, 392.47408472646646, 13743.106698064632, 14637.634059148526, 14876.107433553982, 17125.400610978617, 17497.212625431854, 14995.0, 15087.39650413982, 15098.622534436645, 15100.0, 15202.391904323842, 4427.535108813585, 4746.979399429122, 4750.334953106568, 4806.495317991613, 4810.374651295327, 3519.296140771843, 3704.2221133561984, 4698.718076915379, 5195.766190521416, 5463.2078348639425, 5535.197396377523, 5537.003339398927, 5546.528545073674, 5550.91673624896, 5556.222128901957, 5347.385050719139, 5465.207544905987, 5531.557475401978, 5540.058190107691, 5544.91682624761, 3387.8814241501427, 4954.405471343462, 5275.235090911835, 5275.947240527622, 5333.706646134461, 12072.09459290548, 12166.57416990401, 12247.816282755677, 12386.81419778704, 12409.131360804748, 1856.4894653970132, 1897.7343171955938, 1912.8278454938984, 2012.838972882166, 2216.822654187661, 8972.282217422657, 9313.30150238728, 9741.074597913186, 12491.312977786218, 12737.172083814616, 1562.203276329069, 1566.6240102375461, 1568.9450869219636, 1605.727026405514, 1623.861971732404, 63450.0, 65624.3437565623, 67730.0, 68285.3171468289, 68635.65682171607, 9894.60421583143, 10030.247731420173, 10231.43727095002, 10565.788684226272, 11003.119750420108, 14042.789358159636, 14048.367823447968, 14192.64518387028, 14231.78652320216, 14256.42974281017, 6806.7957961261245, 6978.860422791516, 7092.574445533284, 7335.229800870939, 7396.55620662762, 6478.740850366027, 6650.0, 6832.077669514552, 6921.688524016431, 6984.965075174591, 4416.470023597189, 4447.777611119431, 4489.9551004490195, 4565.817367305337, 4578.992621623238, 1637.4841924793652, 1763.1096296370508, 1814.0, 1874.6344462829618, 1904.7238150468381, 796.5738329993426, 887.0508555845183, 897.3001059173724, 938.7746940734311, 956.3305686019675, 16024.519264422086, 16137.112458814878, 16287.185640717917, 16331.346746130259, 16724.331026759035, 860.8665656823202, 861.8233262181237, 868.913108689126, 874.33113668044, 875.1729615513278, 8849.51327676971, 9384.812303753886, 9460.290478214161, 9484.146426821619, 9622.422654640744, 352401.0, 370862.0, 385218.0, 399085.0, 400791.0, 69310.0, 70805.64597177083, 71662.0, 72935.27064729285, 72984.0, 891.8439273127177, 893.65147592439, 909.2453263791037, 919.7700574856286, 920.6087412849379, 14590.292301440415, 14608.70782584321, 14639.121652700873, 14743.778843317144, 14892.702145957237, 31932.361352773278, 32202.19494512656, 33970.32059358848, 34223.31553368869, 34847.65152348444, 47932.760336198095, 48826.511734882195, 49062.50937490579, 49077.0, 49651.25523117084, 7652.7704168875025, 7761.534307941542, 7784.494007889469, 7834.529928204326, 7933.761987140395, 8524.659013639384, 11169.72075698114, 11650.242734222249, 11672.941635291769, 11724.824127637921, 5601.327840659147, 5777.537796976148, 9649.614015439303, 10055.69832905014, 10260.281780275309, 9311.813763724553, 9759.9024009759, 10150.593976241164, 10269.845952310572, 10332.53503592325, 9935.15551178129, 10287.331323463952, 10299.639512617323, 10351.585936562453, 10616.097631701392, 6561.212654481493, 6937.06349642812, 7696.114946780968, 7873.1733168016535, 8034.276915077671, 9369.0, 10066.094051535105, 10066.647667331608, 10108.747281318027, 10483.895161048293], "value": 7855.676255688527, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.5669900583305, 1370.8149399831022, 1448.1600671610468, 1513.909165450073, 1805.1154934082294, 6737.629430381327, 7459.1049074111115, 7734.187910269425, 7772.028496437945, 7954.2841144297, 7692.192319806423, 7833.37333013359, 7838.568878711669, 7854.960725196366, 7857.6856925722905, 1862.236483041953, 2067.4934641012896, 2140.411386868608, 2149.5378493623866, 2180.563887222554, 2151.8493705440546, 2171.5114099327684, 2171.9782802171935, 2175.3365223606793, 2175.445261458326, 2145.9141634334687, 2162.2540223622823, 2162.37291185556, 2179.0, 2181.3892110209167, 1780.287884846059, 2044.7444069491314, 2050.1184490669007, 2115.3125234298914, 2119.9576008479744, 2104.4738815296178, 2110.6833974903734, 2116.502621883856, 2126.479012641897, 2127.712758777561, 7693.49992250502, 7739.57432341221, 7745.2185997220395, 7772.222777722239, 7772.7668169954995, 4339.305711086211, 4444.133393988173, 4456.2201614717615, 4459.0, 4460.93308600368, 2810.2693299742214, 2904.782141339408, 2987.327851233477, 3009.1123118680043, 3009.5184770436626, 887.9112088791134, 888.1296329597031, 896.7175339767953, 1582.754673025683, 1648.3736180251547, 10568.682939511827, 10681.145508359312, 10695.0, 10736.248462607698, 10737.51681174349, 4069.694772891986, 4090.0, 4146.1914926589625, 4181.414601955728, 4184.66522678185, 8501.0, 8548.059713431518, 8558.786030349167, 8559.95720021396, 8565.528895910784, 4470.240059189946, 4470.307102399133, 4471.5081341052455, 4473.306637471197, 4477.507474177838, 3567.554055743032, 3964.484616999772, 4103.466549348565, 4109.075458021921, 4155.605217504332, 3310.486874534451, 3342.5320455136302, 3398.8300584970652, 3434.553508043988, 3455.274392377579, 970.737900766789, 990.9256805739599, 991.1723710701644, 992.6674564021134, 1002.5338217728792, 742.4357488308924, 859.8237361340911, 878.0999475537498, 890.576975936438, 899.7525680437932, 4926.9014619707405, 5245.082110630625, 5304.416514183436, 5344.225087362311, 5382.973085134549, 376.61397068005516, 381.19187322875683, 402.4647219198459, 406.38229890566174, 408.8569000849738, 3589.2283159120916, 3591.245838373971, 3601.2797440512004, 3626.111602657313, 3688.797116158637, 9361.0, 9638.518074096268, 9705.805883882284, 9735.610575577039, 9747.415155090575, 9552.235821134293, 9624.181944534654, 9636.903630963741, 9639.373440726331, 9665.420074795535, 6748.325167483213, 7009.334113259232, 7015.438764898898, 7129.073220481304, 7308.392153726172, 5526.392096869422, 5662.462066103713, 5710.486056254957, 5794.913076303775, 5808.128780682931, 8619.439736417113, 8950.104989500998, 9006.324525660733, 9042.864357034781, 9049.54752262371, 8992.46045237288, 9021.864672029793, 9049.819003620023, 9083.091690830865, 9088.454692718458, 6055.515558755201, 6152.107944347955, 6278.246610406781, 6381.138546296191, 6393.520485963664, 7433.516821406807, 7480.4015678746655, 7505.437092217996, 7556.433267505069, 7560.206178351194, 6217.347178546188, 6426.164598602152, 6460.45086167681, 6523.18460192476, 6534.0, 6180.721867515883, 6265.592736472115, 6353.8729225416155, 6385.45723613498, 6467.676616169078, 6129.325774164749, 6159.907601385893, 6200.937990620036, 6201.069839524108, 6211.3478084800445, 4446.799894004842, 4553.453585569753, 4584.724916505021, 4708.858734237979, 4733.786979585858, 4578.748168850745, 4606.792694328697, 4638.605718513964, 4655.511171327097, 4699.600533954652], "value": 4001.8411840279114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.06684642566995, 294.76271601360907, 302.24438902743134, 304.4580646449321, 305.2201624848514, 4848.66661668041, 4877.561119469756, 4886.462489126197, 4893.140606569503, 4917.877053073675, 4818.710877347362, 4832.565069143777, 4853.927191092128, 4862.416510018794, 4873.683210591309, 3619.7647152935106, 3730.0674831292176, 3733.682636975847, 3760.3043436964113, 3763.7553559018575, 3674.1549443627982, 3728.459373390857, 3786.185970016446, 3804.4293355996547, 3817.9045523861846, 3708.6662200401956, 3739.5138631977807, 3748.3815170496973, 3775.206776781021, 3780.395136778116, 3570.107473131717, 3743.850245990157, 3762.360398732195, 3783.6405541473514, 3789.5073640426845, 3286.145602143436, 3292.6213485449002, 3295.785773924711, 3296.8516416761304, 3300.785448945811, 4645.674802763808, 4666.390095417076, 4687.468766865888, 4707.0, 4728.976355118237, 4096.365063415175, 4255.957440425587, 4257.297545904953, 4269.487661480611, 4269.701120921537, 5062.443131255559, 5065.0, 5073.543381095719, 5080.110980578384, 5091.79632814687, 3608.82713118235, 3623.1884057971015, 3630.3646861799343, 3630.438911268154, 3638.2905333459985, 5170.353705786777, 5282.630215884889, 5334.653247538898, 5387.865303367447, 5393.352797664266, 3665.90022993101, 3677.871274505433, 3681.650243226889, 3685.2997930393676, 3693.9472250408503, 3746.688658969339, 3748.793816340073, 3751.7186211033736, 3754.511913451234, 3761.097336639242, 4255.680823938155, 4266.360045993064, 4274.187904298174, 4311.103114629615, 4321.595481468536, 4885.877853053631, 5092.567131793765, 5099.87250318745, 5112.233165025276, 5145.434002259748, 1276.8467783865995, 1287.6909541709922, 1291.593148158327, 1292.7091404433927, 1296.3971753134838, 767.7658314214107, 803.8472690188845, 807.0597753617088, 810.4812919731377, 813.1096449387911, 4405.537418571068, 4477.843275485342, 4504.495504495504, 4515.909681806345, 4519.706219095749, 5243.475652434726, 5256.0, 5260.789568417221, 5276.366835979707, 5291.735413229323, 4467.7319360838455, 4469.329600559942, 4476.4180656514445, 4491.30384790358, 4498.122866041091, 2638.8680565971626, 2832.626176304491, 2845.701201373867, 2849.4586028654903, 2861.0401874715885, 4986.628677113823, 5013.0, 5013.649044566845, 5022.824201152942, 5028.572571331478, 5227.477252274818, 5407.783688652488, 5412.675239485643, 5416.160495123262, 5444.564434845203, 4963.131451995814, 4977.626677999092, 4978.0, 5001.924971125436, 5006.299118123466, 5277.182036784305, 5296.496832800878, 5304.655197412156, 5314.707691077027, 5314.787408503771, 5028.164719877292, 5165.612579056661, 5175.171972484384, 5196.714180720097, 5214.374275086862, 4927.260910863399, 4940.086084074458, 4971.304017437634, 4980.352554167935, 4988.351514303117, 3349.91127883434, 3408.471686888536, 3424.4692072728767, 3424.7602667814012, 3438.8452519636176, 4460.397846290709, 4748.246017310021, 4754.809807607657, 4758.619310455225, 4773.856784296477, 4574.954250457586, 4591.885202869955, 4592.931106033346, 4638.049199914077, 4661.790219440201, 4644.790984405642, 4652.627789776742, 4656.3713898623255, 4663.650226232979, 4671.953280467152, 4276.861569215393, 4557.430321209848, 4562.5665561771575, 4568.314752787109, 4573.474050484104, 4730.526947305242, 4870.220764677634, 4966.180580204225, 4985.401751789664, 4993.900121997613, 4852.393450818648, 4871.488493708252, 4921.188003979447, 4955.900881982412, 4992.550670439678], "value": 3769.8612565069366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.519160912232, 594.0762114911314, 622.9719662615182, 634.7175506899432, 701.1516065560671, 11579.53681852726, 12239.755204895897, 12248.877511224886, 12259.325737084457, 12265.141440099196, 12172.330521821295, 12280.078994075458, 12356.629301120958, 12749.681257968556, 12774.93612531936, 640.9198850143732, 784.8430313937207, 800.93592512599, 801.3749275565068, 807.2331285278979, 800.0998876264202, 810.1857633078747, 810.4043528006911, 810.5055915891302, 811.0267678785451, 837.0917554453425, 837.7319257837495, 838.174398217755, 838.1995194589183, 838.5304229631396, 659.5548005096589, 809.8056466448069, 830.7217082277444, 831.3889291370838, 840.1304649687605, 616.257409821169, 617.6355949989528, 617.7467238432221, 617.7590739611555, 618.057462369885, 11870.821937670942, 11874.821877671842, 11899.524019039314, 11902.583409580624, 11903.821442678367, 12242.877571224262, 12591.37043147848, 12679.873201267961, 12905.806412903814, 13150.0, 9690.224782017422, 9871.568622549761, 9917.404955702608, 10788.136949044057, 11268.549258029669, 2737.54830452975, 2875.5399136138117, 4231.576842315774, 4233.576642335773, 4241.066965267636, 59529.0, 60239.39760602426, 60771.39228607702, 60856.69571652158, 60911.69544152295, 9856.704298871045, 9889.851652225223, 10015.599376025024, 10192.439415832201, 10308.175345972304, 15701.685966280611, 15725.606859828596, 15730.921345393428, 15800.60498487547, 15835.762463563056, 6559.573627714183, 6701.430378417792, 6775.559588626724, 6831.351021652935, 6885.931140688529, 3667.8716244931297, 3765.6234376562675, 3773.094457330221, 3785.5268091488565, 3794.2601192767697, 3027.9545806812916, 3124.0940127363265, 3125.0312403155094, 3126.5935428394164, 3128.03031060372, 530.482779290189, 534.9625526213127, 543.2584522127347, 543.8450041738085, 549.7581064331681, 502.4272329544322, 535.2052202479315, 557.9776808927678, 597.2027343496394, 622.116594435893, 7976.680932762741, 8390.412671112963, 8436.704715335056, 8437.957810211032, 8607.698730544402, 526.7919171927067, 559.5831105826186, 625.1810128731377, 628.1927722876082, 655.5804285257439, 3750.549934007882, 3866.8066596670055, 3902.7345961678066, 3903.941440878389, 3995.1610161866333, 69125.65437172783, 72350.63824680843, 72364.63817680984, 82685.0, 83247.0, 62453.687731561055, 73553.26446735571, 76904.61547692226, 77671.61164194143, 80378.19621803708, 46848.29727554089, 64733.35266647273, 71874.64062679654, 72514.99999999894, 74856.62571687215, 8321.464498072777, 8883.822323553364, 9077.319201059814, 9108.544572771467, 9122.908770912207, 31319.21701957469, 34027.829860850536, 35406.0, 37885.242295154494, 41819.790901046516, 56114.0, 61532.0, 62090.68954655198, 62130.0, 62619.373806261356, 11089.27919685218, 11255.718607034889, 11387.544498219979, 11504.827427588425, 12006.21959572625, 12519.56181533642, 12622.87377126217, 12672.556460523838, 12740.808887866875, 12747.0, 12056.819147712617, 12254.693632659255, 12559.246445213317, 12719.173253738478, 13083.084184107021, 12040.879591203975, 12132.514699412277, 12155.635330940086, 12297.56958506448, 12987.610371688865, 10354.430506322225, 10460.0, 11041.44792760375, 11562.884371156517, 11901.940490297493, 9713.417194968324, 10007.09936105754, 10315.27793054479, 10380.48097595102, 10629.309094908805, 10311.175105991653, 10598.31110977784, 10623.89376106229, 10670.253082284165, 10975.28660637056], "value": 6426.876078767015, "unit": "score"}], "name": "dromaeo_css", "value": 6334.746264937997, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 113.0, 111.0, 111.0, 113.0, 112.0, 112.0, 115.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 134.0, 181.0, 130.0, 135.0, 156.0, 130.0, 163.0, 134.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 116.0, 76.0, 76.0, 75.0, 76.0, 100.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 117.0, 86.0, 86.0, 87.0, 121.0, 86.0, 86.0, 125.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 122.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 77.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 82.0, 83.0, 85.0, 84.0, 85.0, 84.0, 114.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 139.0, 147.0, 131.0, 132.0, 129.0, 131.0, 134.0, 153.0, 142.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 168.0, 169.0, 171.0, 167.0, 167.0, 171.0, 171.0, 167.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 66.0, 71.0, 67.0, 66.0, 66.0, 69.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1547.3000000000002, "alertThreshold": 2.0}]} 22:11:07 INFO - Return code: 0 22:11:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:11:07 ERROR - # TBPL SUCCESS # 22:11:07 INFO - Running post-action listener: _resource_record_post_action 22:11:07 INFO - ##### 22:11:07 INFO - ##### Finished run-tests step (success) 22:11:07 INFO - ##### 22:11:07 INFO - Running post-run listener: _resource_record_post_run 22:11:07 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 523685888; Read time: 16; Write time: 421120 22:11:07 INFO - TinderboxPrint: CPU usage
13.2% 22:11:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:11:07 INFO - TinderboxPrint: I/O write bytes / time
523,685,888 / 421,120 22:11:07 INFO - TinderboxPrint: CPU idle
8,316.3 (86.8%) 22:11:07 INFO - TinderboxPrint: CPU user
1,218.5 (12.7%) 22:11:07 INFO - TinderboxPrint: Swap in / out
0 / 0 22:11:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237477888; Read time: 0; Write time: 220648 22:11:07 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286044160; Read time: 16; Write time: 200448 22:11:08 INFO - Running post-run listener: _upload_blobber_files 22:11:08 INFO - Blob upload gear active. 22:11:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:11:08 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 22:11:08 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'] 22:11:08 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 22:11:08 INFO - (blobuploader) - INFO - Open directory for files ... 22:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:10 INFO - (blobuploader) - INFO - Done attempting. 22:11:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:11:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:10 INFO - (blobuploader) - INFO - Done attempting. 22:11:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:11:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:14 INFO - (blobuploader) - INFO - Done attempting. 22:11:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:11:14 INFO - Return code: 0 22:11:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:11:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:11:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b723d72cf17e1b35de12ad50dbe564a8b52d13b1a0003573270dd74c69c69bf9fafbf938a2806f8e544395d4b36f288a2ad9e415831ec41edaa7f51fbeae66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e134854dc80b130c52d8f324e29609982c1fff431a305ba636c3fdac49a71b77124ead8045398b329bc1f5117abea8bfee5e3e7eeb68b4ab59480503215abdb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f402b08260b932ec6b8e55ce73207f1714d3f7643c8b0f8047615ae3377c4f562751791560abe71dd3b9a65af4e8bcfdfa898da750efd664d181bc0df65fdf26"} 22:11:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:11:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:11:14 INFO - Contents: 22:11:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b723d72cf17e1b35de12ad50dbe564a8b52d13b1a0003573270dd74c69c69bf9fafbf938a2806f8e544395d4b36f288a2ad9e415831ec41edaa7f51fbeae66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e134854dc80b130c52d8f324e29609982c1fff431a305ba636c3fdac49a71b77124ead8045398b329bc1f5117abea8bfee5e3e7eeb68b4ab59480503215abdb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f402b08260b932ec6b8e55ce73207f1714d3f7643c8b0f8047615ae3377c4f562751791560abe71dd3b9a65af4e8bcfdfa898da750efd664d181bc0df65fdf26"} 22:11:14 INFO - Running post-run listener: copy_logs_to_upload_dir 22:11:14 INFO - Copying logs to upload dir... 22:11:14 INFO - mkdir: /builds/slave/test/build/upload/logs 22:11:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.513480 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-04 22:11:14.444735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 22:11:14.447951) ========= 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=7de08804244eb36560b44971000001c3-1465101535.678350-418856284 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/16b723d72cf17e1b35de12ad50dbe564a8b52d13b1a0003573270dd74c69c69bf9fafbf938a2806f8e544395d4b36f288a2ad9e415831ec41edaa7f51fbeae66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e134854dc80b130c52d8f324e29609982c1fff431a305ba636c3fdac49a71b77124ead8045398b329bc1f5117abea8bfee5e3e7eeb68b4ab59480503215abdb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f402b08260b932ec6b8e55ce73207f1714d3f7643c8b0f8047615ae3377c4f562751791560abe71dd3b9a65af4e8bcfdfa898da750efd664d181bc0df65fdf26"} build_url:https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/XGi2PHKHRwa4iGYTv3xKcA/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/16b723d72cf17e1b35de12ad50dbe564a8b52d13b1a0003573270dd74c69c69bf9fafbf938a2806f8e544395d4b36f288a2ad9e415831ec41edaa7f51fbeae66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e134854dc80b130c52d8f324e29609982c1fff431a305ba636c3fdac49a71b77124ead8045398b329bc1f5117abea8bfee5e3e7eeb68b4ab59480503215abdb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f402b08260b932ec6b8e55ce73207f1714d3f7643c8b0f8047615ae3377c4f562751791560abe71dd3b9a65af4e8bcfdfa898da750efd664d181bc0df65fdf26"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 22:11:14.472808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:11:14.473193) ========= 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=7de08804244eb36560b44971000001c3-1465101535.678350-418856284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:11:14.558358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 22:11:14.558736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 22:11:14.559042) ========= ========= Total master_lag: 0.18 =========