builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1450181613.53 results: success (0) buildid: 20151215031211 builduid: ac8f1bc046114e1cb1f54b57c020f801 revision: 038664873a7bb62ef3fc904511dc063a28e601a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.528763) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.529401) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.529873) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006492 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.598354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.598748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.706195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.706498) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.769336) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.769658) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.770052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.770388) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 04:13:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.9K=0.3s 2015-12-15 04:13:34 (44.9 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.433618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.219175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.219516) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020919 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.270524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.271100) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 038664873a7bb62ef3fc904511dc063a28e601a4 --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 038664873a7bb62ef3fc904511dc063a28e601a4 --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=49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 04:13:34,913 truncating revision to first 12 chars 2015-12-15 04:13:34,913 Setting DEBUG logging. 2015-12-15 04:13:34,913 attempt 1/10 2015-12-15 04:13:34,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/038664873a7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 04:13:35,137 unpacking tar archive at: fx-team-038664873a7b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.481469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.766556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.766862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.776882) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.777193) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.777645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-15 04:13:34.777937) ========= /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=49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:35 INFO - MultiFileLogger online at 20151215 04:13:35 in /builds/slave/test 04:13:35 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 04:13:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:35 INFO - {'append_to_log': False, 04:13:35 INFO - 'base_work_dir': '/builds/slave/test', 04:13:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:13:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:35 INFO - 'branch': 'Fx-Team-Non-PGO', 04:13:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:35 INFO - 'config_files': ('talos/linux_config.py',), 04:13:35 INFO - 'default_actions': ('clobber', 04:13:35 INFO - 'read-buildbot-config', 04:13:35 INFO - 'download-and-extract', 04:13:35 INFO - 'populate-webroot', 04:13:35 INFO - 'create-virtualenv', 04:13:35 INFO - 'install', 04:13:35 INFO - 'run-tests'), 04:13:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:35 INFO - 'download_minidump_stackwalk': True, 04:13:35 INFO - 'download_symbols': 'ondemand', 04:13:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:35 INFO - 'installer_path': 'installer.exe', 04:13:35 INFO - 'log_level': 'info', 04:13:35 INFO - 'log_name': 'talos', 04:13:35 INFO - 'log_to_console': True, 04:13:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:35 INFO - 'opt_config_files': (), 04:13:35 INFO - 'pip_index': False, 04:13:35 INFO - 'sps_profile': False, 04:13:35 INFO - 'sps_profile_interval': 0, 04:13:35 INFO - 'suite': 'dromaeojs', 04:13:35 INFO - 'system_bits': '64', 04:13:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:35 INFO - 'title': 'talos-linux64-ix-060', 04:13:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:35 INFO - 'use_talos_json': True, 04:13:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:35 INFO - 'work_dir': 'build'} 04:13:35 INFO - ##### 04:13:35 INFO - ##### Running clobber step. 04:13:35 INFO - ##### 04:13:35 INFO - Running pre-action listener: _resource_record_pre_action 04:13:35 INFO - Running main action method: clobber 04:13:35 INFO - rmtree: /builds/slave/test/build 04:13:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:36 INFO - Running post-action listener: _resource_record_post_action 04:13:36 INFO - ##### 04:13:36 INFO - ##### Running read-buildbot-config step. 04:13:36 INFO - ##### 04:13:36 INFO - Running pre-action listener: _resource_record_pre_action 04:13:36 INFO - Running main action method: read_buildbot_config 04:13:36 INFO - Using buildbot properties: 04:13:36 INFO - { 04:13:36 INFO - "properties": { 04:13:36 INFO - "buildnumber": 1011, 04:13:36 INFO - "product": "firefox", 04:13:36 INFO - "script_repo_revision": "production", 04:13:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:13:36 INFO - "repository": "", 04:13:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:13:36 INFO - "buildid": "20151215031211", 04:13:36 INFO - "slavename": "talos-linux64-ix-060", 04:13:36 INFO - "pgo_build": "False", 04:13:36 INFO - "basedir": "/builds/slave/test", 04:13:36 INFO - "project": "", 04:13:36 INFO - "platform": "ubuntu64_hw", 04:13:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:13:36 INFO - "slavebuilddir": "test", 04:13:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:13:36 INFO - "branch": "fx-team", 04:13:36 INFO - "repo_path": "integration/fx-team", 04:13:36 INFO - "stage_platform": "linux64", 04:13:36 INFO - "builduid": "ac8f1bc046114e1cb1f54b57c020f801", 04:13:36 INFO - "revision": "038664873a7bb62ef3fc904511dc063a28e601a4" 04:13:36 INFO - }, 04:13:36 INFO - "sourcestamp": { 04:13:36 INFO - "repository": "", 04:13:36 INFO - "hasPatch": false, 04:13:36 INFO - "project": "", 04:13:36 INFO - "branch": "fx-team-linux64-talos", 04:13:36 INFO - "changes": [ 04:13:36 INFO - { 04:13:36 INFO - "category": null, 04:13:36 INFO - "files": [ 04:13:36 INFO - { 04:13:36 INFO - "url": null, 04:13:36 INFO - "name": "https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:13:36 INFO - } 04:13:36 INFO - ], 04:13:36 INFO - "repository": "", 04:13:36 INFO - "rev": "038664873a7bb62ef3fc904511dc063a28e601a4", 04:13:36 INFO - "who": "apoirot@mozilla.com", 04:13:36 INFO - "when": 1450181570, 04:13:36 INFO - "number": 7361704, 04:13:36 INFO - "comments": "Bug 1228382 - Keep service worker alive when attaching to them. r=janx,ejpbruel", 04:13:36 INFO - "project": "", 04:13:36 INFO - "at": "Tue 15 Dec 2015 04:12:50", 04:13:36 INFO - "branch": "fx-team-linux64-talos", 04:13:36 INFO - "revlink": "", 04:13:36 INFO - "properties": [ 04:13:36 INFO - [ 04:13:36 INFO - "buildid", 04:13:36 INFO - "20151215031211", 04:13:36 INFO - "Change" 04:13:36 INFO - ], 04:13:36 INFO - [ 04:13:36 INFO - "builduid", 04:13:36 INFO - "ac8f1bc046114e1cb1f54b57c020f801", 04:13:36 INFO - "Change" 04:13:36 INFO - ], 04:13:36 INFO - [ 04:13:36 INFO - "pgo_build", 04:13:36 INFO - "False", 04:13:36 INFO - "Change" 04:13:36 INFO - ] 04:13:36 INFO - ], 04:13:36 INFO - "revision": "038664873a7bb62ef3fc904511dc063a28e601a4" 04:13:36 INFO - } 04:13:36 INFO - ], 04:13:36 INFO - "revision": "038664873a7bb62ef3fc904511dc063a28e601a4" 04:13:36 INFO - } 04:13:36 INFO - } 04:13:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:13:36 INFO - Running post-action listener: _resource_record_post_action 04:13:36 INFO - ##### 04:13:36 INFO - ##### Running download-and-extract step. 04:13:36 INFO - ##### 04:13:36 INFO - Running pre-action listener: _resource_record_pre_action 04:13:36 INFO - Running main action method: download_and_extract 04:13:36 INFO - mkdir: /builds/slave/test/build/tests 04:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:36 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json 04:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json 04:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:13:39 INFO - Downloaded 1302 bytes. 04:13:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:13:39 INFO - Using the following test package requirements: 04:13:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'jsshell-linux-x86_64.zip'], 04:13:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:39 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:40 INFO - Downloaded 21869884 bytes. 04:13:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:13:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:13:41 INFO - Return code: 0 04:13:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:41 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:42 INFO - Downloaded 21869884 bytes. 04:13:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:13:43 INFO - Return code: 0 04:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:43 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:13:44 INFO - Downloaded 11132038 bytes. 04:13:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:13:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:13:44 INFO - Return code: 0 04:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:44 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:46 INFO - Downloaded 57742871 bytes. 04:13:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:46 INFO - mkdir: /builds/slave/test/properties 04:13:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:46 INFO - Contents: 04:13:46 INFO - build_url:https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:46 INFO - Running post-action listener: _resource_record_post_action 04:13:46 INFO - Running post-action listener: set_extra_try_arguments 04:13:46 INFO - ##### 04:13:46 INFO - ##### Running populate-webroot step. 04:13:46 INFO - ##### 04:13:46 INFO - Running pre-action listener: _resource_record_pre_action 04:13:46 INFO - Running main action method: populate_webroot 04:13:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:46 INFO - '--tppagecycles', 04:13:46 INFO - '7'], 04:13:46 INFO - 'tests': ['tsvgm']}}, 04:13:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:13:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:46 INFO - 'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:46 INFO - 'tests': ['damp', 'tps']}, 04:13:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:46 INFO - 'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['damp', 'tps']}, 04:13:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:13:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:46 INFO - 'other': {'tests': ['a11yr', 04:13:46 INFO - 'ts_paint', 04:13:46 INFO - 'tpaint', 04:13:46 INFO - 'sessionrestore', 04:13:46 INFO - 'sessionrestore_no_auto_restore']}, 04:13:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['a11yr', 04:13:46 INFO - 'ts_paint', 04:13:46 INFO - 'tpaint', 04:13:46 INFO - 'sessionrestore', 04:13:46 INFO - 'sessionrestore_no_auto_restore']}, 04:13:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['a11yr', 04:13:46 INFO - 'ts_paint', 04:13:46 INFO - 'tpaint', 04:13:46 INFO - 'sessionrestore', 04:13:46 INFO - 'sessionrestore_no_auto_restore']}, 04:13:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['a11yr', 04:13:46 INFO - 'ts_paint', 04:13:46 INFO - 'tpaint', 04:13:46 INFO - 'sessionrestore', 04:13:46 INFO - 'sessionrestore_no_auto_restore']}, 04:13:46 INFO - 'other_l64': {'tests': ['a11yr', 04:13:46 INFO - 'ts_paint', 04:13:46 INFO - 'tpaint', 04:13:46 INFO - 'sessionrestore', 04:13:46 INFO - 'sessionrestore_no_auto_restore']}, 04:13:46 INFO - 'other_nol64': {'tests': ['a11yr', 04:13:46 INFO - 'ts_paint', 04:13:46 INFO - 'tpaint', 04:13:46 INFO - 'sessionrestore', 04:13:46 INFO - 'sessionrestore_no_auto_restore']}, 04:13:46 INFO - 'svgr': {'tests': ['tsvgx', 04:13:46 INFO - 'tsvgr_opacity', 04:13:46 INFO - 'tart', 04:13:46 INFO - 'tscrollx', 04:13:46 INFO - 'cart']}, 04:13:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['tsvgx', 04:13:46 INFO - 'tsvgr_opacity', 04:13:46 INFO - 'tart', 04:13:46 INFO - 'tscrollx', 04:13:46 INFO - 'cart']}, 04:13:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:46 INFO - 'tests': ['tp5o']}, 04:13:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:46 INFO - 'talos_options': ['--e10s'], 04:13:46 INFO - 'tests': ['tp5o']}, 04:13:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:46 INFO - 'talos_options': ['--xperf_path', 04:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:46 INFO - 'tests': ['tp5n']}, 04:13:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:46 INFO - 'talos_options': ['--e10s', 04:13:46 INFO - '--xperf_path', 04:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:46 INFO - 'tests': ['tp5n']}}, 04:13:46 INFO - 'talos.zip': {'path': '', 04:13:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:46 INFO - Running post-action listener: _resource_record_post_action 04:13:46 INFO - ##### 04:13:46 INFO - ##### Running create-virtualenv step. 04:13:46 INFO - ##### 04:13:46 INFO - Running pre-action listener: _resource_record_pre_action 04:13:46 INFO - Running main action method: create_virtualenv 04:13:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:13:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:46 INFO - Using real prefix '/usr' 04:13:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:49 INFO - Installing pip.................done. 04:13:49 INFO - Return code: 0 04:13:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:49 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:49 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 04:13:49 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 04:13:49 INFO - Using env: {'DISPLAY': ':0', 04:13:49 INFO - 'HOME': '/home/cltbld', 04:13:49 INFO - 'LANG': 'en_US.UTF-8', 04:13:49 INFO - 'LANGUAGE': 'en_US:en', 04:13:49 INFO - 'LOGNAME': 'cltbld', 04:13:49 INFO - 'MAIL': '/var/mail/cltbld', 04:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:49 INFO - 'MOZ_NO_REMOTE': '1', 04:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:49 INFO - 'NO_EM_RESTART': '1', 04:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:49 INFO - 'PWD': '/builds/slave/test', 04:13:49 INFO - 'SHELL': '/bin/bash', 04:13:49 INFO - 'SHLVL': '1', 04:13:49 INFO - 'TERM': 'linux', 04:13:49 INFO - 'TMOUT': '86400', 04:13:49 INFO - 'USER': 'cltbld', 04:13:49 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:49 INFO - '_': '/tools/buildbot/bin/python'} 04:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:13:49 INFO - Cleaning up... 04:13:49 INFO - Return code: 0 04:13:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:49 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:49 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 04:13:49 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 04:13:49 INFO - Using env: {'DISPLAY': ':0', 04:13:49 INFO - 'HOME': '/home/cltbld', 04:13:49 INFO - 'LANG': 'en_US.UTF-8', 04:13:49 INFO - 'LANGUAGE': 'en_US:en', 04:13:49 INFO - 'LOGNAME': 'cltbld', 04:13:49 INFO - 'MAIL': '/var/mail/cltbld', 04:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:49 INFO - 'MOZ_NO_REMOTE': '1', 04:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:49 INFO - 'NO_EM_RESTART': '1', 04:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:49 INFO - 'PWD': '/builds/slave/test', 04:13:49 INFO - 'SHELL': '/bin/bash', 04:13:49 INFO - 'SHLVL': '1', 04:13:49 INFO - 'TERM': 'linux', 04:13:49 INFO - 'TMOUT': '86400', 04:13:49 INFO - 'USER': 'cltbld', 04:13:49 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:49 INFO - '_': '/tools/buildbot/bin/python'} 04:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:49 INFO - Downloading/unpacking psutil>=0.7.1 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:13:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:51 INFO - Installing collected packages: psutil 04:13:51 INFO - Running setup.py install for psutil 04:13:51 INFO - building 'psutil._psutil_linux' extension 04:13:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:13:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:13:51 INFO - building 'psutil._psutil_posix' extension 04:13:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:13:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:13:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:52 INFO - Successfully installed psutil 04:13:52 INFO - Cleaning up... 04:13:52 INFO - Return code: 0 04:13:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:52 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 04:13:52 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 04:13:52 INFO - Using env: {'DISPLAY': ':0', 04:13:52 INFO - 'HOME': '/home/cltbld', 04:13:52 INFO - 'LANG': 'en_US.UTF-8', 04:13:52 INFO - 'LANGUAGE': 'en_US:en', 04:13:52 INFO - 'LOGNAME': 'cltbld', 04:13:52 INFO - 'MAIL': '/var/mail/cltbld', 04:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:52 INFO - 'MOZ_NO_REMOTE': '1', 04:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:52 INFO - 'NO_EM_RESTART': '1', 04:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:52 INFO - 'PWD': '/builds/slave/test', 04:13:52 INFO - 'SHELL': '/bin/bash', 04:13:52 INFO - 'SHLVL': '1', 04:13:52 INFO - 'TERM': 'linux', 04:13:52 INFO - 'TMOUT': '86400', 04:13:52 INFO - 'USER': 'cltbld', 04:13:52 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:52 INFO - '_': '/tools/buildbot/bin/python'} 04:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:13:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:13:54 INFO - Installing collected packages: mozsystemmonitor 04:13:54 INFO - Running setup.py install for mozsystemmonitor 04:13:54 INFO - Successfully installed mozsystemmonitor 04:13:54 INFO - Cleaning up... 04:13:54 INFO - Return code: 0 04:13:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:54 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 04:13:54 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 04:13:54 INFO - Using env: {'DISPLAY': ':0', 04:13:54 INFO - 'HOME': '/home/cltbld', 04:13:54 INFO - 'LANG': 'en_US.UTF-8', 04:13:54 INFO - 'LANGUAGE': 'en_US:en', 04:13:54 INFO - 'LOGNAME': 'cltbld', 04:13:54 INFO - 'MAIL': '/var/mail/cltbld', 04:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:54 INFO - 'MOZ_NO_REMOTE': '1', 04:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:54 INFO - 'NO_EM_RESTART': '1', 04:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:54 INFO - 'PWD': '/builds/slave/test', 04:13:54 INFO - 'SHELL': '/bin/bash', 04:13:54 INFO - 'SHLVL': '1', 04:13:54 INFO - 'TERM': 'linux', 04:13:54 INFO - 'TMOUT': '86400', 04:13:54 INFO - 'USER': 'cltbld', 04:13:54 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:54 INFO - '_': '/tools/buildbot/bin/python'} 04:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:56 INFO - Downloading docopt-0.6.1.tar.gz 04:13:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:56 INFO - Running setup.py install for blobuploader 04:13:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:56 INFO - Running setup.py install for requests 04:13:57 INFO - Running setup.py install for docopt 04:13:57 INFO - Successfully installed blobuploader requests docopt 04:13:57 INFO - Cleaning up... 04:13:57 INFO - Return code: 0 04:13:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:57 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 04:13:57 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 04:13:57 INFO - Using env: {'DISPLAY': ':0', 04:13:57 INFO - 'HOME': '/home/cltbld', 04:13:57 INFO - 'LANG': 'en_US.UTF-8', 04:13:57 INFO - 'LANGUAGE': 'en_US:en', 04:13:57 INFO - 'LOGNAME': 'cltbld', 04:13:57 INFO - 'MAIL': '/var/mail/cltbld', 04:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:57 INFO - 'MOZ_NO_REMOTE': '1', 04:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:57 INFO - 'NO_EM_RESTART': '1', 04:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:57 INFO - 'PWD': '/builds/slave/test', 04:13:57 INFO - 'SHELL': '/bin/bash', 04:13:57 INFO - 'SHLVL': '1', 04:13:57 INFO - 'TERM': 'linux', 04:13:57 INFO - 'TMOUT': '86400', 04:13:57 INFO - 'USER': 'cltbld', 04:13:57 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:57 INFO - '_': '/tools/buildbot/bin/python'} 04:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:57 INFO - Running setup.py (path:/tmp/pip-xKcHzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:57 INFO - Running setup.py (path:/tmp/pip-LNXGKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:57 INFO - Running setup.py (path:/tmp/pip-n163h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:57 INFO - Running setup.py (path:/tmp/pip-g0vrpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:57 INFO - Running setup.py (path:/tmp/pip-U_0rJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:57 INFO - Running setup.py (path:/tmp/pip-QvECSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:58 INFO - Running setup.py (path:/tmp/pip-aCqfLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:58 INFO - Running setup.py (path:/tmp/pip-oramYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:58 INFO - Running setup.py (path:/tmp/pip-8esAnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:58 INFO - Running setup.py (path:/tmp/pip-0knAhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:58 INFO - Running setup.py (path:/tmp/pip-LAYKbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:58 INFO - Running setup.py (path:/tmp/pip-klO_Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:58 INFO - Running setup.py (path:/tmp/pip-YLyimr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:58 INFO - Running setup.py (path:/tmp/pip-KMkhJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:58 INFO - Running setup.py (path:/tmp/pip-GNq9MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:58 INFO - Running setup.py (path:/tmp/pip-LWej5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:58 INFO - Running setup.py (path:/tmp/pip-V586iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:58 INFO - Running setup.py install for manifestparser 04:13:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Running setup.py install for mozcrash 04:13:59 INFO - Running setup.py install for mozdebug 04:13:59 INFO - Running setup.py install for mozdevice 04:13:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozfile 04:13:59 INFO - Running setup.py install for mozhttpd 04:13:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozinfo 04:13:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozInstall 04:13:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozleak 04:13:59 INFO - Running setup.py install for mozlog 04:13:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for moznetwork 04:13:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozprocess 04:14:00 INFO - Running setup.py install for mozprofile 04:14:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Running setup.py install for mozrunner 04:14:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Running setup.py install for mozscreenshot 04:14:00 INFO - Running setup.py install for moztest 04:14:00 INFO - Running setup.py install for mozversion 04:14:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:00 INFO - Cleaning up... 04:14:00 INFO - Return code: 0 04:14:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:00 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 04:14:00 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 04:14:00 INFO - Using env: {'DISPLAY': ':0', 04:14:00 INFO - 'HOME': '/home/cltbld', 04:14:00 INFO - 'LANG': 'en_US.UTF-8', 04:14:00 INFO - 'LANGUAGE': 'en_US:en', 04:14:00 INFO - 'LOGNAME': 'cltbld', 04:14:00 INFO - 'MAIL': '/var/mail/cltbld', 04:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:00 INFO - 'MOZ_NO_REMOTE': '1', 04:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:00 INFO - 'NO_EM_RESTART': '1', 04:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:00 INFO - 'PWD': '/builds/slave/test', 04:14:00 INFO - 'SHELL': '/bin/bash', 04:14:00 INFO - 'SHLVL': '1', 04:14:00 INFO - 'TERM': 'linux', 04:14:00 INFO - 'TMOUT': '86400', 04:14:00 INFO - 'USER': 'cltbld', 04:14:00 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:00 INFO - '_': '/tools/buildbot/bin/python'} 04:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:00 INFO - Running setup.py (path:/tmp/pip-uDF1gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:00 INFO - Running setup.py (path:/tmp/pip-4pBOFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:00 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)) 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:00 INFO - Running setup.py (path:/tmp/pip-PTMyOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:01 INFO - Running setup.py (path:/tmp/pip-ddTgOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:01 INFO - Running setup.py (path:/tmp/pip-u4pkf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:01 INFO - Running setup.py (path:/tmp/pip-lluSw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:01 INFO - Running setup.py (path:/tmp/pip-zmjwN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:01 INFO - Running setup.py (path:/tmp/pip-w4tF3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:01 INFO - Running setup.py (path:/tmp/pip-VoRViY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:01 INFO - Running setup.py (path:/tmp/pip-yr0pg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:01 INFO - Running setup.py (path:/tmp/pip-ZtFWBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:01 INFO - Running setup.py (path:/tmp/pip-cFtx4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:01 INFO - Running setup.py (path:/tmp/pip-_repcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:01 INFO - Running setup.py (path:/tmp/pip-wP21aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:01 INFO - Running setup.py (path:/tmp/pip-No6YRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:01 INFO - Running setup.py (path:/tmp/pip-umDTDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:01 INFO - Running setup.py (path:/tmp/pip-jez2Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:14:02 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)) 04:14:02 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)) 04:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:14:02 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)) 04:14:02 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)) 04:14:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:03 INFO - Downloading blessings-1.5.1.tar.gz 04:14:03 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 04:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:03 INFO - Installing collected packages: blessings 04:14:03 INFO - Running setup.py install for blessings 04:14:03 INFO - Successfully installed blessings 04:14:03 INFO - Cleaning up... 04:14:03 INFO - Return code: 0 04:14:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:04 INFO - Reading from file tmpfile_stdout 04:14:04 INFO - Current package versions: 04:14:04 INFO - argparse == 1.2.1 04:14:04 INFO - blessings == 1.5.1 04:14:04 INFO - blobuploader == 1.2.4 04:14:04 INFO - docopt == 0.6.1 04:14:04 INFO - manifestparser == 1.1 04:14:04 INFO - mozInstall == 1.12 04:14:04 INFO - mozcrash == 0.16 04:14:04 INFO - mozdebug == 0.1 04:14:04 INFO - mozdevice == 0.47 04:14:04 INFO - mozfile == 1.2 04:14:04 INFO - mozhttpd == 0.7 04:14:04 INFO - mozinfo == 0.9 04:14:04 INFO - mozleak == 0.1 04:14:04 INFO - mozlog == 3.1 04:14:04 INFO - moznetwork == 0.27 04:14:04 INFO - mozprocess == 0.22 04:14:04 INFO - mozprofile == 0.27 04:14:04 INFO - mozrunner == 6.11 04:14:04 INFO - mozscreenshot == 0.1 04:14:04 INFO - mozsystemmonitor == 0.0 04:14:04 INFO - moztest == 0.7 04:14:04 INFO - mozversion == 1.4 04:14:04 INFO - psutil == 3.1.1 04:14:04 INFO - requests == 1.2.3 04:14:04 INFO - wsgiref == 0.1.2 04:14:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:04 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 04:14:04 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 04:14:04 INFO - Using env: {'DISPLAY': ':0', 04:14:04 INFO - 'HOME': '/home/cltbld', 04:14:04 INFO - 'LANG': 'en_US.UTF-8', 04:14:04 INFO - 'LANGUAGE': 'en_US:en', 04:14:04 INFO - 'LOGNAME': 'cltbld', 04:14:04 INFO - 'MAIL': '/var/mail/cltbld', 04:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:04 INFO - 'MOZ_NO_REMOTE': '1', 04:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:04 INFO - 'NO_EM_RESTART': '1', 04:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:04 INFO - 'PWD': '/builds/slave/test', 04:14:04 INFO - 'SHELL': '/bin/bash', 04:14:04 INFO - 'SHLVL': '1', 04:14:04 INFO - 'TERM': 'linux', 04:14:04 INFO - 'TMOUT': '86400', 04:14:04 INFO - 'USER': 'cltbld', 04:14:04 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:04 INFO - '_': '/tools/buildbot/bin/python'} 04:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:14:04 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)) 04:14:04 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)) 04:14:04 INFO - Cleaning up... 04:14:04 INFO - Return code: 0 04:14:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:04 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 04:14:04 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 04:14:04 INFO - Using env: {'DISPLAY': ':0', 04:14:04 INFO - 'HOME': '/home/cltbld', 04:14:04 INFO - 'LANG': 'en_US.UTF-8', 04:14:04 INFO - 'LANGUAGE': 'en_US:en', 04:14:04 INFO - 'LOGNAME': 'cltbld', 04:14:04 INFO - 'MAIL': '/var/mail/cltbld', 04:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:04 INFO - 'MOZ_NO_REMOTE': '1', 04:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:04 INFO - 'NO_EM_RESTART': '1', 04:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:04 INFO - 'PWD': '/builds/slave/test', 04:14:04 INFO - 'SHELL': '/bin/bash', 04:14:04 INFO - 'SHLVL': '1', 04:14:04 INFO - 'TERM': 'linux', 04:14:04 INFO - 'TMOUT': '86400', 04:14:04 INFO - 'USER': 'cltbld', 04:14:04 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:04 INFO - '_': '/tools/buildbot/bin/python'} 04:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:04 INFO - Downloading/unpacking jsonschema 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:06 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 04:14:06 INFO - Downloading/unpacking functools32 (from jsonschema) 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:06 INFO - warning: no files found matching '*.txt' 04:14:06 INFO - no previously-included directories found matching 'build' 04:14:06 INFO - no previously-included directories found matching 'dist' 04:14:06 INFO - no previously-included directories found matching '.git*' 04:14:06 INFO - Installing collected packages: jsonschema, functools32 04:14:06 INFO - Running setup.py install for functools32 04:14:06 INFO - warning: no files found matching '*.txt' 04:14:06 INFO - no previously-included directories found matching 'build' 04:14:06 INFO - no previously-included directories found matching 'dist' 04:14:06 INFO - no previously-included directories found matching '.git*' 04:14:06 INFO - Successfully installed jsonschema functools32 04:14:06 INFO - Cleaning up... 04:14:06 INFO - Return code: 0 04:14:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:06 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 0x7f3cfcd91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:06 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 04:14:06 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 04:14:06 INFO - Using env: {'DISPLAY': ':0', 04:14:06 INFO - 'HOME': '/home/cltbld', 04:14:06 INFO - 'LANG': 'en_US.UTF-8', 04:14:06 INFO - 'LANGUAGE': 'en_US:en', 04:14:06 INFO - 'LOGNAME': 'cltbld', 04:14:06 INFO - 'MAIL': '/var/mail/cltbld', 04:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:06 INFO - 'MOZ_NO_REMOTE': '1', 04:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:06 INFO - 'NO_EM_RESTART': '1', 04:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:06 INFO - 'PWD': '/builds/slave/test', 04:14:06 INFO - 'SHELL': '/bin/bash', 04:14:06 INFO - 'SHLVL': '1', 04:14:06 INFO - 'TERM': 'linux', 04:14:06 INFO - 'TMOUT': '86400', 04:14:06 INFO - 'USER': 'cltbld', 04:14:06 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:06 INFO - '_': '/tools/buildbot/bin/python'} 04:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:06 INFO - Downloading/unpacking flake8 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:08 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 04:14:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:08 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 04:14:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:09 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 04:14:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:09 INFO - no previously-included directories found matching 'docs/_build' 04:14:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:09 INFO - Running setup.py install for pep8 04:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:09 INFO - no previously-included directories found matching 'docs/_build' 04:14:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:09 INFO - Cleaning up... 04:14:09 INFO - Return code: 0 04:14:09 INFO - Running post-action listener: _resource_record_post_action 04:14:09 INFO - Running post-action listener: _start_resource_monitoring 04:14:09 INFO - Starting resource monitoring. 04:14:09 INFO - ##### 04:14:09 INFO - ##### Running install step. 04:14:09 INFO - ##### 04:14:09 INFO - Running pre-action listener: _resource_record_pre_action 04:14:09 INFO - Running main action method: install 04:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:09 INFO - Reading from file tmpfile_stdout 04:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:09 INFO - Reading from file tmpfile_stdout 04:14:09 INFO - Output received: 04:14:09 INFO - Usage: mozinstall [options] installer 04:14:09 INFO - Options: 04:14:09 INFO - -h, --help show this help message and exit 04:14:09 INFO - -d DEST, --destination=DEST 04:14:09 INFO - Directory to install application into. [default: 04:14:09 INFO - "/builds/slave/test"] 04:14:09 INFO - --app=APP Application being installed. [default: firefox] 04:14:09 INFO - mkdir: /builds/slave/test/build/application 04:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:14:24 INFO - Reading from file tmpfile_stdout 04:14:24 INFO - Output received: 04:14:24 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:24 INFO - Running post-action listener: _resource_record_post_action 04:14:24 INFO - ##### 04:14:24 INFO - ##### Running run-tests step. 04:14:24 INFO - ##### 04:14:24 INFO - Running pre-action listener: _resource_record_pre_action 04:14:24 INFO - Running main action method: run_tests 04:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:24 INFO - Python 2.7.3 04:14:24 INFO - Return code: 0 04:14:24 INFO - grabbing minidump binary from tooltool 04:14: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')]} 04:14:24 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 0x10310b0>, '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 0x1031fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:14:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:14:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:24 INFO - Return code: 0 04:14:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:25 INFO - Return code: 0 04:14:25 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/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test/build 04:14:25 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/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 04:14:25 INFO - Using env: {'DISPLAY': ':0', 04:14:25 INFO - 'HOME': '/home/cltbld', 04:14:25 INFO - 'LANG': 'en_US.UTF-8', 04:14:25 INFO - 'LANGUAGE': 'en_US:en', 04:14:25 INFO - 'LOGNAME': 'cltbld', 04:14:25 INFO - 'MAIL': '/var/mail/cltbld', 04:14:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:25 INFO - 'MOZ_NO_REMOTE': '1', 04:14:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:25 INFO - 'NO_EM_RESTART': '1', 04:14:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:25 INFO - 'PWD': '/builds/slave/test', 04:14:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:25 INFO - 'SHELL': '/bin/bash', 04:14:25 INFO - 'SHLVL': '1', 04:14:25 INFO - 'TERM': 'linux', 04:14:25 INFO - 'TMOUT': '86400', 04:14:25 INFO - 'USER': 'cltbld', 04:14:25 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604', 04:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:25 INFO - '_': '/tools/buildbot/bin/python'} 04:14:25 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/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 04:14:25 INFO - mozversion INFO | application_buildid: 20151215031211 04:14:25 INFO - mozversion INFO | application_changeset: 038664873a7bb62ef3fc904511dc063a28e601a4 04:14:25 INFO - mozversion INFO | application_display_name: Nightly 04:14:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:25 INFO - mozversion INFO | application_name: Firefox 04:14:25 INFO - mozversion INFO | application_remotingname: firefox 04:14:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:14:25 INFO - mozversion INFO | application_vendor: Mozilla 04:14:25 INFO - mozversion INFO | application_version: 46.0a1 04:14:25 INFO - mozversion INFO | platform_buildid: 20151215031211 04:14:25 INFO - mozversion INFO | platform_changeset: 038664873a7bb62ef3fc904511dc063a28e601a4 04:14:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:14:25 INFO - mozversion INFO | platform_version: 46.0a1 04:14:25 INFO - 2015-12-15 04:14:25,613 DEBUG : using testdate: 1450181665 04:14:25 INFO - 2015-12-15 04:14:25,613 DEBUG : actual date: 1450181665 04:14:25 INFO - 2015-12-15 04:14:25,624 INFO : starting webserver on 'localhost:59090' 04:14:25 INFO - 2015-12-15 04:14:25,625 INFO : Starting test suite talos-linux64-ix-060 04:14:25 INFO - 2015-12-15 04:14:25,625 INFO : Starting test dromaeo_css 04:14:25 INFO - 2015-12-15 04:14:25,626 DEBUG : operating with platform_type : linux_ 04:14:25 INFO - 2015-12-15 04:14:25,626 INFO : Initialising browser for dromaeo_css test... 04:14:25 INFO - 2015-12-15 04:14:25,642 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmxzZPX/profile http://localhost:59090/getInfo.html 04:14:29 INFO - 2015-12-15 04:14:29,549 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:14:29 INFO - 2015-12-15 04:14:29,549 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:14:29 INFO - 2015-12-15 04:14:29,549 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:14:29 INFO - 2015-12-15 04:14:29,549 DEBUG : BROWSER_OUTPUT: __metrics 04:14:29 INFO - 2015-12-15 04:14:29,706 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] 04:14:29 INFO - 2015-12-15 04:14:29,767 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] 04:14:31 INFO - 2015-12-15 04:14:31,161 INFO : Browser initialized. 04:14:31 INFO - 2015-12-15 04:14:31,162 INFO : Running cycle 1/1 for dromaeo_css test... 04:14:31 INFO - 2015-12-15 04:14:31,162 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmxzZPX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:14:43 INFO - 2015-12-15 04:14:43,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 143396864 04:14:43 INFO - 2015-12-15 04:14:43,149 DEBUG : BROWSER_OUTPUT: 04:15:34 INFO - 2015-12-15 04:15:34,385 DEBUG : BROWSER_OUTPUT: 1450181734383 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] 04:17:46 INFO - 2015-12-15 04:17:46,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59090/tests/dromaeo/cssquery-ext.html) 04:17:47 INFO - 2015-12-15 04:17:47,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 256393216 04:17:47 INFO - 2015-12-15 04:17:47,384 DEBUG : BROWSER_OUTPUT: 04:20:49 INFO - 2015-12-15 04:20:49,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/dromaeo/cssquery-ext.html (next: http://localhost:59090/tests/dromaeo/cssquery-jquery.html) 04:20:50 INFO - 2015-12-15 04:20:50,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 216309760 04:20:50 INFO - 2015-12-15 04:20:50,433 DEBUG : BROWSER_OUTPUT: 04:23:52 INFO - 2015-12-15 04:23:52,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59090/tests/dromaeo/cssquery-mootools.html) 04:23:53 INFO - 2015-12-15 04:23:53,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 219312128 04:23:53 INFO - 2015-12-15 04:23:53,036 DEBUG : BROWSER_OUTPUT: 04:26:54 INFO - 2015-12-15 04:26:54,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59090/tests/dromaeo/cssquery-prototype.html) 04:26:55 INFO - 2015-12-15 04:26:55,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 200318976 04:26:55 INFO - 2015-12-15 04:26:55,586 DEBUG : BROWSER_OUTPUT: 04:29:58 INFO - 2015-12-15 04:29:58,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59090/tests/dromaeo/cssquery-yui.html) 04:29:58 INFO - 2015-12-15 04:29:58,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 208060416 04:29:58 INFO - 2015-12-15 04:29:58,854 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/dromaeo/cssquery-yui.html (next: http://localhost:59090/tests/dromaeo/cssquery-dojo.html) 04:33:01 INFO - 2015-12-15 04:33:01,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 252080128 04:33:01 INFO - 2015-12-15 04:33:01,440 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,440 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:33:01 INFO - 2015-12-15 04:33:01,440 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:33:01 INFO - 2015-12-15 04:33:01,440 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:33:01 INFO - 2015-12-15 04:33:01,440 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:33:01 INFO - 2015-12-15 04:33:01,440 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2576.267804135798;2682.7853771698265;2691.542437785576;2697.716739742327;2714.321419645088;4425.7123286986325;4580.290055041474;4643.489216186217;4686.367340409044;4697.624190064796;4625.514320996297;4637.675362724611;4689.366935463711;4699.436067671884;4805.8558243252755;4227.1334376452905;4280.486341639008;4310.5042920064125;4401.427814384126;4435;4373.650107991353;4426.77866106695;4429.822807087713;4431.468223813131;4446.799894004761;4133.3386658134705;4174.958250417488;4235.428217190671;4247.214265360918;4277.059047009653;4282;4296.462942132233;4313.547077556843;4334.761588112652;4336.436263285753;4042.4744783178294;4271.700980931336;4278.165757677254;4328.545502722201;4332.4367832181615;4467.597916187558;4549.13566422382;4564.931526027112;4586.839460618862;4590.127875703605;4979.45226025137;4983.875403114951;4986.052649996489;4990.451050384455;4998.800047998076;4783.234682450826;4982.6013918886765;4993.7503124843615;5011.949880501184;5018.498150184989;4448.888777780581;4457.3091170868565;4470;4521.773911304422;4581.496035436099;4975.303457515951;4989.451160372356;4990.700557966534;4996.800127994912;5011.323471331397;4679.461861885927;4808.134535783593;4851.878703032452;4893.09477746618;4941.382327209099;4898.608111351084;4920.089783390084;4942.233953737176;4946.9010619787405;5006.048850718352;4976.552110310017;4989.725565093955;4995;5014.6991180529285;5044.167712327425;4663.743494107789;4958.528939750718;4980.551750342486;4984.127777638899;5012.072766538202;4089.672826173899;4108.568600296926;4127.525334586501;4170.47869016373;4177.728447650893;3649.708023358125;3655.798931058764;3660.213054193308;3689.317476266899;3692.058525076142;4324.610785029363;4325.4593175853015;4328.8268469260875;4332.371806088099;4363.825446982149;4714;4774;4817.686850354716;4879.243717223836;4984.925226121611;4296.334068219431;4341.110072435144;4360.672949528798;4361.956380436219;4402.559744025636;4453.042595841909;4455.509893911667;4455.910881782346;4458.375827384169;4493.393391892053;4556.886077848014;4676.251799712029;4685.1332503486965;4727.550882666142;4865.878353041202;4923.581495572773;4937.284093806306;4940.110780059624;4955;4992.975035124801;4728.38530990969;4728.929066064081;4729.219678752967;4729.858104256878;4779.06808172403;4680.859574212779;4784.47370789206;4788.209945358977;4813.614910807197;4933.605311575137;4920.40955085392;4950.4059512858685;4950.752462376939;4957.454679985127;4998.050370429607;4793.712377257376;4794.328793968777;4795.616350692006;4800.423949126127;4836.105320515716;4609.608183304456;4721.386219791405;4724.4094488188975;4753.619710423227;4908.9754551227015;4716.905661886812;4751.786169622306;4766.809327626856;4772.451168115711;4804.111239420718;4847.466778654416;4863.270509423614;4865.9756701216265;4866.9269960949905;4915.582175514978;4468.64250859924;4583.03756211186;4604.8388306409115;4661.370714953574;4759.928601071056 04:33:01 INFO - 2015-12-15 04:33:01,443 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.7513556467374;583.1806312131454;588.0003993211536;593.0599999001582;601.6269912654155;27530.587041194372;28099.57850632242;28109.437811243763;35875.82062089686;36510;40369.19261614773;40912;40941;40984.38523422144;40998.59001409985;7853.253940875622;8020.919790802076;8021.799455013642;8021.879671804928;8023.157568455315;7206.351428371446;7408.444366672494;10283.023112804272;10545.6309029184;10582.629607963723;10162.796744065114;10253.487325633689;10256.230782691327;10264.384136951807;10267.845982310271;7148.892766608505;7316.414686825041;10148;10273.12678422335;10284.43435611041;9959.701208963743;10327.018933201334;10331.48342582868;10332.58669653213;10332.690019299433;37725.811370943244;37980.81009594962;37998.81000595007;38059;38348.424773628416;2994.8352840593757;3003.3692924485667;3012.6686064532882;3090.304681446679;3562.305350456662;27697.584536231974;27765;28129.718702812916;29547.556786648216;30561.69438305633;3295.3244584860286;3348.1294863335465;3380.323935212967;3404.455287154068;3423.9828800856085;212152;213777;214159.92920035456;214348;215050;51651.74174129105;53132.734336328074;53539.464605354224;56656.71671641698;57083.71458142683;62087.37912620906;63382;63537.36462635407;63603.36396635974;63739;14319.427222911176;14722.852771472362;14723.263836808117;14731.852681473049;14736.852631473763;9675.612975481043;9679;9682.806343873082;9687.41875487473;9742.61029558824;19198.74484258403;19650.21399144047;19681.311154109822;19711.901440492707;19802.108905099307;7859.253370929752;7901.209879012168;8025.197480251928;8045.879311810328;8065.475744076616;801.6673080671457;846.4582667093065;847.9364047696447;874.6107981947972;1005.9144972677258;25470.84844775531;25491.23526294214;25492.617610735855;25701;25810.35474113162;918.4213945214606;928.7028150991617;993.2897977945803;1004.1514919892679;1085.6688709943544;13337.799933001013;15543.533693989199;16728.665426691397;16749.497515074567;17007.914960425118;369655;373169;374985;377879;379058;48047;48340.27489587659;48783.17035615017;48788;48790.26814597784;1141.9371934543515;1142.2061667141256;1165.7726743284977;1224.2960297828783;1255.918365306252;27575.586366204123;28860.42279154447;29001.56497652579;29273.121806345844;29427;42656.57343426526;43697.78151109224;43910;44051.77974110109;44077.11845763003;228608;234670;245173;336146;345405;39336.6066339333;39906.60093399029;39962.60037399589;39975.801935845644;40024.59975400209;41397;41528.37707434451;42051.36922946097;42253.36619950765;42545;34380.14049648779;35692.46461303031;36353.27293454169;36726.08184795295;38855;33259.66740332566;34134.14664633304;34283.314333713686;36602.8169859149;40548.39177412282;33310.83344583261;33985.830070850476;34182;34184.14539636529;34197.82901085479;29143;30274.69725302719;30875.845620771754;30977;31038.844805775825;23757.64363534514;24315.270541883772;25695.614565781903;25843.741562584884;26060.609090863272 04:33:01 INFO - 2015-12-15 04:33:01,443 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.81530343007904;334.3246641783598;334.43814391821735;334.78908287778694;336.7338806089104;11816.704582385444;12307.0154387649;14861.777073343896;15192.772108418383;15809.762853557206;10020;10128.898711012887;10281.691549253534;10363.948180259089;10482.475876206197;4492.865214043584;4559.817607295704;4604.1252162089095;4614.215583350821;4618.237990731525;3390.0846771371716;4512.278035514319;4618.792154353046;5086.41506226785;5113.181890897457;5042.092423363793;5083.517065878736;5093.185090385539;5104.106781313274;5120.974395128038;4922.827701030465;5018.548330650259;5027.572656324235;5029.471905449912;5082.1360368737405;4846.9515304846855;4864.683795553277;4864.854054378375;4866.683665561763;4867.415910090812;10643.627473038407;12715.491380344774;16625.251863666163;19409.417717468357;19463.318783842496;1827.5248435406756;1842.4942078772858;1845.4186931116656;1908.1031914999928;1925.3357591630865;7922.247386498273;8156.265936065783;8275.875861862078;8367;9082.818343633091;1696.4656133317965;1700.217899766109;1713.7001024820606;1739.173892401112;1756.5169578365924;50333.74833125847;51293.974120517756;51922.740386297824;54874.72562637201;56027.43972560263;8866.916274675446;8870.201681848665;8894.377393582387;9089.863652045224;9142.954285228532;11297.435128243555;11322.886771132184;11332.830007549894;11347.716307092389;11351.318920864775;6761.560498567577;6772.085768421299;6785.762498312535;7061;7089.042979197846;6579.309172536815;6595.241547222035;6612.404883560503;6614.8346291343105;6645.202575690948;3795.8481660733814;3807.0862992881507;3849.3263678856088;3941.994791328193;4172.18642364742;1487.8660920517204;1514.863662270401;1531.8238402583622;1706.223668230952;1732.740088986637;735.782944031512;856.0455092571738;863.8185980944072;867.128535821508;939.9013103624021;14101.858981410054;14748;16576.336946522006;16885.15574221284;16992.74510882338;859.3383095016927;868.9435186712843;875.4309698695771;884.4428010353436;901.7610333261691;9092.499912504743;9232.815343693088;9232.815343693223;9234.122758337948;9432.717018489457;457437;469775;479976;480587;482201;74000.62999685075;75041.62479187569;76699.61650191713;77425.61287193529;78248.21751782524;1090.8581884354983;1105.90599799018;1110.2228440091967;1110.9666709998712;1122.0294445304917;13751.312434378442;14261.646828273218;14380;14528.418863245352;14840.332185051482;33211.33577328488;33400.33199336048;33931.83034084814;34183.65816341805;34618.48072278868;39658;42110.57889421067;42912.78543607387;43701.78149109234;46580.30129547992;8144.918550814416;8212.876806847782;8305.792355191168;8439.746807595782;8459.534725589905;9667.27495437859;9746.658866939622;15466.922665387052;15485.84514154889;16520;8993;12774.808377874153;13235.735285294048;13334.33328333599;13790.103643263155;11597.942010289895;12674.429650665557;13117.868821311664;13371.598852034454;13388.665283367995;13421.932890335876;13538.79691804604;14169.929150354183;14939.925300373428;15132.092074475566;8116.634751436318;8233.50598964064;8326.209010144026;8343.958280208803;8420.915790842013;8738.650453981769;11071.72320691989;13811.309434528433;14012.089214201043;14773.482928097465 04:33:01 INFO - 2015-12-15 04:33:01,445 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1444.3283872999054;1661.4018953176853;1677.983220167798;1709.1881356355725;1730.7663465432167;5749.655020698756;6593.967030164848;6678.131842860422;6706.094677218574;6710.7315707371645;6705.362990515893;6859.3826555609985;6874.312568743123;6879.208890977539;6884.621345825977;2011.9195232190732;2042.5404284036122;2051.3333166720877;2053.3326668832615;2054.5685406064745;1987.165390535971;2020.171729590868;2020.6160829442358;2054.0551346380685;2062.4328309714797;1971.221367559813;2008.9698654520193;2043.632146213681;2045.1103769860083;2045.5908818236337;2029.3201777404513;2061.2373421833868;2061.783512731164;2061.9690704639443;2063.3500447359183;2002.5994801039851;2017.7074324222906;2021.6866385710239;2024.817766401031;2052.332991777678;6830.180378354629;6908.378245957838;6912.412444942186;6918.654067296615;6921.757738479129;4010.1177740897247;4071.796410179479;4071.9389209161886;4074.286999775057;4078.4086307485545;2579.1746641074865;2598.9350266243305;2630.447606002742;2634.394089359458;2636.327736427218;806.4193780478047;814.9918500814975;820.7209548753452;821.6056292979343;841.1042240014426;9119.179273865318;9129.315301352424;9139;9144.314176436794;9154.67958621445;3660.670539651444;3682.779033258013;3716.498272733146;3724.478572999782;3743.831527581265;7883.960580197062;7893.407994400443;7893.486923349964;7904.20957904205;7918.881216781753;4043.534993475729;4068.6745060395097;4074.409210664496;4088.9591104089172;4097.057676734308;3160.083575763003;3224.6452890182063;3596.946045809315;3719.237556300952;3719.497867787868;3222.6777322267585;3284.786488878215;3307.4212012897647;3325.1022223999385;3336.899893003214;1022.1260821997234;1040.6825918094903;1047.874255089379;1049.9790004199874;1057.4818339013827;776.4487214078068;825.6325934958886;871.6644092024616;921.0283151275469;971.0192705367489;6266.404691554295;6311.400416960381;6325.557210995186;6341.55609107358;6345.016522439029;991.4497453913148;1019.6940917724653;1019.8623185869961;1029.1766586730585;1038.678009816944;4982.576480999156;5032.899342013139;5037.596992240612;5044.621653376012;5051;7444.478886477895;7777.144514103444;8007.83984320322;8079.555624440713;8114.7565573031725;7505.061867266591;7514.887276690854;7515.586642734593;7554.508956917783;7631.236876312435;6425.1968503937005;6483.805485835527;6490.221173459215;6518.284577790614;6550.639714815731;6259.624422534663;6352.333005034589;6355.269144048493;6358.618482891041;6368.617882927039;7140.036095127091;7304.19653838088;7338.889916651147;7346.265373462611;7356.44826638015;7199;7453.515521491086;7454.068241469817;7471.663775130023;7479.17729049815;6112.572119951561;6174.938250617436;6193.071039344134;6197.25632924052;6206.72069756853;6526.184226971629;6574.309697481887;6581.14445122131;6595.406413422815;6597.6701164940605;5797.507211887037;5967.522598192221;6049.78825741097;6389.680515974275;6407.455366293917;5207.661502002357;5340.065488539568;5907.9704601476715;6173.753049878134;6242.531810114168;6017.277926648655;6069.3020302665755;6074.7266373012435;6082.60463069899;6099;5614.185943038318;5654.378018417889;5658.688772117573;5666.490015898589;5668.716564171693;5694.316681998187;5694.373618901835;5710.8001219957105;5711.228984087095;5715.542756579381 04:33:01 INFO - 2015-12-15 04:33:01,446 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.9539721343192;298.46574631409777;305.3404645964715;305.88223533939424;306.61060453224417;5138.8972220555615;5259.973700131503;5262.605304602161;5298.682079075254;5388.973055134728;5241.3186285782895;5318.228856815769;5321.680699158043;5322.441143679906;5337.039332920072;3860.285847118278;4105.363668631352;4106.117184805266;4108.198901214264;4109.157622687342;3921.745086569364;3930.3711406175016;3950.6246906543975;4055.3105971984833;4091.672666186713;4025.496812898388;4052.5136983562015;4052.9797351013203;4055.959440405588;4070.8778736637946;3799.715021373408;4034.838606455753;4044.69664775143;4046.6358027777496;4047.190561887605;3349.581302337208;3442.0706409269355;3504.1064528545057;3540.13266749648;3550.236699109678;5089.033083714083;5100.770465329069;5102.846914592568;5109.9489005109845;5111.10555652763;4630.652701047435;4635.304704294383;4642.744649044301;4651.558101980307;4651.604613607814;5386.48828361305;5508.283923090013;5510.008198524264;5518.420565840569;5518.779248830042;3841.2701586698436;3851.959970807894;3855.6722678572355;3864.903377415559;3873.8837834865;5634.0703783875615;5702.173184888209;5704.71476426177;5714.142878568248;5715.971420142914;3927.096767743435;3935.5080614923136;3935.901602459904;3939.1727737174942;3939.783311917872;3996.540397854226;3998.9402808255836;4001.15975645112;4004.619561141687;4006.1386801837743;4458.598726114666;4561.498235194126;4562.475315338712;4569.337446070301;4572;5406.567474602022;5425.674459532362;5426.050441172779;5426.782928682808;5430.456954304617;1401.5515035188641;1417.3267697843648;1417.978730319046;1420.5809286260578;1420.8136206267882;937.6062053937362;944.1738478831023;961.9951900240454;964.5707660091332;971.9902800972042;4857.489963553776;4870.318155458239;4871.926921096187;4873.342098816685;4875.366202393737;5742.138679198154;5743.597948143673;5745.511631511285;5752.424757524298;5754.079347304495;4854.2233242681;4867.707937523689;4868.513148685103;4868.78090485929;4869.513048695102;3016.9547456788164;3073.72336489717;3100.1009707185117;3102.991527753489;3109.4247564200696;5286.735663216824;5375.543078838265;5434.809781657623;5518.889622207614;5519.172124181405;5945.316288626776;5952.0476723724;5954.136650185786;5962.105684147413;5966.0454327307425;5497.560195184456;5497.670139791545;5501.339839219319;5502.422245664227;5507.256520369859;5576.052071147996;5763.164341170423;5786.797462088806;5789.102689083199;5817.621854579439;5658.773649053992;5668.7732490701555;5668.943310567007;5675.545956323567;5677.233573467694;5498.642588231752;5507.311586051744;5512.972435137799;5518.944810551843;5520.309961254843;3972.2849887019456;3985.063510075188;4010.7994600269285;4011.1576568920855;4014.3577027675433;5651.773929042793;5787.8553036174435;5793.594448388572;5794.391588883106;5800.912986305125;5542.944570554243;5553.16702494629;5567.137093750313;5567.77728890856;5572.832815015556;5536.529395001309;5554.361248456317;5557.138643510262;5563.443655634566;5564.860878478071;5301.787928482818;5432.7555260012605;5458.781648734165;5461.863453413696;5472.069748142905;5565.888682226414;5570.916436253378;5571.0807716726285;5573.303337082864;5574.16387541872;5473.31583552056;5482.150266708666;5486.259354987025;5486.61593688438;5489.1217405214975 04:33:01 INFO - 2015-12-15 04:33:01,446 DEBUG : BROWSER_OUTPUT: |5;yui.html;776.518558493734;787.2835719495259;791.1455627921841;795.5544894858875;796.1202870827735;11391.088712902969;11856.881431185697;11945;11947.46236419361;11948.522059117646;11609.477573509192;11954;12032.398380080982;12039.398030098504;12051.939740301286;807.4670717326551;819.7950512371907;820.8604537228686;821.0885916632533;821.954792486413;809.8704207326829;818.2308629887916;818.5988865455944;818.7953011747063;818.8444195602816;838.1157878438245;849.4733265375476;849.5327569836596;850.1540966738104;850.8723691446271;841.2176675691635;841.5497708725802;841.6128580852815;841.9326453883705;843.3211264931697;623.1338439569003;625.4464798653224;626.2172284644195;626.5707990026846;627.075064280183;11147;11250.212485126045;11272.041876440513;11278.210525263235;11302.660920172408;9469.66856160038;9738.659146929895;9756.268279878966;9828.11546960777;10039.347442416292;8552.828943421158;8773.385862989593;8783.64865405383;8786.165314295196;8814.735557933209;3285.4743241081314;3303.8513266902805;3323.9501407478906;3333.4333163362285;3340.7828491148;34577.48133777995;34648.480272795925;38684;39427.8028609858;40317.79841100776;8409.789755256168;8716.128387161232;9065.954670226738;9364.62541498346;9539.856902146474;16452.588685282964;16487.83512164887;16503.09232992197;16614.83385166133;16626.83373166277;6409.327020662857;6634.270230274666;6669.399754022162;6774.051632771416;6911.343422374866;3565.6434356564655;3574.928501430009;3575.713942884563;3601.099725068733;3634.309481198564;2587.896484140613;2592.066855931863;2617.7774889134257;2618.201448558208;2622.1871219921886;457.12688764460387;461.3057348690267;464.1042787420244;469.0665575504721;473.8981119059419;463.2009783124084;470.4237309296153;501.653858837401;520.6849855837239;550.8127236739527;7336.303051210127;7444.776656700307;7573.659185336563;7725.884111738328;7816.257455541714;486.47946697033836;531.264199084271;572.2932178759229;594.785877084258;599.8470390050509;3517.1854556670382;3549.467579863041;3568.4825700273313;3601.819909004539;3655.908602284911;46662;47425.76287118543;51882.74058629683;52424;52549.21176182284;41409.378859317134;42219.788901055916;42301.36547951783;42483.57516424858;42752.57247427486;33564;35141;37683;38636.2272754549;39123;7571.621418929141;7623.847523049619;7992.600369981594;8140.83718325642;8164.306033987177;30065.699343007163;30805.537916930814;30840.845795771776;31022.379552408373;31341.216469588442;34261.314773704886;35381;35865.64134358623;37418.251634966604;38215;9707.6116955321;10301.9484902575;10576.36541807494;10721.731956701145;10900.400477973788;11625.941870290595;11699.590514331958;11964.880351196376;12024.639260822189;12040;10683.786324273626;10696.786064278827;10796.244262901835;10864.293820901616;11338.489767960627;10630.8405373921;10653.680389588015;10720.624778132727;10804.621838235624;10812.945935270587;10653.414062226651;10811;10825.56697732082;10909.890901090888;11061.281016733887;9340.579673914826;9376.156145946898;9446.102620251066;9653.082957119062;9735.41587504752;8726.432781869158;8808.20726134651;8835.20483156519;8926.285897128084;9326.626934922528 04:33:01 INFO - 2015-12-15 04:33:01,446 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:33:01 INFO - 2015-12-15 04:33:01,446 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:33:01 INFO - 2015-12-15 04:33:01,447 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 04:33:01 INFO - 2015-12-15 04:33:01,447 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:33:01 INFO - 2015-12-15 04:33:01,447 DEBUG : BROWSER_OUTPUT: __startTimestamp1450182781437__endTimestamp 04:33:01 INFO - 2015-12-15 04:33:01,447 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,447 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:33:01 INFO - 2015-12-15 04:33:01,447 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:33:01 INFO - 2015-12-15 04:33:01,447 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,447 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4573.36 Median:4689.37 stddev:459.89 (9.8%) stddev-sans-first:433.80 04:33:01 INFO - 2015-12-15 04:33:01,449 DEBUG : BROWSER_OUTPUT: Values: 2576.3 2682.8 2691.5 2697.7 2714.3 4425.7 4580.3 4643.5 4686.4 4697.6 4625.5 4637.7 4689.4 4699.4 4805.9 4227.1 4280.5 4310.5 4401.4 4435.0 4373.7 4426.8 4429.8 4431.5 4446.8 4133.3 4175.0 4235.4 4247.2 4277.1 4282.0 4296.5 4313.5 4334.8 4336.4 4042.5 4271.7 4278.2 4328.5 4332.4 4467.6 4549.1 4564.9 4586.8 4590.1 4979.5 4983.9 4986.1 4990.5 4998.8 4783.2 4982.6 4993.8 5011.9 5018.5 4448.9 4457.3 4470.0 4521.8 4581.5 4975.3 4989.5 4990.7 4996.8 5011.3 4679.5 4808.1 4851.9 4893.1 4941.4 4898.6 4920.1 4942.2 4946.9 5006.0 4976.6 4989.7 4995.0 5014.7 5044.2 4663.7 4958.5 4980.6 4984.1 5012.1 4089.7 4108.6 4127.5 4170.5 4177.7 3649.7 3655.8 3660.2 3689.3 3692.1 4324.6 4325.5 4328.8 4332.4 4363.8 4714.0 4774.0 4817.7 4879.2 4984.9 4296.3 4341.1 4360.7 4362.0 4402.6 4453.0 4455.5 4455.9 4458.4 4493.4 4556.9 4676.3 4685.1 4727.6 4865.9 4923.6 4937.3 4940.1 4955.0 4993.0 4728.4 4728.9 4729.2 4729.9 4779.1 4680.9 4784.5 4788.2 4813.6 4933.6 4920.4 4950.4 4950.8 4957.5 4998.1 4793.7 4794.3 4795.6 4800.4 4836.1 4609.6 4721.4 4724.4 4753.6 4909.0 4716.9 4751.8 4766.8 4772.5 4804.1 4847.5 4863.3 4866.0 4866.9 4915.6 4468.6 4583.0 4604.8 4661.4 4759.9 04:33:01 INFO - 2015-12-15 04:33:01,449 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,449 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45505.63 Median:18853.65 stddev:78313.48 (415.4%) stddev-sans-first:78460.45 04:33:01 INFO - 2015-12-15 04:33:01,449 DEBUG : BROWSER_OUTPUT: Values: 558.8 583.2 588.0 593.1 601.6 27530.6 28099.6 28109.4 35875.8 36510.0 40369.2 40912.0 40941.0 40984.4 40998.6 7853.3 8020.9 8021.8 8021.9 8023.2 7206.4 7408.4 10283.0 10545.6 10582.6 10162.8 10253.5 10256.2 10264.4 10267.8 7148.9 7316.4 10148.0 10273.1 10284.4 9959.7 10327.0 10331.5 10332.6 10332.7 37725.8 37980.8 37998.8 38059.0 38348.4 2994.8 3003.4 3012.7 3090.3 3562.3 27697.6 27765.0 28129.7 29547.6 30561.7 3295.3 3348.1 3380.3 3404.5 3424.0 212152.0 213777.0 214159.9 214348.0 215050.0 51651.7 53132.7 53539.5 56656.7 57083.7 62087.4 63382.0 63537.4 63603.4 63739.0 14319.4 14722.9 14723.3 14731.9 14736.9 9675.6 9679.0 9682.8 9687.4 9742.6 19198.7 19650.2 19681.3 19711.9 19802.1 7859.3 7901.2 8025.2 8045.9 8065.5 801.7 846.5 847.9 874.6 1005.9 25470.8 25491.2 25492.6 25701.0 25810.4 918.4 928.7 993.3 1004.2 1085.7 13337.8 15543.5 16728.7 16749.5 17007.9 369655.0 373169.0 374985.0 377879.0 379058.0 48047.0 48340.3 48783.2 48788.0 48790.3 1141.9 1142.2 1165.8 1224.3 1255.9 27575.6 28860.4 29001.6 29273.1 29427.0 42656.6 43697.8 43910.0 44051.8 44077.1 228608.0 234670.0 245173.0 336146.0 345405.0 39336.6 39906.6 39962.6 39975.8 40024.6 41397.0 41528.4 42051.4 42253.4 42545.0 34380.1 35692.5 36353.3 36726.1 38855.0 33259.7 34134.1 34283.3 36602.8 40548.4 33310.8 33985.8 34182.0 34184.1 34197.8 29143.0 30274.7 30875.8 30977.0 31038.8 23757.6 24315.3 25695.6 25843.7 26060.6 04:33:01 INFO - 2015-12-15 04:33:01,449 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,449 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25555.47 Median:24097.32 stddev:77587.41 (322.0%) stddev-sans-first:77781.94 04:33:01 INFO - 2015-12-15 04:33:01,449 DEBUG : BROWSER_OUTPUT: Values: 329.8 334.3 334.4 334.8 336.7 11816.7 12307.0 14861.8 15192.8 15809.8 10020.0 10128.9 10281.7 10363.9 10482.5 4492.9 4559.8 4604.1 4614.2 4618.2 3390.1 4512.3 4618.8 5086.4 5113.2 5042.1 5083.5 5093.2 5104.1 5121.0 4922.8 5018.5 5027.6 5029.5 5082.1 4847.0 4864.7 4864.9 4866.7 4867.4 10643.6 12715.5 16625.3 19409.4 19463.3 1827.5 1842.5 1845.4 1908.1 1925.3 7922.2 8156.3 8275.9 8367.0 9082.8 1696.5 1700.2 1713.7 1739.2 1756.5 50333.7 51294.0 51922.7 54874.7 56027.4 8866.9 8870.2 8894.4 9089.9 9143.0 11297.4 11322.9 11332.8 11347.7 11351.3 6761.6 6772.1 6785.8 7061.0 7089.0 6579.3 6595.2 6612.4 6614.8 6645.2 3795.8 3807.1 3849.3 3942.0 4172.2 1487.9 1514.9 1531.8 1706.2 1732.7 735.8 856.0 863.8 867.1 939.9 14101.9 14748.0 16576.3 16885.2 16992.7 859.3 868.9 875.4 884.4 901.8 9092.5 9232.8 9232.8 9234.1 9432.7 457437.0 469775.0 479976.0 480587.0 482201.0 74000.6 75041.6 76699.6 77425.6 78248.2 1090.9 1105.9 1110.2 1111.0 1122.0 13751.3 14261.6 14380.0 14528.4 14840.3 33211.3 33400.3 33931.8 34183.7 34618.5 39658.0 42110.6 42912.8 43701.8 46580.3 8144.9 8212.9 8305.8 8439.7 8459.5 9667.3 9746.7 15466.9 15485.8 16520.0 8993.0 12774.8 13235.7 13334.3 13790.1 11597.9 12674.4 13117.9 13371.6 13388.7 13421.9 13538.8 14169.9 14939.9 15132.1 8116.6 8233.5 8326.2 8344.0 8420.9 8738.7 11071.7 13811.3 14012.1 14773.5 04:33:01 INFO - 2015-12-15 04:33:01,450 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,450 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4735.24 Median:6033.53 stddev:2408.70 (39.9%) stddev-sans-first:2402.76 04:33:01 INFO - 2015-12-15 04:33:01,451 DEBUG : BROWSER_OUTPUT: Values: 1444.3 1661.4 1678.0 1709.2 1730.8 5749.7 6594.0 6678.1 6706.1 6710.7 6705.4 6859.4 6874.3 6879.2 6884.6 2011.9 2042.5 2051.3 2053.3 2054.6 1987.2 2020.2 2020.6 2054.1 2062.4 1971.2 2009.0 2043.6 2045.1 2045.6 2029.3 2061.2 2061.8 2062.0 2063.4 2002.6 2017.7 2021.7 2024.8 2052.3 6830.2 6908.4 6912.4 6918.7 6921.8 4010.1 4071.8 4071.9 4074.3 4078.4 2579.2 2598.9 2630.4 2634.4 2636.3 806.4 815.0 820.7 821.6 841.1 9119.2 9129.3 9139.0 9144.3 9154.7 3660.7 3682.8 3716.5 3724.5 3743.8 7884.0 7893.4 7893.5 7904.2 7918.9 4043.5 4068.7 4074.4 4089.0 4097.1 3160.1 3224.6 3596.9 3719.2 3719.5 3222.7 3284.8 3307.4 3325.1 3336.9 1022.1 1040.7 1047.9 1050.0 1057.5 776.4 825.6 871.7 921.0 971.0 6266.4 6311.4 6325.6 6341.6 6345.0 991.4 1019.7 1019.9 1029.2 1038.7 4982.6 5032.9 5037.6 5044.6 5051.0 7444.5 7777.1 8007.8 8079.6 8114.8 7505.1 7514.9 7515.6 7554.5 7631.2 6425.2 6483.8 6490.2 6518.3 6550.6 6259.6 6352.3 6355.3 6358.6 6368.6 7140.0 7304.2 7338.9 7346.3 7356.4 7199.0 7453.5 7454.1 7471.7 7479.2 6112.6 6174.9 6193.1 6197.3 6206.7 6526.2 6574.3 6581.1 6595.4 6597.7 5797.5 5967.5 6049.8 6389.7 6407.5 5207.7 5340.1 5908.0 6173.8 6242.5 6017.3 6069.3 6074.7 6082.6 6099.0 5614.2 5654.4 5658.7 5666.5 5668.7 5694.3 5694.4 5710.8 5711.2 5715.5 04:33:01 INFO - 2015-12-15 04:33:01,451 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,451 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4590.28 Median:5300.24 stddev:1359.04 (25.6%) stddev-sans-first:1324.09 04:33:01 INFO - 2015-12-15 04:33:01,453 DEBUG : BROWSER_OUTPUT: Values: 297.0 298.5 305.3 305.9 306.6 5138.9 5260.0 5262.6 5298.7 5389.0 5241.3 5318.2 5321.7 5322.4 5337.0 3860.3 4105.4 4106.1 4108.2 4109.2 3921.7 3930.4 3950.6 4055.3 4091.7 4025.5 4052.5 4053.0 4056.0 4070.9 3799.7 4034.8 4044.7 4046.6 4047.2 3349.6 3442.1 3504.1 3540.1 3550.2 5089.0 5100.8 5102.8 5109.9 5111.1 4630.7 4635.3 4642.7 4651.6 4651.6 5386.5 5508.3 5510.0 5518.4 5518.8 3841.3 3852.0 3855.7 3864.9 3873.9 5634.1 5702.2 5704.7 5714.1 5716.0 3927.1 3935.5 3935.9 3939.2 3939.8 3996.5 3998.9 4001.2 4004.6 4006.1 4458.6 4561.5 4562.5 4569.3 4572.0 5406.6 5425.7 5426.1 5426.8 5430.5 1401.6 1417.3 1418.0 1420.6 1420.8 937.6 944.2 962.0 964.6 972.0 4857.5 4870.3 4871.9 4873.3 4875.4 5742.1 5743.6 5745.5 5752.4 5754.1 4854.2 4867.7 4868.5 4868.8 4869.5 3017.0 3073.7 3100.1 3103.0 3109.4 5286.7 5375.5 5434.8 5518.9 5519.2 5945.3 5952.0 5954.1 5962.1 5966.0 5497.6 5497.7 5501.3 5502.4 5507.3 5576.1 5763.2 5786.8 5789.1 5817.6 5658.8 5668.8 5668.9 5675.5 5677.2 5498.6 5507.3 5513.0 5518.9 5520.3 3972.3 3985.1 4010.8 4011.2 4014.4 5651.8 5787.9 5793.6 5794.4 5800.9 5542.9 5553.2 5567.1 5567.8 5572.8 5536.5 5554.4 5557.1 5563.4 5564.9 5301.8 5432.8 5458.8 5461.9 5472.1 5565.9 5570.9 5571.1 5573.3 5574.2 5473.3 5482.2 5486.3 5486.6 5489.1 04:33:01 INFO - 2015-12-15 04:33:01,453 DEBUG : BROWSER_OUTPUT: 04:33:01 INFO - 2015-12-15 04:33:01,453 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11878.09 Median:459.22 stddev:13149.09 (2863.4%) stddev-sans-first:13159.55 04:33:01 INFO - 2015-12-15 04:33:01,453 DEBUG : BROWSER_OUTPUT: Values: 776.5 787.3 791.1 795.6 796.1 11391.1 11856.9 11945.0 11947.5 11948.5 11609.5 11954.0 12032.4 12039.4 12051.9 807.5 819.8 820.9 821.1 822.0 809.9 818.2 818.6 818.8 818.8 838.1 849.5 849.5 850.2 850.9 841.2 841.5 841.6 841.9 843.3 623.1 625.4 626.2 626.6 627.1 11147.0 11250.2 11272.0 11278.2 11302.7 9469.7 9738.7 9756.3 9828.1 10039.3 8552.8 8773.4 8783.6 8786.2 8814.7 3285.5 3303.9 3324.0 3333.4 3340.8 34577.5 34648.5 38684.0 39427.8 40317.8 8409.8 8716.1 9066.0 9364.6 9539.9 16452.6 16487.8 16503.1 16614.8 16626.8 6409.3 6634.3 6669.4 6774.1 6911.3 3565.6 3574.9 3575.7 3601.1 3634.3 2587.9 2592.1 2617.8 2618.2 2622.2 457.1 461.3 464.1 469.1 473.9 463.2 470.4 501.7 520.7 550.8 7336.3 7444.8 7573.7 7725.9 7816.3 486.5 531.3 572.3 594.8 599.8 3517.2 3549.5 3568.5 3601.8 3655.9 46662.0 47425.8 51882.7 52424.0 52549.2 41409.4 42219.8 42301.4 42483.6 42752.6 33564.0 35141.0 37683.0 38636.2 39123.0 7571.6 7623.8 7992.6 8140.8 8164.3 30065.7 30805.5 30840.8 31022.4 31341.2 34261.3 35381.0 35865.6 37418.3 38215.0 9707.6 10301.9 10576.4 10721.7 10900.4 11625.9 11699.6 11964.9 12024.6 12040.0 10683.8 10696.8 10796.2 10864.3 11338.5 10630.8 10653.7 10720.6 10804.6 10812.9 10653.4 10811.0 10825.6 10909.9 11061.3 9340.6 9376.2 9446.1 9653.1 9735.4 8726.4 8808.2 8835.2 8926.3 9326.6 04:33:01 INFO - 2015-12-15 04:33:01,453 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:33:01 INFO - 2015-12-15 04:33:01,453 DEBUG : BROWSER_OUTPUT: 04:33:02 INFO - 2015-12-15 04:33:02,261 INFO : Browser exited with error code: 0 04:33:02 INFO - 2015-12-15 04:33:02,282 INFO : Completed test dromaeo_css (00:18:36) 04:33:02 INFO - 2015-12-15 04:33:02,282 INFO : Starting test kraken 04:33:02 INFO - 2015-12-15 04:33:02,282 DEBUG : operating with platform_type : linux_ 04:33:02 INFO - 2015-12-15 04:33:02,283 INFO : Initialising browser for kraken test... 04:33:02 INFO - 2015-12-15 04:33:02,289 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCK7Zlb/profile http://localhost:59090/getInfo.html 04:33:06 INFO - 2015-12-15 04:33:06,572 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:06 INFO - 2015-12-15 04:33:06,572 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:06 INFO - 2015-12-15 04:33:06,572 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:33:06 INFO - 2015-12-15 04:33:06,572 DEBUG : BROWSER_OUTPUT: __metrics 04:33:06 INFO - 2015-12-15 04:33:06,648 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] 04:33:06 INFO - 2015-12-15 04:33:06,709 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] 04:33:06 ERROR - 2015-12-15 04:33:06,724 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:33:07 INFO - 2015-12-15 04:33:07,558 INFO : Browser initialized. 04:33:07 INFO - 2015-12-15 04:33:07,558 INFO : Running cycle 1/1 for kraken test... 04:33:07 INFO - 2015-12-15 04:33:07,558 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCK7Zlb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:19 INFO - 2015-12-15 04:33:19,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 142364672 04:33:19 INFO - 2015-12-15 04:33:19,549 DEBUG : BROWSER_OUTPUT: 04:33:22 INFO - 2015-12-15 04:33:22,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59090/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:22 INFO - 2015-12-15 04:33:22,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 178368512 04:33:22 INFO - 2015-12-15 04:33:22,759 DEBUG : BROWSER_OUTPUT: 04:33:25 INFO - 2015-12-15 04:33:25,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59090/tests/kraken/driver.html?testName=audio-dft) 04:33:26 INFO - 2015-12-15 04:33:26,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 168153088 04:33:26 INFO - 2015-12-15 04:33:26,090 DEBUG : BROWSER_OUTPUT: 04:33:29 INFO - 2015-12-15 04:33:29,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59090/tests/kraken/driver.html?testName=audio-fft) 04:33:29 INFO - 2015-12-15 04:33:29,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 153083904 04:33:29 INFO - 2015-12-15 04:33:29,708 DEBUG : BROWSER_OUTPUT: 04:33:31 INFO - 2015-12-15 04:33:31,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59090/tests/kraken/driver.html?testName=audio-oscillator) 04:33:32 INFO - 2015-12-15 04:33:32,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 156573696 04:33:32 INFO - 2015-12-15 04:33:32,325 DEBUG : BROWSER_OUTPUT: 04:33:34 INFO - 2015-12-15 04:33:34,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:35 INFO - 2015-12-15 04:33:35,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 157630464 04:33:35 INFO - 2015-12-15 04:33:35,140 DEBUG : BROWSER_OUTPUT: 04:33:38 INFO - 2015-12-15 04:33:38,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59090/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:38 INFO - 2015-12-15 04:33:38,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 157241344 04:33:38 INFO - 2015-12-15 04:33:38,705 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-15 04:33:42,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59090/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:42 INFO - 2015-12-15 04:33:42,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 157286400 04:33:42 INFO - 2015-12-15 04:33:42,675 DEBUG : BROWSER_OUTPUT: 04:33:45 INFO - 2015-12-15 04:33:45,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59090/tests/kraken/driver.html?testName=json-parse-financial) 04:33:46 INFO - 2015-12-15 04:33:46,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 159068160 04:33:46 INFO - 2015-12-15 04:33:46,117 DEBUG : BROWSER_OUTPUT: 04:33:47 INFO - 2015-12-15 04:33:47,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:48 INFO - 2015-12-15 04:33:48,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 165978112 04:33:48 INFO - 2015-12-15 04:33:48,453 DEBUG : BROWSER_OUTPUT: 04:33:50 INFO - 2015-12-15 04:33:50,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59090/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:50 INFO - 2015-12-15 04:33:50,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 164757504 04:33:50 INFO - 2015-12-15 04:33:50,957 DEBUG : BROWSER_OUTPUT: 04:33:53 INFO - 2015-12-15 04:33:53,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:53 INFO - 2015-12-15 04:33:53,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 178253824 04:33:53 INFO - 2015-12-15 04:33:53,756 DEBUG : BROWSER_OUTPUT: 04:33:56 INFO - 2015-12-15 04:33:56,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:56 INFO - 2015-12-15 04:33:56,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 181198848 04:33:56 INFO - 2015-12-15 04:33:56,893 DEBUG : BROWSER_OUTPUT: 04:33:59 INFO - 2015-12-15 04:33:59,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:00 INFO - 2015-12-15 04:34:00,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 180830208 04:34:00 INFO - 2015-12-15 04:34:00,202 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59090/tests/kraken/driver.html?testName=ai-astar) 04:34:02 INFO - 2015-12-15 04:34:02,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 238456832 04:34:02 INFO - 2015-12-15 04:34:02,274 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,274 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:02 INFO - 2015-12-15 04:34:02,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:02 INFO - 2015-12-15 04:34:02,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:02 INFO - 2015-12-15 04:34:02,274 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:02 INFO - 2015-12-15 04:34:02,274 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;116;106;114;113;112;103;114;113;114 04:34:02 INFO - 2015-12-15 04:34:02,275 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;129;156;169;138;161;159;131;166;131 04:34:02 INFO - 2015-12-15 04:34:02,275 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;161;165;163;162;163;162;162 04:34:02 INFO - 2015-12-15 04:34:02,275 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;89;91;77;73;79;112;90;73 04:34:02 INFO - 2015-12-15 04:34:02,275 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;132;95;96;95;137;95;94;127 04:34:02 INFO - 2015-12-15 04:34:02,275 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;110;110;110;109 04:34:02 INFO - 2015-12-15 04:34:02,275 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;147;147;147;147;147;147;148 04:34:02 INFO - 2015-12-15 04:34:02,275 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;96;95;95;95 04:34:02 INFO - 2015-12-15 04:34:02,275 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;73;72;73;74;73;82;72;73 04:34:02 INFO - 2015-12-15 04:34:02,276 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;70;69;69;69;69;68 04:34:02 INFO - 2015-12-15 04:34:02,276 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;90;89;87;88;88;95;87;88;90 04:34:02 INFO - 2015-12-15 04:34:02,276 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;129;129;119;129;133;122;126;121;129 04:34:02 INFO - 2015-12-15 04:34:02,276 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;151;169;159;158;146;165;158;156;155 04:34:02 INFO - 2015-12-15 04:34:02,276 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;74;73;72;74;74;72;71;72;73 04:34:02 INFO - 2015-12-15 04:34:02,276 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:02 INFO - 2015-12-15 04:34:02,276 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:34:02 INFO - 2015-12-15 04:34:02,276 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1011 04:34:02 INFO - 2015-12-15 04:34:02,277 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:34:02 INFO - 2015-12-15 04:34:02,277 DEBUG : BROWSER_OUTPUT: __startTimestamp1450182842268__endTimestamp 04:34:02 INFO - 2015-12-15 04:34:02,277 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,277 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:02 INFO - 2015-12-15 04:34:02,277 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:34:02 INFO - 2015-12-15 04:34:02,277 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,278 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:114.00 stddev:4.09 (3.6%) stddev-sans-first:4.27 04:34:02 INFO - 2015-12-15 04:34:02,278 DEBUG : BROWSER_OUTPUT: Values: 114.0 116.0 106.0 114.0 113.0 112.0 103.0 114.0 113.0 114.0 04:34:02 INFO - 2015-12-15 04:34:02,278 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,278 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:158.00 stddev:15.67 (9.9%) stddev-sans-first:16.40 04:34:02 INFO - 2015-12-15 04:34:02,279 DEBUG : BROWSER_OUTPUT: Values: 157.0 129.0 156.0 169.0 138.0 161.0 159.0 131.0 166.0 131.0 04:34:02 INFO - 2015-12-15 04:34:02,279 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,279 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 04:34:02 INFO - 2015-12-15 04:34:02,279 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 161.0 165.0 163.0 162.0 163.0 162.0 162.0 04:34:02 INFO - 2015-12-15 04:34:02,280 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,280 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.00 Median:78.00 stddev:12.66 (16.2%) stddev-sans-first:12.90 04:34:02 INFO - 2015-12-15 04:34:02,280 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 89.0 91.0 77.0 73.0 79.0 112.0 90.0 73.0 04:34:02 INFO - 2015-12-15 04:34:02,280 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,280 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:18.03 (19.0%) stddev-sans-first:18.67 04:34:02 INFO - 2015-12-15 04:34:02,280 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 132.0 95.0 96.0 95.0 137.0 95.0 94.0 127.0 04:34:02 INFO - 2015-12-15 04:34:02,280 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,281 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 04:34:02 INFO - 2015-12-15 04:34:02,281 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 04:34:02 INFO - 2015-12-15 04:34:02,281 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,281 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 04:34:02 INFO - 2015-12-15 04:34:02,281 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 04:34:02 INFO - 2015-12-15 04:34:02,281 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,281 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:34:02 INFO - 2015-12-15 04:34:02,281 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 04:34:02 INFO - 2015-12-15 04:34:02,282 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,282 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.90 Median:73.00 stddev:2.92 (4.0%) stddev-sans-first:3.10 04:34:02 INFO - 2015-12-15 04:34:02,282 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 72.0 73.0 74.0 73.0 82.0 72.0 73.0 04:34:02 INFO - 2015-12-15 04:34:02,282 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,282 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 04:34:02 INFO - 2015-12-15 04:34:02,282 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 68.0 04:34:02 INFO - 2015-12-15 04:34:02,282 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,282 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:88.50 stddev:2.53 (2.9%) stddev-sans-first:2.47 04:34:02 INFO - 2015-12-15 04:34:02,283 DEBUG : BROWSER_OUTPUT: Values: 86.0 90.0 89.0 87.0 88.0 88.0 95.0 87.0 88.0 90.0 04:34:02 INFO - 2015-12-15 04:34:02,283 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,283 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:129.00 stddev:4.83 (3.7%) stddev-sans-first:4.66 04:34:02 INFO - 2015-12-15 04:34:02,283 DEBUG : BROWSER_OUTPUT: Values: 120.0 129.0 129.0 119.0 129.0 133.0 122.0 126.0 121.0 129.0 04:34:02 INFO - 2015-12-15 04:34:02,283 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,284 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:158.00 stddev:6.54 (4.1%) stddev-sans-first:6.84 04:34:02 INFO - 2015-12-15 04:34:02,284 DEBUG : BROWSER_OUTPUT: Values: 154.0 151.0 169.0 159.0 158.0 146.0 165.0 158.0 156.0 155.0 04:34:02 INFO - 2015-12-15 04:34:02,284 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,285 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.50 stddev:1.10 (1.5%) stddev-sans-first:1.09 04:34:02 INFO - 2015-12-15 04:34:02,285 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 73.0 72.0 74.0 74.0 72.0 71.0 72.0 73.0 04:34:02 INFO - 2015-12-15 04:34:02,285 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:02 INFO - 2015-12-15 04:34:02,285 DEBUG : BROWSER_OUTPUT: 04:34:03 INFO - 2015-12-15 04:34:03,141 INFO : Browser exited with error code: 0 04:34:03 INFO - 2015-12-15 04:34:03,190 INFO : Completed test kraken (00:01:00) 04:34:03 INFO - 2015-12-15 04:34:03,190 INFO : Starting test v8_7 04:34:03 INFO - 2015-12-15 04:34:03,190 DEBUG : operating with platform_type : linux_ 04:34:03 INFO - 2015-12-15 04:34:03,191 INFO : Initialising browser for v8_7 test... 04:34:03 INFO - 2015-12-15 04:34:03,197 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAyuPae/profile http://localhost:59090/getInfo.html 04:34:07 INFO - 2015-12-15 04:34:07,455 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:34:07 INFO - 2015-12-15 04:34:07,455 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:34:07 INFO - 2015-12-15 04:34:07,455 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:34:07 INFO - 2015-12-15 04:34:07,455 DEBUG : BROWSER_OUTPUT: __metrics 04:34:07 INFO - 2015-12-15 04:34:07,531 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] 04:34:07 INFO - 2015-12-15 04:34:07,592 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] 04:34:07 ERROR - 2015-12-15 04:34:07,599 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:34:08 INFO - 2015-12-15 04:34:08,516 INFO : Browser initialized. 04:34:08 INFO - 2015-12-15 04:34:08,516 INFO : Running cycle 1/1 for v8_7 test... 04:34:08 INFO - 2015-12-15 04:34:08,517 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAyuPae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:20 INFO - 2015-12-15 04:34:20,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 142163968 04:34:20 INFO - 2015-12-15 04:34:20,540 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59090/tests/v8_7/run.html (next: http://localhost:59090/tests/v8_7/run.html) 04:34:42 INFO - 2015-12-15 04:34:42,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 443637760 04:34:42 INFO - 2015-12-15 04:34:42,148 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,149 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:42 INFO - 2015-12-15 04:34:42,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:42 INFO - 2015-12-15 04:34:42,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:42 INFO - 2015-12-15 04:34:42,150 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:42 INFO - 2015-12-15 04:34:42,150 DEBUG : BROWSER_OUTPUT: |0;Richards;168.49199663016006 04:34:42 INFO - 2015-12-15 04:34:42,150 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.37118231216039 04:34:42 INFO - 2015-12-15 04:34:42,150 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.4858757062147 04:34:42 INFO - 2015-12-15 04:34:42,150 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 04:34:42 INFO - 2015-12-15 04:34:42,150 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1960.7843137254902 04:34:42 INFO - 2015-12-15 04:34:42,150 DEBUG : BROWSER_OUTPUT: |5;Earley;788.6435331230284 04:34:42 INFO - 2015-12-15 04:34:42,150 DEBUG : BROWSER_OUTPUT: |6;Boyer;11904.761904761905 04:34:42 INFO - 2015-12-15 04:34:42,151 DEBUG : BROWSER_OUTPUT: |7;RegExp;26473.684210526317 04:34:42 INFO - 2015-12-15 04:34:42,151 DEBUG : BROWSER_OUTPUT: |8;Splay;613.8735420503376 04:34:42 INFO - 2015-12-15 04:34:42,151 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4916.666666666667 04:34:42 INFO - 2015-12-15 04:34:42,151 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:42 INFO - 2015-12-15 04:34:42,151 DEBUG : BROWSER_OUTPUT: __startTimestamp1450182882148__endTimestamp 04:34:42 INFO - 2015-12-15 04:34:42,151 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,153 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:42 INFO - 2015-12-15 04:34:42,153 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:34:42 INFO - 2015-12-15 04:34:42,153 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,154 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.49 Median:168.49 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,154 DEBUG : BROWSER_OUTPUT: Values: 168.5 04:34:42 INFO - 2015-12-15 04:34:42,154 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,154 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.37 Median:187.37 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,154 DEBUG : BROWSER_OUTPUT: Values: 187.4 04:34:42 INFO - 2015-12-15 04:34:42,154 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,154 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.49 Median:282.49 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,155 DEBUG : BROWSER_OUTPUT: Values: 282.5 04:34:42 INFO - 2015-12-15 04:34:42,155 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,155 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,155 DEBUG : BROWSER_OUTPUT: Values: 5229.2 04:34:42 INFO - 2015-12-15 04:34:42,155 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,155 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,155 DEBUG : BROWSER_OUTPUT: Values: 1960.8 04:34:42 INFO - 2015-12-15 04:34:42,155 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,156 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,156 DEBUG : BROWSER_OUTPUT: Values: 788.6 04:34:42 INFO - 2015-12-15 04:34:42,156 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,156 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11904.76 Median:11904.76 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,156 DEBUG : BROWSER_OUTPUT: Values: 11904.8 04:34:42 INFO - 2015-12-15 04:34:42,156 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,156 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26473.68 Median:26473.68 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,157 DEBUG : BROWSER_OUTPUT: Values: 26473.7 04:34:42 INFO - 2015-12-15 04:34:42,157 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,157 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.87 Median:613.87 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,157 DEBUG : BROWSER_OUTPUT: Values: 613.9 04:34:42 INFO - 2015-12-15 04:34:42,157 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,157 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4916.67 Median:4916.67 stddev:0.00 (0.0%) 04:34:42 INFO - 2015-12-15 04:34:42,157 DEBUG : BROWSER_OUTPUT: Values: 4916.7 04:34:42 INFO - 2015-12-15 04:34:42,158 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:42 INFO - 2015-12-15 04:34:42,158 DEBUG : BROWSER_OUTPUT: 04:34:43 INFO - 2015-12-15 04:34:43,061 INFO : Browser exited with error code: 0 04:34:43 INFO - 2015-12-15 04:34:43,076 INFO : Completed test v8_7 (00:00:39) 04:34:43 INFO - 2015-12-15 04:34:43,230 INFO : Completed test suite (00:20:17) 04:34:43 INFO - 2015-12-15 04:34:43,230 DEBUG : Working with test: dromaeo_css 04:34:43 INFO - 2015-12-15 04:34:43,230 DEBUG : Generating results file: dromaeo_css 04:34:43 INFO - 2015-12-15 04:34:43,232 DEBUG : Working with test: kraken 04:34:43 INFO - 2015-12-15 04:34:43,232 DEBUG : Generating results file: kraken 04:34:43 INFO - 2015-12-15 04:34:43,232 INFO : javascript benchmark 04:34:43 INFO - 2015-12-15 04:34:43,232 DEBUG : Working with test: v8_7 04:34:43 INFO - 2015-12-15 04:34:43,232 DEBUG : Generating results file: v8_7 04:34:43 INFO - 2015-12-15 04:34:43,233 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:43 INFO - 2015-12-15 04:34:43,287 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 04:34:43 INFO - 2015-12-15 04:34:43,287 DEBUG : process_Request line: dromaeo_css 6243.01 graph.html#tests=[[72,132,35]] 04:34:43 INFO - 2015-12-15 04:34:43,287 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:43 INFO - 2015-12-15 04:34:43,318 DEBUG : process_Request line: kraken 1551.80 graph.html#tests=[[232,132,35]] 04:34:43 INFO - 2015-12-15 04:34:43,318 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:43 INFO - 2015-12-15 04:34:43,349 DEBUG : process_Request line: v8_7 19759.55 graph.html#tests=[[230,132,35]] 04:34:43 INFO - 2015-12-15 04:34:43,350 INFO : javascript benchmark 04:34:43 INFO - 2015-12-15 04:34:43,354 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2576.267804135798, 2682.7853771698265, 2691.542437785576, 2697.716739742327, 2714.321419645088, 4425.7123286986325, 4580.290055041474, 4643.489216186217, 4686.367340409044, 4697.624190064796, 4625.514320996297, 4637.675362724611, 4689.366935463711, 4699.436067671884, 4805.8558243252755, 4227.1334376452905, 4280.486341639008, 4310.5042920064125, 4401.427814384126, 4435.0, 4373.650107991353, 4426.77866106695, 4429.822807087713, 4431.468223813131, 4446.799894004761, 4133.3386658134705, 4174.958250417488, 4235.428217190671, 4247.214265360918, 4277.059047009653, 4282.0, 4296.462942132233, 4313.547077556843, 4334.761588112652, 4336.436263285753, 4042.4744783178294, 4271.700980931336, 4278.165757677254, 4328.545502722201, 4332.4367832181615, 4467.597916187558, 4549.13566422382, 4564.931526027112, 4586.839460618862, 4590.127875703605, 4979.45226025137, 4983.875403114951, 4986.052649996489, 4990.451050384455, 4998.800047998076, 4783.234682450826, 4982.6013918886765, 4993.7503124843615, 5011.949880501184, 5018.498150184989, 4448.888777780581, 4457.3091170868565, 4470.0, 4521.773911304422, 4581.496035436099, 4975.303457515951, 4989.451160372356, 4990.700557966534, 4996.800127994912, 5011.323471331397, 4679.461861885927, 4808.134535783593, 4851.878703032452, 4893.09477746618, 4941.382327209099, 4898.608111351084, 4920.089783390084, 4942.233953737176, 4946.9010619787405, 5006.048850718352, 4976.552110310017, 4989.725565093955, 4995.0, 5014.6991180529285, 5044.167712327425, 4663.743494107789, 4958.528939750718, 4980.551750342486, 4984.127777638899, 5012.072766538202, 4089.672826173899, 4108.568600296926, 4127.525334586501, 4170.47869016373, 4177.728447650893, 3649.708023358125, 3655.798931058764, 3660.213054193308, 3689.317476266899, 3692.058525076142, 4324.610785029363, 4325.4593175853015, 4328.8268469260875, 4332.371806088099, 4363.825446982149, 4714.0, 4774.0, 4817.686850354716, 4879.243717223836, 4984.925226121611, 4296.334068219431, 4341.110072435144, 4360.672949528798, 4361.956380436219, 4402.559744025636, 4453.042595841909, 4455.509893911667, 4455.910881782346, 4458.375827384169, 4493.393391892053, 4556.886077848014, 4676.251799712029, 4685.1332503486965, 4727.550882666142, 4865.878353041202, 4923.581495572773, 4937.284093806306, 4940.110780059624, 4955.0, 4992.975035124801, 4728.38530990969, 4728.929066064081, 4729.219678752967, 4729.858104256878, 4779.06808172403, 4680.859574212779, 4784.47370789206, 4788.209945358977, 4813.614910807197, 4933.605311575137, 4920.40955085392, 4950.4059512858685, 4950.752462376939, 4957.454679985127, 4998.050370429607, 4793.712377257376, 4794.328793968777, 4795.616350692006, 4800.423949126127, 4836.105320515716, 4609.608183304456, 4721.386219791405, 4724.4094488188975, 4753.619710423227, 4908.9754551227015, 4716.905661886812, 4751.786169622306, 4766.809327626856, 4772.451168115711, 4804.111239420718, 4847.466778654416, 4863.270509423614, 4865.9756701216265, 4866.9269960949905, 4915.582175514978, 4468.64250859924, 4583.03756211186, 4604.8388306409115, 4661.370714953574, 4759.928601071056], "unit": "ms", "name": "dojo.html", "value": 4545.742901994117}, {"lowerIsBetter": false, "replicates": [558.7513556467374, 583.1806312131454, 588.0003993211536, 593.0599999001582, 601.6269912654155, 27530.587041194372, 28099.57850632242, 28109.437811243763, 35875.82062089686, 36510.0, 40369.19261614773, 40912.0, 40941.0, 40984.38523422144, 40998.59001409985, 7853.253940875622, 8020.919790802076, 8021.799455013642, 8021.879671804928, 8023.157568455315, 7206.351428371446, 7408.444366672494, 10283.023112804272, 10545.6309029184, 10582.629607963723, 10162.796744065114, 10253.487325633689, 10256.230782691327, 10264.384136951807, 10267.845982310271, 7148.892766608505, 7316.414686825041, 10148.0, 10273.12678422335, 10284.43435611041, 9959.701208963743, 10327.018933201334, 10331.48342582868, 10332.58669653213, 10332.690019299433, 37725.811370943244, 37980.81009594962, 37998.81000595007, 38059.0, 38348.424773628416, 2994.8352840593757, 3003.3692924485667, 3012.6686064532882, 3090.304681446679, 3562.305350456662, 27697.584536231974, 27765.0, 28129.718702812916, 29547.556786648216, 30561.69438305633, 3295.3244584860286, 3348.1294863335465, 3380.323935212967, 3404.455287154068, 3423.9828800856085, 212152.0, 213777.0, 214159.92920035456, 214348.0, 215050.0, 51651.74174129105, 53132.734336328074, 53539.464605354224, 56656.71671641698, 57083.71458142683, 62087.37912620906, 63382.0, 63537.36462635407, 63603.36396635974, 63739.0, 14319.427222911176, 14722.852771472362, 14723.263836808117, 14731.852681473049, 14736.852631473763, 9675.612975481043, 9679.0, 9682.806343873082, 9687.41875487473, 9742.61029558824, 19198.74484258403, 19650.21399144047, 19681.311154109822, 19711.901440492707, 19802.108905099307, 7859.253370929752, 7901.209879012168, 8025.197480251928, 8045.879311810328, 8065.475744076616, 801.6673080671457, 846.4582667093065, 847.9364047696447, 874.6107981947972, 1005.9144972677258, 25470.84844775531, 25491.23526294214, 25492.617610735855, 25701.0, 25810.35474113162, 918.4213945214606, 928.7028150991617, 993.2897977945803, 1004.1514919892679, 1085.6688709943544, 13337.799933001013, 15543.533693989199, 16728.665426691397, 16749.497515074567, 17007.914960425118, 369655.0, 373169.0, 374985.0, 377879.0, 379058.0, 48047.0, 48340.27489587659, 48783.17035615017, 48788.0, 48790.26814597784, 1141.9371934543515, 1142.2061667141256, 1165.7726743284977, 1224.2960297828783, 1255.918365306252, 27575.586366204123, 28860.42279154447, 29001.56497652579, 29273.121806345844, 29427.0, 42656.57343426526, 43697.78151109224, 43910.0, 44051.77974110109, 44077.11845763003, 228608.0, 234670.0, 245173.0, 336146.0, 345405.0, 39336.6066339333, 39906.60093399029, 39962.60037399589, 39975.801935845644, 40024.59975400209, 41397.0, 41528.37707434451, 42051.36922946097, 42253.36619950765, 42545.0, 34380.14049648779, 35692.46461303031, 36353.27293454169, 36726.08184795295, 38855.0, 33259.66740332566, 34134.14664633304, 34283.314333713686, 36602.8169859149, 40548.39177412282, 33310.83344583261, 33985.830070850476, 34182.0, 34184.14539636529, 34197.82901085479, 29143.0, 30274.69725302719, 30875.845620771754, 30977.0, 31038.844805775825, 23757.64363534514, 24315.270541883772, 25695.614565781903, 25843.741562584884, 26060.609090863272], "unit": "ms", "name": "ext.html", "value": 17977.73808764586}, {"lowerIsBetter": false, "replicates": [329.81530343007904, 334.3246641783598, 334.43814391821735, 334.78908287778694, 336.7338806089104, 11816.704582385444, 12307.0154387649, 14861.777073343896, 15192.772108418383, 15809.762853557206, 10020.0, 10128.898711012887, 10281.691549253534, 10363.948180259089, 10482.475876206197, 4492.865214043584, 4559.817607295704, 4604.1252162089095, 4614.215583350821, 4618.237990731525, 3390.0846771371716, 4512.278035514319, 4618.792154353046, 5086.41506226785, 5113.181890897457, 5042.092423363793, 5083.517065878736, 5093.185090385539, 5104.106781313274, 5120.974395128038, 4922.827701030465, 5018.548330650259, 5027.572656324235, 5029.471905449912, 5082.1360368737405, 4846.9515304846855, 4864.683795553277, 4864.854054378375, 4866.683665561763, 4867.415910090812, 10643.627473038407, 12715.491380344774, 16625.251863666163, 19409.417717468357, 19463.318783842496, 1827.5248435406756, 1842.4942078772858, 1845.4186931116656, 1908.1031914999928, 1925.3357591630865, 7922.247386498273, 8156.265936065783, 8275.875861862078, 8367.0, 9082.818343633091, 1696.4656133317965, 1700.217899766109, 1713.7001024820606, 1739.173892401112, 1756.5169578365924, 50333.74833125847, 51293.974120517756, 51922.740386297824, 54874.72562637201, 56027.43972560263, 8866.916274675446, 8870.201681848665, 8894.377393582387, 9089.863652045224, 9142.954285228532, 11297.435128243555, 11322.886771132184, 11332.830007549894, 11347.716307092389, 11351.318920864775, 6761.560498567577, 6772.085768421299, 6785.762498312535, 7061.0, 7089.042979197846, 6579.309172536815, 6595.241547222035, 6612.404883560503, 6614.8346291343105, 6645.202575690948, 3795.8481660733814, 3807.0862992881507, 3849.3263678856088, 3941.994791328193, 4172.18642364742, 1487.8660920517204, 1514.863662270401, 1531.8238402583622, 1706.223668230952, 1732.740088986637, 735.782944031512, 856.0455092571738, 863.8185980944072, 867.128535821508, 939.9013103624021, 14101.858981410054, 14748.0, 16576.336946522006, 16885.15574221284, 16992.74510882338, 859.3383095016927, 868.9435186712843, 875.4309698695771, 884.4428010353436, 901.7610333261691, 9092.499912504743, 9232.815343693088, 9232.815343693223, 9234.122758337948, 9432.717018489457, 457437.0, 469775.0, 479976.0, 480587.0, 482201.0, 74000.62999685075, 75041.62479187569, 76699.61650191713, 77425.61287193529, 78248.21751782524, 1090.8581884354983, 1105.90599799018, 1110.2228440091967, 1110.9666709998712, 1122.0294445304917, 13751.312434378442, 14261.646828273218, 14380.0, 14528.418863245352, 14840.332185051482, 33211.33577328488, 33400.33199336048, 33931.83034084814, 34183.65816341805, 34618.48072278868, 39658.0, 42110.57889421067, 42912.78543607387, 43701.78149109234, 46580.30129547992, 8144.918550814416, 8212.876806847782, 8305.792355191168, 8439.746807595782, 8459.534725589905, 9667.27495437859, 9746.658866939622, 15466.922665387052, 15485.84514154889, 16520.0, 8993.0, 12774.808377874153, 13235.735285294048, 13334.33328333599, 13790.103643263155, 11597.942010289895, 12674.429650665557, 13117.868821311664, 13371.598852034454, 13388.665283367995, 13421.932890335876, 13538.79691804604, 14169.929150354183, 14939.925300373428, 15132.092074475566, 8116.634751436318, 8233.50598964064, 8326.209010144026, 8343.958280208803, 8420.915790842013, 8738.650453981769, 11071.72320691989, 13811.309434528433, 14012.089214201043, 14773.482928097465], "unit": "ms", "name": "jquery.html", "value": 7886.512999093799}, {"lowerIsBetter": false, "replicates": [1444.3283872999054, 1661.4018953176853, 1677.983220167798, 1709.1881356355725, 1730.7663465432167, 5749.655020698756, 6593.967030164848, 6678.131842860422, 6706.094677218574, 6710.7315707371645, 6705.362990515893, 6859.3826555609985, 6874.312568743123, 6879.208890977539, 6884.621345825977, 2011.9195232190732, 2042.5404284036122, 2051.3333166720877, 2053.3326668832615, 2054.5685406064745, 1987.165390535971, 2020.171729590868, 2020.6160829442358, 2054.0551346380685, 2062.4328309714797, 1971.221367559813, 2008.9698654520193, 2043.632146213681, 2045.1103769860083, 2045.5908818236337, 2029.3201777404513, 2061.2373421833868, 2061.783512731164, 2061.9690704639443, 2063.3500447359183, 2002.5994801039851, 2017.7074324222906, 2021.6866385710239, 2024.817766401031, 2052.332991777678, 6830.180378354629, 6908.378245957838, 6912.412444942186, 6918.654067296615, 6921.757738479129, 4010.1177740897247, 4071.796410179479, 4071.9389209161886, 4074.286999775057, 4078.4086307485545, 2579.1746641074865, 2598.9350266243305, 2630.447606002742, 2634.394089359458, 2636.327736427218, 806.4193780478047, 814.9918500814975, 820.7209548753452, 821.6056292979343, 841.1042240014426, 9119.179273865318, 9129.315301352424, 9139.0, 9144.314176436794, 9154.67958621445, 3660.670539651444, 3682.779033258013, 3716.498272733146, 3724.478572999782, 3743.831527581265, 7883.960580197062, 7893.407994400443, 7893.486923349964, 7904.20957904205, 7918.881216781753, 4043.534993475729, 4068.6745060395097, 4074.409210664496, 4088.9591104089172, 4097.057676734308, 3160.083575763003, 3224.6452890182063, 3596.946045809315, 3719.237556300952, 3719.497867787868, 3222.6777322267585, 3284.786488878215, 3307.4212012897647, 3325.1022223999385, 3336.899893003214, 1022.1260821997234, 1040.6825918094903, 1047.874255089379, 1049.9790004199874, 1057.4818339013827, 776.4487214078068, 825.6325934958886, 871.6644092024616, 921.0283151275469, 971.0192705367489, 6266.404691554295, 6311.400416960381, 6325.557210995186, 6341.55609107358, 6345.016522439029, 991.4497453913148, 1019.6940917724653, 1019.8623185869961, 1029.1766586730585, 1038.678009816944, 4982.576480999156, 5032.899342013139, 5037.596992240612, 5044.621653376012, 5051.0, 7444.478886477895, 7777.144514103444, 8007.83984320322, 8079.555624440713, 8114.7565573031725, 7505.061867266591, 7514.887276690854, 7515.586642734593, 7554.508956917783, 7631.236876312435, 6425.1968503937005, 6483.805485835527, 6490.221173459215, 6518.284577790614, 6550.639714815731, 6259.624422534663, 6352.333005034589, 6355.269144048493, 6358.618482891041, 6368.617882927039, 7140.036095127091, 7304.19653838088, 7338.889916651147, 7346.265373462611, 7356.44826638015, 7199.0, 7453.515521491086, 7454.068241469817, 7471.663775130023, 7479.17729049815, 6112.572119951561, 6174.938250617436, 6193.071039344134, 6197.25632924052, 6206.72069756853, 6526.184226971629, 6574.309697481887, 6581.14445122131, 6595.406413422815, 6597.6701164940605, 5797.507211887037, 5967.522598192221, 6049.78825741097, 6389.680515974275, 6407.455366293917, 5207.661502002357, 5340.065488539568, 5907.9704601476715, 6173.753049878134, 6242.531810114168, 6017.277926648655, 6069.3020302665755, 6074.7266373012435, 6082.60463069899, 6099.0, 5614.185943038318, 5654.378018417889, 5658.688772117573, 5666.490015898589, 5668.716564171693, 5694.316681998187, 5694.373618901835, 5710.8001219957105, 5711.228984087095, 5715.542756579381], "unit": "ms", "name": "mootools.html", "value": 3911.582276572262}, {"lowerIsBetter": false, "replicates": [296.9539721343192, 298.46574631409777, 305.3404645964715, 305.88223533939424, 306.61060453224417, 5138.8972220555615, 5259.973700131503, 5262.605304602161, 5298.682079075254, 5388.973055134728, 5241.3186285782895, 5318.228856815769, 5321.680699158043, 5322.441143679906, 5337.039332920072, 3860.285847118278, 4105.363668631352, 4106.117184805266, 4108.198901214264, 4109.157622687342, 3921.745086569364, 3930.3711406175016, 3950.6246906543975, 4055.3105971984833, 4091.672666186713, 4025.496812898388, 4052.5136983562015, 4052.9797351013203, 4055.959440405588, 4070.8778736637946, 3799.715021373408, 4034.838606455753, 4044.69664775143, 4046.6358027777496, 4047.190561887605, 3349.581302337208, 3442.0706409269355, 3504.1064528545057, 3540.13266749648, 3550.236699109678, 5089.033083714083, 5100.770465329069, 5102.846914592568, 5109.9489005109845, 5111.10555652763, 4630.652701047435, 4635.304704294383, 4642.744649044301, 4651.558101980307, 4651.604613607814, 5386.48828361305, 5508.283923090013, 5510.008198524264, 5518.420565840569, 5518.779248830042, 3841.2701586698436, 3851.959970807894, 3855.6722678572355, 3864.903377415559, 3873.8837834865, 5634.0703783875615, 5702.173184888209, 5704.71476426177, 5714.142878568248, 5715.971420142914, 3927.096767743435, 3935.5080614923136, 3935.901602459904, 3939.1727737174942, 3939.783311917872, 3996.540397854226, 3998.9402808255836, 4001.15975645112, 4004.619561141687, 4006.1386801837743, 4458.598726114666, 4561.498235194126, 4562.475315338712, 4569.337446070301, 4572.0, 5406.567474602022, 5425.674459532362, 5426.050441172779, 5426.782928682808, 5430.456954304617, 1401.5515035188641, 1417.3267697843648, 1417.978730319046, 1420.5809286260578, 1420.8136206267882, 937.6062053937362, 944.1738478831023, 961.9951900240454, 964.5707660091332, 971.9902800972042, 4857.489963553776, 4870.318155458239, 4871.926921096187, 4873.342098816685, 4875.366202393737, 5742.138679198154, 5743.597948143673, 5745.511631511285, 5752.424757524298, 5754.079347304495, 4854.2233242681, 4867.707937523689, 4868.513148685103, 4868.78090485929, 4869.513048695102, 3016.9547456788164, 3073.72336489717, 3100.1009707185117, 3102.991527753489, 3109.4247564200696, 5286.735663216824, 5375.543078838265, 5434.809781657623, 5518.889622207614, 5519.172124181405, 5945.316288626776, 5952.0476723724, 5954.136650185786, 5962.105684147413, 5966.0454327307425, 5497.560195184456, 5497.670139791545, 5501.339839219319, 5502.422245664227, 5507.256520369859, 5576.052071147996, 5763.164341170423, 5786.797462088806, 5789.102689083199, 5817.621854579439, 5658.773649053992, 5668.7732490701555, 5668.943310567007, 5675.545956323567, 5677.233573467694, 5498.642588231752, 5507.311586051744, 5512.972435137799, 5518.944810551843, 5520.309961254843, 3972.2849887019456, 3985.063510075188, 4010.7994600269285, 4011.1576568920855, 4014.3577027675433, 5651.773929042793, 5787.8553036174435, 5793.594448388572, 5794.391588883106, 5800.912986305125, 5542.944570554243, 5553.16702494629, 5567.137093750313, 5567.77728890856, 5572.832815015556, 5536.529395001309, 5554.361248456317, 5557.138643510262, 5563.443655634566, 5564.860878478071, 5301.787928482818, 5432.7555260012605, 5458.781648734165, 5461.863453413696, 5472.069748142905, 5565.888682226414, 5570.916436253378, 5571.0807716726285, 5573.303337082864, 5574.16387541872, 5473.31583552056, 5482.150266708666, 5486.259354987025, 5486.61593688438, 5489.1217405214975], "unit": "ms", "name": "prototype.html", "value": 4153.765216292366}, {"lowerIsBetter": false, "replicates": [776.518558493734, 787.2835719495259, 791.1455627921841, 795.5544894858875, 796.1202870827735, 11391.088712902969, 11856.881431185697, 11945.0, 11947.46236419361, 11948.522059117646, 11609.477573509192, 11954.0, 12032.398380080982, 12039.398030098504, 12051.939740301286, 807.4670717326551, 819.7950512371907, 820.8604537228686, 821.0885916632533, 821.954792486413, 809.8704207326829, 818.2308629887916, 818.5988865455944, 818.7953011747063, 818.8444195602816, 838.1157878438245, 849.4733265375476, 849.5327569836596, 850.1540966738104, 850.8723691446271, 841.2176675691635, 841.5497708725802, 841.6128580852815, 841.9326453883705, 843.3211264931697, 623.1338439569003, 625.4464798653224, 626.2172284644195, 626.5707990026846, 627.075064280183, 11147.0, 11250.212485126045, 11272.041876440513, 11278.210525263235, 11302.660920172408, 9469.66856160038, 9738.659146929895, 9756.268279878966, 9828.11546960777, 10039.347442416292, 8552.828943421158, 8773.385862989593, 8783.64865405383, 8786.165314295196, 8814.735557933209, 3285.4743241081314, 3303.8513266902805, 3323.9501407478906, 3333.4333163362285, 3340.7828491148, 34577.48133777995, 34648.480272795925, 38684.0, 39427.8028609858, 40317.79841100776, 8409.789755256168, 8716.128387161232, 9065.954670226738, 9364.62541498346, 9539.856902146474, 16452.588685282964, 16487.83512164887, 16503.09232992197, 16614.83385166133, 16626.83373166277, 6409.327020662857, 6634.270230274666, 6669.399754022162, 6774.051632771416, 6911.343422374866, 3565.6434356564655, 3574.928501430009, 3575.713942884563, 3601.099725068733, 3634.309481198564, 2587.896484140613, 2592.066855931863, 2617.7774889134257, 2618.201448558208, 2622.1871219921886, 457.12688764460387, 461.3057348690267, 464.1042787420244, 469.0665575504721, 473.8981119059419, 463.2009783124084, 470.4237309296153, 501.653858837401, 520.6849855837239, 550.8127236739527, 7336.303051210127, 7444.776656700307, 7573.659185336563, 7725.884111738328, 7816.257455541714, 486.47946697033836, 531.264199084271, 572.2932178759229, 594.785877084258, 599.8470390050509, 3517.1854556670382, 3549.467579863041, 3568.4825700273313, 3601.819909004539, 3655.908602284911, 46662.0, 47425.76287118543, 51882.74058629683, 52424.0, 52549.21176182284, 41409.378859317134, 42219.788901055916, 42301.36547951783, 42483.57516424858, 42752.57247427486, 33564.0, 35141.0, 37683.0, 38636.2272754549, 39123.0, 7571.621418929141, 7623.847523049619, 7992.600369981594, 8140.83718325642, 8164.306033987177, 30065.699343007163, 30805.537916930814, 30840.845795771776, 31022.379552408373, 31341.216469588442, 34261.314773704886, 35381.0, 35865.64134358623, 37418.251634966604, 38215.0, 9707.6116955321, 10301.9484902575, 10576.36541807494, 10721.731956701145, 10900.400477973788, 11625.941870290595, 11699.590514331958, 11964.880351196376, 12024.639260822189, 12040.0, 10683.786324273626, 10696.786064278827, 10796.244262901835, 10864.293820901616, 11338.489767960627, 10630.8405373921, 10653.680389588015, 10720.624778132727, 10804.621838235624, 10812.945935270587, 10653.414062226651, 10811.0, 10825.56697732082, 10909.890901090888, 11061.281016733887, 9340.579673914826, 9376.156145946898, 9446.102620251066, 9653.082957119062, 9735.41587504752, 8726.432781869158, 8808.20726134651, 8835.20483156519, 8926.285897128084, 9326.626934922528], "unit": "ms", "name": "yui.html", "value": 5653.203661560163}], "name": "dromaeo_css", "value": 6243.008968359773}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 116.0, 106.0, 114.0, 113.0, 112.0, 103.0, 114.0, 113.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 156.0, 169.0, 138.0, 161.0, 159.0, 131.0, 166.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 165.0, 163.0, 162.0, 163.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 89.0, 91.0, 77.0, 73.0, 79.0, 112.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 132.0, 95.0, 96.0, 95.0, 137.0, 95.0, 94.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 72.0, 73.0, 74.0, 73.0, 82.0, 72.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 73.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 89.0, 87.0, 88.0, 88.0, 95.0, 87.0, 88.0, 90.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.8}, {"lowerIsBetter": true, "replicates": [120.0, 129.0, 129.0, 119.0, 129.0, 133.0, 122.0, 126.0, 121.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [154.0, 151.0, 169.0, 159.0, 158.0, 146.0, 165.0, 158.0, 156.0, 155.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 157.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 72.0, 74.0, 74.0, 72.0, 71.0, 72.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.9}], "name": "kraken", "value": 1551.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.49199663016006], "unit": "score", "name": "Richards", "value": 209.51736999999997}, {"lowerIsBetter": false, "replicates": [187.37118231216039], "unit": "score", "name": "DeltaBlue", "value": 352.8717660000001}, {"lowerIsBetter": false, "replicates": [282.4858757062147], "unit": "score", "name": "Encrypt", "value": 942.2807399999999}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [11904.761904761905], "unit": "score", "name": "Boyer", "value": 55.98289200000003}, {"lowerIsBetter": false, "replicates": [26473.684210526317], "unit": "score", "name": "RegExp", "value": 34.410964214711704}, {"lowerIsBetter": false, "replicates": [613.8735420503376], "unit": "score", "name": "Splay", "value": 132.748839}, {"lowerIsBetter": false, "replicates": [4916.666666666667], "unit": "score", "name": "NavierStokes", "value": 301.83050847457605}], "name": "v8_7", "value": 19759.549492593076}]} 04:34:43 INFO - RETURN: dromaeo_css: 6243.01 04:34:43 INFO - RETURN: kraken: 1551.80 04:34:43 INFO - RETURN: v8_7: 19759.55 04:34:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19759.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1551.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6243.01"}}} 04:34:43 INFO - Return code: 0 04:34:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:34:43 ERROR - # TBPL SUCCESS # 04:34:43 INFO - Running post-action listener: _resource_record_post_action 04:34:43 INFO - Running post-run listener: _resource_record_post_run 04:34:44 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 522653696; Read time: 0; Write time: 404800 04:34:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 245313536; Read time: 0; Write time: 217088 04:34:44 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 277041152; Read time: 0; Write time: 187692 04:34:44 INFO - Running post-run listener: _upload_blobber_files 04:34:44 INFO - Blob upload gear active. 04:34:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:34:44 INFO - Copying logs to upload dir... 04:34:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.231672 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-15 04:34:44.026890) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:34:44.030861) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010014 build_url: 'https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.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-15 04:34:44.083178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:34:44.083613) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450179425.497983-1891762604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004643 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:34:44.133689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 04:34:44.134085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 04:34:44.134457) ========= ========= Total master_lag: 0.28 =========