builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1450147058.77 results: success (0) buildid: 20151214180411 builduid: bca6f7cedca446dc9008fdb9d992709a revision: 063c2822231032a310ad6508daf7a52486ec2e5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:38.769523) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:38.770096) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:38.770442) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006475 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:38.859433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:38.859793) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:38.954333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:38.954623) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.007200) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.007815) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.008454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.008877) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 18:37:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2015-12-14 18:37:41 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.198267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.198842) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017919 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.262361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.262735) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 063c2822231032a310ad6508daf7a52486ec2e5c --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 063c2822231032a310ad6508daf7a52486ec2e5c --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=0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 18:37:41,189 truncating revision to first 12 chars 2015-12-14 18:37:41,189 Setting DEBUG logging. 2015-12-14 18:37:41,189 attempt 1/10 2015-12-14 18:37:41,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/063c28222310?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 18:37:41,451 unpacking tar archive at: fx-team-063c28222310/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.858645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.859052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.871727) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.872090) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 18:37:39.872643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-14 18:37:39.873079) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:37:41 INFO - MultiFileLogger online at 20151214 18:37:41 in /builds/slave/test 18:37:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:37:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:37:41 INFO - {'append_to_log': False, 18:37:41 INFO - 'base_work_dir': '/builds/slave/test', 18:37:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:37:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:37:41 INFO - 'branch': 'Fx-Team-Non-PGO', 18:37:41 INFO - 'buildbot_json_path': 'buildprops.json', 18:37:41 INFO - 'config_files': ('talos/linux_config.py',), 18:37:41 INFO - 'default_actions': ('clobber', 18:37:41 INFO - 'read-buildbot-config', 18:37:41 INFO - 'download-and-extract', 18:37:41 INFO - 'populate-webroot', 18:37:41 INFO - 'create-virtualenv', 18:37:41 INFO - 'install', 18:37:41 INFO - 'run-tests'), 18:37:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:37:41 INFO - 'download_minidump_stackwalk': True, 18:37:41 INFO - 'download_symbols': 'ondemand', 18:37:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:37:41 INFO - 'tooltool.py': '/tools/tooltool.py', 18:37:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:37:41 INFO - '/tools/misc-python/virtualenv.py')}, 18:37:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:37:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:37:41 INFO - 'installer_path': 'installer.exe', 18:37:41 INFO - 'log_level': 'info', 18:37:41 INFO - 'log_name': 'talos', 18:37:41 INFO - 'log_to_console': True, 18:37:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:37:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:37:41 INFO - 'opt_config_files': (), 18:37:41 INFO - 'pip_index': False, 18:37:41 INFO - 'sps_profile': False, 18:37:41 INFO - 'sps_profile_interval': 0, 18:37:41 INFO - 'suite': 'dromaeojs', 18:37:41 INFO - 'system_bits': '64', 18:37:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:37:41 INFO - 'title': 'talos-linux64-ix-035', 18:37:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:37:41 INFO - 'use_talos_json': True, 18:37:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:37:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:37:41 INFO - 'work_dir': 'build'} 18:37:41 INFO - ##### 18:37:41 INFO - ##### Running clobber step. 18:37:41 INFO - ##### 18:37:41 INFO - Running pre-action listener: _resource_record_pre_action 18:37:41 INFO - Running main action method: clobber 18:37:41 INFO - rmtree: /builds/slave/test/build 18:37:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:37:42 INFO - Running post-action listener: _resource_record_post_action 18:37:42 INFO - ##### 18:37:42 INFO - ##### Running read-buildbot-config step. 18:37:42 INFO - ##### 18:37:42 INFO - Running pre-action listener: _resource_record_pre_action 18:37:42 INFO - Running main action method: read_buildbot_config 18:37:42 INFO - Using buildbot properties: 18:37:42 INFO - { 18:37:42 INFO - "properties": { 18:37:42 INFO - "buildnumber": 2210, 18:37:42 INFO - "product": "firefox", 18:37:42 INFO - "script_repo_revision": "production", 18:37:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:37:42 INFO - "repository": "", 18:37:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:37:42 INFO - "buildid": "20151214180411", 18:37:42 INFO - "slavename": "talos-linux64-ix-035", 18:37:42 INFO - "pgo_build": "False", 18:37:42 INFO - "basedir": "/builds/slave/test", 18:37:42 INFO - "project": "", 18:37:42 INFO - "platform": "ubuntu64_hw", 18:37:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:37:42 INFO - "slavebuilddir": "test", 18:37:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:37:42 INFO - "branch": "fx-team", 18:37:42 INFO - "repo_path": "integration/fx-team", 18:37:42 INFO - "stage_platform": "linux64", 18:37:42 INFO - "builduid": "bca6f7cedca446dc9008fdb9d992709a", 18:37:42 INFO - "revision": "063c2822231032a310ad6508daf7a52486ec2e5c" 18:37:42 INFO - }, 18:37:42 INFO - "sourcestamp": { 18:37:42 INFO - "repository": "", 18:37:42 INFO - "hasPatch": false, 18:37:42 INFO - "project": "", 18:37:42 INFO - "branch": "fx-team-linux64-talos", 18:37:42 INFO - "changes": [ 18:37:42 INFO - { 18:37:42 INFO - "category": null, 18:37:42 INFO - "files": [ 18:37:42 INFO - { 18:37:42 INFO - "url": null, 18:37:42 INFO - "name": "https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:37:42 INFO - } 18:37:42 INFO - ], 18:37:42 INFO - "repository": "", 18:37:42 INFO - "rev": "063c2822231032a310ad6508daf7a52486ec2e5c", 18:37:42 INFO - "who": "bgrinstead@mozilla.com", 18:37:42 INFO - "when": 1450147035, 18:37:42 INFO - "number": 7360522, 18:37:42 INFO - "comments": "Bug 1224726 - Do not attempt to parse source file when searching in debugger if text > 1MB;r=jlongster", 18:37:42 INFO - "project": "", 18:37:42 INFO - "at": "Mon 14 Dec 2015 18:37:15", 18:37:42 INFO - "branch": "fx-team-linux64-talos", 18:37:42 INFO - "revlink": "", 18:37:42 INFO - "properties": [ 18:37:42 INFO - [ 18:37:42 INFO - "buildid", 18:37:42 INFO - "20151214180411", 18:37:42 INFO - "Change" 18:37:42 INFO - ], 18:37:42 INFO - [ 18:37:42 INFO - "builduid", 18:37:42 INFO - "bca6f7cedca446dc9008fdb9d992709a", 18:37:42 INFO - "Change" 18:37:42 INFO - ], 18:37:42 INFO - [ 18:37:42 INFO - "pgo_build", 18:37:42 INFO - "False", 18:37:42 INFO - "Change" 18:37:42 INFO - ] 18:37:42 INFO - ], 18:37:42 INFO - "revision": "063c2822231032a310ad6508daf7a52486ec2e5c" 18:37:42 INFO - } 18:37:42 INFO - ], 18:37:42 INFO - "revision": "063c2822231032a310ad6508daf7a52486ec2e5c" 18:37:42 INFO - } 18:37:42 INFO - } 18:37:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:37:42 INFO - Running post-action listener: _resource_record_post_action 18:37:42 INFO - ##### 18:37:42 INFO - ##### Running download-and-extract step. 18:37:42 INFO - ##### 18:37:42 INFO - Running pre-action listener: _resource_record_pre_action 18:37:42 INFO - Running main action method: download_and_extract 18:37:42 INFO - mkdir: /builds/slave/test/build/tests 18:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:42 INFO - https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/test_packages.json 18:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/test_packages.json 18:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:37:45 INFO - Downloaded 1302 bytes. 18:37:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:37:45 INFO - Using the following test package requirements: 18:37:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:37:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:45 INFO - u'jsshell-linux-x86_64.zip'], 18:37:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:37:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:37:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:37:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:37:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:37:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:45 INFO - https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:37:55 INFO - Downloaded 21869889 bytes. 18:37:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:37:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:37:56 INFO - Return code: 0 18:37:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:56 INFO - https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:37:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:38:02 INFO - Downloaded 21869889 bytes. 18:38:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:38:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:38:03 INFO - Return code: 0 18:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:03 INFO - https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:38:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:38:04 INFO - Downloaded 11132038 bytes. 18:38:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:38:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:38:04 INFO - Return code: 0 18:38: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')]} 18:38:04 INFO - https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:38:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:38:06 INFO - Downloaded 57741665 bytes. 18:38:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:06 INFO - mkdir: /builds/slave/test/properties 18:38:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:38:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:38:06 INFO - Contents: 18:38:06 INFO - build_url:https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:06 INFO - Running post-action listener: _resource_record_post_action 18:38:06 INFO - Running post-action listener: set_extra_try_arguments 18:38:06 INFO - ##### 18:38:06 INFO - ##### Running populate-webroot step. 18:38:06 INFO - ##### 18:38:06 INFO - Running pre-action listener: _resource_record_pre_action 18:38:06 INFO - Running main action method: populate_webroot 18:38:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:38:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:38:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:38:06 INFO - '--tppagecycles', 18:38:06 INFO - '7'], 18:38:06 INFO - 'tests': ['tsvgm']}}, 18:38:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:38:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:38:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:38:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:38:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:06 INFO - 'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:06 INFO - 'tests': ['damp', 'tps']}, 18:38:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:06 INFO - 'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['damp', 'tps']}, 18:38:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:38:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:38:06 INFO - 'other': {'tests': ['a11yr', 18:38:06 INFO - 'ts_paint', 18:38:06 INFO - 'tpaint', 18:38:06 INFO - 'sessionrestore', 18:38:06 INFO - 'sessionrestore_no_auto_restore']}, 18:38:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['a11yr', 18:38:06 INFO - 'ts_paint', 18:38:06 INFO - 'tpaint', 18:38:06 INFO - 'sessionrestore', 18:38:06 INFO - 'sessionrestore_no_auto_restore']}, 18:38:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['a11yr', 18:38:06 INFO - 'ts_paint', 18:38:06 INFO - 'tpaint', 18:38:06 INFO - 'sessionrestore', 18:38:06 INFO - 'sessionrestore_no_auto_restore']}, 18:38:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['a11yr', 18:38:06 INFO - 'ts_paint', 18:38:06 INFO - 'tpaint', 18:38:06 INFO - 'sessionrestore', 18:38:06 INFO - 'sessionrestore_no_auto_restore']}, 18:38:06 INFO - 'other_l64': {'tests': ['a11yr', 18:38:06 INFO - 'ts_paint', 18:38:06 INFO - 'tpaint', 18:38:06 INFO - 'sessionrestore', 18:38:06 INFO - 'sessionrestore_no_auto_restore']}, 18:38:06 INFO - 'other_nol64': {'tests': ['a11yr', 18:38:06 INFO - 'ts_paint', 18:38:06 INFO - 'tpaint', 18:38:06 INFO - 'sessionrestore', 18:38:06 INFO - 'sessionrestore_no_auto_restore']}, 18:38:06 INFO - 'svgr': {'tests': ['tsvgx', 18:38:06 INFO - 'tsvgr_opacity', 18:38:06 INFO - 'tart', 18:38:06 INFO - 'tscrollx', 18:38:06 INFO - 'cart']}, 18:38:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['tsvgx', 18:38:06 INFO - 'tsvgr_opacity', 18:38:06 INFO - 'tart', 18:38:06 INFO - 'tscrollx', 18:38:06 INFO - 'cart']}, 18:38:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:06 INFO - 'tests': ['tp5o']}, 18:38:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:06 INFO - 'talos_options': ['--e10s'], 18:38:06 INFO - 'tests': ['tp5o']}, 18:38:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:06 INFO - 'talos_options': ['--xperf_path', 18:38:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:06 INFO - 'tests': ['tp5n']}, 18:38:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:06 INFO - 'talos_options': ['--e10s', 18:38:06 INFO - '--xperf_path', 18:38:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:06 INFO - 'tests': ['tp5n']}}, 18:38:06 INFO - 'talos.zip': {'path': '', 18:38:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:38:06 INFO - Running post-action listener: _resource_record_post_action 18:38:06 INFO - ##### 18:38:06 INFO - ##### Running create-virtualenv step. 18:38:06 INFO - ##### 18:38:06 INFO - Running pre-action listener: _resource_record_pre_action 18:38:06 INFO - Running main action method: create_virtualenv 18:38:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:38:06 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 18:38:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:38:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:38:06 INFO - Using real prefix '/usr' 18:38:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:38:07 INFO - Installing distribute.............................................................................................................................................................................................done. 18:38:09 INFO - Installing pip.................done. 18:38:09 INFO - Return code: 0 18:38:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:38:09 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')]} 18:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:09 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')]} 18:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:09 INFO - Using env: {'DISPLAY': ':0', 18:38:09 INFO - 'HOME': '/home/cltbld', 18:38:09 INFO - 'LANG': 'en_US.UTF-8', 18:38:09 INFO - 'LANGUAGE': 'en_US:en', 18:38:09 INFO - 'LOGNAME': 'cltbld', 18:38:09 INFO - 'MAIL': '/var/mail/cltbld', 18:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:09 INFO - 'MOZ_NO_REMOTE': '1', 18:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:09 INFO - 'NO_EM_RESTART': '1', 18:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:09 INFO - 'PWD': '/builds/slave/test', 18:38:09 INFO - 'SHELL': '/bin/bash', 18:38:09 INFO - 'SHLVL': '1', 18:38:09 INFO - 'TERM': 'linux', 18:38:09 INFO - 'TMOUT': '86400', 18:38:09 INFO - 'USER': 'cltbld', 18:38:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:09 INFO - '_': '/tools/buildbot/bin/python'} 18:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:09 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 18:38:09 INFO - Cleaning up... 18:38:09 INFO - Return code: 0 18:38:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:38:09 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')]} 18:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:09 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')]} 18:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:38:09 INFO - Using env: {'DISPLAY': ':0', 18:38:09 INFO - 'HOME': '/home/cltbld', 18:38:09 INFO - 'LANG': 'en_US.UTF-8', 18:38:09 INFO - 'LANGUAGE': 'en_US:en', 18:38:09 INFO - 'LOGNAME': 'cltbld', 18:38:09 INFO - 'MAIL': '/var/mail/cltbld', 18:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:09 INFO - 'MOZ_NO_REMOTE': '1', 18:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:09 INFO - 'NO_EM_RESTART': '1', 18:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:09 INFO - 'PWD': '/builds/slave/test', 18:38:09 INFO - 'SHELL': '/bin/bash', 18:38:09 INFO - 'SHLVL': '1', 18:38:09 INFO - 'TERM': 'linux', 18:38:09 INFO - 'TMOUT': '86400', 18:38:09 INFO - 'USER': 'cltbld', 18:38:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:09 INFO - '_': '/tools/buildbot/bin/python'} 18:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:09 INFO - Downloading/unpacking psutil>=0.7.1 18:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:11 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:38:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:11 INFO - Installing collected packages: psutil 18:38:11 INFO - Running setup.py install for psutil 18:38:11 INFO - building 'psutil._psutil_linux' extension 18:38:11 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 18:38:11 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 18:38:11 INFO - building 'psutil._psutil_posix' extension 18:38:11 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 18:38:11 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 18:38:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:11 INFO - Successfully installed psutil 18:38:11 INFO - Cleaning up... 18:38:11 INFO - Return code: 0 18:38:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:38:11 INFO - Using env: {'DISPLAY': ':0', 18:38:11 INFO - 'HOME': '/home/cltbld', 18:38:11 INFO - 'LANG': 'en_US.UTF-8', 18:38:11 INFO - 'LANGUAGE': 'en_US:en', 18:38:11 INFO - 'LOGNAME': 'cltbld', 18:38:11 INFO - 'MAIL': '/var/mail/cltbld', 18:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:11 INFO - 'MOZ_NO_REMOTE': '1', 18:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:11 INFO - 'NO_EM_RESTART': '1', 18:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:11 INFO - 'PWD': '/builds/slave/test', 18:38:11 INFO - 'SHELL': '/bin/bash', 18:38:11 INFO - 'SHLVL': '1', 18:38:11 INFO - 'TERM': 'linux', 18:38:11 INFO - 'TMOUT': '86400', 18:38:11 INFO - 'USER': 'cltbld', 18:38:11 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:11 INFO - '_': '/tools/buildbot/bin/python'} 18:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:38:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:38:13 INFO - Installing collected packages: mozsystemmonitor 18:38:13 INFO - Running setup.py install for mozsystemmonitor 18:38:13 INFO - Successfully installed mozsystemmonitor 18:38:13 INFO - Cleaning up... 18:38:13 INFO - Return code: 0 18:38:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:38:13 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')]} 18:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:13 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')]} 18:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:13 INFO - Using env: {'DISPLAY': ':0', 18:38:13 INFO - 'HOME': '/home/cltbld', 18:38:13 INFO - 'LANG': 'en_US.UTF-8', 18:38:13 INFO - 'LANGUAGE': 'en_US:en', 18:38:13 INFO - 'LOGNAME': 'cltbld', 18:38:13 INFO - 'MAIL': '/var/mail/cltbld', 18:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:13 INFO - 'MOZ_NO_REMOTE': '1', 18:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:13 INFO - 'NO_EM_RESTART': '1', 18:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:13 INFO - 'PWD': '/builds/slave/test', 18:38:13 INFO - 'SHELL': '/bin/bash', 18:38:13 INFO - 'SHLVL': '1', 18:38:13 INFO - 'TERM': 'linux', 18:38:13 INFO - 'TMOUT': '86400', 18:38:13 INFO - 'USER': 'cltbld', 18:38:13 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:13 INFO - '_': '/tools/buildbot/bin/python'} 18:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:14 INFO - Downloading/unpacking blobuploader==1.2.4 18:38:14 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 18:38:14 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 18:38:14 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 18:38:14 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 18:38:14 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 18:38:14 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 18:38:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:38:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38:16 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 18:38:16 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 18:38:16 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 18:38:16 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 18:38:16 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 18:38:16 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 18:38:16 INFO - Downloading docopt-0.6.1.tar.gz 18:38:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:16 INFO - Running setup.py install for blobuploader 18:38:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:38:16 INFO - Running setup.py install for requests 18:38:17 INFO - Running setup.py install for docopt 18:38:17 INFO - Successfully installed blobuploader requests docopt 18:38:17 INFO - Cleaning up... 18:38:17 INFO - Return code: 0 18:38:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 18:38:17 INFO - Using env: {'DISPLAY': ':0', 18:38:17 INFO - 'HOME': '/home/cltbld', 18:38:17 INFO - 'LANG': 'en_US.UTF-8', 18:38:17 INFO - 'LANGUAGE': 'en_US:en', 18:38:17 INFO - 'LOGNAME': 'cltbld', 18:38:17 INFO - 'MAIL': '/var/mail/cltbld', 18:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:17 INFO - 'MOZ_NO_REMOTE': '1', 18:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:17 INFO - 'NO_EM_RESTART': '1', 18:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:17 INFO - 'PWD': '/builds/slave/test', 18:38:17 INFO - 'SHELL': '/bin/bash', 18:38:17 INFO - 'SHLVL': '1', 18:38:17 INFO - 'TERM': 'linux', 18:38:17 INFO - 'TMOUT': '86400', 18:38:17 INFO - 'USER': 'cltbld', 18:38:17 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:17 INFO - '_': '/tools/buildbot/bin/python'} 18:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:17 INFO - Running setup.py (path:/tmp/pip-MFPBMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:17 INFO - Running setup.py (path:/tmp/pip-wiWnAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:17 INFO - Running setup.py (path:/tmp/pip-GKD0R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:17 INFO - Running setup.py (path:/tmp/pip-RQVpAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:17 INFO - Running setup.py (path:/tmp/pip-jHHcaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:17 INFO - Running setup.py (path:/tmp/pip-l8VPnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:17 INFO - Running setup.py (path:/tmp/pip-6ysFgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:17 INFO - Running setup.py (path:/tmp/pip-5EbYBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:17 INFO - Running setup.py (path:/tmp/pip-ybO_uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:17 INFO - Running setup.py (path:/tmp/pip-FHNvkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:18 INFO - Running setup.py (path:/tmp/pip-saMty9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:18 INFO - Running setup.py (path:/tmp/pip-p7EUDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:18 INFO - Running setup.py (path:/tmp/pip-SBfpJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:18 INFO - Running setup.py (path:/tmp/pip-1PCCw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:18 INFO - Running setup.py (path:/tmp/pip-DsVTn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:18 INFO - Running setup.py (path:/tmp/pip-hMadP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:18 INFO - Running setup.py (path:/tmp/pip-0GdkSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:18 INFO - Running setup.py install for manifestparser 18:38:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:38:18 INFO - Running setup.py install for mozcrash 18:38:18 INFO - Running setup.py install for mozdebug 18:38:18 INFO - Running setup.py install for mozdevice 18:38:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:38:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:38:18 INFO - Running setup.py install for mozfile 18:38:19 INFO - Running setup.py install for mozhttpd 18:38:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Running setup.py install for mozinfo 18:38:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Running setup.py install for mozInstall 18:38:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Running setup.py install for mozleak 18:38:19 INFO - Running setup.py install for mozlog 18:38:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Running setup.py install for moznetwork 18:38:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Running setup.py install for mozprocess 18:38:19 INFO - Running setup.py install for mozprofile 18:38:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Running setup.py install for mozrunner 18:38:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:38:20 INFO - Running setup.py install for mozscreenshot 18:38:20 INFO - Running setup.py install for moztest 18:38:20 INFO - Running setup.py install for mozversion 18:38:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:38:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:20 INFO - Cleaning up... 18:38:20 INFO - Return code: 0 18:38:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:20 INFO - Using env: {'DISPLAY': ':0', 18:38:20 INFO - 'HOME': '/home/cltbld', 18:38:20 INFO - 'LANG': 'en_US.UTF-8', 18:38:20 INFO - 'LANGUAGE': 'en_US:en', 18:38:20 INFO - 'LOGNAME': 'cltbld', 18:38:20 INFO - 'MAIL': '/var/mail/cltbld', 18:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:20 INFO - 'MOZ_NO_REMOTE': '1', 18:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:20 INFO - 'NO_EM_RESTART': '1', 18:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:20 INFO - 'PWD': '/builds/slave/test', 18:38:20 INFO - 'SHELL': '/bin/bash', 18:38:20 INFO - 'SHLVL': '1', 18:38:20 INFO - 'TERM': 'linux', 18:38:20 INFO - 'TMOUT': '86400', 18:38:20 INFO - 'USER': 'cltbld', 18:38:20 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:20 INFO - '_': '/tools/buildbot/bin/python'} 18:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:20 INFO - Running setup.py (path:/tmp/pip-J4vVO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:20 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)) 18:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:20 INFO - Running setup.py (path:/tmp/pip-TpUGee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 18:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:20 INFO - Running setup.py (path:/tmp/pip-SDXcek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:20 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)) 18:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:20 INFO - Running setup.py (path:/tmp/pip-g9MTkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 18:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:20 INFO - Running setup.py (path:/tmp/pip-fU8JEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:20 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)) 18:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:20 INFO - Running setup.py (path:/tmp/pip-Ed80Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:21 INFO - Running setup.py (path:/tmp/pip-qYZgz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:21 INFO - Running setup.py (path:/tmp/pip-88fH6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:21 INFO - Running setup.py (path:/tmp/pip-R2pvVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:21 INFO - Running setup.py (path:/tmp/pip-Fh_YSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:21 INFO - Running setup.py (path:/tmp/pip-_aKZV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:21 INFO - Running setup.py (path:/tmp/pip-mNTCDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:21 INFO - Running setup.py (path:/tmp/pip-tCP5C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:21 INFO - Running setup.py (path:/tmp/pip-3t5Mbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:21 INFO - Running setup.py (path:/tmp/pip-JrOXyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:21 INFO - Running setup.py (path:/tmp/pip-nq8U8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:21 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)) 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:21 INFO - Running setup.py (path:/tmp/pip-LNn6V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:21 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)) 18:38:21 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38:21 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38:21 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)) 18:38:21 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:21 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:38:21 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 18:38:21 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 18:38:21 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 18:38:21 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 18:38:21 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 18:38:21 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 18:38:23 INFO - Downloading blessings-1.5.1.tar.gz 18:38:23 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:38:23 INFO - Installing collected packages: blessings 18:38:23 INFO - Running setup.py install for blessings 18:38:23 INFO - Successfully installed blessings 18:38:23 INFO - Cleaning up... 18:38:23 INFO - Return code: 0 18:38:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:38:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:23 INFO - Reading from file tmpfile_stdout 18:38:23 INFO - Current package versions: 18:38:23 INFO - argparse == 1.2.1 18:38:23 INFO - blessings == 1.5.1 18:38:23 INFO - blobuploader == 1.2.4 18:38:23 INFO - docopt == 0.6.1 18:38:23 INFO - manifestparser == 1.1 18:38:23 INFO - mozInstall == 1.12 18:38:23 INFO - mozcrash == 0.16 18:38:23 INFO - mozdebug == 0.1 18:38:23 INFO - mozdevice == 0.47 18:38:23 INFO - mozfile == 1.2 18:38:23 INFO - mozhttpd == 0.7 18:38:23 INFO - mozinfo == 0.9 18:38:23 INFO - mozleak == 0.1 18:38:23 INFO - mozlog == 3.1 18:38:23 INFO - moznetwork == 0.27 18:38:23 INFO - mozprocess == 0.22 18:38:23 INFO - mozprofile == 0.27 18:38:23 INFO - mozrunner == 6.11 18:38:23 INFO - mozscreenshot == 0.1 18:38:23 INFO - mozsystemmonitor == 0.0 18:38:23 INFO - moztest == 0.7 18:38:23 INFO - mozversion == 1.4 18:38:23 INFO - psutil == 3.1.1 18:38:23 INFO - requests == 1.2.3 18:38:23 INFO - wsgiref == 0.1.2 18:38:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:23 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')]} 18:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:23 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')]} 18:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:23 INFO - Using env: {'DISPLAY': ':0', 18:38:23 INFO - 'HOME': '/home/cltbld', 18:38:23 INFO - 'LANG': 'en_US.UTF-8', 18:38:23 INFO - 'LANGUAGE': 'en_US:en', 18:38:23 INFO - 'LOGNAME': 'cltbld', 18:38:23 INFO - 'MAIL': '/var/mail/cltbld', 18:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:23 INFO - 'MOZ_NO_REMOTE': '1', 18:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:23 INFO - 'NO_EM_RESTART': '1', 18:38:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:23 INFO - 'PWD': '/builds/slave/test', 18:38:23 INFO - 'SHELL': '/bin/bash', 18:38:23 INFO - 'SHLVL': '1', 18:38:23 INFO - 'TERM': 'linux', 18:38:23 INFO - 'TMOUT': '86400', 18:38:23 INFO - 'USER': 'cltbld', 18:38:23 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:23 INFO - '_': '/tools/buildbot/bin/python'} 18:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:24 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 1)) 18:38:24 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 2)) 18:38:24 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 3)) 18:38:24 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 4)) 18:38:24 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 5)) 18:38:24 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 6)) 18:38:24 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 7)) 18:38:24 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 8)) 18:38:24 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:38:24 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 3)) 18:38:24 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:38:24 INFO - Cleaning up... 18:38:24 INFO - Return code: 0 18:38:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:38:24 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')]} 18:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:24 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')]} 18:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:24 INFO - Using env: {'DISPLAY': ':0', 18:38:24 INFO - 'HOME': '/home/cltbld', 18:38:24 INFO - 'LANG': 'en_US.UTF-8', 18:38:24 INFO - 'LANGUAGE': 'en_US:en', 18:38:24 INFO - 'LOGNAME': 'cltbld', 18:38:24 INFO - 'MAIL': '/var/mail/cltbld', 18:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:24 INFO - 'MOZ_NO_REMOTE': '1', 18:38:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:24 INFO - 'NO_EM_RESTART': '1', 18:38:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:24 INFO - 'PWD': '/builds/slave/test', 18:38:24 INFO - 'SHELL': '/bin/bash', 18:38:24 INFO - 'SHLVL': '1', 18:38:24 INFO - 'TERM': 'linux', 18:38:24 INFO - 'TMOUT': '86400', 18:38:24 INFO - 'USER': 'cltbld', 18:38:24 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:24 INFO - '_': '/tools/buildbot/bin/python'} 18:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:24 INFO - Downloading/unpacking jsonschema 18:38:24 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 18:38:24 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 18:38:24 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 18:38:24 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 18:38:24 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 18:38:24 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 18:38:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:38:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:38:26 INFO - Downloading/unpacking functools32 (from jsonschema) 18:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:38:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:38:26 INFO - warning: no files found matching '*.txt' 18:38:26 INFO - no previously-included directories found matching 'build' 18:38:26 INFO - no previously-included directories found matching 'dist' 18:38:26 INFO - no previously-included directories found matching '.git*' 18:38:26 INFO - Installing collected packages: jsonschema, functools32 18:38:26 INFO - Running setup.py install for functools32 18:38:26 INFO - warning: no files found matching '*.txt' 18:38:26 INFO - no previously-included directories found matching 'build' 18:38:26 INFO - no previously-included directories found matching 'dist' 18:38:26 INFO - no previously-included directories found matching '.git*' 18:38:26 INFO - Successfully installed jsonschema functools32 18:38:26 INFO - Cleaning up... 18:38:26 INFO - Return code: 0 18:38:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcb3797ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1418240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', '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 18:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:26 INFO - Using env: {'DISPLAY': ':0', 18:38:26 INFO - 'HOME': '/home/cltbld', 18:38:26 INFO - 'LANG': 'en_US.UTF-8', 18:38:26 INFO - 'LANGUAGE': 'en_US:en', 18:38:26 INFO - 'LOGNAME': 'cltbld', 18:38:26 INFO - 'MAIL': '/var/mail/cltbld', 18:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:26 INFO - 'MOZ_NO_REMOTE': '1', 18:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:26 INFO - 'NO_EM_RESTART': '1', 18:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:26 INFO - 'PWD': '/builds/slave/test', 18:38:26 INFO - 'SHELL': '/bin/bash', 18:38:26 INFO - 'SHLVL': '1', 18:38:26 INFO - 'TERM': 'linux', 18:38:26 INFO - 'TMOUT': '86400', 18:38:26 INFO - 'USER': 'cltbld', 18:38:26 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:26 INFO - '_': '/tools/buildbot/bin/python'} 18:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:26 INFO - Downloading/unpacking flake8 18:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:38:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:38:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:38:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:38:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:38:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 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 18:38:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:38:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:38:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:38:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:38:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:38:29 INFO - no previously-included directories found matching 'docs/_build' 18:38:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:38:29 INFO - Running setup.py install for pep8 18:38:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:38:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:38:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:38:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:38:29 INFO - no previously-included directories found matching 'docs/_build' 18:38:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:38:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:38:29 INFO - Cleaning up... 18:38:29 INFO - Return code: 0 18:38:29 INFO - Running post-action listener: _resource_record_post_action 18:38:29 INFO - Running post-action listener: _start_resource_monitoring 18:38:29 INFO - Starting resource monitoring. 18:38:29 INFO - ##### 18:38:29 INFO - ##### Running install step. 18:38:29 INFO - ##### 18:38:29 INFO - Running pre-action listener: _resource_record_pre_action 18:38:29 INFO - Running main action method: install 18:38:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:29 INFO - Reading from file tmpfile_stdout 18:38:29 INFO - Detecting whether we're running mozinstall >=1.0... 18:38:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:38:29 INFO - Reading from file tmpfile_stdout 18:38:29 INFO - Output received: 18:38:29 INFO - Usage: mozinstall [options] installer 18:38:29 INFO - Options: 18:38:29 INFO - -h, --help show this help message and exit 18:38:29 INFO - -d DEST, --destination=DEST 18:38:29 INFO - Directory to install application into. [default: 18:38:29 INFO - "/builds/slave/test"] 18:38:29 INFO - --app=APP Application being installed. [default: firefox] 18:38:29 INFO - mkdir: /builds/slave/test/build/application 18:38:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:38:44 INFO - Reading from file tmpfile_stdout 18:38:44 INFO - Output received: 18:38:44 INFO - /builds/slave/test/build/application/firefox/firefox 18:38:44 INFO - Running post-action listener: _resource_record_post_action 18:38:44 INFO - ##### 18:38:44 INFO - ##### Running run-tests step. 18:38:44 INFO - ##### 18:38:44 INFO - Running pre-action listener: _resource_record_pre_action 18:38:44 INFO - Running main action method: run_tests 18:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:38:44 INFO - Python 2.7.3 18:38:44 INFO - Return code: 0 18:38:44 INFO - grabbing minidump binary from tooltool 18:38: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')]} 18:38:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a70b0>, '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 0x14a7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a8440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:38:44 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 18:38:44 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 18:38:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:38:44 INFO - Return code: 0 18:38:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:38:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:38:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:38:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:38:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:38:45 INFO - Return code: 0 18:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test/build 18:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 18:38:45 INFO - Using env: {'DISPLAY': ':0', 18:38:45 INFO - 'HOME': '/home/cltbld', 18:38:45 INFO - 'LANG': 'en_US.UTF-8', 18:38:45 INFO - 'LANGUAGE': 'en_US:en', 18:38:45 INFO - 'LOGNAME': 'cltbld', 18:38:45 INFO - 'MAIL': '/var/mail/cltbld', 18:38:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:38:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:45 INFO - 'MOZ_NO_REMOTE': '1', 18:38:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:45 INFO - 'NO_EM_RESTART': '1', 18:38:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:45 INFO - 'PWD': '/builds/slave/test', 18:38:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:38:45 INFO - 'SHELL': '/bin/bash', 18:38:45 INFO - 'SHLVL': '1', 18:38:45 INFO - 'TERM': 'linux', 18:38:45 INFO - 'TMOUT': '86400', 18:38:45 INFO - 'USER': 'cltbld', 18:38:45 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653', 18:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:45 INFO - '_': '/tools/buildbot/bin/python'} 18:38:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 18:38:45 INFO - mozversion INFO | application_buildid: 20151214180411 18:38:45 INFO - mozversion INFO | application_changeset: 063c2822231032a310ad6508daf7a52486ec2e5c 18:38:45 INFO - mozversion INFO | application_display_name: Nightly 18:38:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:38:45 INFO - mozversion INFO | application_name: Firefox 18:38:45 INFO - mozversion INFO | application_remotingname: firefox 18:38:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:38:45 INFO - mozversion INFO | application_vendor: Mozilla 18:38:45 INFO - mozversion INFO | application_version: 45.0a1 18:38:45 INFO - mozversion INFO | platform_buildid: 20151214180411 18:38:45 INFO - mozversion INFO | platform_changeset: 063c2822231032a310ad6508daf7a52486ec2e5c 18:38:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:38:45 INFO - mozversion INFO | platform_version: 45.0a1 18:38:45 INFO - 2015-12-14 18:38:45,343 DEBUG : using testdate: 1450147125 18:38:45 INFO - 2015-12-14 18:38:45,343 DEBUG : actual date: 1450147125 18:38:45 INFO - 2015-12-14 18:38:45,352 INFO : starting webserver on 'localhost:49374' 18:38:45 INFO - 2015-12-14 18:38:45,353 INFO : Starting test suite talos-linux64-ix-035 18:38:45 INFO - 2015-12-14 18:38:45,353 INFO : Starting test dromaeo_css 18:38:45 INFO - 2015-12-14 18:38:45,353 DEBUG : operating with platform_type : linux_ 18:38:45 INFO - 2015-12-14 18:38:45,354 INFO : Initialising browser for dromaeo_css test... 18:38:45 INFO - 2015-12-14 18:38:45,367 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE0Y240/profile http://localhost:49374/getInfo.html 18:38:49 INFO - 2015-12-14 18:38:49,826 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:38:49 INFO - 2015-12-14 18:38:49,826 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:38:49 INFO - 2015-12-14 18:38:49,826 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:38:49 INFO - 2015-12-14 18:38:49,826 DEBUG : BROWSER_OUTPUT: __metrics 18:38:49 INFO - 2015-12-14 18:38:49,934 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:38:50 INFO - 2015-12-14 18:38:50,015 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:50 INFO - 2015-12-14 18:38:50,314 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 18:38:51 INFO - 2015-12-14 18:38:51,038 INFO : Browser initialized. 18:38:51 INFO - 2015-12-14 18:38:51,038 INFO : Running cycle 1/1 for dromaeo_css test... 18:38:51 INFO - 2015-12-14 18:38:51,039 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE0Y240/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:39:03 INFO - 2015-12-14 18:39:03,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 139816960 18:39:03 INFO - 2015-12-14 18:39:03,076 DEBUG : BROWSER_OUTPUT: 18:39:54 INFO - 2015-12-14 18:39:54,246 DEBUG : BROWSER_OUTPUT: 1450147194244 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] 18:42:06 INFO - 2015-12-14 18:42:06,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49374/tests/dromaeo/cssquery-ext.html) 18:42:07 INFO - 2015-12-14 18:42:07,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 220692480 18:42:07 INFO - 2015-12-14 18:42:07,284 DEBUG : BROWSER_OUTPUT: 18:45:09 INFO - 2015-12-14 18:45:09,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-ext.html (next: http://localhost:49374/tests/dromaeo/cssquery-jquery.html) 18:45:10 INFO - 2015-12-14 18:45:10,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 225828864 18:45:10 INFO - 2015-12-14 18:45:10,467 DEBUG : BROWSER_OUTPUT: 18:48:12 INFO - 2015-12-14 18:48:12,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49374/tests/dromaeo/cssquery-mootools.html) 18:48:13 INFO - 2015-12-14 18:48:13,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 216035328 18:48:13 INFO - 2015-12-14 18:48:13,211 DEBUG : BROWSER_OUTPUT: 18:51:15 INFO - 2015-12-14 18:51:15,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49374/tests/dromaeo/cssquery-prototype.html) 18:51:15 INFO - 2015-12-14 18:51:15,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 207446016 18:51:15 INFO - 2015-12-14 18:51:15,778 DEBUG : BROWSER_OUTPUT: 18:54:18 INFO - 2015-12-14 18:54:18,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49374/tests/dromaeo/cssquery-yui.html) 18:54:19 INFO - 2015-12-14 18:54:19,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 210628608 18:54:19 INFO - 2015-12-14 18:54:19,075 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-yui.html (next: http://localhost:49374/tests/dromaeo/cssquery-dojo.html) 18:57:21 INFO - 2015-12-14 18:57:21,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 217460736 18:57:21 INFO - 2015-12-14 18:57:21,917 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,917 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:57:21 INFO - 2015-12-14 18:57:21,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:57:21 INFO - 2015-12-14 18:57:21,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:57:21 INFO - 2015-12-14 18:57:21,917 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:57:21 INFO - 2015-12-14 18:57:21,917 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2575.472028234212;2674.2378422149677;2681.74523420275;2695.5282825505533;2708.7020427752946;4558.703684260521;4638.768061596919;4697.084068606623;4706.058788242348;4723.433188017434;4631.467381251157;4657.184992626286;4700.929486057712;4726.810927562893;4744.38323018008;4270.487541495025;4275.615194632474;4304.741715497064;4309.052008558112;4327.697061205717;4175.832966681329;4358.3462480628;4363.869083927471;4405.625521830632;4427.981564240226;4174.499060112776;4225.6830737694645;4239.046214601721;4287.378330142144;4293.506246781629;4315;4339.869803905888;4355.760433176174;4364.759938203398;4394.011347446831;4309.418228539138;4327.459067616548;4330.112326972963;4330.675199360029;4363.934540981888;4491.191585514606;4591.885202869955;4612.815487380501;4630.305454181866;4724.1580572586;5032.220005899091;5042.319286896259;5046.041252162114;5046.924296135561;5071;5063;5073.746312684388;5076.6192535559985;5098.949010509921;5109.41241757199;4498.302763071762;4547.136044151601;4602.987342784582;4605.953940460619;4685.742284174369;5151.0470562945975;5152.9742351288005;5156.458571849977;5166.793328266827;5167.689938603696;4944.1100601892;4951.405831300267;4952.034353301072;4960.280759289883;4995.9500404996215;4827;4929.260610908321;4932.7286999215385;4941.555260026615;5028.547430731252;4840.443349014838;4850.102730994778;4895.877603059952;4955.231939049453;4983.053219888209;4918.680285781413;4935.506449355107;4944.307796908436;4949.034938187019;4980.252962055721;4161.91676166475;4164.6251837334785;4165.187788381237;4167.124903770182;4173.39485774567;3523.3657941570764;3588.049166970755;3631.94552081719;3648.288583726201;3682.5396825396824;4326.567343265711;4348.456442944632;4361.258586040381;4366.410534577855;4408.426904502394;5043.344365232496;5057.140286151363;5074.2895994560795;5076.771545280471;5120.948790512121;4150.149219410014;4221.472315960505;4226.049138943775;4250.0437401584395;4251.171021650748;4384.583464570861;4392.05570802279;4399.560043995575;4411.316245981814;4427.5572442755465;4759.547842954914;4784.665073444895;4787.928181077286;4790.233562629963;4794.184988551885;4771.260454629399;4909.5090490950615;5037.899242015213;5047.268146118866;5075.365579302587;4678.485366609602;4751.619870410428;4801.207800712843;4802.8799280018275;4806.831760888492;4962.801487940442;4972.0801651694555;4978.477259887804;4983.078130545716;5027.798888044437;5031.421386540448;5042.924356134734;5050.747462626928;5056.266841308064;5057;4637.118947399983;4737.099951009297;4754.23932170851;4756.476787553297;4857.392825896763;4836.903261934812;4879.829205977774;4879.95120048795;4885.413750349981;4910;4716.434027916672;4785.282207668877;4788.545088216753;4804.495527969513;4835.419749630067;4703.106409782131;4819.493953135011;4835.58897493717;4935.62982776286;4969.801207951641;4782.473927867863;4782.976085119552;4805.087033463631;4806.8077276909935;4839.879003024953 18:57:21 INFO - 2015-12-14 18:57:21,919 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.9467100625442;573.3177518752682;578.4244676546836;579.5305802300137;579.8144593730008;26777.196684099483;34843.477347839806;35705.1073723157;35755.82122089392;35780;39103;39606.405903911465;39648.224624276314;39659.60340396595;39723;6993.125859267591;7105.360517553419;7867.252611001945;8041.356691464698;8045.436819422643;9708.41749495029;9795.363301385387;9832;9886.802263954753;9897.802043959116;9678;9857.309988300822;9860.556274967643;9871;9902.702918912444;7247.963760181192;7429.182789893108;9970.15253703436;10092.697219083439;10284.125849302818;9838;9914.652987145415;9976.401415915068;9993.350432221881;10003.699889003341;37009.81495092507;37533.24933501315;37539;37558.43662345067;37618;2907.2150519359866;2947.911562653124;2968.807027543224;2975.6280464941883;3457.0493114393494;28029.159125226277;28088.578671319945;28205.576916346272;28833.27916802076;28881.277968050756;3384.424647809878;3427.6915077642884;3436.1581412553833;3494.2312691207894;3521.1725244567506;216771;218254;219111;219157.9999999984;219558;48444;48912.26631600529;48941.51058489441;51651.22523162155;51888;61303.6934815332;62155;62355.68822155951;62524.687376562826;62599.37400626027;12584.496620135274;12691.746165076831;12771.169873958162;12780.680482988;12792.168509046882;10512.21158413122;10593.31143475687;10599.099076578423;10607.84088238677;10615.256932014685;17781;17906.5523361917;17913.10434478271;17942.910285448488;18111.275548978156;7206.171290301578;7467.805151175786;7472.738454154079;7540.660670269851;7566.924330756732;780.9023872015998;836.6820608168979;838.6477679374556;860.6342304520554;908.8863892013499;26434.305659436548;26487.735122648526;26632.733672663413;26795.732042679323;26806.5979010315;937.3953799799092;963.1620490173594;1023.5445226873969;1042.8748550173875;1075.5213929801164;13641;14171;14249.358778854976;14290.356933937997;14406.495772648117;315222;320082;320704;320840;321362;46975.29537056947;47412.05175896532;47458.28812567814;47496;47513.76243118831;995.1686008865953;1115.6095366621616;1192.773373059116;1225.7548490301974;1298.4092238031485;27164.592531111655;28501.287467813472;28506.714932850406;28803.8559807208;28914.27714307159;35855;36120.638793611724;36141.27717445689;36199.63800361963;36244.27511449703;227010;232248;255592;260302;261973;29497.705022949496;29770.534419837197;29820.254493636963;29891;29957.550636740903;38026.80986595049;38922.80538597289;39306;39487.21025579415;39749.80125099356;30505;30598.388032238785;30631.54052689256;31151.376972460876;31471.213219668774;34352;34455;34491.827540862134;38372.42441363438;39955.80022099871;33795.3240935175;39334;39515.2096958065;39737.40393894036;39830.60169398269;27243.59134613022;30320;33472.330553389285;35601;36579.817100914326;23267.1856485029;24082.51834963256;24112.51774964526;25427;26204.73795262023 18:57:21 INFO - 2015-12-14 18:57:21,919 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.9373119107368;330.3656978601086;336.90398236502585;338.50409150594385;339.08109024543484;12446.377681115953;12838.743225135491;14404.927975360122;15001.324940377683;15571.688566228682;14416;14811.333489992949;15593.84406155938;16326.510204693848;16332.918335408336;5645.491905728483;6319.083732858733;6498.772542960997;6505.08928749973;6505.5120865935005;4067.064575147703;4193.706440549163;6342.619442833422;6508.381703738138;6534.509911756613;6408.679566021704;6469.029645553158;6509.479241660656;6510.1536800216145;6612.570182938118;6540.247871494791;6550.050242714779;6577.276499585066;6579.84852650789;6581.934180658228;6025.216721826178;6203.844903877439;6212.72042758077;6213.471854892339;6277.52918531112;19796;19902;19909.50226244341;20380.388588342226;20439;1902.9714554281559;1920.270297287022;1944.824965753089;1946.5036415714044;1977.683570628707;13471.326433678278;13549.187048777105;13562;14190.787138192936;14307.85692143086;1858.6282743451363;1888.9433317000376;1928.4889504281377;2031.126744491792;2169.7070895429074;55487.445125548635;59589.7020514899;59591.702041489945;60142.39857601455;60159.69920150415;15215.771763423558;15292.158931258888;15303.46437874669;15314.693706125816;15358.616034599225;22323.66514502284;22335.106595736313;22575.322740317817;22612.208572700205;22619.43451413728;8162.775583662498;8170.591470426455;8533.146685331418;8556.871646925301;8760.4305720128;6825.726970921108;6838.589684618939;7118.252583478764;7140.178879428932;7159.534630249017;6684.364985326386;6931.653417329113;7546.2831031051965;7585.544867307979;7591.772246832604;2673.388405001357;2866.4840328741025;2953.394554116401;2954.1875984104113;2967.940641187164;355.91102224443887;357.2176932517778;366.3021943198212;759.7682706774376;775.8176828445311;9350.579223934803;9937.602495900228;10093.899061009295;10154.847677284846;10227.94886025565;382.6957568732864;384.11269966377756;384.7076222071246;384.77298393947706;398.0645483114657;5358.490943360374;5389.272448219519;5415;5426.294581704432;5515.7242137892945;472176;476365;479897;480018;495199;72998;73203;73535.63232183804;74566.6271668649;76042.61978690182;418.40168558960977;421.81229352937646;422.7019950934584;422.8308676529351;423.73304817964487;9241.907580924104;9363.110504502334;9454.243660507005;9505.809883802147;9540.522973851419;31410.66926283713;31569.52645710362;31830.68169318277;32992.505112422856;33159.83420082884;46195.76902115468;46331;46452.07095858132;47510.762446187546;47532.2870156941;8479.830403392021;8716.520591367536;9061.09389061115;9078.364514483923;9080.818383632159;10751.516181771996;12335.938320308342;12423;12465.626031219077;15120.773188401963;12930.448346198516;13486.662833429244;13578.45686172542;13742.725145497234;13790.103643263155;12988.155769875306;13090.60728178118;13176.80234796498;13272.867271327163;13548.916086713236;10334.483275836028;11128.44357782124;11302.94348528285;13709.314534273446;13959.581212563638;8982.505962171881;9097.636094556143;9102.408343457653;9230.861537076815;9230.953845230732;9769.706908792748;14156.575302740934;14482.420703171754;14546.709065818413;14555.27223638835 18:57:21 INFO - 2015-12-14 18:57:21,920 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1269.1306455078277;1678.2196278730387;1724.732666436702;1725.292630021691;1752.0101142854294;5876.823695289143;6614.074029635849;6914.654267286641;6961.721531138748;6961.756338528153;6889.827754306145;7038.366547010768;7044.22513523512;7048.718051277956;7060.329268719476;1697.7623132761423;1721.8622510199154;1724.8275172482777;2034.928777492788;2082.2191678120703;1767.0546257752105;2018.0313449544228;2040.5102775333962;2045.478403007231;2047.1504325704889;1980.1089509720684;2012.5371164632143;2041.1529215375601;2045.0490521907311;2045.4170561390006;1972.0435588739522;1988.4631149589675;1991.950201244966;1992.1732481020358;1993.3621241202748;2013.6576781946958;2029.2593203480772;2044;2044.2334124703236;2044.9570718933303;6665.300143484913;6745.9662701686175;6750.392464678153;6756.898646520306;6804.319568043205;4001.5998400160042;4061.289274376972;4069.267531844267;4075.8777236682945;4081.3673880548267;2556.5526032944163;2567.9871600642064;2606.0487921908557;2614.816962812604;2631.934201644955;839.3327304792643;840.3277378097558;852.5694524265268;852.8209076094028;877.4779006491127;9054.683086092022;9174.954125229398;9185.862212066824;9185.862212066892;9187.908120918839;3755.061234691327;3796.3166630006313;3828.349180639298;3846.4999550058315;3852.056246219694;8177.509349439053;8178.550179740171;8179;8182.059063207688;8192.877106843402;4133.235351459929;4138.8551400701435;4154.106867023544;4156.293430116887;4158.37624356349;3762.3039737648623;3781.5084039074745;3785.0537365658583;3788.431735239681;3791.1469919268498;2892.638420197475;3199.376121656301;3209.1656169396124;3225.177579717157;3230.5315729219133;917.4586993673764;1027.3989716016215;1059.56557811297;1067.4395942130288;1070.9143268538498;870.1602953150241;897.4391005621486;902.8058967322057;905.4431524612316;1153.313778301909;6355.396237357444;6446.967765161145;6466.482681385572;6475.546711730133;6486.091947127406;567.3787203012695;569.9743511541991;571.0206995003589;573.8823541174049;717.1859938969308;4916.311716359713;4940.555350018443;4946.08497427977;4964.925526117111;4965.950340496621;7963.681452741941;8247.422680412434;8282.834343313221;8349.457285276438;8357.456765310235;8265.793355166048;8274.089850116483;8277.04813946404;8277.379196560281;8286.627101780434;6387.712552935036;6522.934770652328;6528.771492997722;6636.336366363325;6645.999999999904;6250.687465626791;6311.463525600376;6311.779087732091;6316.715747791269;6327.303996560467;7191.964040179975;7406.962965185139;7481.962590187014;7483.139438964588;7507.361874240751;7414.925850741423;7652.693892244248;7660.080790305199;7768.106667733283;7772.7668169954995;6093.055576385667;6130.969345153424;6135.11040899076;6139.693015349126;6156.1381406604005;5571.526420254324;6637.369449902251;6751.189857217166;6781.796546103625;6797.762078327235;5629.408912064175;6138.202033735586;6164.568480206522;6227.190465239671;6370.58591191571;6101.145839582373;6116.357782432959;6299.149614801943;6316.747330106744;6330.8100756977365;6263.530235232284;6291.779787707408;6301.054841773771;6322.683865806784;6330.841728956813;5742.684152371493;5859.033259512133;5859.5019423347785;5862.882742345044;5870.0607902735355;5911.793087241926;5950.553708471795;5956.821295361146;5975.820725378246;5976.193213916065 18:57:21 INFO - 2015-12-14 18:57:21,921 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.3786952725458;296.6158824322502;299.70179671227135;301.83248297195047;303.7873488558009;5127.05149547334;5187.22191671249;5230.947690523103;5291.735413229338;5297.761600727967;5079.542841144296;5180.14527602946;5191.5846732261425;5216.504432078956;5234.476552344764;4014.9360419488858;4026.9798651006704;4027.194561087787;4042.130941847502;4043.6967227457912;3818.2745278397156;3903.8438462461468;3917.5886531914166;4026.053877338823;4052.4731784868072;4010.077682133111;4015.9799201003952;4020.8793736187963;4021.4571032910476;4028.8187031583648;4008.498937632796;4008.7995600219874;4020.8793736187963;4021.075152714892;4030.3349947258666;3512.5609298837644;3519.1905861651962;3519.8240087995755;3520.612732599412;3527.9823600882087;4952.133376659071;5043.445221025684;5083.79664813407;5086.287919691246;5087.771050302746;4607.608353289975;4612.976935115303;4633.62930965522;4637.86086417408;4638.373819534353;5488.725563721798;5490;5499.560035197214;5503.514051206192;5511.366192887789;3579.2662504186837;3672.577653569847;3697.0757310672334;3814.370628846265;3846.0577158596043;5721.170430287627;5768.192453056576;5775.855603609902;5783.9710801446145;5791.971040144772;3897.8440862365187;3903.531576210873;3907.316219661548;3909.237698648793;3910.276598829169;3964.1278918637854;3965.464662270614;3966.7619942803526;3972.66232370246;3973.7615743055508;4462.152191083748;4568.680192386501;4571.725696458223;4588.220002599566;4588.311753237042;5479;5486.753096110685;5499.532539734088;5506.587005974568;5508.394076651565;1376.421902800826;1377.9517716879861;1378.23507953087;1379.5792283353674;1379.6275005748591;927.5594092805998;936.7751739582451;937.0910217089412;961.5817119552877;966.3622009473713;4859.95140048595;4873.756312184377;4875.878103047381;4876.414830220326;4877.561019508261;5702.401247868914;5713;5718.571107166979;5724.427557244326;5725.312962444534;4861.51384861511;4862.586680132157;4871.585915197177;4873.098476781806;4873.342098816685;3005.383896301253;3057.1287183152695;3080.5995220621626;3083.429565530384;3083.8458077096057;5393.78424863009;5398.4871437213405;5399.865003374947;5400.62195646301;5404;5853.268341457318;5853.853653658693;5862.208601838783;5862.325832529228;5864.091065884794;5368.892622147535;5383.946160538423;5392.164214546751;5399.244105825266;5400.405955344909;5555.30558680165;5703.657780533182;5707.372189059117;5713.685747283773;5720.799772007959;5377.865553361197;5535;5562.054450743464;5563.944360556505;5573.080441727069;5289.68261904287;5439.809606663748;5459.890802184013;5464.699441530754;5471.50756431923;3932.2921874062945;3935.252302062599;3939.8030098495533;3940.9014774630864;3942.290387730236;5754.625949313281;5764.481196692318;5765;5767.452092051249;5770.6249093808765;5393.865153371197;5526.088195447706;5540.861478463071;5544.279243698294;5550.4449555044175;5530.474604912527;5541.224228608079;5541.528970037431;5544.889102218014;5548.722563871709;5417.133258678593;5430.321209848769;5433.483819037185;5436.483534064258;5438.972805135949;5402.540784033401;5583;5585.245991791056;5594.216809646734;5598.244237027949;5466.043442397644;5473.507384335429;5481.424450432647;5485.341758988788;5489.149181876815 18:57:21 INFO - 2015-12-14 18:57:21,921 DEBUG : BROWSER_OUTPUT: |5;yui.html;668.3183153183753;702.7856503766351;709.6735501669232;718.7232915327597;725.166059032113;11249.55001799928;11547.595834145806;11595.536178552848;11611.18721689481;14076.507322243724;13185.604431867036;13324.267165305904;13363;13365.131266467673;13387.464501419956;630.9589876658002;637.9681015949208;639.0414378432351;819.2217393476207;836.1680128272347;634.5843472525503;817.4727300890921;832.3923535818856;832.5795473285982;832.5837081459271;846.8772028055959;860.4106187261746;861.3109512390095;861.6467248428146;861.9353548483857;656.0880376276979;662.3145044878528;839.4963022186639;851.29342645604;851.3231980575426;636.9713362898681;637.111229834383;637.3212528656966;638.5242993969522;638.6934271549636;11781.882181178164;11841.993430558327;11966.042716582739;11999.52001919922;12114.878851211462;10758.462076896201;11054.944725276402;11182.32906025641;11205.271657342246;11449.656510304705;9332.626694932194;9342.57958391874;9428.717138485856;9533.189678877303;9623.326367154303;3228.063861480168;3231.96768032319;3241.286916878283;3241.33552621712;3268.6241082275606;39814.20371592581;40330.79834600808;40409.39385909214;40443.39334909979;40495;9005.954970225106;9042.954785226031;9060.320475964198;9236.907630923739;9322.86015709765;15925.522234332988;16080.43718469848;16109.516714498584;16321.91839040821;16328.428505002505;6404.23149222087;6466.773662921869;6555.836104097436;6583.63789991555;6585.6707164641575;3649.525561676965;3656.213914008501;3660.1215708229834;3681.5950245472977;3723.106454450912;2525.06572568151;2554.118829003991;2573.3823882268493;2575.9227223183334;2578.071894118116;511.31994447384886;516.9663971841818;525.406290891298;525.8606469285643;526.242211215848;481.30691803802415;528.1865926473188;530.8646295194778;541.3828235811178;584.8187062010791;7555.282248186413;7745.457817952689;7767.883481747778;7967;8003.239692229229;391.3093390166359;503.30795156659593;552.4475524475524;563.4844117632321;578.4302462074853;3560.7151427885706;3679.7424180307657;3683.650053244937;3740.382836831947;3756.3537531240904;46884.765576172584;47930;47947.520524795;48099.75950120227;48212.75893620509;43087.784561076995;43634;43825.78087109544;43870.122597547874;44001.11997760027;38656.22687546234;39334;39342;40114.39828402518;40154;7173.5337203081635;7183.557082109794;7298.854022919406;7757.961210193913;7858.174891636296;29943.311110224204;30481.390372192876;30800.53799193059;31288.687113129487;32225.51661725029;36554;36569.817150914074;36684.26631467303;38502.80748596351;38517;9977.301588888999;9997.12384333864;10161.542730576994;10272.897271027494;10292.382457052601;10389.844152337871;11127;11133.220674552704;11456.656300311004;11636.418179090842;9858;10009.249306302203;10308.32995855267;10402;10557.260991730505;9303.488308142847;9478.715638530855;10048.09567138961;10107.39355638664;10117.59529618807;8449;9879.703608891745;10416.263502885424;10547.48915653024;10549.735608101182;8867.379283450096;8972.506512141896;8988.55057247122;9076.591553379982;9190.448573085636;8655.52394618302;8820.25027872638;8998.460092394478;9027.819443611223;9030.096990300917 18:57:21 INFO - 2015-12-14 18:57:21,921 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:57:21 INFO - 2015-12-14 18:57:21,921 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:57:21 INFO - 2015-12-14 18:57:21,921 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,951 18:57:21 INFO - 2015-12-14 18:57:21,921 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:57:21 INFO - 2015-12-14 18:57:21,921 DEBUG : BROWSER_OUTPUT: __startTimestamp1450148241915__endTimestamp 18:57:21 INFO - 2015-12-14 18:57:21,922 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4614.93 Median:4756.48 stddev:488.93 (10.3%) stddev-sans-first:463.52 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: Values: 2575.5 2674.2 2681.7 2695.5 2708.7 4558.7 4638.8 4697.1 4706.1 4723.4 4631.5 4657.2 4700.9 4726.8 4744.4 4270.5 4275.6 4304.7 4309.1 4327.7 4175.8 4358.3 4363.9 4405.6 4428.0 4174.5 4225.7 4239.0 4287.4 4293.5 4315.0 4339.9 4355.8 4364.8 4394.0 4309.4 4327.5 4330.1 4330.7 4363.9 4491.2 4591.9 4612.8 4630.3 4724.2 5032.2 5042.3 5046.0 5046.9 5071.0 5063.0 5073.7 5076.6 5098.9 5109.4 4498.3 4547.1 4603.0 4606.0 4685.7 5151.0 5153.0 5156.5 5166.8 5167.7 4944.1 4951.4 4952.0 4960.3 4996.0 4827.0 4929.3 4932.7 4941.6 5028.5 4840.4 4850.1 4895.9 4955.2 4983.1 4918.7 4935.5 4944.3 4949.0 4980.3 4161.9 4164.6 4165.2 4167.1 4173.4 3523.4 3588.0 3631.9 3648.3 3682.5 4326.6 4348.5 4361.3 4366.4 4408.4 5043.3 5057.1 5074.3 5076.8 5120.9 4150.1 4221.5 4226.0 4250.0 4251.2 4384.6 4392.1 4399.6 4411.3 4427.6 4759.5 4784.7 4787.9 4790.2 4794.2 4771.3 4909.5 5037.9 5047.3 5075.4 4678.5 4751.6 4801.2 4802.9 4806.8 4962.8 4972.1 4978.5 4983.1 5027.8 5031.4 5042.9 5050.7 5056.3 5057.0 4637.1 4737.1 4754.2 4756.5 4857.4 4836.9 4879.8 4880.0 4885.4 4910.0 4716.4 4785.3 4788.5 4804.5 4835.4 4703.1 4819.5 4835.6 4935.6 4969.8 4782.5 4783.0 4805.1 4806.8 4839.9 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42400.33 Median:19150.26 stddev:69353.66 (362.2%) stddev-sans-first:69477.07 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: Values: 560.9 573.3 578.4 579.5 579.8 26777.2 34843.5 35705.1 35755.8 35780.0 39103.0 39606.4 39648.2 39659.6 39723.0 6993.1 7105.4 7867.3 8041.4 8045.4 9708.4 9795.4 9832.0 9886.8 9897.8 9678.0 9857.3 9860.6 9871.0 9902.7 7248.0 7429.2 9970.2 10092.7 10284.1 9838.0 9914.7 9976.4 9993.4 10003.7 37009.8 37533.2 37539.0 37558.4 37618.0 2907.2 2947.9 2968.8 2975.6 3457.0 28029.2 28088.6 28205.6 28833.3 28881.3 3384.4 3427.7 3436.2 3494.2 3521.2 216771.0 218254.0 219111.0 219158.0 219558.0 48444.0 48912.3 48941.5 51651.2 51888.0 61303.7 62155.0 62355.7 62524.7 62599.4 12584.5 12691.7 12771.2 12780.7 12792.2 10512.2 10593.3 10599.1 10607.8 10615.3 17781.0 17906.6 17913.1 17942.9 18111.3 7206.2 7467.8 7472.7 7540.7 7566.9 780.9 836.7 838.6 860.6 908.9 26434.3 26487.7 26632.7 26795.7 26806.6 937.4 963.2 1023.5 1042.9 1075.5 13641.0 14171.0 14249.4 14290.4 14406.5 315222.0 320082.0 320704.0 320840.0 321362.0 46975.3 47412.1 47458.3 47496.0 47513.8 995.2 1115.6 1192.8 1225.8 1298.4 27164.6 28501.3 28506.7 28803.9 28914.3 35855.0 36120.6 36141.3 36199.6 36244.3 227010.0 232248.0 255592.0 260302.0 261973.0 29497.7 29770.5 29820.3 29891.0 29957.6 38026.8 38922.8 39306.0 39487.2 39749.8 30505.0 30598.4 30631.5 31151.4 31471.2 34352.0 34455.0 34491.8 38372.4 39955.8 33795.3 39334.0 39515.2 39737.4 39830.6 27243.6 30320.0 33472.3 35601.0 36579.8 23267.2 24082.5 24112.5 25427.0 26204.7 18:57:21 INFO - 2015-12-14 18:57:21,925 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26778.66 Median:2242.73 stddev:78558.59 (3502.8%) stddev-sans-first:78753.87 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: Values: 329.9 330.4 336.9 338.5 339.1 12446.4 12838.7 14404.9 15001.3 15571.7 14416.0 14811.3 15593.8 16326.5 16332.9 5645.5 6319.1 6498.8 6505.1 6505.5 4067.1 4193.7 6342.6 6508.4 6534.5 6408.7 6469.0 6509.5 6510.2 6612.6 6540.2 6550.1 6577.3 6579.8 6581.9 6025.2 6203.8 6212.7 6213.5 6277.5 19796.0 19902.0 19909.5 20380.4 20439.0 1903.0 1920.3 1944.8 1946.5 1977.7 13471.3 13549.2 13562.0 14190.8 14307.9 1858.6 1888.9 1928.5 2031.1 2169.7 55487.4 59589.7 59591.7 60142.4 60159.7 15215.8 15292.2 15303.5 15314.7 15358.6 22323.7 22335.1 22575.3 22612.2 22619.4 8162.8 8170.6 8533.1 8556.9 8760.4 6825.7 6838.6 7118.3 7140.2 7159.5 6684.4 6931.7 7546.3 7585.5 7591.8 2673.4 2866.5 2953.4 2954.2 2967.9 355.9 357.2 366.3 759.8 775.8 9350.6 9937.6 10093.9 10154.8 10227.9 382.7 384.1 384.7 384.8 398.1 5358.5 5389.3 5415.0 5426.3 5515.7 472176.0 476365.0 479897.0 480018.0 495199.0 72998.0 73203.0 73535.6 74566.6 76042.6 418.4 421.8 422.7 422.8 423.7 9241.9 9363.1 9454.2 9505.8 9540.5 31410.7 31569.5 31830.7 32992.5 33159.8 46195.8 46331.0 46452.1 47510.8 47532.3 8479.8 8716.5 9061.1 9078.4 9080.8 10751.5 12335.9 12423.0 12465.6 15120.8 12930.4 13486.7 13578.5 13742.7 13790.1 12988.2 13090.6 13176.8 13272.9 13548.9 10334.5 11128.4 11302.9 13709.3 13959.6 8982.5 9097.6 9102.4 9230.9 9231.0 9769.7 14156.6 14482.4 14546.7 14555.3 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4809.86 Median:6133.04 stddev:2513.04 (41.0%) stddev-sans-first:2505.99 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: Values: 1269.1 1678.2 1724.7 1725.3 1752.0 5876.8 6614.1 6914.7 6961.7 6961.8 6889.8 7038.4 7044.2 7048.7 7060.3 1697.8 1721.9 1724.8 2034.9 2082.2 1767.1 2018.0 2040.5 2045.5 2047.2 1980.1 2012.5 2041.2 2045.0 2045.4 1972.0 1988.5 1992.0 1992.2 1993.4 2013.7 2029.3 2044.0 2044.2 2045.0 6665.3 6746.0 6750.4 6756.9 6804.3 4001.6 4061.3 4069.3 4075.9 4081.4 2556.6 2568.0 2606.0 2614.8 2631.9 839.3 840.3 852.6 852.8 877.5 9054.7 9175.0 9185.9 9185.9 9187.9 3755.1 3796.3 3828.3 3846.5 3852.1 8177.5 8178.6 8179.0 8182.1 8192.9 4133.2 4138.9 4154.1 4156.3 4158.4 3762.3 3781.5 3785.1 3788.4 3791.1 2892.6 3199.4 3209.2 3225.2 3230.5 917.5 1027.4 1059.6 1067.4 1070.9 870.2 897.4 902.8 905.4 1153.3 6355.4 6447.0 6466.5 6475.5 6486.1 567.4 570.0 571.0 573.9 717.2 4916.3 4940.6 4946.1 4964.9 4966.0 7963.7 8247.4 8282.8 8349.5 8357.5 8265.8 8274.1 8277.0 8277.4 8286.6 6387.7 6522.9 6528.8 6636.3 6646.0 6250.7 6311.5 6311.8 6316.7 6327.3 7192.0 7407.0 7482.0 7483.1 7507.4 7414.9 7652.7 7660.1 7768.1 7772.8 6093.1 6131.0 6135.1 6139.7 6156.1 5571.5 6637.4 6751.2 6781.8 6797.8 5629.4 6138.2 6164.6 6227.2 6370.6 6101.1 6116.4 6299.1 6316.7 6330.8 6263.5 6291.8 6301.1 6322.7 6330.8 5742.7 5859.0 5859.5 5862.9 5870.1 5911.8 5950.6 5956.8 5975.8 5976.2 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4560.20 Median:5223.73 stddev:1353.40 (25.9%) stddev-sans-first:1318.74 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: Values: 292.4 296.6 299.7 301.8 303.8 5127.1 5187.2 5230.9 5291.7 5297.8 5079.5 5180.1 5191.6 5216.5 5234.5 4014.9 4027.0 4027.2 4042.1 4043.7 3818.3 3903.8 3917.6 4026.1 4052.5 4010.1 4016.0 4020.9 4021.5 4028.8 4008.5 4008.8 4020.9 4021.1 4030.3 3512.6 3519.2 3519.8 3520.6 3528.0 4952.1 5043.4 5083.8 5086.3 5087.8 4607.6 4613.0 4633.6 4637.9 4638.4 5488.7 5490.0 5499.6 5503.5 5511.4 3579.3 3672.6 3697.1 3814.4 3846.1 5721.2 5768.2 5775.9 5784.0 5792.0 3897.8 3903.5 3907.3 3909.2 3910.3 3964.1 3965.5 3966.8 3972.7 3973.8 4462.2 4568.7 4571.7 4588.2 4588.3 5479.0 5486.8 5499.5 5506.6 5508.4 1376.4 1378.0 1378.2 1379.6 1379.6 927.6 936.8 937.1 961.6 966.4 4860.0 4873.8 4875.9 4876.4 4877.6 5702.4 5713.0 5718.6 5724.4 5725.3 4861.5 4862.6 4871.6 4873.1 4873.3 3005.4 3057.1 3080.6 3083.4 3083.8 5393.8 5398.5 5399.9 5400.6 5404.0 5853.3 5853.9 5862.2 5862.3 5864.1 5368.9 5383.9 5392.2 5399.2 5400.4 5555.3 5703.7 5707.4 5713.7 5720.8 5377.9 5535.0 5562.1 5563.9 5573.1 5289.7 5439.8 5459.9 5464.7 5471.5 3932.3 3935.3 3939.8 3940.9 3942.3 5754.6 5764.5 5765.0 5767.5 5770.6 5393.9 5526.1 5540.9 5544.3 5550.4 5530.5 5541.2 5541.5 5544.9 5548.7 5417.1 5430.3 5433.5 5436.5 5439.0 5402.5 5583.0 5585.2 5594.2 5598.2 5466.0 5473.5 5481.4 5485.3 5489.1 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: 18:57:21 INFO - 2015-12-14 18:57:21,926 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12027.62 Median:47938.76 stddev:13421.08 (28.0%) stddev-sans-first:13431.62 18:57:21 INFO - 2015-12-14 18:57:21,928 DEBUG : BROWSER_OUTPUT: Values: 668.3 702.8 709.7 718.7 725.2 11249.6 11547.6 11595.5 11611.2 14076.5 13185.6 13324.3 13363.0 13365.1 13387.5 631.0 638.0 639.0 819.2 836.2 634.6 817.5 832.4 832.6 832.6 846.9 860.4 861.3 861.6 861.9 656.1 662.3 839.5 851.3 851.3 637.0 637.1 637.3 638.5 638.7 11781.9 11842.0 11966.0 11999.5 12114.9 10758.5 11054.9 11182.3 11205.3 11449.7 9332.6 9342.6 9428.7 9533.2 9623.3 3228.1 3232.0 3241.3 3241.3 3268.6 39814.2 40330.8 40409.4 40443.4 40495.0 9006.0 9043.0 9060.3 9236.9 9322.9 15925.5 16080.4 16109.5 16321.9 16328.4 6404.2 6466.8 6555.8 6583.6 6585.7 3649.5 3656.2 3660.1 3681.6 3723.1 2525.1 2554.1 2573.4 2575.9 2578.1 511.3 517.0 525.4 525.9 526.2 481.3 528.2 530.9 541.4 584.8 7555.3 7745.5 7767.9 7967.0 8003.2 391.3 503.3 552.4 563.5 578.4 3560.7 3679.7 3683.7 3740.4 3756.4 46884.8 47930.0 47947.5 48099.8 48212.8 43087.8 43634.0 43825.8 43870.1 44001.1 38656.2 39334.0 39342.0 40114.4 40154.0 7173.5 7183.6 7298.9 7758.0 7858.2 29943.3 30481.4 30800.5 31288.7 32225.5 36554.0 36569.8 36684.3 38502.8 38517.0 9977.3 9997.1 10161.5 10272.9 10292.4 10389.8 11127.0 11133.2 11456.7 11636.4 9858.0 10009.2 10308.3 10402.0 10557.3 9303.5 9478.7 10048.1 10107.4 10117.6 8449.0 9879.7 10416.3 10547.5 10549.7 8867.4 8972.5 8988.6 9076.6 9190.4 8655.5 8820.3 8998.5 9027.8 9030.1 18:57:21 INFO - 2015-12-14 18:57:21,928 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:57:21 INFO - 2015-12-14 18:57:21,928 DEBUG : BROWSER_OUTPUT: 18:57:22 INFO - 2015-12-14 18:57:22,666 INFO : Browser exited with error code: 0 18:57:22 INFO - 2015-12-14 18:57:22,681 INFO : Completed test dromaeo_css (00:18:37) 18:57:22 INFO - 2015-12-14 18:57:22,682 INFO : Starting test kraken 18:57:22 INFO - 2015-12-14 18:57:22,682 DEBUG : operating with platform_type : linux_ 18:57:22 INFO - 2015-12-14 18:57:22,682 INFO : Initialising browser for kraken test... 18:57:22 INFO - 2015-12-14 18:57:22,688 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK346SB/profile http://localhost:49374/getInfo.html 18:57:26 INFO - 2015-12-14 18:57:26,586 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:57:26 INFO - 2015-12-14 18:57:26,586 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:57:26 INFO - 2015-12-14 18:57:26,586 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:57:26 INFO - 2015-12-14 18:57:26,586 DEBUG : BROWSER_OUTPUT: __metrics 18:57:26 INFO - 2015-12-14 18:57:26,662 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:57:26 INFO - 2015-12-14 18:57:26,739 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:57:28 INFO - 2015-12-14 18:57:28,007 INFO : Browser initialized. 18:57:28 INFO - 2015-12-14 18:57:28,008 INFO : Running cycle 1/1 for kraken test... 18:57:28 INFO - 2015-12-14 18:57:28,008 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK346SB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:57:40 INFO - 2015-12-14 18:57:40,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 142684160 18:57:40 INFO - 2015-12-14 18:57:40,029 DEBUG : BROWSER_OUTPUT: 18:57:42 INFO - 2015-12-14 18:57:42,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection) 18:57:43 INFO - 2015-12-14 18:57:43,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 180277248 18:57:43 INFO - 2015-12-14 18:57:43,233 DEBUG : BROWSER_OUTPUT: 18:57:45 INFO - 2015-12-14 18:57:45,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-dft) 18:57:46 INFO - 2015-12-14 18:57:46,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 168546304 18:57:46 INFO - 2015-12-14 18:57:46,548 DEBUG : BROWSER_OUTPUT: 18:57:49 INFO - 2015-12-14 18:57:49,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-fft) 18:57:50 INFO - 2015-12-14 18:57:50,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 153100288 18:57:50 INFO - 2015-12-14 18:57:50,147 DEBUG : BROWSER_OUTPUT: 18:57:52 INFO - 2015-12-14 18:57:52,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator) 18:57:52 INFO - 2015-12-14 18:57:52,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 155840512 18:57:52 INFO - 2015-12-14 18:57:52,770 DEBUG : BROWSER_OUTPUT: 18:57:55 INFO - 2015-12-14 18:57:55,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:57:55 INFO - 2015-12-14 18:57:55,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 157999104 18:57:55 INFO - 2015-12-14 18:57:55,596 DEBUG : BROWSER_OUTPUT: 18:57:58 INFO - 2015-12-14 18:57:58,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom) 18:57:59 INFO - 2015-12-14 18:57:59,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 158515200 18:57:59 INFO - 2015-12-14 18:57:59,190 DEBUG : BROWSER_OUTPUT: 18:58:02 INFO - 2015-12-14 18:58:02,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate) 18:58:03 INFO - 2015-12-14 18:58:03,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 158392320 18:58:03 INFO - 2015-12-14 18:58:03,181 DEBUG : BROWSER_OUTPUT: 18:58:06 INFO - 2015-12-14 18:58:06,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial) 18:58:06 INFO - 2015-12-14 18:58:06,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 157028352 18:58:06 INFO - 2015-12-14 18:58:06,675 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-12-14 18:58:08,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:58:09 INFO - 2015-12-14 18:58:09,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 167116800 18:58:09 INFO - 2015-12-14 18:58:09,051 DEBUG : BROWSER_OUTPUT: 18:58:10 INFO - 2015-12-14 18:58:10,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:11 INFO - 2015-12-14 18:58:11,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 166240256 18:58:11 INFO - 2015-12-14 18:58:11,547 DEBUG : BROWSER_OUTPUT: 18:58:13 INFO - 2015-12-14 18:58:13,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:14 INFO - 2015-12-14 18:58:14,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 177909760 18:58:14 INFO - 2015-12-14 18:58:14,212 DEBUG : BROWSER_OUTPUT: 18:58:16 INFO - 2015-12-14 18:58:16,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:17 INFO - 2015-12-14 18:58:17,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 184004608 18:58:17 INFO - 2015-12-14 18:58:17,292 DEBUG : BROWSER_OUTPUT: 18:58:19 INFO - 2015-12-14 18:58:19,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:20 INFO - 2015-12-14 18:58:20,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 179290112 18:58:20 INFO - 2015-12-14 18:58:20,457 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49374/tests/kraken/driver.html?testName=ai-astar) 18:58:22 INFO - 2015-12-14 18:58:22,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 239165440 18:58:22 INFO - 2015-12-14 18:58:22,490 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,491 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:58:22 INFO - 2015-12-14 18:58:22,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:58:22 INFO - 2015-12-14 18:58:22,493 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:58:22 INFO - 2015-12-14 18:58:22,493 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:58:22 INFO - 2015-12-14 18:58:22,493 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;115;107;110;113;113;101;112;112;111 18:58:22 INFO - 2015-12-14 18:58:22,493 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;138;153;182;130;158;154;129;170;132 18:58:22 INFO - 2015-12-14 18:58:22,493 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;160;165;160;163;163;162;161 18:58:22 INFO - 2015-12-14 18:58:22,493 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;91;97;72;72;75;112;90;72 18:58:22 INFO - 2015-12-14 18:58:22,493 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;133;94;94;96;132;94;95;127 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;109;110;110;110;109 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;148;147;147;147;146;147 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;95;96;96;95;95 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;73;73;73;74;74;73;81;72;71 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;69;68;69;69;69 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;82;83;84;83;83;84;85;83 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;121;120;118;121;122;122;120;121;121 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;148;161;147;150;141;150;149;140;137 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;77;70;72;74;70;71;70;70;70 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,996 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: __startTimestamp1450148302491__endTimestamp 18:58:22 INFO - 2015-12-14 18:58:22,494 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.95 (3.5%) stddev-sans-first:4.19 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: Values: 111.0 115.0 107.0 110.0 113.0 113.0 101.0 112.0 112.0 111.0 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.30 Median:155.50 stddev:17.86 (11.5%) stddev-sans-first:18.78 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: Values: 157.0 138.0 153.0 182.0 130.0 158.0 154.0 129.0 170.0 132.0 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 160.0 165.0 160.0 163.0 163.0 162.0 161.0 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,498 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.60 Median:74.00 stddev:14.13 (19.1%) stddev-sans-first:14.55 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 91.0 97.0 72.0 72.0 75.0 112.0 90.0 72.0 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.50 stddev:17.38 (18.4%) stddev-sans-first:18.08 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 133.0 94.0 94.0 96.0 132.0 94.0 95.0 127.0 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 148.0 147.0 147.0 147.0 146.0 147.0 18:58:22 INFO - 2015-12-14 18:58:22,499 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.90 Median:73.50 stddev:2.73 (3.7%) stddev-sans-first:2.86 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 73.0 73.0 74.0 74.0 73.0 81.0 72.0 71.0 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 69.0 18:58:22 INFO - 2015-12-14 18:58:22,500 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:0.95 (1.1%) stddev-sans-first:0.88 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 82.0 83.0 84.0 83.0 83.0 84.0 85.0 83.0 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.00 stddev:1.27 (1.0%) stddev-sans-first:1.22 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 120.0 118.0 121.0 122.0 122.0 120.0 121.0 121.0 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:148.50 stddev:7.28 (4.9%) stddev-sans-first:7.11 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: Values: 138.0 148.0 161.0 147.0 150.0 141.0 150.0 149.0 140.0 137.0 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:70.50 stddev:2.37 (3.4%) stddev-sans-first:2.46 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: Values: 70.0 77.0 70.0 72.0 74.0 70.0 71.0 70.0 70.0 70.0 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:58:22 INFO - 2015-12-14 18:58:22,501 DEBUG : BROWSER_OUTPUT: 18:58:23 INFO - 2015-12-14 18:58:23,413 INFO : Browser exited with error code: 0 18:58:23 INFO - 2015-12-14 18:58:23,467 INFO : Completed test kraken (00:01:00) 18:58:23 INFO - 2015-12-14 18:58:23,467 INFO : Starting test v8_7 18:58:23 INFO - 2015-12-14 18:58:23,467 DEBUG : operating with platform_type : linux_ 18:58:23 INFO - 2015-12-14 18:58:23,467 INFO : Initialising browser for v8_7 test... 18:58:23 INFO - 2015-12-14 18:58:23,473 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgW8Gp/profile http://localhost:49374/getInfo.html 18:58:27 INFO - 2015-12-14 18:58:27,518 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:58:27 INFO - 2015-12-14 18:58:27,518 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:58:27 INFO - 2015-12-14 18:58:27,518 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:58:27 INFO - 2015-12-14 18:58:27,518 DEBUG : BROWSER_OUTPUT: __metrics 18:58:27 INFO - 2015-12-14 18:58:27,627 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:58:27 INFO - 2015-12-14 18:58:27,688 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:58:28 INFO - 2015-12-14 18:58:28,842 INFO : Browser initialized. 18:58:28 INFO - 2015-12-14 18:58:28,843 INFO : Running cycle 1/1 for v8_7 test... 18:58:28 INFO - 2015-12-14 18:58:28,843 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgW8Gp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:58:40 INFO - 2015-12-14 18:58:40,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 142331904 18:58:40 INFO - 2015-12-14 18:58:40,819 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49374/tests/v8_7/run.html (next: http://localhost:49374/tests/v8_7/run.html) 18:59:02 INFO - 2015-12-14 18:59:02,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 443957248 18:59:02 INFO - 2015-12-14 18:59:02,443 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,443 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:59:02 INFO - 2015-12-14 18:59:02,443 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:59:02 INFO - 2015-12-14 18:59:02,443 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:59:02 INFO - 2015-12-14 18:59:02,444 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:59:02 INFO - 2015-12-14 18:59:02,444 DEBUG : BROWSER_OUTPUT: |0;Richards;168.89039013680122 18:59:02 INFO - 2015-12-14 18:59:02,444 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.04651162790697 18:59:02 INFO - 2015-12-14 18:59:02,444 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 18:59:02 INFO - 2015-12-14 18:59:02,444 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 18:59:02 INFO - 2015-12-14 18:59:02,444 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 18:59:02 INFO - 2015-12-14 18:59:02,444 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 18:59:02 INFO - 2015-12-14 18:59:02,445 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 18:59:02 INFO - 2015-12-14 18:59:02,445 DEBUG : BROWSER_OUTPUT: |7;RegExp;27054.054054054053 18:59:02 INFO - 2015-12-14 18:59:02,445 DEBUG : BROWSER_OUTPUT: |8;Splay;613.8735420503376 18:59:02 INFO - 2015-12-14 18:59:02,445 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 18:59:02 INFO - 2015-12-14 18:59:02,446 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:59:02 INFO - 2015-12-14 18:59:02,446 DEBUG : BROWSER_OUTPUT: __startTimestamp1450148342441__endTimestamp 18:59:02 INFO - 2015-12-14 18:59:02,446 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,446 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:59:02 INFO - 2015-12-14 18:59:02,446 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:59:02 INFO - 2015-12-14 18:59:02,447 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,447 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.89 Median:168.89 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,447 DEBUG : BROWSER_OUTPUT: Values: 168.9 18:59:02 INFO - 2015-12-14 18:59:02,447 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,447 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.05 Median:186.05 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,447 DEBUG : BROWSER_OUTPUT: Values: 186.0 18:59:02 INFO - 2015-12-14 18:59:02,448 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,448 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,448 DEBUG : BROWSER_OUTPUT: Values: 279.3 18:59:02 INFO - 2015-12-14 18:59:02,448 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,449 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,449 DEBUG : BROWSER_OUTPUT: Values: 5191.7 18:59:02 INFO - 2015-12-14 18:59:02,449 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,450 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,450 DEBUG : BROWSER_OUTPUT: Values: 1972.4 18:59:02 INFO - 2015-12-14 18:59:02,450 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,450 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,451 DEBUG : BROWSER_OUTPUT: Values: 791.8 18:59:02 INFO - 2015-12-14 18:59:02,451 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,451 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,451 DEBUG : BROWSER_OUTPUT: Values: 12292.7 18:59:02 INFO - 2015-12-14 18:59:02,451 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,451 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,451 DEBUG : BROWSER_OUTPUT: Values: 27054.1 18:59:02 INFO - 2015-12-14 18:59:02,452 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,452 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.87 Median:613.87 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,452 DEBUG : BROWSER_OUTPUT: Values: 613.9 18:59:02 INFO - 2015-12-14 18:59:02,452 DEBUG : BROWSER_OUTPUT: 18:59:02 INFO - 2015-12-14 18:59:02,452 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 18:59:02 INFO - 2015-12-14 18:59:02,452 DEBUG : BROWSER_OUTPUT: Values: 4835.7 18:59:02 INFO - 2015-12-14 18:59:02,452 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:59:02 INFO - 2015-12-14 18:59:02,453 DEBUG : BROWSER_OUTPUT: 18:59:03 INFO - 2015-12-14 18:59:03,389 INFO : Browser exited with error code: 0 18:59:03 INFO - 2015-12-14 18:59:03,406 INFO : Completed test v8_7 (00:00:39) 18:59:03 INFO - 2015-12-14 18:59:03,501 INFO : Completed test suite (00:20:18) 18:59:03 INFO - 2015-12-14 18:59:03,501 DEBUG : Working with test: dromaeo_css 18:59:03 INFO - 2015-12-14 18:59:03,501 DEBUG : Generating results file: dromaeo_css 18:59:03 INFO - 2015-12-14 18:59:03,503 DEBUG : Working with test: kraken 18:59:03 INFO - 2015-12-14 18:59:03,503 DEBUG : Generating results file: kraken 18:59:03 INFO - 2015-12-14 18:59:03,503 INFO : javascript benchmark 18:59:03 INFO - 2015-12-14 18:59:03,503 DEBUG : Working with test: v8_7 18:59:03 INFO - 2015-12-14 18:59:03,503 DEBUG : Generating results file: v8_7 18:59:03 INFO - 2015-12-14 18:59:03,504 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:03 INFO - 2015-12-14 18:59:03,568 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 18:59:03 INFO - 2015-12-14 18:59:03,569 DEBUG : process_Request line: dromaeo_css 6254.94 graph.html#tests=[[72,132,35]] 18:59:03 INFO - 2015-12-14 18:59:03,569 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:03 INFO - 2015-12-14 18:59:03,607 DEBUG : process_Request line: kraken 1526.90 graph.html#tests=[[232,132,35]] 18:59:03 INFO - 2015-12-14 18:59:03,607 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:03 INFO - 2015-12-14 18:59:03,640 DEBUG : process_Request line: v8_7 19714.22 graph.html#tests=[[230,132,35]] 18:59:03 INFO - 2015-12-14 18:59:03,641 INFO : javascript benchmark 18:59:03 INFO - 2015-12-14 18:59:03,644 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2575.472028234212, 2674.2378422149677, 2681.74523420275, 2695.5282825505533, 2708.7020427752946, 4558.703684260521, 4638.768061596919, 4697.084068606623, 4706.058788242348, 4723.433188017434, 4631.467381251157, 4657.184992626286, 4700.929486057712, 4726.810927562893, 4744.38323018008, 4270.487541495025, 4275.615194632474, 4304.741715497064, 4309.052008558112, 4327.697061205717, 4175.832966681329, 4358.3462480628, 4363.869083927471, 4405.625521830632, 4427.981564240226, 4174.499060112776, 4225.6830737694645, 4239.046214601721, 4287.378330142144, 4293.506246781629, 4315.0, 4339.869803905888, 4355.760433176174, 4364.759938203398, 4394.011347446831, 4309.418228539138, 4327.459067616548, 4330.112326972963, 4330.675199360029, 4363.934540981888, 4491.191585514606, 4591.885202869955, 4612.815487380501, 4630.305454181866, 4724.1580572586, 5032.220005899091, 5042.319286896259, 5046.041252162114, 5046.924296135561, 5071.0, 5063.0, 5073.746312684388, 5076.6192535559985, 5098.949010509921, 5109.41241757199, 4498.302763071762, 4547.136044151601, 4602.987342784582, 4605.953940460619, 4685.742284174369, 5151.0470562945975, 5152.9742351288005, 5156.458571849977, 5166.793328266827, 5167.689938603696, 4944.1100601892, 4951.405831300267, 4952.034353301072, 4960.280759289883, 4995.9500404996215, 4827.0, 4929.260610908321, 4932.7286999215385, 4941.555260026615, 5028.547430731252, 4840.443349014838, 4850.102730994778, 4895.877603059952, 4955.231939049453, 4983.053219888209, 4918.680285781413, 4935.506449355107, 4944.307796908436, 4949.034938187019, 4980.252962055721, 4161.91676166475, 4164.6251837334785, 4165.187788381237, 4167.124903770182, 4173.39485774567, 3523.3657941570764, 3588.049166970755, 3631.94552081719, 3648.288583726201, 3682.5396825396824, 4326.567343265711, 4348.456442944632, 4361.258586040381, 4366.410534577855, 4408.426904502394, 5043.344365232496, 5057.140286151363, 5074.2895994560795, 5076.771545280471, 5120.948790512121, 4150.149219410014, 4221.472315960505, 4226.049138943775, 4250.0437401584395, 4251.171021650748, 4384.583464570861, 4392.05570802279, 4399.560043995575, 4411.316245981814, 4427.5572442755465, 4759.547842954914, 4784.665073444895, 4787.928181077286, 4790.233562629963, 4794.184988551885, 4771.260454629399, 4909.5090490950615, 5037.899242015213, 5047.268146118866, 5075.365579302587, 4678.485366609602, 4751.619870410428, 4801.207800712843, 4802.8799280018275, 4806.831760888492, 4962.801487940442, 4972.0801651694555, 4978.477259887804, 4983.078130545716, 5027.798888044437, 5031.421386540448, 5042.924356134734, 5050.747462626928, 5056.266841308064, 5057.0, 4637.118947399983, 4737.099951009297, 4754.23932170851, 4756.476787553297, 4857.392825896763, 4836.903261934812, 4879.829205977774, 4879.95120048795, 4885.413750349981, 4910.0, 4716.434027916672, 4785.282207668877, 4788.545088216753, 4804.495527969513, 4835.419749630067, 4703.106409782131, 4819.493953135011, 4835.58897493717, 4935.62982776286, 4969.801207951641, 4782.473927867863, 4782.976085119552, 4805.087033463631, 4806.8077276909935, 4839.879003024953], "unit": "ms", "name": "dojo.html", "value": 4583.976183871805}, {"lowerIsBetter": false, "replicates": [560.9467100625442, 573.3177518752682, 578.4244676546836, 579.5305802300137, 579.8144593730008, 26777.196684099483, 34843.477347839806, 35705.1073723157, 35755.82122089392, 35780.0, 39103.0, 39606.405903911465, 39648.224624276314, 39659.60340396595, 39723.0, 6993.125859267591, 7105.360517553419, 7867.252611001945, 8041.356691464698, 8045.436819422643, 9708.41749495029, 9795.363301385387, 9832.0, 9886.802263954753, 9897.802043959116, 9678.0, 9857.309988300822, 9860.556274967643, 9871.0, 9902.702918912444, 7247.963760181192, 7429.182789893108, 9970.15253703436, 10092.697219083439, 10284.125849302818, 9838.0, 9914.652987145415, 9976.401415915068, 9993.350432221881, 10003.699889003341, 37009.81495092507, 37533.24933501315, 37539.0, 37558.43662345067, 37618.0, 2907.2150519359866, 2947.911562653124, 2968.807027543224, 2975.6280464941883, 3457.0493114393494, 28029.159125226277, 28088.578671319945, 28205.576916346272, 28833.27916802076, 28881.277968050756, 3384.424647809878, 3427.6915077642884, 3436.1581412553833, 3494.2312691207894, 3521.1725244567506, 216771.0, 218254.0, 219111.0, 219157.9999999984, 219558.0, 48444.0, 48912.26631600529, 48941.51058489441, 51651.22523162155, 51888.0, 61303.6934815332, 62155.0, 62355.68822155951, 62524.687376562826, 62599.37400626027, 12584.496620135274, 12691.746165076831, 12771.169873958162, 12780.680482988, 12792.168509046882, 10512.21158413122, 10593.31143475687, 10599.099076578423, 10607.84088238677, 10615.256932014685, 17781.0, 17906.5523361917, 17913.10434478271, 17942.910285448488, 18111.275548978156, 7206.171290301578, 7467.805151175786, 7472.738454154079, 7540.660670269851, 7566.924330756732, 780.9023872015998, 836.6820608168979, 838.6477679374556, 860.6342304520554, 908.8863892013499, 26434.305659436548, 26487.735122648526, 26632.733672663413, 26795.732042679323, 26806.5979010315, 937.3953799799092, 963.1620490173594, 1023.5445226873969, 1042.8748550173875, 1075.5213929801164, 13641.0, 14171.0, 14249.358778854976, 14290.356933937997, 14406.495772648117, 315222.0, 320082.0, 320704.0, 320840.0, 321362.0, 46975.29537056947, 47412.05175896532, 47458.28812567814, 47496.0, 47513.76243118831, 995.1686008865953, 1115.6095366621616, 1192.773373059116, 1225.7548490301974, 1298.4092238031485, 27164.592531111655, 28501.287467813472, 28506.714932850406, 28803.8559807208, 28914.27714307159, 35855.0, 36120.638793611724, 36141.27717445689, 36199.63800361963, 36244.27511449703, 227010.0, 232248.0, 255592.0, 260302.0, 261973.0, 29497.705022949496, 29770.534419837197, 29820.254493636963, 29891.0, 29957.550636740903, 38026.80986595049, 38922.80538597289, 39306.0, 39487.21025579415, 39749.80125099356, 30505.0, 30598.388032238785, 30631.54052689256, 31151.376972460876, 31471.213219668774, 34352.0, 34455.0, 34491.827540862134, 38372.42441363438, 39955.80022099871, 33795.3240935175, 39334.0, 39515.2096958065, 39737.40393894036, 39830.60169398269, 27243.59134613022, 30320.0, 33472.330553389285, 35601.0, 36579.817100914326, 23267.1856485029, 24082.51834963256, 24112.51774964526, 25427.0, 26204.73795262023], "unit": "ms", "name": "ext.html", "value": 17339.8473093603}, {"lowerIsBetter": false, "replicates": [329.9373119107368, 330.3656978601086, 336.90398236502585, 338.50409150594385, 339.08109024543484, 12446.377681115953, 12838.743225135491, 14404.927975360122, 15001.324940377683, 15571.688566228682, 14416.0, 14811.333489992949, 15593.84406155938, 16326.510204693848, 16332.918335408336, 5645.491905728483, 6319.083732858733, 6498.772542960997, 6505.08928749973, 6505.5120865935005, 4067.064575147703, 4193.706440549163, 6342.619442833422, 6508.381703738138, 6534.509911756613, 6408.679566021704, 6469.029645553158, 6509.479241660656, 6510.1536800216145, 6612.570182938118, 6540.247871494791, 6550.050242714779, 6577.276499585066, 6579.84852650789, 6581.934180658228, 6025.216721826178, 6203.844903877439, 6212.72042758077, 6213.471854892339, 6277.52918531112, 19796.0, 19902.0, 19909.50226244341, 20380.388588342226, 20439.0, 1902.9714554281559, 1920.270297287022, 1944.824965753089, 1946.5036415714044, 1977.683570628707, 13471.326433678278, 13549.187048777105, 13562.0, 14190.787138192936, 14307.85692143086, 1858.6282743451363, 1888.9433317000376, 1928.4889504281377, 2031.126744491792, 2169.7070895429074, 55487.445125548635, 59589.7020514899, 59591.702041489945, 60142.39857601455, 60159.69920150415, 15215.771763423558, 15292.158931258888, 15303.46437874669, 15314.693706125816, 15358.616034599225, 22323.66514502284, 22335.106595736313, 22575.322740317817, 22612.208572700205, 22619.43451413728, 8162.775583662498, 8170.591470426455, 8533.146685331418, 8556.871646925301, 8760.4305720128, 6825.726970921108, 6838.589684618939, 7118.252583478764, 7140.178879428932, 7159.534630249017, 6684.364985326386, 6931.653417329113, 7546.2831031051965, 7585.544867307979, 7591.772246832604, 2673.388405001357, 2866.4840328741025, 2953.394554116401, 2954.1875984104113, 2967.940641187164, 355.91102224443887, 357.2176932517778, 366.3021943198212, 759.7682706774376, 775.8176828445311, 9350.579223934803, 9937.602495900228, 10093.899061009295, 10154.847677284846, 10227.94886025565, 382.6957568732864, 384.11269966377756, 384.7076222071246, 384.77298393947706, 398.0645483114657, 5358.490943360374, 5389.272448219519, 5415.0, 5426.294581704432, 5515.7242137892945, 472176.0, 476365.0, 479897.0, 480018.0, 495199.0, 72998.0, 73203.0, 73535.63232183804, 74566.6271668649, 76042.61978690182, 418.40168558960977, 421.81229352937646, 422.7019950934584, 422.8308676529351, 423.73304817964487, 9241.907580924104, 9363.110504502334, 9454.243660507005, 9505.809883802147, 9540.522973851419, 31410.66926283713, 31569.52645710362, 31830.68169318277, 32992.505112422856, 33159.83420082884, 46195.76902115468, 46331.0, 46452.07095858132, 47510.762446187546, 47532.2870156941, 8479.830403392021, 8716.520591367536, 9061.09389061115, 9078.364514483923, 9080.818383632159, 10751.516181771996, 12335.938320308342, 12423.0, 12465.626031219077, 15120.773188401963, 12930.448346198516, 13486.662833429244, 13578.45686172542, 13742.725145497234, 13790.103643263155, 12988.155769875306, 13090.60728178118, 13176.80234796498, 13272.867271327163, 13548.916086713236, 10334.483275836028, 11128.44357782124, 11302.94348528285, 13709.314534273446, 13959.581212563638, 8982.505962171881, 9097.636094556143, 9102.408343457653, 9230.861537076815, 9230.953845230732, 9769.706908792748, 14156.575302740934, 14482.420703171754, 14546.709065818413, 14555.27223638835], "unit": "ms", "name": "jquery.html", "value": 8306.624201354887}, {"lowerIsBetter": false, "replicates": [1269.1306455078277, 1678.2196278730387, 1724.732666436702, 1725.292630021691, 1752.0101142854294, 5876.823695289143, 6614.074029635849, 6914.654267286641, 6961.721531138748, 6961.756338528153, 6889.827754306145, 7038.366547010768, 7044.22513523512, 7048.718051277956, 7060.329268719476, 1697.7623132761423, 1721.8622510199154, 1724.8275172482777, 2034.928777492788, 2082.2191678120703, 1767.0546257752105, 2018.0313449544228, 2040.5102775333962, 2045.478403007231, 2047.1504325704889, 1980.1089509720684, 2012.5371164632143, 2041.1529215375601, 2045.0490521907311, 2045.4170561390006, 1972.0435588739522, 1988.4631149589675, 1991.950201244966, 1992.1732481020358, 1993.3621241202748, 2013.6576781946958, 2029.2593203480772, 2044.0, 2044.2334124703236, 2044.9570718933303, 6665.300143484913, 6745.9662701686175, 6750.392464678153, 6756.898646520306, 6804.319568043205, 4001.5998400160042, 4061.289274376972, 4069.267531844267, 4075.8777236682945, 4081.3673880548267, 2556.5526032944163, 2567.9871600642064, 2606.0487921908557, 2614.816962812604, 2631.934201644955, 839.3327304792643, 840.3277378097558, 852.5694524265268, 852.8209076094028, 877.4779006491127, 9054.683086092022, 9174.954125229398, 9185.862212066824, 9185.862212066892, 9187.908120918839, 3755.061234691327, 3796.3166630006313, 3828.349180639298, 3846.4999550058315, 3852.056246219694, 8177.509349439053, 8178.550179740171, 8179.0, 8182.059063207688, 8192.877106843402, 4133.235351459929, 4138.8551400701435, 4154.106867023544, 4156.293430116887, 4158.37624356349, 3762.3039737648623, 3781.5084039074745, 3785.0537365658583, 3788.431735239681, 3791.1469919268498, 2892.638420197475, 3199.376121656301, 3209.1656169396124, 3225.177579717157, 3230.5315729219133, 917.4586993673764, 1027.3989716016215, 1059.56557811297, 1067.4395942130288, 1070.9143268538498, 870.1602953150241, 897.4391005621486, 902.8058967322057, 905.4431524612316, 1153.313778301909, 6355.396237357444, 6446.967765161145, 6466.482681385572, 6475.546711730133, 6486.091947127406, 567.3787203012695, 569.9743511541991, 571.0206995003589, 573.8823541174049, 717.1859938969308, 4916.311716359713, 4940.555350018443, 4946.08497427977, 4964.925526117111, 4965.950340496621, 7963.681452741941, 8247.422680412434, 8282.834343313221, 8349.457285276438, 8357.456765310235, 8265.793355166048, 8274.089850116483, 8277.04813946404, 8277.379196560281, 8286.627101780434, 6387.712552935036, 6522.934770652328, 6528.771492997722, 6636.336366363325, 6645.999999999904, 6250.687465626791, 6311.463525600376, 6311.779087732091, 6316.715747791269, 6327.303996560467, 7191.964040179975, 7406.962965185139, 7481.962590187014, 7483.139438964588, 7507.361874240751, 7414.925850741423, 7652.693892244248, 7660.080790305199, 7768.106667733283, 7772.7668169954995, 6093.055576385667, 6130.969345153424, 6135.11040899076, 6139.693015349126, 6156.1381406604005, 5571.526420254324, 6637.369449902251, 6751.189857217166, 6781.796546103625, 6797.762078327235, 5629.408912064175, 6138.202033735586, 6164.568480206522, 6227.190465239671, 6370.58591191571, 6101.145839582373, 6116.357782432959, 6299.149614801943, 6316.747330106744, 6330.8100756977365, 6263.530235232284, 6291.779787707408, 6301.054841773771, 6322.683865806784, 6330.841728956813, 5742.684152371493, 5859.033259512133, 5859.5019423347785, 5862.882742345044, 5870.0607902735355, 5911.793087241926, 5950.553708471795, 5956.821295361146, 5975.820725378246, 5976.193213916065], "unit": "ms", "name": "mootools.html", "value": 3902.792307064131}, {"lowerIsBetter": false, "replicates": [292.3786952725458, 296.6158824322502, 299.70179671227135, 301.83248297195047, 303.7873488558009, 5127.05149547334, 5187.22191671249, 5230.947690523103, 5291.735413229338, 5297.761600727967, 5079.542841144296, 5180.14527602946, 5191.5846732261425, 5216.504432078956, 5234.476552344764, 4014.9360419488858, 4026.9798651006704, 4027.194561087787, 4042.130941847502, 4043.6967227457912, 3818.2745278397156, 3903.8438462461468, 3917.5886531914166, 4026.053877338823, 4052.4731784868072, 4010.077682133111, 4015.9799201003952, 4020.8793736187963, 4021.4571032910476, 4028.8187031583648, 4008.498937632796, 4008.7995600219874, 4020.8793736187963, 4021.075152714892, 4030.3349947258666, 3512.5609298837644, 3519.1905861651962, 3519.8240087995755, 3520.612732599412, 3527.9823600882087, 4952.133376659071, 5043.445221025684, 5083.79664813407, 5086.287919691246, 5087.771050302746, 4607.608353289975, 4612.976935115303, 4633.62930965522, 4637.86086417408, 4638.373819534353, 5488.725563721798, 5490.0, 5499.560035197214, 5503.514051206192, 5511.366192887789, 3579.2662504186837, 3672.577653569847, 3697.0757310672334, 3814.370628846265, 3846.0577158596043, 5721.170430287627, 5768.192453056576, 5775.855603609902, 5783.9710801446145, 5791.971040144772, 3897.8440862365187, 3903.531576210873, 3907.316219661548, 3909.237698648793, 3910.276598829169, 3964.1278918637854, 3965.464662270614, 3966.7619942803526, 3972.66232370246, 3973.7615743055508, 4462.152191083748, 4568.680192386501, 4571.725696458223, 4588.220002599566, 4588.311753237042, 5479.0, 5486.753096110685, 5499.532539734088, 5506.587005974568, 5508.394076651565, 1376.421902800826, 1377.9517716879861, 1378.23507953087, 1379.5792283353674, 1379.6275005748591, 927.5594092805998, 936.7751739582451, 937.0910217089412, 961.5817119552877, 966.3622009473713, 4859.95140048595, 4873.756312184377, 4875.878103047381, 4876.414830220326, 4877.561019508261, 5702.401247868914, 5713.0, 5718.571107166979, 5724.427557244326, 5725.312962444534, 4861.51384861511, 4862.586680132157, 4871.585915197177, 4873.098476781806, 4873.342098816685, 3005.383896301253, 3057.1287183152695, 3080.5995220621626, 3083.429565530384, 3083.8458077096057, 5393.78424863009, 5398.4871437213405, 5399.865003374947, 5400.62195646301, 5404.0, 5853.268341457318, 5853.853653658693, 5862.208601838783, 5862.325832529228, 5864.091065884794, 5368.892622147535, 5383.946160538423, 5392.164214546751, 5399.244105825266, 5400.405955344909, 5555.30558680165, 5703.657780533182, 5707.372189059117, 5713.685747283773, 5720.799772007959, 5377.865553361197, 5535.0, 5562.054450743464, 5563.944360556505, 5573.080441727069, 5289.68261904287, 5439.809606663748, 5459.890802184013, 5464.699441530754, 5471.50756431923, 3932.2921874062945, 3935.252302062599, 3939.8030098495533, 3940.9014774630864, 3942.290387730236, 5754.625949313281, 5764.481196692318, 5765.0, 5767.452092051249, 5770.6249093808765, 5393.865153371197, 5526.088195447706, 5540.861478463071, 5544.279243698294, 5550.4449555044175, 5530.474604912527, 5541.224228608079, 5541.528970037431, 5544.889102218014, 5548.722563871709, 5417.133258678593, 5430.321209848769, 5433.483819037185, 5436.483534064258, 5438.972805135949, 5402.540784033401, 5583.0, 5585.245991791056, 5594.216809646734, 5598.244237027949, 5466.043442397644, 5473.507384335429, 5481.424450432647, 5485.341758988788, 5489.149181876815], "unit": "ms", "name": "prototype.html", "value": 4123.673743350792}, {"lowerIsBetter": false, "replicates": [668.3183153183753, 702.7856503766351, 709.6735501669232, 718.7232915327597, 725.166059032113, 11249.55001799928, 11547.595834145806, 11595.536178552848, 11611.18721689481, 14076.507322243724, 13185.604431867036, 13324.267165305904, 13363.0, 13365.131266467673, 13387.464501419956, 630.9589876658002, 637.9681015949208, 639.0414378432351, 819.2217393476207, 836.1680128272347, 634.5843472525503, 817.4727300890921, 832.3923535818856, 832.5795473285982, 832.5837081459271, 846.8772028055959, 860.4106187261746, 861.3109512390095, 861.6467248428146, 861.9353548483857, 656.0880376276979, 662.3145044878528, 839.4963022186639, 851.29342645604, 851.3231980575426, 636.9713362898681, 637.111229834383, 637.3212528656966, 638.5242993969522, 638.6934271549636, 11781.882181178164, 11841.993430558327, 11966.042716582739, 11999.52001919922, 12114.878851211462, 10758.462076896201, 11054.944725276402, 11182.32906025641, 11205.271657342246, 11449.656510304705, 9332.626694932194, 9342.57958391874, 9428.717138485856, 9533.189678877303, 9623.326367154303, 3228.063861480168, 3231.96768032319, 3241.286916878283, 3241.33552621712, 3268.6241082275606, 39814.20371592581, 40330.79834600808, 40409.39385909214, 40443.39334909979, 40495.0, 9005.954970225106, 9042.954785226031, 9060.320475964198, 9236.907630923739, 9322.86015709765, 15925.522234332988, 16080.43718469848, 16109.516714498584, 16321.91839040821, 16328.428505002505, 6404.23149222087, 6466.773662921869, 6555.836104097436, 6583.63789991555, 6585.6707164641575, 3649.525561676965, 3656.213914008501, 3660.1215708229834, 3681.5950245472977, 3723.106454450912, 2525.06572568151, 2554.118829003991, 2573.3823882268493, 2575.9227223183334, 2578.071894118116, 511.31994447384886, 516.9663971841818, 525.406290891298, 525.8606469285643, 526.242211215848, 481.30691803802415, 528.1865926473188, 530.8646295194778, 541.3828235811178, 584.8187062010791, 7555.282248186413, 7745.457817952689, 7767.883481747778, 7967.0, 8003.239692229229, 391.3093390166359, 503.30795156659593, 552.4475524475524, 563.4844117632321, 578.4302462074853, 3560.7151427885706, 3679.7424180307657, 3683.650053244937, 3740.382836831947, 3756.3537531240904, 46884.765576172584, 47930.0, 47947.520524795, 48099.75950120227, 48212.75893620509, 43087.784561076995, 43634.0, 43825.78087109544, 43870.122597547874, 44001.11997760027, 38656.22687546234, 39334.0, 39342.0, 40114.39828402518, 40154.0, 7173.5337203081635, 7183.557082109794, 7298.854022919406, 7757.961210193913, 7858.174891636296, 29943.311110224204, 30481.390372192876, 30800.53799193059, 31288.687113129487, 32225.51661725029, 36554.0, 36569.817150914074, 36684.26631467303, 38502.80748596351, 38517.0, 9977.301588888999, 9997.12384333864, 10161.542730576994, 10272.897271027494, 10292.382457052601, 10389.844152337871, 11127.0, 11133.220674552704, 11456.656300311004, 11636.418179090842, 9858.0, 10009.249306302203, 10308.32995855267, 10402.0, 10557.260991730505, 9303.488308142847, 9478.715638530855, 10048.09567138961, 10107.39355638664, 10117.59529618807, 8449.0, 9879.703608891745, 10416.263502885424, 10547.48915653024, 10549.735608101182, 8867.379283450096, 8972.506512141896, 8988.55057247122, 9076.591553379982, 9190.448573085636, 8655.52394618302, 8820.25027872638, 8998.460092394478, 9027.819443611223, 9030.096990300917], "unit": "ms", "name": "yui.html", "value": 5635.297395148868}], "name": "dromaeo_css", "value": 6254.937595734336}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 107.0, 110.0, 113.0, 113.0, 101.0, 112.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [157.0, 138.0, 153.0, 182.0, 130.0, 158.0, 154.0, 129.0, 170.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 160.0, 165.0, 160.0, 163.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 91.0, 97.0, 72.0, 72.0, 75.0, 112.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 133.0, 94.0, 94.0, 96.0, 132.0, 94.0, 95.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 73.0, 73.0, 74.0, 74.0, 73.0, 81.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 83.0, 84.0, 83.0, 83.0, 84.0, 85.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [119.0, 121.0, 120.0, 118.0, 121.0, 122.0, 122.0, 120.0, 121.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 161.0, 147.0, 150.0, 141.0, 150.0, 149.0, 140.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [70.0, 77.0, 70.0, 72.0, 74.0, 70.0, 71.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.4}], "name": "kraken", "value": 1526.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.89039013680122], "unit": "score", "name": "Richards", "value": 209.0231420000001}, {"lowerIsBetter": false, "replicates": [186.04651162790697], "unit": "score", "name": "DeltaBlue", "value": 355.38425000000007}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [27054.054054054053], "unit": "score", "name": "RegExp", "value": 33.67277222777225}, {"lowerIsBetter": false, "replicates": [613.8735420503376], "unit": "score", "name": "Splay", "value": 132.748839}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19714.2196995786}]} 18:59:03 INFO - RETURN: dromaeo_css: 6254.94 18:59:03 INFO - RETURN: kraken: 1526.90 18:59:03 INFO - RETURN: v8_7: 19714.22 18:59:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19714.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1526.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6254.94"}}} 18:59:03 INFO - Return code: 0 18:59:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:59:03 INFO - # TBPL SUCCESS # 18:59:03 INFO - Running post-action listener: _resource_record_post_action 18:59:03 INFO - Running post-run listener: _resource_record_post_run 18:59:04 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508321792; Read time: 12; Write time: 460808 18:59:04 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 232144896; Read time: 0; Write time: 298388 18:59:04 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276176896; Read time: 12; Write time: 162420 18:59:04 INFO - Running post-run listener: _upload_blobber_files 18:59:04 INFO - Blob upload gear active. 18:59:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:59:04 INFO - Copying logs to upload dir... 18:59:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.134824 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-14 18:59:03.027846) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 18:59:03.031517) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010223 build_url: 'https://queue.taskcluster.net/v1/task/dW3JwpeUR4WrseI68-ZkIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 18:59:03.084242) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:59:03.084601) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450145580.709793-757256653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 18:59:03.136873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 18:59:03.137610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 18:59:03.138329) ========= ========= Total master_lag: 0.33 =========