builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1465041438.02 results: success (0) buildid: 20160604023008 builduid: b00c519d82954b4fa1ae72a7bd5a5204 revision: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.024865) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.025310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.025606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.056188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.056445) ========= 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-1465040121.905744-399504062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 04:57: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-04 04:57:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.195798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.196113) ========= 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-1465040121.905744-399504062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020152 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.248976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.249299) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe --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 e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe --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-1465040121.905744-399504062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 04:57:18,446 truncating revision to first 12 chars 2016-06-04 04:57:18,446 Setting DEBUG logging. 2016-06-04 04:57:18,447 attempt 1/10 2016-06-04 04:57:18,447 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1fb7ee96e4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 04:57:18,766 unpacking tar archive at: fx-team-e1fb7ee96e4e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.910268) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.910561) ========= script_repo_revision: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.910923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.911226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.921586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-04 04:57:18.921867) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1465040121.905744-399504062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:57:19 INFO - MultiFileLogger online at 20160604 04:57:19 in /builds/slave/test 04:57:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:57:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:19 INFO - {'append_to_log': False, 04:57:19 INFO - 'base_work_dir': '/builds/slave/test', 04:57:19 INFO - 'blob_upload_branch': 'Fx-Team', 04:57:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:19 INFO - 'branch': 'Fx-Team', 04:57:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:19 INFO - 'config_files': ('talos/linux_config.py',), 04:57:19 INFO - 'default_actions': ('clobber', 04:57:19 INFO - 'read-buildbot-config', 04:57:19 INFO - 'download-and-extract', 04:57:19 INFO - 'populate-webroot', 04:57:19 INFO - 'create-virtualenv', 04:57:19 INFO - 'install', 04:57:19 INFO - 'run-tests'), 04:57:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:19 INFO - 'download_minidump_stackwalk': True, 04:57:19 INFO - 'download_symbols': 'ondemand', 04:57:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:19 INFO - 'installer_path': 'installer.exe', 04:57:19 INFO - 'log_level': 'info', 04:57:19 INFO - 'log_name': 'talos', 04:57:19 INFO - 'log_to_console': True, 04:57:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:57:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:57:19 INFO - 'opt_config_files': (), 04:57:19 INFO - 'pip_index': False, 04:57:19 INFO - 'sps_profile': False, 04:57:19 INFO - 'sps_profile_interval': 0, 04:57:19 INFO - 'suite': 'dromaeojs', 04:57:19 INFO - 'system_bits': '32', 04:57:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:19 INFO - 'title': 'talos-linux64-ix-003', 04:57:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:19 INFO - 'use_talos_json': True, 04:57:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:19 INFO - 'work_dir': 'build'} 04:57:19 INFO - ##### 04:57:19 INFO - ##### Running clobber step. 04:57:19 INFO - ##### 04:57:19 INFO - Running pre-action listener: _resource_record_pre_action 04:57:19 INFO - Running main action method: clobber 04:57:19 INFO - rmtree: /builds/slave/test/build 04:57:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:19 INFO - Running post-action listener: _resource_record_post_action 04:57:19 INFO - ##### 04:57:19 INFO - ##### Finished clobber step (success) 04:57:19 INFO - ##### 04:57:19 INFO - ##### 04:57:19 INFO - ##### Running read-buildbot-config step. 04:57:19 INFO - ##### 04:57:19 INFO - Running pre-action listener: _resource_record_pre_action 04:57:19 INFO - Running main action method: read_buildbot_config 04:57:19 INFO - Using buildbot properties: 04:57:19 INFO - { 04:57:19 INFO - "project": "", 04:57:19 INFO - "product": "firefox", 04:57:19 INFO - "script_repo_revision": "production", 04:57:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:57:19 INFO - "repository": "", 04:57:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:57:19 INFO - "buildid": "20160604023008", 04:57:19 INFO - "pgo_build": "True", 04:57:19 INFO - "basedir": "/builds/slave/test", 04:57:19 INFO - "buildnumber": 153, 04:57:19 INFO - "slavename": "talos-linux64-ix-003", 04:57:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:57:19 INFO - "platform": "ubuntu64_hw", 04:57:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:57:19 INFO - "branch": "fx-team", 04:57:19 INFO - "repo_path": "integration/fx-team", 04:57:19 INFO - "revision": "e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe", 04:57:19 INFO - "stage_platform": "linux64-pgo", 04:57:19 INFO - "builduid": "b00c519d82954b4fa1ae72a7bd5a5204", 04:57:19 INFO - "slavebuilddir": "test" 04:57:19 INFO - } 04:57:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:57:19 INFO - Running post-action listener: _resource_record_post_action 04:57:19 INFO - ##### 04:57:19 INFO - ##### Finished read-buildbot-config step (success) 04:57:19 INFO - ##### 04:57:19 INFO - ##### 04:57:19 INFO - ##### Running download-and-extract step. 04:57:19 INFO - ##### 04:57:19 INFO - Running pre-action listener: _resource_record_pre_action 04:57:19 INFO - Running main action method: download_and_extract 04:57:19 INFO - mkdir: /builds/slave/test/build/tests 04:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:19 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:21 INFO - Downloaded 1361 bytes. 04:57:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:57:21 INFO - Using the following test package requirements: 04:57:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:57:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:57:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:21 INFO - u'jsshell-linux-x86_64.zip'], 04:57:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:57:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:57:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:57:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:57:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:57:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:21 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:24 INFO - Downloaded 24440840 bytes. 04:57:24 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'] 04:57:24 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 04:57:25 INFO - Return code: 0 04:57:25 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 04:57: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')]} 04:57:25 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:41 INFO - Downloaded 24440840 bytes. 04:57:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:57:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:57:43 INFO - Return code: 0 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:43 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:44 INFO - Downloaded 10833369 bytes. 04:57:44 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'] 04:57:44 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 04:57:44 INFO - Return code: 0 04:57: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')]} 04:57:44 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:57:46 INFO - Downloaded 59083666 bytes. 04:57:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:46 INFO - mkdir: /builds/slave/test/properties 04:57:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:57:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:57:46 INFO - Contents: 04:57:46 INFO - build_url:https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:46 INFO - Running post-action listener: _resource_record_post_action 04:57:46 INFO - Running post-action listener: set_extra_try_arguments 04:57:46 INFO - ##### 04:57:46 INFO - ##### Finished download-and-extract step (success) 04:57:46 INFO - ##### 04:57:46 INFO - ##### 04:57:46 INFO - ##### Running populate-webroot step. 04:57:46 INFO - ##### 04:57:46 INFO - Running pre-action listener: _resource_record_pre_action 04:57:46 INFO - Running main action method: populate_webroot 04:57:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:46 INFO - '--tppagecycles', 04:57:46 INFO - '7'], 04:57:46 INFO - 'tests': ['tsvgm']}}, 04:57:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:57:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:57:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:57:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['damp', 'tps']}, 04:57:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'tests': ['damp', 'tps']}, 04:57:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['dromaeo_dom']}, 04:57:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore', 04:57:46 INFO - 'tabpaint']}, 04:57:46 INFO - 'other-e10s': {'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore', 04:57:46 INFO - 'tabpaint']}, 04:57:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore', 04:57:46 INFO - 'tabpaint']}, 04:57:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore', 04:57:46 INFO - 'tabpaint']}, 04:57:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore', 04:57:46 INFO - 'tabpaint']}, 04:57:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore', 04:57:46 INFO - 'tabpaint']}, 04:57:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['tsvgx', 04:57:46 INFO - 'tsvgr_opacity', 04:57:46 INFO - 'tart', 04:57:46 INFO - 'tscrollx', 04:57:46 INFO - 'cart']}, 04:57:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:57:46 INFO - 'tsvgr_opacity', 04:57:46 INFO - 'tart', 04:57:46 INFO - 'tscrollx', 04:57:46 INFO - 'cart']}, 04:57:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--disable-e10s'], 04:57:46 INFO - 'tests': ['tp5o']}, 04:57:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'tests': ['tp5o']}, 04:57:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--disable-e10s', 04:57:46 INFO - '--xperf_path', 04:57:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:46 INFO - 'tests': ['tp5n']}, 04:57:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--xperf_path', 04:57:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:46 INFO - 'tests': ['tp5n']}}, 04:57:46 INFO - 'talos.zip': {'path': '', 04:57:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:46 INFO - Running post-action listener: _resource_record_post_action 04:57:46 INFO - ##### 04:57:46 INFO - ##### Finished populate-webroot step (success) 04:57:46 INFO - ##### 04:57:46 INFO - ##### 04:57:46 INFO - ##### Running create-virtualenv step. 04:57:46 INFO - ##### 04:57:46 INFO - Running pre-action listener: _resource_record_pre_action 04:57:46 INFO - Running main action method: create_virtualenv 04:57:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:57:46 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 04:57:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:57:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:47 INFO - Using real prefix '/usr' 04:57:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:57:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:49 INFO - Installing pip.................done. 04:57:49 INFO - Return code: 0 04:57:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:57:49 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 04:57:49 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 04:57:49 INFO - Using env: {'DISPLAY': ':0', 04:57:49 INFO - 'HOME': '/home/cltbld', 04:57:49 INFO - 'LANG': 'en_US.UTF-8', 04:57:49 INFO - 'LANGUAGE': 'en_US:en', 04:57:49 INFO - 'LOGNAME': 'cltbld', 04:57:49 INFO - 'MAIL': '/var/mail/cltbld', 04:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:49 INFO - 'MOZ_NO_REMOTE': '1', 04:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:49 INFO - 'NO_EM_RESTART': '1', 04:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:49 INFO - 'PWD': '/builds/slave/test', 04:57:49 INFO - 'SHELL': '/bin/bash', 04:57:49 INFO - 'SHLVL': '1', 04:57:49 INFO - 'TERM': 'linux', 04:57:49 INFO - 'TMOUT': '86400', 04:57:49 INFO - 'USER': 'cltbld', 04:57:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:49 INFO - '_': '/tools/buildbot/bin/python'} 04:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:49 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 04:57:49 INFO - Cleaning up... 04:57:49 INFO - Return code: 0 04:57:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:57:49 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 04:57:49 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 04:57:49 INFO - Using env: {'DISPLAY': ':0', 04:57:49 INFO - 'HOME': '/home/cltbld', 04:57:49 INFO - 'LANG': 'en_US.UTF-8', 04:57:49 INFO - 'LANGUAGE': 'en_US:en', 04:57:49 INFO - 'LOGNAME': 'cltbld', 04:57:49 INFO - 'MAIL': '/var/mail/cltbld', 04:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:49 INFO - 'MOZ_NO_REMOTE': '1', 04:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:49 INFO - 'NO_EM_RESTART': '1', 04:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:49 INFO - 'PWD': '/builds/slave/test', 04:57:49 INFO - 'SHELL': '/bin/bash', 04:57:49 INFO - 'SHLVL': '1', 04:57:49 INFO - 'TERM': 'linux', 04:57:49 INFO - 'TMOUT': '86400', 04:57:49 INFO - 'USER': 'cltbld', 04:57:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:49 INFO - '_': '/tools/buildbot/bin/python'} 04:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:49 INFO - Downloading/unpacking psutil>=3.1.1 04:57:49 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 04:57:49 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 04:57:49 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 04:57:49 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 04:57:49 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 04:57:49 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 04:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:51 INFO - Installing collected packages: psutil 04:57:51 INFO - Running setup.py install for psutil 04:57:52 INFO - building 'psutil._psutil_linux' extension 04:57:52 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 04:57:52 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 04:57:52 INFO - building 'psutil._psutil_posix' extension 04:57:52 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 04:57:52 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 04:57:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:52 INFO - Successfully installed psutil 04:57:52 INFO - Cleaning up... 04:57:52 INFO - Return code: 0 04:57:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:57: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:57: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 mozsystemmonitor==0.3 04:57:52 INFO - Using env: {'DISPLAY': ':0', 04:57:52 INFO - 'HOME': '/home/cltbld', 04:57:52 INFO - 'LANG': 'en_US.UTF-8', 04:57:52 INFO - 'LANGUAGE': 'en_US:en', 04:57:52 INFO - 'LOGNAME': 'cltbld', 04:57:52 INFO - 'MAIL': '/var/mail/cltbld', 04:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:52 INFO - 'MOZ_NO_REMOTE': '1', 04:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:52 INFO - 'NO_EM_RESTART': '1', 04:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:52 INFO - 'PWD': '/builds/slave/test', 04:57:52 INFO - 'SHELL': '/bin/bash', 04:57:52 INFO - 'SHLVL': '1', 04:57:52 INFO - 'TERM': 'linux', 04:57:52 INFO - 'TMOUT': '86400', 04:57:52 INFO - 'USER': 'cltbld', 04:57:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:52 INFO - '_': '/tools/buildbot/bin/python'} 04:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:57:54 INFO - Installing collected packages: mozsystemmonitor 04:57:54 INFO - Running setup.py install for mozsystemmonitor 04:57:54 INFO - Successfully installed mozsystemmonitor 04:57:54 INFO - Cleaning up... 04:57:54 INFO - Return code: 0 04:57:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:54 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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:57:54 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 04:57:54 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 04:57:54 INFO - Using env: {'DISPLAY': ':0', 04:57:54 INFO - 'HOME': '/home/cltbld', 04:57:54 INFO - 'LANG': 'en_US.UTF-8', 04:57:54 INFO - 'LANGUAGE': 'en_US:en', 04:57:54 INFO - 'LOGNAME': 'cltbld', 04:57:54 INFO - 'MAIL': '/var/mail/cltbld', 04:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:54 INFO - 'MOZ_NO_REMOTE': '1', 04:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:54 INFO - 'NO_EM_RESTART': '1', 04:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:54 INFO - 'PWD': '/builds/slave/test', 04:57:54 INFO - 'SHELL': '/bin/bash', 04:57:54 INFO - 'SHLVL': '1', 04:57:54 INFO - 'TERM': 'linux', 04:57:54 INFO - 'TMOUT': '86400', 04:57:54 INFO - 'USER': 'cltbld', 04:57:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:54 INFO - '_': '/tools/buildbot/bin/python'} 04:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:54 INFO - Downloading/unpacking jsonschema==2.5.1 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:57 INFO - warning: no files found matching '*.txt' 04:57:57 INFO - no previously-included directories found matching 'build' 04:57:57 INFO - no previously-included directories found matching 'dist' 04:57:57 INFO - no previously-included directories found matching '.git*' 04:57:57 INFO - Installing collected packages: jsonschema, functools32 04:57:57 INFO - Running setup.py install for functools32 04:57:57 INFO - warning: no files found matching '*.txt' 04:57:57 INFO - no previously-included directories found matching 'build' 04:57:57 INFO - no previously-included directories found matching 'dist' 04:57:57 INFO - no previously-included directories found matching '.git*' 04:57:57 INFO - Successfully installed jsonschema functools32 04:57:57 INFO - Cleaning up... 04:57:57 INFO - Return code: 0 04:57:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:57:57 INFO - Using env: {'DISPLAY': ':0', 04:57:57 INFO - 'HOME': '/home/cltbld', 04:57:57 INFO - 'LANG': 'en_US.UTF-8', 04:57:57 INFO - 'LANGUAGE': 'en_US:en', 04:57:57 INFO - 'LOGNAME': 'cltbld', 04:57:57 INFO - 'MAIL': '/var/mail/cltbld', 04:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:57 INFO - 'MOZ_NO_REMOTE': '1', 04:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:57 INFO - 'NO_EM_RESTART': '1', 04:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:57 INFO - 'PWD': '/builds/slave/test', 04:57:57 INFO - 'SHELL': '/bin/bash', 04:57:57 INFO - 'SHLVL': '1', 04:57:57 INFO - 'TERM': 'linux', 04:57:57 INFO - 'TMOUT': '86400', 04:57:57 INFO - 'USER': 'cltbld', 04:57:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:57 INFO - '_': '/tools/buildbot/bin/python'} 04:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:57 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:00 INFO - Downloading docopt-0.6.1.tar.gz 04:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:00 INFO - Running setup.py install for blobuploader 04:58:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:58:00 INFO - Running setup.py install for requests 04:58:00 INFO - Running setup.py install for docopt 04:58:00 INFO - Successfully installed blobuploader requests docopt 04:58:00 INFO - Cleaning up... 04:58:00 INFO - Return code: 0 04:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:58:00 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 04:58:00 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 04:58:00 INFO - Using env: {'DISPLAY': ':0', 04:58:00 INFO - 'HOME': '/home/cltbld', 04:58:00 INFO - 'LANG': 'en_US.UTF-8', 04:58:00 INFO - 'LANGUAGE': 'en_US:en', 04:58:00 INFO - 'LOGNAME': 'cltbld', 04:58:00 INFO - 'MAIL': '/var/mail/cltbld', 04:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:00 INFO - 'MOZ_NO_REMOTE': '1', 04:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:00 INFO - 'NO_EM_RESTART': '1', 04:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:00 INFO - 'PWD': '/builds/slave/test', 04:58:00 INFO - 'SHELL': '/bin/bash', 04:58:00 INFO - 'SHLVL': '1', 04:58:00 INFO - 'TERM': 'linux', 04:58:00 INFO - 'TMOUT': '86400', 04:58:00 INFO - 'USER': 'cltbld', 04:58:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:00 INFO - '_': '/tools/buildbot/bin/python'} 04:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:01 INFO - Running setup.py (path:/tmp/pip-rOnAyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:01 INFO - Running setup.py (path:/tmp/pip-Z8VlZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:01 INFO - Running setup.py (path:/tmp/pip-vMgSXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:01 INFO - Running setup.py (path:/tmp/pip-ky0jfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:01 INFO - Running setup.py (path:/tmp/pip-SliCIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:01 INFO - Running setup.py (path:/tmp/pip-24fGW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:01 INFO - Running setup.py (path:/tmp/pip-crW8b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:01 INFO - Running setup.py (path:/tmp/pip-hseRX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:01 INFO - Running setup.py (path:/tmp/pip-FIn6FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:01 INFO - Running setup.py (path:/tmp/pip-AsIYJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:01 INFO - Running setup.py (path:/tmp/pip-YrkBa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:01 INFO - Running setup.py (path:/tmp/pip-XDF1N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:01 INFO - Running setup.py (path:/tmp/pip-RetDld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:02 INFO - Running setup.py (path:/tmp/pip-A_OwDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:02 INFO - Running setup.py (path:/tmp/pip-0ybUWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:02 INFO - Running setup.py (path:/tmp/pip-gpkhOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:02 INFO - Running setup.py (path:/tmp/pip-8Yccie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:02 INFO - Running setup.py install for manifestparser 04:58:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:58:02 INFO - Running setup.py install for mozcrash 04:58:02 INFO - Running setup.py install for mozdebug 04:58:02 INFO - Running setup.py install for mozdevice 04:58:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:58:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:58:02 INFO - Running setup.py install for mozfile 04:58:02 INFO - Running setup.py install for mozhttpd 04:58:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:58:02 INFO - Running setup.py install for mozinfo 04:58:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:58:02 INFO - Running setup.py install for mozInstall 04:58:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Running setup.py install for mozleak 04:58:03 INFO - Running setup.py install for mozlog 04:58:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Running setup.py install for moznetwork 04:58:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Running setup.py install for mozprocess 04:58:03 INFO - Running setup.py install for mozprofile 04:58:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Running setup.py install for mozrunner 04:58:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Running setup.py install for mozscreenshot 04:58:03 INFO - Running setup.py install for moztest 04:58:03 INFO - Running setup.py install for mozversion 04:58:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:58:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:04 INFO - Cleaning up... 04:58:04 INFO - Return code: 0 04:58:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:04 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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:58:04 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 04:58:04 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 04:58:04 INFO - Using env: {'DISPLAY': ':0', 04:58:04 INFO - 'HOME': '/home/cltbld', 04:58:04 INFO - 'LANG': 'en_US.UTF-8', 04:58:04 INFO - 'LANGUAGE': 'en_US:en', 04:58:04 INFO - 'LOGNAME': 'cltbld', 04:58:04 INFO - 'MAIL': '/var/mail/cltbld', 04:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:04 INFO - 'MOZ_NO_REMOTE': '1', 04:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:04 INFO - 'NO_EM_RESTART': '1', 04:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:04 INFO - 'PWD': '/builds/slave/test', 04:58:04 INFO - 'SHELL': '/bin/bash', 04:58:04 INFO - 'SHLVL': '1', 04:58:04 INFO - 'TERM': 'linux', 04:58:04 INFO - 'TMOUT': '86400', 04:58:04 INFO - 'USER': 'cltbld', 04:58:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:04 INFO - '_': '/tools/buildbot/bin/python'} 04:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:04 INFO - Running setup.py (path:/tmp/pip-FvOdDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:04 INFO - Running setup.py (path:/tmp/pip-6lXA4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:04 INFO - Running setup.py (path:/tmp/pip-qX7Sfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:04 INFO - Running setup.py (path:/tmp/pip-Gv_Ojx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:04 INFO - Running setup.py (path:/tmp/pip-lSarck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:04 INFO - Running setup.py (path:/tmp/pip-_M1TJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:04 INFO - Running setup.py (path:/tmp/pip-Szw1Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:04 INFO - Running setup.py (path:/tmp/pip-uMJb6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:04 INFO - Running setup.py (path:/tmp/pip-8kL7xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:04 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)) 04:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:04 INFO - Running setup.py (path:/tmp/pip-kp8UIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:05 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)) 04:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:05 INFO - Running setup.py (path:/tmp/pip-FG6GYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:05 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)) 04:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:05 INFO - Running setup.py (path:/tmp/pip-o0Fdlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:05 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)) 04:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:05 INFO - Running setup.py (path:/tmp/pip-nD74eD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:05 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)) 04:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:05 INFO - Running setup.py (path:/tmp/pip-rtgflc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:05 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)) 04:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:05 INFO - Running setup.py (path:/tmp/pip-9RS69H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:05 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)) 04:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:05 INFO - Running setup.py (path:/tmp/pip-hhLVRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:05 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)) 04:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:05 INFO - Running setup.py (path:/tmp/pip-EQjXhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:05 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)) 04:58:05 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)) 04:58:05 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)) 04:58:05 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)) 04:58:05 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)) 04:58:05 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)) 04:58:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58:07 INFO - Downloading blessings-1.6.tar.gz 04:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:07 INFO - Installing collected packages: blessings 04:58:07 INFO - Running setup.py install for blessings 04:58:07 INFO - Successfully installed blessings 04:58:07 INFO - Cleaning up... 04:58:07 INFO - Return code: 0 04:58:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:58:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:07 INFO - Reading from file tmpfile_stdout 04:58:07 INFO - Current package versions: 04:58:07 INFO - argparse == 1.2.1 04:58:07 INFO - blessings == 1.6 04:58:07 INFO - blobuploader == 1.2.4 04:58:07 INFO - docopt == 0.6.1 04:58:07 INFO - functools32 == 3.2.3-2 04:58:07 INFO - jsonschema == 2.5.1 04:58:07 INFO - manifestparser == 1.1 04:58:07 INFO - mozInstall == 1.12 04:58:07 INFO - mozcrash == 0.17 04:58:07 INFO - mozdebug == 0.1 04:58:07 INFO - mozdevice == 0.48 04:58:07 INFO - mozfile == 1.2 04:58:07 INFO - mozhttpd == 0.7 04:58:07 INFO - mozinfo == 0.9 04:58:07 INFO - mozleak == 0.1 04:58:07 INFO - mozlog == 3.2 04:58:07 INFO - moznetwork == 0.27 04:58:07 INFO - mozprocess == 0.22 04:58:07 INFO - mozprofile == 0.28 04:58:07 INFO - mozrunner == 6.11 04:58:07 INFO - mozscreenshot == 0.1 04:58:07 INFO - mozsystemmonitor == 0.3 04:58:07 INFO - moztest == 0.7 04:58:07 INFO - mozversion == 1.4 04:58:07 INFO - psutil == 3.1.1 04:58:07 INFO - requests == 1.2.3 04:58:07 INFO - wsgiref == 0.1.2 04:58:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:07 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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:58:07 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 04:58:07 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 04:58:07 INFO - Using env: {'DISPLAY': ':0', 04:58:07 INFO - 'HOME': '/home/cltbld', 04:58:07 INFO - 'LANG': 'en_US.UTF-8', 04:58:07 INFO - 'LANGUAGE': 'en_US:en', 04:58:07 INFO - 'LOGNAME': 'cltbld', 04:58:07 INFO - 'MAIL': '/var/mail/cltbld', 04:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:07 INFO - 'MOZ_NO_REMOTE': '1', 04:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:07 INFO - 'NO_EM_RESTART': '1', 04:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:07 INFO - 'PWD': '/builds/slave/test', 04:58:07 INFO - 'SHELL': '/bin/bash', 04:58:07 INFO - 'SHLVL': '1', 04:58:07 INFO - 'TERM': 'linux', 04:58:07 INFO - 'TMOUT': '86400', 04:58:07 INFO - 'USER': 'cltbld', 04:58:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:07 INFO - '_': '/tools/buildbot/bin/python'} 04:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 INFO - Cleaning up... 04:58:08 INFO - Return code: 0 04:58:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:08 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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:58:08 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 04:58:08 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 04:58:08 INFO - Using env: {'DISPLAY': ':0', 04:58:08 INFO - 'HOME': '/home/cltbld', 04:58:08 INFO - 'LANG': 'en_US.UTF-8', 04:58:08 INFO - 'LANGUAGE': 'en_US:en', 04:58:08 INFO - 'LOGNAME': 'cltbld', 04:58:08 INFO - 'MAIL': '/var/mail/cltbld', 04:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:08 INFO - 'MOZ_NO_REMOTE': '1', 04:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:08 INFO - 'NO_EM_RESTART': '1', 04:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:08 INFO - 'PWD': '/builds/slave/test', 04:58:08 INFO - 'SHELL': '/bin/bash', 04:58:08 INFO - 'SHLVL': '1', 04:58:08 INFO - 'TERM': 'linux', 04:58:08 INFO - 'TMOUT': '86400', 04:58:08 INFO - 'USER': 'cltbld', 04:58:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:08 INFO - '_': '/tools/buildbot/bin/python'} 04:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:58:08 INFO - Cleaning up... 04:58:08 INFO - Return code: 0 04:58:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:08 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 0x7f9c0161cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, '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-1465040121.905744-399504062', '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 04:58:08 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 04:58:08 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 04:58:08 INFO - Using env: {'DISPLAY': ':0', 04:58:08 INFO - 'HOME': '/home/cltbld', 04:58:08 INFO - 'LANG': 'en_US.UTF-8', 04:58:08 INFO - 'LANGUAGE': 'en_US:en', 04:58:08 INFO - 'LOGNAME': 'cltbld', 04:58:08 INFO - 'MAIL': '/var/mail/cltbld', 04:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:08 INFO - 'MOZ_NO_REMOTE': '1', 04:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:08 INFO - 'NO_EM_RESTART': '1', 04:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:08 INFO - 'PWD': '/builds/slave/test', 04:58:08 INFO - 'SHELL': '/bin/bash', 04:58:08 INFO - 'SHLVL': '1', 04:58:08 INFO - 'TERM': 'linux', 04:58:08 INFO - 'TMOUT': '86400', 04:58:08 INFO - 'USER': 'cltbld', 04:58:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:08 INFO - '_': '/tools/buildbot/bin/python'} 04:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:08 INFO - Downloading/unpacking flake8 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:58:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:58:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:58:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:11 INFO - no previously-included directories found matching 'docs/_build' 04:58:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:58:11 INFO - Running setup.py install for pep8 04:58:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:11 INFO - no previously-included directories found matching 'docs/_build' 04:58:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:58:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:58:11 INFO - Cleaning up... 04:58:11 INFO - Return code: 0 04:58:11 INFO - Running post-action listener: _resource_record_post_action 04:58:11 INFO - Running post-action listener: _start_resource_monitoring 04:58:11 INFO - Starting resource monitoring. 04:58:11 INFO - ##### 04:58:11 INFO - ##### Finished create-virtualenv step (success) 04:58:11 INFO - ##### 04:58:11 INFO - ##### 04:58:11 INFO - ##### Running install step. 04:58:11 INFO - ##### 04:58:11 INFO - Running pre-action listener: _resource_record_pre_action 04:58:11 INFO - Running main action method: install 04:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:11 INFO - Reading from file tmpfile_stdout 04:58:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:11 INFO - Reading from file tmpfile_stdout 04:58:11 INFO - Output received: 04:58:11 INFO - Usage: mozinstall [options] installer 04:58:11 INFO - Options: 04:58:11 INFO - -h, --help show this help message and exit 04:58:11 INFO - -d DEST, --destination=DEST 04:58:11 INFO - Directory to install application into. [default: 04:58:11 INFO - "/builds/slave/test"] 04:58:11 INFO - --app=APP Application being installed. [default: firefox] 04:58:11 INFO - mkdir: /builds/slave/test/build/application 04:58:11 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'] 04:58:11 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 04:58:28 INFO - Reading from file tmpfile_stdout 04:58:28 INFO - Output received: 04:58:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:58:28 INFO - Running post-action listener: _resource_record_post_action 04:58:28 INFO - ##### 04:58:28 INFO - ##### Finished install step (success) 04:58:28 INFO - ##### 04:58:28 INFO - ##### 04:58:28 INFO - ##### Running run-tests step. 04:58:28 INFO - ##### 04:58:28 INFO - Running pre-action listener: _resource_record_pre_action 04:58:28 INFO - Running main action method: run_tests 04:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:28 INFO - Python 2.7.3 04:58:28 INFO - Return code: 0 04:58:28 INFO - grabbing minidump binary from tooltool 04:58:28 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')]} 04:58:28 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 0x285d1c0>, '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 0x285e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:28 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 04:58:28 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 04:58:28 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 04:58:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:28 INFO - Return code: 0 04:58:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:58:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:58:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:58:29 INFO - Return code: 0 04:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:58:29 INFO - Using env: {'DISPLAY': ':0', 04:58:29 INFO - 'HOME': '/home/cltbld', 04:58:29 INFO - 'LANG': 'en_US.UTF-8', 04:58:29 INFO - 'LANGUAGE': 'en_US:en', 04:58:29 INFO - 'LOGNAME': 'cltbld', 04:58:29 INFO - 'MAIL': '/var/mail/cltbld', 04:58:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:29 INFO - 'MOZ_NO_REMOTE': '1', 04:58:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:29 INFO - 'NO_EM_RESTART': '1', 04:58:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:29 INFO - 'PWD': '/builds/slave/test', 04:58:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:29 INFO - 'SHELL': '/bin/bash', 04:58:29 INFO - 'SHLVL': '1', 04:58:29 INFO - 'TERM': 'linux', 04:58:29 INFO - 'TMOUT': '86400', 04:58:29 INFO - 'USER': 'cltbld', 04:58:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465040121.905744-399504062', 04:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:29 INFO - '_': '/tools/buildbot/bin/python'} 04:58:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/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 04:58:29 INFO - mozversion application_buildid: 20160604023008 04:58:29 INFO - mozversion application_changeset: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe 04:58:29 INFO - mozversion application_display_name: Nightly 04:58:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:29 INFO - mozversion application_name: Firefox 04:58:29 INFO - mozversion application_remotingname: firefox 04:58:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:58:29 INFO - mozversion application_vendor: Mozilla 04:58:29 INFO - mozversion application_version: 49.0a1 04:58:29 INFO - mozversion platform_buildid: 20160604023008 04:58:29 INFO - mozversion platform_changeset: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe 04:58:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:58:29 INFO - mozversion platform_version: 49.0a1 04:58:29 INFO - using testdate: 1465041509 04:58:29 INFO - actual date: 1465041509 04:58:29 INFO - starting webserver on 'localhost:37249' 04:58:29 INFO - SUITE-START | Running 2 tests 04:58:29 INFO - TEST-START | dromaeo_css 04:58:29 INFO - operating with platform_type : linux_ 04:58:29 INFO - Initialising browser for dromaeo_css test... 04:58:29 INFO - TEST-INFO | started process 5876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBfMb9s/profile http://localhost:37249/getInfo.html) 04:58:33 INFO - PROCESS | 5876 | __metrics Screen width/height:1600/1200 04:58:33 INFO - PROCESS | 5876 | colorDepth:24 04:58:33 INFO - PROCESS | 5876 | Browser inner width/height: 1024/697 04:58:33 INFO - PROCESS | 5876 | __metrics 04:58:35 ERROR - PROCESS | 5876 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:58:36 INFO - TEST-INFO | 5876: exit 0 04:58:36 INFO - Browser initialized. 04:58:36 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:36 INFO - TEST-INFO | started process 5959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBfMb9s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:48 INFO - PROCESS | 5959 | RSS: Main: 156033024 04:58:48 INFO - PROCESS | 5959 | 04:59:39 INFO - PROCESS | 5959 | 1465041579246 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] 05:01:46 INFO - PROCESS | 5959 | Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37249/tests/dromaeo/cssquery-ext.html) 05:01:48 INFO - PROCESS | 5959 | RSS: Main: 286175232 05:01:48 INFO - PROCESS | 5959 | 05:04:50 INFO - PROCESS | 5959 | Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-ext.html (next: http://localhost:37249/tests/dromaeo/cssquery-jquery.html) 05:04:51 INFO - PROCESS | 5959 | RSS: Main: 243511296 05:04:51 INFO - PROCESS | 5959 | 05:07:53 INFO - PROCESS | 5959 | Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37249/tests/dromaeo/cssquery-mootools.html) 05:07:53 INFO - PROCESS | 5959 | RSS: Main: 242139136 05:07:53 INFO - PROCESS | 5959 | 05:10:55 INFO - PROCESS | 5959 | Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37249/tests/dromaeo/cssquery-prototype.html) 05:10:56 INFO - PROCESS | 5959 | RSS: Main: 230391808 05:10:56 INFO - PROCESS | 5959 | 05:13:59 INFO - PROCESS | 5959 | Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37249/tests/dromaeo/cssquery-yui.html) 05:13:59 INFO - PROCESS | 5959 | RSS: Main: 223571968 05:13:59 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-yui.html (next: http://localhost:37249/tests/dromaeo/cssquery-dojo.html) 05:17:02 INFO - PROCESS | 5959 | RSS: Main: 275214336 05:17:02 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | __start_tp_report 05:17:02 INFO - PROCESS | 5959 | _x_x_mozilla_page_load 05:17:02 INFO - PROCESS | 5959 | _x_x_mozilla_page_load_details 05:17:02 INFO - PROCESS | 5959 | |i|pagename|runs| 05:17:02 INFO - PROCESS | 5959 | |0;dojo.html;3133.122725636821;3139.4035133324664;3148.1657360799377;3180.8250546219947;3202.1354234356722;5193.065248255312;5239.266502689627;5286.2334961430615;5399.730013499324;5418.187271909211;5227.9738601307035;5293.57651387889;5324.174752913295;5326.493983071612;5344;4783.952160478394;4860.611151107921;4874.2444921037295;4875.780589873464;5023.522765337287;4941;5001.574866136365;5006.5744411725045;5013.699178049311;5044.445111037783;4674.90650186996;4714.50497697742;4789.952100478986;4861.319415281828;4894.583960363373;4806.327114204014;4818.975905120487;4819.566239038469;4915.90168196634;4945.010997800418;4826.0347930414055;4850.320955066293;4855.126077306083;4857.73282469464;4898.926516102261;5117.948820511784;5213.061648903196;5354.170103633943;5360.705161216131;5368.892622147535;5667.178259152441;5726.484616384504;5778.24882765242;5779.711014449261;5784.248047753765;5753.050746626802;5768.019436695772;5803.912941305884;5811.215485909391;5819.010768169379;5184.481551844823;5287.259783630295;5352.4915133062295;5378.704171270579;5390.78436862525;5858;5866;5876.588638795243;5879.5002424794375;5893.970530147321;5633.436656334416;5652.491275785199;5671.773129074791;5678.5741069419955;5685.431456854364;5469.9179512306555;5574.86062848432;5687.772489100473;5688.658680479184;5769.480746732815;5678.290213723285;5680.488756011896;5681.204631351614;5693.544516438675;5704.144378343199;5655.010373184677;5673.8297851064535;5673.858153546194;5675.347335056439;5682.062459694187;4152.43942067823;4182.142660754538;4219.852305169305;4293.570642935744;4301.763403012865;3819.7135214858995;3851.2490064437725;3857.3442514772555;3888.0279930017496;3898.707596930185;5363.088274993261;5406.621536492407;5416.295881535375;5420.105682562333;5423.105187643994;5534.280543529316;5631.1271752878365;5712.11462223356;5732.6847023413275;5756.42435756421;5385.9730701347025;5401.594880383908;5403.351597808288;5410;5424.050791111618;4752.643551733565;4900.411950565955;4913.729744863996;4920.089783390084;4961.107000739901;5808.215890854681;5881.705914704333;5896.705164741746;5923.6149650273455;5927.733252003584;5694.544436445157;5709.371969083314;5722.570807189561;5724.227229323988;5726.255586773693;5713.714314284186;5796.652200867961;5948.464638182411;5976.133460648269;5978.282606087298;5586.748596313095;5610.158476228435;5613.438656134354;5620.915686264628;5668.744906479301;5705.800296989585;5710.057840456278;5710.714464276853;5712.171735098471;5714.685692286964;5393.244945707683;5475.2334673145;5551.833444996657;5557.36090349615;5564.527015203753;5567.3040869891265;5567.860803479945;5583.2462617547735;5589.916151257653;5629.0712032514175;5437.755301011543;5454.4545545445135;5477.534409575072;5482.753276102665;5505.987262417078;5394.676319420847;5566.610337276352;5618.803341883015;5650.35020972577;5674.120511320752;5334.3865455473115;5372;5383.488568585978;5453.127499600045;5453.781848726166 05:17:02 INFO - PROCESS | 5959 | |1;ext.html;580.1384943359111;621.2886245249192;625.031201637462;641.2241188162321;646.1309538670492;31112.844435777817;42930;43391.566084339145;43911.78044109775;44389.33415998763;40621.39067913983;41376.79311603438;45624.543754562525;45680;45722;8035.959820200891;8548.529830859316;8720.389572729911;8725.301975841918;8732.650693972266;8099.878501822477;10485.790284194312;10679;10689.679309620724;11011;10462.163026957864;10611.734706632318;10617.256792024562;10919.071878890303;10919.781604367909;10753.83869241958;10871.402072885989;10889.292196007234;10889.346639201594;10894.18293627981;10613.73465663357;10722.142228621691;10729.248952573324;10733.892661073445;10739.946300268448;43652.56347436549;44074.559254407366;44110.77944610288;44118.77940610277;44164.55835441669;3664.6885014773775;3888.137750029835;3921.627445392683;4281.529031806499;4362.323839804803;33789.831050844834;34040;34075.82962085198;34259.31481370384;35793.28413431717;4291.699581029329;4293.506246781598;4344.283193273106;4376.846810361622;4459.687821852472;379994;382948;383312.08343958383;383927;384747;65716.34283657103;66314.66842665756;66330;66358.66820665865;66366;62124.37875621276;62317;62418.375816241256;62460.687696562134;62462.375376245654;16895.493135205965;17228.741568876478;17236.310547577956;17344.566385840204;17392.652146957244;12617.495300188073;12640.620781376574;12644.051696122828;12645.557405490763;12672.366381680878;19112.802027766986;20241.59516809685;20466;20522.58954820895;20588.38234852957;7235.674394652148;7352.301531354513;7548.150183607748;7566.31903128721;7590.658420371096;923.4044041593135;1030.8196065688473;1090.9945450272699;1096.5887792077972;1140.4582823159099;32685;32803;33018.3396332072;33267.833660832024;33377.66622333746;1092.1426680056277;1108.3239224073309;1146.6617347882395;1154.0421450196318;1156.502703837358;16630.417935372447;17319.913400432917;17455.73816392755;17504.04703498817;17566;556605;559443;560720;560822;563114.1844290834;59953.700231498566;60701;60766.69616651889;60804.391956080755;60835.39164608297;1304.5760127958451;1396.3297617143828;1414.2080434956251;1414.6039109049482;1419.8438171801095;31069;32680.34639307248;32769;33006.66993330132;33236.50145247775;52561.7371913138;52850.207246892096;53181;53241;53331.20003199878;470871;471954;473489;473540;474228;28121;28931.276718081375;29025.709742903146;44257.33613995728;44825.55174448344;47903;48498;48999;49154.50845491499;49667.75166124146;40974.385384218665;42269;42328;42728.35907461328;43276.35085473657;40690.79654601827;40903.59096408998;41111.58888411077;41662.37506437467;42329.1534169321;31509.381819568072;36476.81761591175;41563.58436415597;41730.58269417267;41835.372469412374;33068.669313307524;38072.80963595164;38115;38617.61382386253;38664.80667596644;27332.453350932472;28183.859080704464;29275.55937693704;29279.56080658749;29580 05:17:02 INFO - PROCESS | 5959 | |2;jquery.html;373.3540974114783;383.79275191396647;385.69722767627417;394.4083874188717;409.45951344225614;14166.787498187523;18711.3451029214;18971.43085707431;19302.613947721056;19333.613327733437;18478.630427391443;18551.536211594717;18851;18864.434066978014;19564.31524896629;5409.918851217225;5523.806666766664;5525.530329921961;5577.749001294931;5584.91622625661;5569.081101618228;5707.942920570804;5759.913601295984;5762.193292938971;5766.394528574502;5567.550277877721;5593.888122237553;5690.06113991191;5699.886002279952;5705.771769129251;5685.971570142123;5714;5716;5717.485426311631;5723.8569035774235;4920.434150072751;5073.822416215415;5112.079825631385;5131.743412829381;5135.4094279157625;22150.113995440322;22363.888180559155;22691;22824.201152959566;22933;2113.93658190253;2375.714914210306;2561.6413702081536;2582.3802287451063;3131.4363414585364;9214.631414743402;9660.335920537087;9900.603975840957;10163.847542286872;13738.862611373957;1881.3415304643402;1933.2943475631434;1976.713376560405;1982.6332128556264;2080.053575623103;76685.61657191678;77594.22405775983;78944;79168.60415697942;81509.18490815016;10826.67519974402;10840.186985976083;10852.348859068481;11027.338359698444;11221.943890280496;15431.074135551902;15456.613584660248;15507.302171402314;15518.068915865084;15532.92233538825;8101.149379315205;8275.875861862078;8311.376646751396;8420.8315833683;8535.231829135408;8001.719939802196;8072.152423995513;8119;8277.379196560281;8308.376871734645;4703.576678098988;4749.24012158053;4750.548697873696;4780.4741478437345;4823.204171311694;1924.490010147312;1931.748872646547;1951.8536109791823;1954.9413517594494;1971.4775584470126;856.4261944497201;967.3905439573165;1019.1846522781744;1059.4914441068331;1090.8854570270166;18328;18550.257989680533;19155.084491550733;19382.8061719381;19487.317943871898;970.3013830042358;988.7528117970508;1010.3735683876043;1017.4251547875575;1029.330934892326;10244.129249013768;10906.182036347147;10937.476574330072;10953;10979;507418;507794;522603;524832;535374;81908.18091819125;91531;94896.52551737335;95910;96854.5157274209;1028.5114570579065;1042.8279333909973;1071.7267096890398;1077.7305673581604;1077.951492182838;16820.663586728442;17618.914993932463;18004.099795009934;18117.637647247244;18243.905365678103;40425.79787101046;40785.59214407818;41059.68873268383;42430.36354454624;42658.5734142667;56814.715926420104;57483.825016310824;58397.70801145967;58680;59900.70049649724;8313.293370063613;8404.20160084791;8495.702650407206;8554.230119289294;8646.913530864611;9229.676961306322;11648;12979.805302920275;13148.868511314764;13149;11395.601153959571;11500;11548.480318385526;11767.293962361944;11803.350815704875;11260.718482038015;11389.145814063813;11482.138839586898;11843.763124737628;11872.228305160137;11655.242409243372;11672;11749.118816088998;12067.396630168281;12134.33261170644;8440.66237350499;8610;8706.695265665672;8744.935245718212;8900.688475903313;8651.394402391772;11216.719582010515;11279.266847654877;11349.602763903224;11412.201145920038 05:17:02 INFO - PROCESS | 5959 | |3;mootools.html;1321.6431563477856;1471.5144002479183;1489.709506646204;1649.637079842435;1806.3316572868032;8059.274665280123;8328.750137495877;8349.958250208749;8485.78785530362;8502.319814414848;8227.95886020569;8407.234480759047;8410.411271211002;8414.957925210365;8416.95791521043;2087.8642888212294;2159.470929622245;2302.7236731592234;2328.813694904412;2329.4875127472014;2420.322309753272;2432.62294344376;2432.7080750309988;2433.318670772178;2435.3789783605243;2333.428310064028;2342.7422983471806;2363.7636236376397;2363.9409014774683;2366.230974933145;2036.1041141897517;2298.586254474194;2317.7450480447137;2378.108209421467;2381.988090059556;2370.2415227127326;2392.437777122375;2392.7726865947707;2394.174009966559;2395.1856368834506;8641.52471614061;8701.347398945105;8705.7823554411;8708.259797917184;8714.477131372138;5142.61430392722;5188.6367954243215;5330.1205301125265;5338.199270109476;5385.919211211835;3268.215628249227;3412.334594754024;3437.535932649085;3471.9132021699406;3480.5823301203764;1139.5897476908306;1164.126904821384;1167.6788883057143;1184.6505280942142;1191.559123124441;12291.201071930385;12298.077644176634;12312.13815032948;12317.322547259897;12361.938190309082;4579.656525760582;4709.646776491777;4735.83424580138;4818.975905120452;4820.9517904820505;10392.42841643717;10397.896021039693;10405.9479702601;10406.323588966692;10410.427426491615;5313.123334649817;5314.8937021260135;5318.228856815817;5321.122014867581;5325.360956685223;4198;4750.61995040396;4875.658703890694;4895.290182923456;4942.654014219042;3881.825317860703;3954.9011274717786;4007.779572123503;4047;4059.6752259819145;1264.4689230523202;1272.6691060324383;1277.916935399196;1289.1878116786365;1293.043148070421;869.6260607938647;990.2078337330107;1002.869626948492;1003.3628645809963;1006.869528556906;5965.135055417027;6026.0659597762415;6039.275286965592;6072.483838873657;6114.510839132859;446.7743789386404;448.22233425007585;476.53537800644096;477.8853075261912;484.09474283090844;3986.362182050858;4062.1875624875142;4080.7755573443746;4087.2438598859308;4114.917701645951;10690.198235132397;10695.304805187794;11114.277571957797;11167.274127181707;11179.608713695145;10911.290766100177;10962.068224200873;11041.282316649393;11057.336559806437;11064.668059958214;7905.802354941173;7935.682572697143;8219.95890020546;8243.670253189925;8382.455140415976;6034.698265086816;6108.114323423168;6123.2958209804665;6206.782762603287;6244.843878903063;9814.116729494379;10049;10241.129503992244;10261.74345641365;10262.58949642006;10221.693349199535;10281.177505799667;10331.173506119643;10361.274710770174;10401.375917444977;6954.79135625932;7578.242175782598;7756.185600511865;7845.686172553034;7964.601769911365;8613.353998450017;8673.00260470054;8714.302855771397;8728.389012769045;8739.781505462413;7487.138979017265;7836.725714599962;7840.411969102226;7847.136814950465;7964.163762805054;7544;7624.618769061413;7662.080550333995;7774;7907.090684571348;6924.169099707866;6969.7909062728195;6977.651117444006;6983.022376867141;7007.789766307019;5015.122353588181;5034.647574669738;5100.5409513143995;5143.71709555963;5203.11547036997;5148.948510514847;5171.482851714798;5205.479452054764;5236.947630523799;5289.312389389354 05:17:02 INFO - PROCESS | 5959 | |4;prototype.html;327.51691255398305;330.9354675838211;340.6100015482273;343.6065704768039;343.792005836469;5192.273081768555;5315.627906046579;5374.683202615364;5416.1604951232575;5428.18155917768;5265.97313523863;5281.128613778731;5318.973405132979;5325.281087053247;5328.760205790739;4146.087860670647;4159.480064991883;4165.812538435763;4167.854125105622;4197.7271477354025;3849.961500384988;3917.412388141773;4073.775942323171;4107.383892416132;4127.422160897477;4059.776712280823;4077.2660921034203;4100.569440208765;4102.979485102585;4111.979440102796;4101.938470922939;4106.733062350952;4112.300908845488;4129.607687269705;4146.709730318879;3491.8428670709877;3532.4877892705413;3552.2717842842158;3587.282543491286;3593.7484376093685;5047.848564543069;5071.873203169914;5075.314832497603;5083.779892825695;5102.38771347437;4659.4408670959365;4675.836345727883;4682.953170468286;4689.226277664181;4694.685488063314;5369.409364969889;5487.067198576212;5502.614816962814;5507.256520369779;5516.531094856942;3937.1731936293413;3944.4280579315837;3944.4419454315384;3952.604739526053;3967.5716741972865;5455.863603409907;5560.527355174815;5699.544036477072;5752.769889204426;5760.711964401805;4004.1791432756213;4041.2523683118716;4041.535223449341;4052.77709725962;4054.5134583849535;4084.7753373564146;4100.630943215125;4105.384192371109;4119.608637179464;4120.505539335299;4567.748773817472;4710.788014539354;4721.079389519079;4721.173794585934;4724.669273150916;5445.945540544623;5447.455254474521;5536.169574563767;5547.528460080857;5603.411641777636;1393.6724869655623;1409.9154050756988;1409.9224542650252;1419.4882450190514;1422.6585619451257;856.9657213711382;900.4192295969194;907.4283201583092;919.2645883293338;921.9631214751334;4770.904581908342;4801.207800712913;4877.829275975324;4892.431473476382;4917.262410638361;5081.8729531762;5088.516590923857;5093.643444958891;5103.234514822806;5120.820771272987;4518.403245613562;4807.6394270429855;4822.373091498082;4828.692345743178;4833.709977401367;2690.5157071726885;2693.9326516837236;2712.6744790625253;2714.687810901732;2735.2341344423594;5241.868953276198;5255;5264.605154613343;5293.550048245942;5295.76169072385;4872.926906096412;5189.1837856749835;5199.66202196856;5227.869303267373;5231.979763945994;5357.491038351351;5362.766563690373;5364.785408583613;5369.597280204079;5371.758270877898;5148.099082660445;5156.653722556153;5183.574517007853;5190.6107041971245;5195.3246078009615;4747.952520474751;4873.707577545359;4897.461279259207;5025.773840177128;5157.355330583677;5263.736703191283;5698.31620205578;5778.479936805707;5903.321118071477;5947.167396564571;3990.3415936371334;4011.4383986242533;4032.7580345179385;4045.797710114424;4057.776822274803;5719.8570035749435;5722.570807189561;5725.770969161187;5727.541796656341;5728.541716662574;5325.786968521371;5610.691411972381;5654.180143879033;5662.178984047372;5698.202251684685;5537.5569954402745;5560.944390556205;5609.943900560942;5615.241942337732;5619.80330688424;5257.421683614876;5506.614536982373;5526.613137080527;5534.418886016911;5557.527610153183;5615.971920140537;5641.576881733969;5657.745401456862;5664.207011018543;5670.206171135962;5507.476789704971;5515.428102990629;5523.204958388459;5532.1425179097305;5536.418676039119 05:17:02 INFO - PROCESS | 5959 | |5;yui.html;688.272436185175;766.9386449084072;778.9571573563452;798.3174385900058;835.0605568735173;14297.642558936019;14993.700125997488;15091.547253582383;15476.458323958677;15821.208939553006;14559.490417835377;14622.780658290134;14769.852301477009;14782.113073215614;14796.852031479682;677.9457643388541;802.0415603353995;809.7368355284541;822.4325215601245;826.4215049465369;800.2117913854848;803.895493585833;803.9598020099;805.3597390074875;807.3258828877894;857.5197889182047;857.8155696525246;859.2696208222992;859.5831021954347;860.1613426908776;707.6744697439184;829.9626516806758;850.4259624753266;853.4367317570374;855.5038077914857;616.1958643969618;616.3220457496762;616.5591602004588;617.4566381584222;617.5707883021302;14793.334299956528;14800.481983130647;14843.257837108102;14854.480093196686;14887.10677359362;14206.147631142165;14438.133711977314;14514.491992780202;14547.709045819025;14727.779083313759;12701.618951431472;12872.29202393868;12903.483860645563;12962.935185324013;13000.139969206759;4447.812498452178;4492.505824359318;4500.729956202638;4508.842190523316;4637.165310244155;66669;67805.66097169532;68654;72732.27267727308;73156.26843731548;10975.231733778559;11035.172362072877;11121.27711698737;11124.888751112547;11207.831882521768;19850.801491984894;20082.19671213135;20083.297084601967;20103.29638462647;20120.29578964729;8182.386321025947;8248;8290.875636865452;8401.495910245283;8509.10654381281;4678.368420263289;4927.162382395001;5017.548420642087;5025.095482813055;5036.244563315458;3650.872219472306;3734.141147536028;3793.203427280247;3797.278517081801;3800.638939300762;636.4749082007362;653.1900443450182;663.8771827211981;665.1187176990506;670;720.8342081321325;720.9170945341353;725.6879541797078;734.713461749918;748.3227678950558;9822.852657210147;10074.395536267848;10183.490825458846;10194.235432342455;10456;729.4638440746047;761.5963539324167;768.8616049111101;774.817917789319;806.9919300807035;4626.745528995937;4724.976375118171;4774.283857421415;4864.78108485119;4871.926921096187;66835.33164668389;74062;87479.12520874837;107727.46136269269;114505.42747286211;93082.53458732663;94451.52774236085;95343.52328238453;97011.51494242484;97807;80795;82692;83725.58137209396;86022;86940.74306708427;9348.392354496937;9443.952780236055;9468.95265523668;9559.426434413957;9588.185004274716;52091.73954130205;52153.47846521486;52739.73630131825;54082;54368;65504.672476637315;66692;72325.6383718078;73262.63368683122;74669.62665186639;11869.940650296694;11928.880711193124;11984.40077996114;12333.383330833602;12563.309018004098;13555.796663049865;13596.521704602796;13685.45258189701;13883.583492495241;14163.575092747235;12384;12420.503179872703;12585.433655485342;13377.531786387819;13658.863411365759;12264.32546209967;12610.243385396905;12838.229706217657;13494.730105398034;13674.111182773486;12500.812487812509;12757.170783899017;12893.833319255496;13192.868071319164;13675.521356752864;10334;10450.529726162493;10485.318454300752;10841.783164336826;10898.400587967737;10088.293819432569;10597.62908298206;10633.946830265799;10753.1935104869;10792.622258220925 05:17:02 INFO - PROCESS | 5959 | __end_tp_report 05:17:02 INFO - PROCESS | 5959 | __start_cc_report 05:17:02 INFO - PROCESS | 5959 | _x_x_mozilla_cycle_collect,1131 05:17:02 INFO - PROCESS | 5959 | __end_cc_report 05:17:02 INFO - PROCESS | 5959 | __startTimestamp1465042622745__endTimestamp 05:17:02 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | ------- Summary: start ------- 05:17:02 INFO - PROCESS | 5959 | Number of tests: 6 05:17:02 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | [#0] dojo.html Cycles:165 Average:5293.03 Median:5453.78 stddev:600.21 (11.0%) stddev-sans-first:577.64 05:17:02 INFO - PROCESS | 5959 | Values: 3133.1 3139.4 3148.2 3180.8 3202.1 5193.1 5239.3 5286.2 5399.7 5418.2 5228.0 5293.6 5324.2 5326.5 5344.0 4784.0 4860.6 4874.2 4875.8 5023.5 4941.0 5001.6 5006.6 5013.7 5044.4 4674.9 4714.5 4790.0 4861.3 4894.6 4806.3 4819.0 4819.6 4915.9 4945.0 4826.0 4850.3 4855.1 4857.7 4898.9 5117.9 5213.1 5354.2 5360.7 5368.9 5667.2 5726.5 5778.2 5779.7 5784.2 5753.1 5768.0 5803.9 5811.2 5819.0 5184.5 5287.3 5352.5 5378.7 5390.8 5858.0 5866.0 5876.6 5879.5 5894.0 5633.4 5652.5 5671.8 5678.6 5685.4 5469.9 5574.9 5687.8 5688.7 5769.5 5678.3 5680.5 5681.2 5693.5 5704.1 5655.0 5673.8 5673.9 5675.3 5682.1 4152.4 4182.1 4219.9 4293.6 4301.8 3819.7 3851.2 3857.3 3888.0 3898.7 5363.1 5406.6 5416.3 5420.1 5423.1 5534.3 5631.1 5712.1 5732.7 5756.4 5386.0 5401.6 5403.4 5410.0 5424.1 4752.6 4900.4 4913.7 4920.1 4961.1 5808.2 5881.7 5896.7 5923.6 5927.7 5694.5 5709.4 5722.6 5724.2 5726.3 5713.7 5796.7 5948.5 5976.1 5978.3 5586.7 5610.2 5613.4 5620.9 5668.7 5705.8 5710.1 5710.7 5712.2 5714.7 5393.2 5475.2 5551.8 5557.4 5564.5 5567.3 5567.9 5583.2 5589.9 5629.1 5437.8 5454.5 5477.5 5482.8 5506.0 5394.7 5566.6 5618.8 5650.4 5674.1 5334.4 5372.0 5383.5 5453.1 5453.8 05:17:02 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | [#1] ext.html Cycles:180 Average:63825.15 Median:3904.88 stddev:126591.91 (3241.9%) stddev-sans-first:126857.98 05:17:02 INFO - PROCESS | 5959 | Values: 580.1 621.3 625.0 641.2 646.1 31112.8 42930.0 43391.6 43911.8 44389.3 40621.4 41376.8 45624.5 45680.0 45722.0 8036.0 8548.5 8720.4 8725.3 8732.7 8099.9 10485.8 10679.0 10689.7 11011.0 10462.2 10611.7 10617.3 10919.1 10919.8 10753.8 10871.4 10889.3 10889.3 10894.2 10613.7 10722.1 10729.2 10733.9 10739.9 43652.6 44074.6 44110.8 44118.8 44164.6 3664.7 3888.1 3921.6 4281.5 4362.3 33789.8 34040.0 34075.8 34259.3 35793.3 4291.7 4293.5 4344.3 4376.8 4459.7 379994.0 382948.0 383312.1 383927.0 384747.0 65716.3 66314.7 66330.0 66358.7 66366.0 62124.4 62317.0 62418.4 62460.7 62462.4 16895.5 17228.7 17236.3 17344.6 17392.7 12617.5 12640.6 12644.1 12645.6 12672.4 19112.8 20241.6 20466.0 20522.6 20588.4 7235.7 7352.3 7548.2 7566.3 7590.7 923.4 1030.8 1091.0 1096.6 1140.5 32685.0 32803.0 33018.3 33267.8 33377.7 1092.1 1108.3 1146.7 1154.0 1156.5 16630.4 17319.9 17455.7 17504.0 17566.0 556605.0 559443.0 560720.0 560822.0 563114.2 59953.7 60701.0 60766.7 60804.4 60835.4 1304.6 1396.3 1414.2 1414.6 1419.8 31069.0 32680.3 32769.0 33006.7 33236.5 52561.7 52850.2 53181.0 53241.0 53331.2 470871.0 471954.0 473489.0 473540.0 474228.0 28121.0 28931.3 29025.7 44257.3 44825.6 47903.0 48498.0 48999.0 49154.5 49667.8 40974.4 42269.0 42328.0 42728.4 43276.4 40690.8 40903.6 41111.6 41662.4 42329.2 31509.4 36476.8 41563.6 41730.6 41835.4 33068.7 38072.8 38115.0 38617.6 38664.8 27332.5 28183.9 29275.6 29279.6 29580.0 05:17:02 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | [#2] jquery.html Cycles:180 Average:29673.75 Median:1752.40 stddev:85527.93 (4880.6%) stddev-sans-first:85739.56 05:17:02 INFO - PROCESS | 5959 | Values: 373.4 383.8 385.7 394.4 409.5 14166.8 18711.3 18971.4 19302.6 19333.6 18478.6 18551.5 18851.0 18864.4 19564.3 5409.9 5523.8 5525.5 5577.7 5584.9 5569.1 5707.9 5759.9 5762.2 5766.4 5567.6 5593.9 5690.1 5699.9 5705.8 5686.0 5714.0 5716.0 5717.5 5723.9 4920.4 5073.8 5112.1 5131.7 5135.4 22150.1 22363.9 22691.0 22824.2 22933.0 2113.9 2375.7 2561.6 2582.4 3131.4 9214.6 9660.3 9900.6 10163.8 13738.9 1881.3 1933.3 1976.7 1982.6 2080.1 76685.6 77594.2 78944.0 79168.6 81509.2 10826.7 10840.2 10852.3 11027.3 11221.9 15431.1 15456.6 15507.3 15518.1 15532.9 8101.1 8275.9 8311.4 8420.8 8535.2 8001.7 8072.2 8119.0 8277.4 8308.4 4703.6 4749.2 4750.5 4780.5 4823.2 1924.5 1931.7 1951.9 1954.9 1971.5 856.4 967.4 1019.2 1059.5 1090.9 18328.0 18550.3 19155.1 19382.8 19487.3 970.3 988.8 1010.4 1017.4 1029.3 10244.1 10906.2 10937.5 10953.0 10979.0 507418.0 507794.0 522603.0 524832.0 535374.0 81908.2 91531.0 94896.5 95910.0 96854.5 1028.5 1042.8 1071.7 1077.7 1078.0 16820.7 17618.9 18004.1 18117.6 18243.9 40425.8 40785.6 41059.7 42430.4 42658.6 56814.7 57483.8 58397.7 58680.0 59900.7 8313.3 8404.2 8495.7 8554.2 8646.9 9229.7 11648.0 12979.8 13148.9 13149.0 11395.6 11500.0 11548.5 11767.3 11803.4 11260.7 11389.1 11482.1 11843.8 11872.2 11655.2 11672.0 11749.1 12067.4 12134.3 8440.7 8610.0 8706.7 8744.9 8900.7 8651.4 11216.7 11279.3 11349.6 11412.2 05:17:02 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | [#3] mootools.html Cycles:180 Average:5795.59 Median:4644.65 stddev:3309.41 (71.3%) stddev-sans-first:3301.62 05:17:02 INFO - PROCESS | 5959 | Values: 1321.6 1471.5 1489.7 1649.6 1806.3 8059.3 8328.8 8350.0 8485.8 8502.3 8228.0 8407.2 8410.4 8415.0 8417.0 2087.9 2159.5 2302.7 2328.8 2329.5 2420.3 2432.6 2432.7 2433.3 2435.4 2333.4 2342.7 2363.8 2363.9 2366.2 2036.1 2298.6 2317.7 2378.1 2382.0 2370.2 2392.4 2392.8 2394.2 2395.2 8641.5 8701.3 8705.8 8708.3 8714.5 5142.6 5188.6 5330.1 5338.2 5385.9 3268.2 3412.3 3437.5 3471.9 3480.6 1139.6 1164.1 1167.7 1184.7 1191.6 12291.2 12298.1 12312.1 12317.3 12361.9 4579.7 4709.6 4735.8 4819.0 4821.0 10392.4 10397.9 10405.9 10406.3 10410.4 5313.1 5314.9 5318.2 5321.1 5325.4 4198.0 4750.6 4875.7 4895.3 4942.7 3881.8 3954.9 4007.8 4047.0 4059.7 1264.5 1272.7 1277.9 1289.2 1293.0 869.6 990.2 1002.9 1003.4 1006.9 5965.1 6026.1 6039.3 6072.5 6114.5 446.8 448.2 476.5 477.9 484.1 3986.4 4062.2 4080.8 4087.2 4114.9 10690.2 10695.3 11114.3 11167.3 11179.6 10911.3 10962.1 11041.3 11057.3 11064.7 7905.8 7935.7 8220.0 8243.7 8382.5 6034.7 6108.1 6123.3 6206.8 6244.8 9814.1 10049.0 10241.1 10261.7 10262.6 10221.7 10281.2 10331.2 10361.3 10401.4 6954.8 7578.2 7756.2 7845.7 7964.6 8613.4 8673.0 8714.3 8728.4 8739.8 7487.1 7836.7 7840.4 7847.1 7964.2 7544.0 7624.6 7662.1 7774.0 7907.1 6924.2 6969.8 6977.7 6983.0 7007.8 5015.1 5034.6 5100.5 5143.7 5203.1 5148.9 5171.5 5205.5 5236.9 5289.3 05:17:02 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | [#4] prototype.html Cycles:180 Average:4528.80 Median:5091.08 stddev:1319.65 (25.9%) stddev-sans-first:1285.13 05:17:02 INFO - PROCESS | 5959 | Values: 327.5 330.9 340.6 343.6 343.8 5192.3 5315.6 5374.7 5416.2 5428.2 5266.0 5281.1 5319.0 5325.3 5328.8 4146.1 4159.5 4165.8 4167.9 4197.7 3850.0 3917.4 4073.8 4107.4 4127.4 4059.8 4077.3 4100.6 4103.0 4112.0 4101.9 4106.7 4112.3 4129.6 4146.7 3491.8 3532.5 3552.3 3587.3 3593.7 5047.8 5071.9 5075.3 5083.8 5102.4 4659.4 4675.8 4683.0 4689.2 4694.7 5369.4 5487.1 5502.6 5507.3 5516.5 3937.2 3944.4 3944.4 3952.6 3967.6 5455.9 5560.5 5699.5 5752.8 5760.7 4004.2 4041.3 4041.5 4052.8 4054.5 4084.8 4100.6 4105.4 4119.6 4120.5 4567.7 4710.8 4721.1 4721.2 4724.7 5445.9 5447.5 5536.2 5547.5 5603.4 1393.7 1409.9 1409.9 1419.5 1422.7 857.0 900.4 907.4 919.3 922.0 4770.9 4801.2 4877.8 4892.4 4917.3 5081.9 5088.5 5093.6 5103.2 5120.8 4518.4 4807.6 4822.4 4828.7 4833.7 2690.5 2693.9 2712.7 2714.7 2735.2 5241.9 5255.0 5264.6 5293.6 5295.8 4872.9 5189.2 5199.7 5227.9 5232.0 5357.5 5362.8 5364.8 5369.6 5371.8 5148.1 5156.7 5183.6 5190.6 5195.3 4748.0 4873.7 4897.5 5025.8 5157.4 5263.7 5698.3 5778.5 5903.3 5947.2 3990.3 4011.4 4032.8 4045.8 4057.8 5719.9 5722.6 5725.8 5727.5 5728.5 5325.8 5610.7 5654.2 5662.2 5698.2 5537.6 5560.9 5609.9 5615.2 5619.8 5257.4 5506.6 5526.6 5534.4 5557.5 5616.0 5641.6 5657.7 5664.2 5670.2 5507.5 5515.4 5523.2 5532.1 5536.4 05:17:02 INFO - PROCESS | 5959 | 05:17:02 INFO - PROCESS | 5959 | [#5] yui.html Cycles:180 Average:19582.73 Median:4868.35 stddev:27216.93 (559.1%) stddev-sans-first:27256.30 05:17:02 INFO - PROCESS | 5959 | Values: 688.3 766.9 779.0 798.3 835.1 14297.6 14993.7 15091.5 15476.5 15821.2 14559.5 14622.8 14769.9 14782.1 14796.9 677.9 802.0 809.7 822.4 826.4 800.2 803.9 804.0 805.4 807.3 857.5 857.8 859.3 859.6 860.2 707.7 830.0 850.4 853.4 855.5 616.2 616.3 616.6 617.5 617.6 14793.3 14800.5 14843.3 14854.5 14887.1 14206.1 14438.1 14514.5 14547.7 14727.8 12701.6 12872.3 12903.5 12962.9 13000.1 4447.8 4492.5 4500.7 4508.8 4637.2 66669.0 67805.7 68654.0 72732.3 73156.3 10975.2 11035.2 11121.3 11124.9 11207.8 19850.8 20082.2 20083.3 20103.3 20120.3 8182.4 8248.0 8290.9 8401.5 8509.1 4678.4 4927.2 5017.5 5025.1 5036.2 3650.9 3734.1 3793.2 3797.3 3800.6 636.5 653.2 663.9 665.1 670.0 720.8 720.9 725.7 734.7 748.3 9822.9 10074.4 10183.5 10194.2 10456.0 729.5 761.6 768.9 774.8 807.0 4626.7 4725.0 4774.3 4864.8 4871.9 66835.3 74062.0 87479.1 107727.5 114505.4 93082.5 94451.5 95343.5 97011.5 97807.0 80795.0 82692.0 83725.6 86022.0 86940.7 9348.4 9444.0 9469.0 9559.4 9588.2 52091.7 52153.5 52739.7 54082.0 54368.0 65504.7 66692.0 72325.6 73262.6 74669.6 11869.9 11928.9 11984.4 12333.4 12563.3 13555.8 13596.5 13685.5 13883.6 14163.6 12384.0 12420.5 12585.4 13377.5 13658.9 12264.3 12610.2 12838.2 13494.7 13674.1 12500.8 12757.2 12893.8 13192.9 13675.5 10334.0 10450.5 10485.3 10841.8 10898.4 10088.3 10597.6 10633.9 10753.2 10792.6 05:17:02 INFO - PROCESS | 5959 | -------- Summary: end -------- 05:17:02 INFO - PROCESS | 5959 | 05:17:03 INFO - TEST-INFO | 5959: exit 0 05:17:03 INFO - TEST-OK | dromaeo_css | took 1113705ms 05:17:03 INFO - TEST-START | kraken 05:17:03 INFO - operating with platform_type : linux_ 05:17:03 INFO - Initialising browser for kraken test... 05:17:03 INFO - TEST-INFO | started process 6143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Kkh2z/profile http://localhost:37249/getInfo.html) 05:17:07 INFO - PROCESS | 6143 | __metrics Screen width/height:1600/1200 05:17:07 INFO - PROCESS | 6143 | colorDepth:24 05:17:07 INFO - PROCESS | 6143 | Browser inner width/height: 1024/697 05:17:07 INFO - PROCESS | 6143 | __metrics 05:17:08 ERROR - PROCESS | 6143 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:17:09 INFO - TEST-INFO | 6143: exit 0 05:17:09 INFO - Browser initialized. 05:17:09 INFO - Running cycle 1/1 for kraken test... 05:17:09 INFO - TEST-INFO | started process 6228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Kkh2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:21 INFO - PROCESS | 6228 | RSS: Main: 156147712 05:17:21 INFO - PROCESS | 6228 | 05:17:23 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37249/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:24 INFO - PROCESS | 6228 | RSS: Main: 214536192 05:17:24 INFO - PROCESS | 6228 | 05:17:27 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37249/tests/kraken/driver.html?testName=audio-dft) 05:17:27 INFO - PROCESS | 6228 | RSS: Main: 202543104 05:17:27 INFO - PROCESS | 6228 | 05:17:31 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37249/tests/kraken/driver.html?testName=audio-fft) 05:17:31 INFO - PROCESS | 6228 | RSS: Main: 268517376 05:17:31 INFO - PROCESS | 6228 | 05:17:33 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37249/tests/kraken/driver.html?testName=audio-oscillator) 05:17:34 INFO - PROCESS | 6228 | RSS: Main: 179572736 05:17:34 INFO - PROCESS | 6228 | 05:17:36 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:37 INFO - PROCESS | 6228 | RSS: Main: 183410688 05:17:37 INFO - PROCESS | 6228 | 05:17:40 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37249/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:40 INFO - PROCESS | 6228 | RSS: Main: 217792512 05:17:40 INFO - PROCESS | 6228 | 05:17:44 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37249/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:44 INFO - PROCESS | 6228 | RSS: Main: 219942912 05:17:44 INFO - PROCESS | 6228 | 05:17:47 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37249/tests/kraken/driver.html?testName=json-parse-financial) 05:17:48 INFO - PROCESS | 6228 | RSS: Main: 220205056 05:17:48 INFO - PROCESS | 6228 | 05:17:49 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:50 INFO - PROCESS | 6228 | RSS: Main: 206131200 05:17:50 INFO - PROCESS | 6228 | 05:17:52 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:52 INFO - PROCESS | 6228 | RSS: Main: 209645568 05:17:52 INFO - PROCESS | 6228 | 05:17:54 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:55 INFO - PROCESS | 6228 | RSS: Main: 216137728 05:17:55 INFO - PROCESS | 6228 | 05:17:57 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:58 INFO - PROCESS | 6228 | RSS: Main: 221872128 05:17:58 INFO - PROCESS | 6228 | 05:18:01 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:01 INFO - PROCESS | 6228 | RSS: Main: 222318592 05:18:01 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37249/tests/kraken/driver.html?testName=ai-astar) 05:18:03 INFO - PROCESS | 6228 | RSS: Main: 264552448 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | __start_tp_report 05:18:03 INFO - PROCESS | 6228 | _x_x_mozilla_page_load 05:18:03 INFO - PROCESS | 6228 | _x_x_mozilla_page_load_details 05:18:03 INFO - PROCESS | 6228 | |i|pagename|runs| 05:18:03 INFO - PROCESS | 6228 | |0;ai-astar;111;106;112;109;111;110;112;110;110;110 05:18:03 INFO - PROCESS | 6228 | |1;audio-beat-detection;155;124;139;174;125;161;151;125;185;133 05:18:03 INFO - PROCESS | 6228 | |2;audio-dft;159;162;161;161;162;161;160;162;163;161 05:18:03 INFO - PROCESS | 6228 | |3;audio-fft;75;75;75;121;75;76;75;74;111;76 05:18:03 INFO - PROCESS | 6228 | |4;audio-oscillator;85;85;107;85;85;85;111;85;85;130 05:18:03 INFO - PROCESS | 6228 | |5;imaging-gaussian-blur;116;116;116;117;117;117;116;117;118;117 05:18:03 INFO - PROCESS | 6228 | |6;imaging-darkroom;145;145;145;146;145;145;145;146;146;145 05:18:03 INFO - PROCESS | 6228 | |7;imaging-desaturate;95;95;94;95;95;95;94;95;94;94 05:18:03 INFO - PROCESS | 6228 | |8;json-parse-financial;57;57;57;57;57;58;57;57;58;58 05:18:03 INFO - PROCESS | 6228 | |9;json-stringify-tinderbox;63;64;62;62;62;65;62;63;62;62 05:18:03 INFO - PROCESS | 6228 | |10;stanford-crypto-aes;79;78;79;80;80;80;80;81;110;80 05:18:03 INFO - PROCESS | 6228 | |11;stanford-crypto-ccm;133;121;130;118;120;127;121;127;123;121 05:18:03 INFO - PROCESS | 6228 | |12;stanford-crypto-pbkdf2;167;161;159;159;158;159;159;156;159;158 05:18:03 INFO - PROCESS | 6228 | |13;stanford-crypto-sha256-iterative;64;68;65;62;63;62;62;64;63;61 05:18:03 INFO - PROCESS | 6228 | __end_tp_report 05:18:03 INFO - PROCESS | 6228 | __start_cc_report 05:18:03 INFO - PROCESS | 6228 | _x_x_mozilla_cycle_collect,1618 05:18:03 INFO - PROCESS | 6228 | __end_cc_report 05:18:03 INFO - PROCESS | 6228 | __startTimestamp1465042683663__endTimestamp 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | ------- Summary: start ------- 05:18:03 INFO - PROCESS | 6228 | Number of tests: 14 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:1.73 (1.6%) stddev-sans-first:1.80 05:18:03 INFO - PROCESS | 6228 | Values: 111.0 106.0 112.0 109.0 111.0 110.0 112.0 110.0 110.0 110.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:153.00 stddev:21.62 (14.1%) stddev-sans-first:22.74 05:18:03 INFO - PROCESS | 6228 | Values: 155.0 124.0 139.0 174.0 125.0 161.0 151.0 125.0 185.0 133.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:0.88 05:18:03 INFO - PROCESS | 6228 | Values: 159.0 162.0 161.0 161.0 162.0 161.0 160.0 162.0 163.0 161.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:17.40 (23.2%) stddev-sans-first:18.20 05:18:03 INFO - PROCESS | 6228 | Values: 75.0 75.0 75.0 121.0 75.0 76.0 75.0 74.0 111.0 76.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:85.00 stddev:16.06 (18.9%) stddev-sans-first:16.67 05:18:03 INFO - PROCESS | 6228 | Values: 85.0 85.0 107.0 85.0 85.0 85.0 111.0 85.0 85.0 130.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 05:18:03 INFO - PROCESS | 6228 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:18:03 INFO - PROCESS | 6228 | Values: 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:18:03 INFO - PROCESS | 6228 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 05:18:03 INFO - PROCESS | 6228 | Values: 57.0 57.0 57.0 57.0 57.0 58.0 57.0 57.0 58.0 58.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.50 stddev:1.06 (1.7%) stddev-sans-first:1.12 05:18:03 INFO - PROCESS | 6228 | Values: 63.0 64.0 62.0 62.0 62.0 65.0 62.0 63.0 62.0 62.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:80.00 stddev:9.63 (12.0%) stddev-sans-first:10.12 05:18:03 INFO - PROCESS | 6228 | Values: 79.0 78.0 79.0 80.0 80.0 80.0 80.0 81.0 110.0 80.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.00 stddev:4.89 (3.9%) stddev-sans-first:3.98 05:18:03 INFO - PROCESS | 6228 | Values: 133.0 121.0 130.0 118.0 120.0 127.0 121.0 127.0 123.0 121.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.00 stddev:2.92 (1.8%) stddev-sans-first:1.32 05:18:03 INFO - PROCESS | 6228 | Values: 167.0 161.0 159.0 159.0 158.0 159.0 159.0 156.0 159.0 158.0 05:18:03 INFO - PROCESS | 6228 | 05:18:03 INFO - PROCESS | 6228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:2.01 (3.2%) stddev-sans-first:2.12 05:18:03 INFO - PROCESS | 6228 | Values: 64.0 68.0 65.0 62.0 63.0 62.0 62.0 64.0 63.0 61.0 05:18:03 INFO - PROCESS | 6228 | -------- Summary: end -------- 05:18:03 INFO - PROCESS | 6228 | 05:18:04 INFO - TEST-INFO | 6228: exit 0 05:18:04 INFO - TEST-OK | kraken | took 61234ms 05:18:04 INFO - SUITE-END | took 1174s 05:18:04 INFO - Completed test suite (00:19:35) 05:18:04 INFO - javascript benchmark 05:18:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.122725636821, 3139.4035133324664, 3148.1657360799377, 3180.8250546219947, 3202.1354234356722, 5193.065248255312, 5239.266502689627, 5286.2334961430615, 5399.730013499324, 5418.187271909211, 5227.9738601307035, 5293.57651387889, 5324.174752913295, 5326.493983071612, 5344.0, 4783.952160478394, 4860.611151107921, 4874.2444921037295, 4875.780589873464, 5023.522765337287, 4941.0, 5001.574866136365, 5006.5744411725045, 5013.699178049311, 5044.445111037783, 4674.90650186996, 4714.50497697742, 4789.952100478986, 4861.319415281828, 4894.583960363373, 4806.327114204014, 4818.975905120487, 4819.566239038469, 4915.90168196634, 4945.010997800418, 4826.0347930414055, 4850.320955066293, 4855.126077306083, 4857.73282469464, 4898.926516102261, 5117.948820511784, 5213.061648903196, 5354.170103633943, 5360.705161216131, 5368.892622147535, 5667.178259152441, 5726.484616384504, 5778.24882765242, 5779.711014449261, 5784.248047753765, 5753.050746626802, 5768.019436695772, 5803.912941305884, 5811.215485909391, 5819.010768169379, 5184.481551844823, 5287.259783630295, 5352.4915133062295, 5378.704171270579, 5390.78436862525, 5858.0, 5866.0, 5876.588638795243, 5879.5002424794375, 5893.970530147321, 5633.436656334416, 5652.491275785199, 5671.773129074791, 5678.5741069419955, 5685.431456854364, 5469.9179512306555, 5574.86062848432, 5687.772489100473, 5688.658680479184, 5769.480746732815, 5678.290213723285, 5680.488756011896, 5681.204631351614, 5693.544516438675, 5704.144378343199, 5655.010373184677, 5673.8297851064535, 5673.858153546194, 5675.347335056439, 5682.062459694187, 4152.43942067823, 4182.142660754538, 4219.852305169305, 4293.570642935744, 4301.763403012865, 3819.7135214858995, 3851.2490064437725, 3857.3442514772555, 3888.0279930017496, 3898.707596930185, 5363.088274993261, 5406.621536492407, 5416.295881535375, 5420.105682562333, 5423.105187643994, 5534.280543529316, 5631.1271752878365, 5712.11462223356, 5732.6847023413275, 5756.42435756421, 5385.9730701347025, 5401.594880383908, 5403.351597808288, 5410.0, 5424.050791111618, 4752.643551733565, 4900.411950565955, 4913.729744863996, 4920.089783390084, 4961.107000739901, 5808.215890854681, 5881.705914704333, 5896.705164741746, 5923.6149650273455, 5927.733252003584, 5694.544436445157, 5709.371969083314, 5722.570807189561, 5724.227229323988, 5726.255586773693, 5713.714314284186, 5796.652200867961, 5948.464638182411, 5976.133460648269, 5978.282606087298, 5586.748596313095, 5610.158476228435, 5613.438656134354, 5620.915686264628, 5668.744906479301, 5705.800296989585, 5710.057840456278, 5710.714464276853, 5712.171735098471, 5714.685692286964, 5393.244945707683, 5475.2334673145, 5551.833444996657, 5557.36090349615, 5564.527015203753, 5567.3040869891265, 5567.860803479945, 5583.2462617547735, 5589.916151257653, 5629.0712032514175, 5437.755301011543, 5454.4545545445135, 5477.534409575072, 5482.753276102665, 5505.987262417078, 5394.676319420847, 5566.610337276352, 5618.803341883015, 5650.35020972577, 5674.120511320752, 5334.3865455473115, 5372.0, 5383.488568585978, 5453.127499600045, 5453.781848726166], "value": 5253.043561758839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.1384943359111, 621.2886245249192, 625.031201637462, 641.2241188162321, 646.1309538670492, 31112.844435777817, 42930.0, 43391.566084339145, 43911.78044109775, 44389.33415998763, 40621.39067913983, 41376.79311603438, 45624.543754562525, 45680.0, 45722.0, 8035.959820200891, 8548.529830859316, 8720.389572729911, 8725.301975841918, 8732.650693972266, 8099.878501822477, 10485.790284194312, 10679.0, 10689.679309620724, 11011.0, 10462.163026957864, 10611.734706632318, 10617.256792024562, 10919.071878890303, 10919.781604367909, 10753.83869241958, 10871.402072885989, 10889.292196007234, 10889.346639201594, 10894.18293627981, 10613.73465663357, 10722.142228621691, 10729.248952573324, 10733.892661073445, 10739.946300268448, 43652.56347436549, 44074.559254407366, 44110.77944610288, 44118.77940610277, 44164.55835441669, 3664.6885014773775, 3888.137750029835, 3921.627445392683, 4281.529031806499, 4362.323839804803, 33789.831050844834, 34040.0, 34075.82962085198, 34259.31481370384, 35793.28413431717, 4291.699581029329, 4293.506246781598, 4344.283193273106, 4376.846810361622, 4459.687821852472, 379994.0, 382948.0, 383312.08343958383, 383927.0, 384747.0, 65716.34283657103, 66314.66842665756, 66330.0, 66358.66820665865, 66366.0, 62124.37875621276, 62317.0, 62418.375816241256, 62460.687696562134, 62462.375376245654, 16895.493135205965, 17228.741568876478, 17236.310547577956, 17344.566385840204, 17392.652146957244, 12617.495300188073, 12640.620781376574, 12644.051696122828, 12645.557405490763, 12672.366381680878, 19112.802027766986, 20241.59516809685, 20466.0, 20522.58954820895, 20588.38234852957, 7235.674394652148, 7352.301531354513, 7548.150183607748, 7566.31903128721, 7590.658420371096, 923.4044041593135, 1030.8196065688473, 1090.9945450272699, 1096.5887792077972, 1140.4582823159099, 32685.0, 32803.0, 33018.3396332072, 33267.833660832024, 33377.66622333746, 1092.1426680056277, 1108.3239224073309, 1146.6617347882395, 1154.0421450196318, 1156.502703837358, 16630.417935372447, 17319.913400432917, 17455.73816392755, 17504.04703498817, 17566.0, 556605.0, 559443.0, 560720.0, 560822.0, 563114.1844290834, 59953.700231498566, 60701.0, 60766.69616651889, 60804.391956080755, 60835.39164608297, 1304.5760127958451, 1396.3297617143828, 1414.2080434956251, 1414.6039109049482, 1419.8438171801095, 31069.0, 32680.34639307248, 32769.0, 33006.66993330132, 33236.50145247775, 52561.7371913138, 52850.207246892096, 53181.0, 53241.0, 53331.20003199878, 470871.0, 471954.0, 473489.0, 473540.0, 474228.0, 28121.0, 28931.276718081375, 29025.709742903146, 44257.33613995728, 44825.55174448344, 47903.0, 48498.0, 48999.0, 49154.50845491499, 49667.75166124146, 40974.385384218665, 42269.0, 42328.0, 42728.35907461328, 43276.35085473657, 40690.79654601827, 40903.59096408998, 41111.58888411077, 41662.37506437467, 42329.1534169321, 31509.381819568072, 36476.81761591175, 41563.58436415597, 41730.58269417267, 41835.372469412374, 33068.669313307524, 38072.80963595164, 38115.0, 38617.61382386253, 38664.80667596644, 27332.453350932472, 28183.859080704464, 29275.55937693704, 29279.56080658749, 29580.0], "value": 21187.60646651123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.3540974114783, 383.79275191396647, 385.69722767627417, 394.4083874188717, 409.45951344225614, 14166.787498187523, 18711.3451029214, 18971.43085707431, 19302.613947721056, 19333.613327733437, 18478.630427391443, 18551.536211594717, 18851.0, 18864.434066978014, 19564.31524896629, 5409.918851217225, 5523.806666766664, 5525.530329921961, 5577.749001294931, 5584.91622625661, 5569.081101618228, 5707.942920570804, 5759.913601295984, 5762.193292938971, 5766.394528574502, 5567.550277877721, 5593.888122237553, 5690.06113991191, 5699.886002279952, 5705.771769129251, 5685.971570142123, 5714.0, 5716.0, 5717.485426311631, 5723.8569035774235, 4920.434150072751, 5073.822416215415, 5112.079825631385, 5131.743412829381, 5135.4094279157625, 22150.113995440322, 22363.888180559155, 22691.0, 22824.201152959566, 22933.0, 2113.93658190253, 2375.714914210306, 2561.6413702081536, 2582.3802287451063, 3131.4363414585364, 9214.631414743402, 9660.335920537087, 9900.603975840957, 10163.847542286872, 13738.862611373957, 1881.3415304643402, 1933.2943475631434, 1976.713376560405, 1982.6332128556264, 2080.053575623103, 76685.61657191678, 77594.22405775983, 78944.0, 79168.60415697942, 81509.18490815016, 10826.67519974402, 10840.186985976083, 10852.348859068481, 11027.338359698444, 11221.943890280496, 15431.074135551902, 15456.613584660248, 15507.302171402314, 15518.068915865084, 15532.92233538825, 8101.149379315205, 8275.875861862078, 8311.376646751396, 8420.8315833683, 8535.231829135408, 8001.719939802196, 8072.152423995513, 8119.0, 8277.379196560281, 8308.376871734645, 4703.576678098988, 4749.24012158053, 4750.548697873696, 4780.4741478437345, 4823.204171311694, 1924.490010147312, 1931.748872646547, 1951.8536109791823, 1954.9413517594494, 1971.4775584470126, 856.4261944497201, 967.3905439573165, 1019.1846522781744, 1059.4914441068331, 1090.8854570270166, 18328.0, 18550.257989680533, 19155.084491550733, 19382.8061719381, 19487.317943871898, 970.3013830042358, 988.7528117970508, 1010.3735683876043, 1017.4251547875575, 1029.330934892326, 10244.129249013768, 10906.182036347147, 10937.476574330072, 10953.0, 10979.0, 507418.0, 507794.0, 522603.0, 524832.0, 535374.0, 81908.18091819125, 91531.0, 94896.52551737335, 95910.0, 96854.5157274209, 1028.5114570579065, 1042.8279333909973, 1071.7267096890398, 1077.7305673581604, 1077.951492182838, 16820.663586728442, 17618.914993932463, 18004.099795009934, 18117.637647247244, 18243.905365678103, 40425.79787101046, 40785.59214407818, 41059.68873268383, 42430.36354454624, 42658.5734142667, 56814.715926420104, 57483.825016310824, 58397.70801145967, 58680.0, 59900.70049649724, 8313.293370063613, 8404.20160084791, 8495.702650407206, 8554.230119289294, 8646.913530864611, 9229.676961306322, 11648.0, 12979.805302920275, 13148.868511314764, 13149.0, 11395.601153959571, 11500.0, 11548.480318385526, 11767.293962361944, 11803.350815704875, 11260.718482038015, 11389.145814063813, 11482.138839586898, 11843.763124737628, 11872.228305160137, 11655.242409243372, 11672.0, 11749.118816088998, 12067.396630168281, 12134.33261170644, 8440.66237350499, 8610.0, 8706.695265665672, 8744.935245718212, 8900.688475903313, 8651.394402391772, 11216.719582010515, 11279.266847654877, 11349.602763903224, 11412.201145920038], "value": 9187.919773053207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.6431563477856, 1471.5144002479183, 1489.709506646204, 1649.637079842435, 1806.3316572868032, 8059.274665280123, 8328.750137495877, 8349.958250208749, 8485.78785530362, 8502.319814414848, 8227.95886020569, 8407.234480759047, 8410.411271211002, 8414.957925210365, 8416.95791521043, 2087.8642888212294, 2159.470929622245, 2302.7236731592234, 2328.813694904412, 2329.4875127472014, 2420.322309753272, 2432.62294344376, 2432.7080750309988, 2433.318670772178, 2435.3789783605243, 2333.428310064028, 2342.7422983471806, 2363.7636236376397, 2363.9409014774683, 2366.230974933145, 2036.1041141897517, 2298.586254474194, 2317.7450480447137, 2378.108209421467, 2381.988090059556, 2370.2415227127326, 2392.437777122375, 2392.7726865947707, 2394.174009966559, 2395.1856368834506, 8641.52471614061, 8701.347398945105, 8705.7823554411, 8708.259797917184, 8714.477131372138, 5142.61430392722, 5188.6367954243215, 5330.1205301125265, 5338.199270109476, 5385.919211211835, 3268.215628249227, 3412.334594754024, 3437.535932649085, 3471.9132021699406, 3480.5823301203764, 1139.5897476908306, 1164.126904821384, 1167.6788883057143, 1184.6505280942142, 1191.559123124441, 12291.201071930385, 12298.077644176634, 12312.13815032948, 12317.322547259897, 12361.938190309082, 4579.656525760582, 4709.646776491777, 4735.83424580138, 4818.975905120452, 4820.9517904820505, 10392.42841643717, 10397.896021039693, 10405.9479702601, 10406.323588966692, 10410.427426491615, 5313.123334649817, 5314.8937021260135, 5318.228856815817, 5321.122014867581, 5325.360956685223, 4198.0, 4750.61995040396, 4875.658703890694, 4895.290182923456, 4942.654014219042, 3881.825317860703, 3954.9011274717786, 4007.779572123503, 4047.0, 4059.6752259819145, 1264.4689230523202, 1272.6691060324383, 1277.916935399196, 1289.1878116786365, 1293.043148070421, 869.6260607938647, 990.2078337330107, 1002.869626948492, 1003.3628645809963, 1006.869528556906, 5965.135055417027, 6026.0659597762415, 6039.275286965592, 6072.483838873657, 6114.510839132859, 446.7743789386404, 448.22233425007585, 476.53537800644096, 477.8853075261912, 484.09474283090844, 3986.362182050858, 4062.1875624875142, 4080.7755573443746, 4087.2438598859308, 4114.917701645951, 10690.198235132397, 10695.304805187794, 11114.277571957797, 11167.274127181707, 11179.608713695145, 10911.290766100177, 10962.068224200873, 11041.282316649393, 11057.336559806437, 11064.668059958214, 7905.802354941173, 7935.682572697143, 8219.95890020546, 8243.670253189925, 8382.455140415976, 6034.698265086816, 6108.114323423168, 6123.2958209804665, 6206.782762603287, 6244.843878903063, 9814.116729494379, 10049.0, 10241.129503992244, 10261.74345641365, 10262.58949642006, 10221.693349199535, 10281.177505799667, 10331.173506119643, 10361.274710770174, 10401.375917444977, 6954.79135625932, 7578.242175782598, 7756.185600511865, 7845.686172553034, 7964.601769911365, 8613.353998450017, 8673.00260470054, 8714.302855771397, 8728.389012769045, 8739.781505462413, 7487.138979017265, 7836.725714599962, 7840.411969102226, 7847.136814950465, 7964.163762805054, 7544.0, 7624.618769061413, 7662.080550333995, 7774.0, 7907.090684571348, 6924.169099707866, 6969.7909062728195, 6977.651117444006, 6983.022376867141, 7007.789766307019, 5015.122353588181, 5034.647574669738, 5100.5409513143995, 5143.71709555963, 5203.11547036997, 5148.948510514847, 5171.482851714798, 5205.479452054764, 5236.947630523799, 5289.312389389354], "value": 4568.158101577026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.51691255398305, 330.9354675838211, 340.6100015482273, 343.6065704768039, 343.792005836469, 5192.273081768555, 5315.627906046579, 5374.683202615364, 5416.1604951232575, 5428.18155917768, 5265.97313523863, 5281.128613778731, 5318.973405132979, 5325.281087053247, 5328.760205790739, 4146.087860670647, 4159.480064991883, 4165.812538435763, 4167.854125105622, 4197.7271477354025, 3849.961500384988, 3917.412388141773, 4073.775942323171, 4107.383892416132, 4127.422160897477, 4059.776712280823, 4077.2660921034203, 4100.569440208765, 4102.979485102585, 4111.979440102796, 4101.938470922939, 4106.733062350952, 4112.300908845488, 4129.607687269705, 4146.709730318879, 3491.8428670709877, 3532.4877892705413, 3552.2717842842158, 3587.282543491286, 3593.7484376093685, 5047.848564543069, 5071.873203169914, 5075.314832497603, 5083.779892825695, 5102.38771347437, 4659.4408670959365, 4675.836345727883, 4682.953170468286, 4689.226277664181, 4694.685488063314, 5369.409364969889, 5487.067198576212, 5502.614816962814, 5507.256520369779, 5516.531094856942, 3937.1731936293413, 3944.4280579315837, 3944.4419454315384, 3952.604739526053, 3967.5716741972865, 5455.863603409907, 5560.527355174815, 5699.544036477072, 5752.769889204426, 5760.711964401805, 4004.1791432756213, 4041.2523683118716, 4041.535223449341, 4052.77709725962, 4054.5134583849535, 4084.7753373564146, 4100.630943215125, 4105.384192371109, 4119.608637179464, 4120.505539335299, 4567.748773817472, 4710.788014539354, 4721.079389519079, 4721.173794585934, 4724.669273150916, 5445.945540544623, 5447.455254474521, 5536.169574563767, 5547.528460080857, 5603.411641777636, 1393.6724869655623, 1409.9154050756988, 1409.9224542650252, 1419.4882450190514, 1422.6585619451257, 856.9657213711382, 900.4192295969194, 907.4283201583092, 919.2645883293338, 921.9631214751334, 4770.904581908342, 4801.207800712913, 4877.829275975324, 4892.431473476382, 4917.262410638361, 5081.8729531762, 5088.516590923857, 5093.643444958891, 5103.234514822806, 5120.820771272987, 4518.403245613562, 4807.6394270429855, 4822.373091498082, 4828.692345743178, 4833.709977401367, 2690.5157071726885, 2693.9326516837236, 2712.6744790625253, 2714.687810901732, 2735.2341344423594, 5241.868953276198, 5255.0, 5264.605154613343, 5293.550048245942, 5295.76169072385, 4872.926906096412, 5189.1837856749835, 5199.66202196856, 5227.869303267373, 5231.979763945994, 5357.491038351351, 5362.766563690373, 5364.785408583613, 5369.597280204079, 5371.758270877898, 5148.099082660445, 5156.653722556153, 5183.574517007853, 5190.6107041971245, 5195.3246078009615, 4747.952520474751, 4873.707577545359, 4897.461279259207, 5025.773840177128, 5157.355330583677, 5263.736703191283, 5698.31620205578, 5778.479936805707, 5903.321118071477, 5947.167396564571, 3990.3415936371334, 4011.4383986242533, 4032.7580345179385, 4045.797710114424, 4057.776822274803, 5719.8570035749435, 5722.570807189561, 5725.770969161187, 5727.541796656341, 5728.541716662574, 5325.786968521371, 5610.691411972381, 5654.180143879033, 5662.178984047372, 5698.202251684685, 5537.5569954402745, 5560.944390556205, 5609.943900560942, 5615.241942337732, 5619.80330688424, 5257.421683614876, 5506.614536982373, 5526.613137080527, 5534.418886016911, 5557.527610153183, 5615.971920140537, 5641.576881733969, 5657.745401456862, 5664.207011018543, 5670.206171135962, 5507.476789704971, 5515.428102990629, 5523.204958388459, 5532.1425179097305, 5536.418676039119], "value": 4111.442681866924, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.272436185175, 766.9386449084072, 778.9571573563452, 798.3174385900058, 835.0605568735173, 14297.642558936019, 14993.700125997488, 15091.547253582383, 15476.458323958677, 15821.208939553006, 14559.490417835377, 14622.780658290134, 14769.852301477009, 14782.113073215614, 14796.852031479682, 677.9457643388541, 802.0415603353995, 809.7368355284541, 822.4325215601245, 826.4215049465369, 800.2117913854848, 803.895493585833, 803.9598020099, 805.3597390074875, 807.3258828877894, 857.5197889182047, 857.8155696525246, 859.2696208222992, 859.5831021954347, 860.1613426908776, 707.6744697439184, 829.9626516806758, 850.4259624753266, 853.4367317570374, 855.5038077914857, 616.1958643969618, 616.3220457496762, 616.5591602004588, 617.4566381584222, 617.5707883021302, 14793.334299956528, 14800.481983130647, 14843.257837108102, 14854.480093196686, 14887.10677359362, 14206.147631142165, 14438.133711977314, 14514.491992780202, 14547.709045819025, 14727.779083313759, 12701.618951431472, 12872.29202393868, 12903.483860645563, 12962.935185324013, 13000.139969206759, 4447.812498452178, 4492.505824359318, 4500.729956202638, 4508.842190523316, 4637.165310244155, 66669.0, 67805.66097169532, 68654.0, 72732.27267727308, 73156.26843731548, 10975.231733778559, 11035.172362072877, 11121.27711698737, 11124.888751112547, 11207.831882521768, 19850.801491984894, 20082.19671213135, 20083.297084601967, 20103.29638462647, 20120.29578964729, 8182.386321025947, 8248.0, 8290.875636865452, 8401.495910245283, 8509.10654381281, 4678.368420263289, 4927.162382395001, 5017.548420642087, 5025.095482813055, 5036.244563315458, 3650.872219472306, 3734.141147536028, 3793.203427280247, 3797.278517081801, 3800.638939300762, 636.4749082007362, 653.1900443450182, 663.8771827211981, 665.1187176990506, 670.0, 720.8342081321325, 720.9170945341353, 725.6879541797078, 734.713461749918, 748.3227678950558, 9822.852657210147, 10074.395536267848, 10183.490825458846, 10194.235432342455, 10456.0, 729.4638440746047, 761.5963539324167, 768.8616049111101, 774.817917789319, 806.9919300807035, 4626.745528995937, 4724.976375118171, 4774.283857421415, 4864.78108485119, 4871.926921096187, 66835.33164668389, 74062.0, 87479.12520874837, 107727.46136269269, 114505.42747286211, 93082.53458732663, 94451.52774236085, 95343.52328238453, 97011.51494242484, 97807.0, 80795.0, 82692.0, 83725.58137209396, 86022.0, 86940.74306708427, 9348.392354496937, 9443.952780236055, 9468.95265523668, 9559.426434413957, 9588.185004274716, 52091.73954130205, 52153.47846521486, 52739.73630131825, 54082.0, 54368.0, 65504.672476637315, 66692.0, 72325.6383718078, 73262.63368683122, 74669.62665186639, 11869.940650296694, 11928.880711193124, 11984.40077996114, 12333.383330833602, 12563.309018004098, 13555.796663049865, 13596.521704602796, 13685.45258189701, 13883.583492495241, 14163.575092747235, 12384.0, 12420.503179872703, 12585.433655485342, 13377.531786387819, 13658.863411365759, 12264.32546209967, 12610.243385396905, 12838.229706217657, 13494.730105398034, 13674.111182773486, 12500.812487812509, 12757.170783899017, 12893.833319255496, 13192.868071319164, 13675.521356752864, 10334.0, 10450.529726162493, 10485.318454300752, 10841.783164336826, 10898.400587967737, 10088.293819432569, 10597.62908298206, 10633.946830265799, 10753.1935104869, 10792.622258220925], "value": 7464.477473561892, "unit": "score"}], "name": "dromaeo_css", "value": 7234.619038744623, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 109.0, 111.0, 110.0, 112.0, 110.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 139.0, 174.0, 125.0, 161.0, 151.0, 125.0, 185.0, 133.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0, 162.0, 163.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 121.0, 75.0, 76.0, 75.0, 74.0, 111.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 107.0, 85.0, 85.0, 85.0, 111.0, 85.0, 85.0, 130.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 57.0, 58.0, 58.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 62.0, 65.0, 62.0, 63.0, 62.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 80.0, 80.0, 80.0, 80.0, 81.0, 110.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 121.0, 130.0, 118.0, 120.0, 127.0, 121.0, 127.0, 123.0, 121.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 159.0, 159.0, 158.0, 159.0, 159.0, 156.0, 159.0, 158.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 65.0, 62.0, 63.0, 62.0, 62.0, 64.0, 63.0, 61.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1502.3999999999999, "alertThreshold": 2.0}]} 05:18:04 INFO - Return code: 0 05:18:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:18:05 ERROR - # TBPL SUCCESS # 05:18:05 INFO - Running post-action listener: _resource_record_post_action 05:18:05 INFO - ##### 05:18:05 INFO - ##### Finished run-tests step (success) 05:18:05 INFO - ##### 05:18:05 INFO - Running post-run listener: _resource_record_post_run 05:18:05 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 135168; Write bytes: 540172288; Read time: 32; Write time: 484232 05:18:05 INFO - TinderboxPrint: CPU usage
13.2% 05:18:05 INFO - TinderboxPrint: I/O read bytes / time
135,168 / 32 05:18:05 INFO - TinderboxPrint: I/O write bytes / time
540,172,288 / 484,232 05:18:05 INFO - TinderboxPrint: CPU idle
8,262.3 (86.8%) 05:18:05 INFO - TinderboxPrint: CPU user
1,213.6 (12.7%) 05:18:05 INFO - TinderboxPrint: Swap in / out
0 / 0 05:18:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247787520; Read time: 0; Write time: 269976 05:18:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 135168; Write bytes: 291500032; Read time: 32; Write time: 214232 05:18:05 INFO - Running post-run listener: _upload_blobber_files 05:18:05 INFO - Blob upload gear active. 05:18:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18:05 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 05:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:18:06 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:06 INFO - (blobuploader) - INFO - Done attempting. 05:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:18:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:07 INFO - (blobuploader) - INFO - Done attempting. 05:18:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:18:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:18:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:11 INFO - (blobuploader) - INFO - Done attempting. 05:18:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:11 INFO - Return code: 0 05:18:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7046fa57fc48435a09e561c099b99886898f60c7f034092c1a1aa582b9d5b7fe64958274f8e912efb70d0f7a47b3e803087b5530d93ad6a65c966c8efe2a0dc0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd6e7ced5a86ff4067504e1c8c8d1e4f65aea308e2103783c1ca74db9e122e10cfbe6a3b1a13297826e35cd3be7727a6c873fe3afab76228153e0f1b57d3820c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/db1aca98e5335e118e028c73d5399317da1284c4f548f10f4472d5feb2600afbead7e57cdae9e6751ac5450e9589495bc7fcefc28ea1775ef0cff49c56ca20ea"} 05:18:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:11 INFO - Contents: 05:18:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7046fa57fc48435a09e561c099b99886898f60c7f034092c1a1aa582b9d5b7fe64958274f8e912efb70d0f7a47b3e803087b5530d93ad6a65c966c8efe2a0dc0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd6e7ced5a86ff4067504e1c8c8d1e4f65aea308e2103783c1ca74db9e122e10cfbe6a3b1a13297826e35cd3be7727a6c873fe3afab76228153e0f1b57d3820c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/db1aca98e5335e118e028c73d5399317da1284c4f548f10f4472d5feb2600afbead7e57cdae9e6751ac5450e9589495bc7fcefc28ea1775ef0cff49c56ca20ea"} 05:18:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:11 INFO - Copying logs to upload dir... 05:18:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.770733 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-04 05:18:11.711811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 05:18:11.715000) ========= 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-1465040121.905744-399504062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7046fa57fc48435a09e561c099b99886898f60c7f034092c1a1aa582b9d5b7fe64958274f8e912efb70d0f7a47b3e803087b5530d93ad6a65c966c8efe2a0dc0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd6e7ced5a86ff4067504e1c8c8d1e4f65aea308e2103783c1ca74db9e122e10cfbe6a3b1a13297826e35cd3be7727a6c873fe3afab76228153e0f1b57d3820c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/db1aca98e5335e118e028c73d5399317da1284c4f548f10f4472d5feb2600afbead7e57cdae9e6751ac5450e9589495bc7fcefc28ea1775ef0cff49c56ca20ea"} build_url:https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7046fa57fc48435a09e561c099b99886898f60c7f034092c1a1aa582b9d5b7fe64958274f8e912efb70d0f7a47b3e803087b5530d93ad6a65c966c8efe2a0dc0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd6e7ced5a86ff4067504e1c8c8d1e4f65aea308e2103783c1ca74db9e122e10cfbe6a3b1a13297826e35cd3be7727a6c873fe3afab76228153e0f1b57d3820c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/db1aca98e5335e118e028c73d5399317da1284c4f548f10f4472d5feb2600afbead7e57cdae9e6751ac5450e9589495bc7fcefc28ea1775ef0cff49c56ca20ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 05:18:11.740272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:18:11.740619) ========= 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-1465040121.905744-399504062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004382 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:18:11.825443) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 05:18:11.825772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 05:18:11.826068) ========= ========= Total master_lag: 0.18 =========