builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1450271261.32 results: success (0) buildid: 20151216033907 builduid: 59a0b588721344efac4fb45824e0993b revision: 2f6ab7e45670e267e186fcb205a0e6fc9038363c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.319650) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.320130) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.320445) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006206 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.342762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.343049) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.355966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.356237) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.404803) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.405112) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.405458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.405734) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 05:07:42-- 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% 77.1M=0s 2015-12-16 05:07:42 (77.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109471 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.527786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.528111) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022211 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:41.578025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 05:07:41.578406) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f6ab7e45670e267e186fcb205a0e6fc9038363c --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 2f6ab7e45670e267e186fcb205a0e6fc9038363c --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=d7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 05:07:42,954 truncating revision to first 12 chars 2015-12-16 05:07:42,955 Setting DEBUG logging. 2015-12-16 05:07:42,955 attempt 1/10 2015-12-16 05:07:42,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f6ab7e45670?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 05:07:43,781 unpacking tar archive at: fx-team-2f6ab7e45670/testing/mozharness/ program finished with exit code 0 elapsedTime=1.104965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 05:07:42.697717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:42.698050) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:42.707550) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:42.707799) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 05:07:42.708189) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-16 05:07:42.708469) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=d7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:44 INFO - MultiFileLogger online at 20151216 05:07:44 in /builds/slave/test 05:07:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 05:07:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:44 INFO - {'append_to_log': False, 05:07:44 INFO - 'base_work_dir': '/builds/slave/test', 05:07:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:07:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:44 INFO - 'branch': 'Fx-Team-Non-PGO', 05:07:44 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:44 INFO - 'config_files': ('talos/linux_config.py',), 05:07:44 INFO - 'default_actions': ('clobber', 05:07:44 INFO - 'read-buildbot-config', 05:07:44 INFO - 'download-and-extract', 05:07:44 INFO - 'populate-webroot', 05:07:44 INFO - 'create-virtualenv', 05:07:44 INFO - 'install', 05:07:44 INFO - 'run-tests'), 05:07:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:44 INFO - 'download_minidump_stackwalk': True, 05:07:44 INFO - 'download_symbols': 'ondemand', 05:07:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:44 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:44 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:44 INFO - 'installer_path': 'installer.exe', 05:07:44 INFO - 'log_level': 'info', 05:07:44 INFO - 'log_name': 'talos', 05:07:44 INFO - 'log_to_console': True, 05:07:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:44 INFO - 'opt_config_files': (), 05:07:44 INFO - 'pip_index': False, 05:07:44 INFO - 'sps_profile': False, 05:07:44 INFO - 'sps_profile_interval': 0, 05:07:44 INFO - 'suite': 'dromaeojs-e10s', 05:07:44 INFO - 'system_bits': '64', 05:07:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:44 INFO - 'title': 'talos-linux64-ix-068', 05:07:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:44 INFO - 'use_talos_json': True, 05:07:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:44 INFO - 'work_dir': 'build'} 05:07:44 INFO - ##### 05:07:44 INFO - ##### Running clobber step. 05:07:44 INFO - ##### 05:07:44 INFO - Running pre-action listener: _resource_record_pre_action 05:07:44 INFO - Running main action method: clobber 05:07:44 INFO - rmtree: /builds/slave/test/build 05:07:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:44 INFO - Running post-action listener: _resource_record_post_action 05:07:44 INFO - ##### 05:07:44 INFO - ##### Running read-buildbot-config step. 05:07:44 INFO - ##### 05:07:44 INFO - Running pre-action listener: _resource_record_pre_action 05:07:44 INFO - Running main action method: read_buildbot_config 05:07:44 INFO - Using buildbot properties: 05:07:44 INFO - { 05:07:44 INFO - "properties": { 05:07:44 INFO - "buildnumber": 821, 05:07:44 INFO - "product": "firefox", 05:07:44 INFO - "script_repo_revision": "production", 05:07:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:07:44 INFO - "repository": "", 05:07:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:07:44 INFO - "buildid": "20151216033907", 05:07:44 INFO - "slavename": "talos-linux64-ix-068", 05:07:44 INFO - "pgo_build": "False", 05:07:44 INFO - "basedir": "/builds/slave/test", 05:07:44 INFO - "project": "", 05:07:44 INFO - "platform": "ubuntu64_hw", 05:07:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:07:44 INFO - "slavebuilddir": "test", 05:07:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:07:44 INFO - "branch": "fx-team", 05:07:44 INFO - "repo_path": "integration/fx-team", 05:07:44 INFO - "stage_platform": "linux64", 05:07:44 INFO - "builduid": "59a0b588721344efac4fb45824e0993b", 05:07:44 INFO - "revision": "2f6ab7e45670e267e186fcb205a0e6fc9038363c" 05:07:44 INFO - }, 05:07:44 INFO - "sourcestamp": { 05:07:44 INFO - "repository": "", 05:07:44 INFO - "hasPatch": false, 05:07:44 INFO - "project": "", 05:07:44 INFO - "branch": "fx-team-linux64-talos", 05:07:44 INFO - "changes": [ 05:07:44 INFO - { 05:07:44 INFO - "category": null, 05:07:44 INFO - "files": [ 05:07:44 INFO - { 05:07:44 INFO - "url": null, 05:07:44 INFO - "name": "https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 05:07:44 INFO - } 05:07:44 INFO - ], 05:07:44 INFO - "repository": "", 05:07:44 INFO - "rev": "2f6ab7e45670e267e186fcb205a0e6fc9038363c", 05:07:44 INFO - "who": "cbook@mozilla.com", 05:07:44 INFO - "when": 1450269352, 05:07:44 INFO - "number": 7365795, 05:07:44 INFO - "comments": "Bug 1232364 - remove the pref 'browser.panorama.animate_zoom', follow up bug 1222490. r=Gijs", 05:07:44 INFO - "project": "", 05:07:44 INFO - "at": "Wed 16 Dec 2015 04:35:52", 05:07:44 INFO - "branch": "fx-team-linux64-talos", 05:07:44 INFO - "revlink": "", 05:07:44 INFO - "properties": [ 05:07:44 INFO - [ 05:07:44 INFO - "buildid", 05:07:44 INFO - "20151216033907", 05:07:44 INFO - "Change" 05:07:44 INFO - ], 05:07:44 INFO - [ 05:07:44 INFO - "builduid", 05:07:44 INFO - "59a0b588721344efac4fb45824e0993b", 05:07:44 INFO - "Change" 05:07:44 INFO - ], 05:07:44 INFO - [ 05:07:44 INFO - "pgo_build", 05:07:44 INFO - "False", 05:07:44 INFO - "Change" 05:07:44 INFO - ] 05:07:44 INFO - ], 05:07:44 INFO - "revision": "2f6ab7e45670e267e186fcb205a0e6fc9038363c" 05:07:44 INFO - } 05:07:44 INFO - ], 05:07:44 INFO - "revision": "2f6ab7e45670e267e186fcb205a0e6fc9038363c" 05:07:44 INFO - } 05:07:44 INFO - } 05:07:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:07:44 INFO - Running post-action listener: _resource_record_post_action 05:07:44 INFO - ##### 05:07:44 INFO - ##### Running download-and-extract step. 05:07:44 INFO - ##### 05:07:44 INFO - Running pre-action listener: _resource_record_pre_action 05:07:44 INFO - Running main action method: download_and_extract 05:07:44 INFO - mkdir: /builds/slave/test/build/tests 05:07: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')]} 05:07:44 INFO - https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/test_packages.json 05:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/test_packages.json 05:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:07:45 INFO - Downloaded 1302 bytes. 05:07:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:07:45 INFO - Using the following test package requirements: 05:07:45 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:45 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:45 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:45 INFO - u'jsshell-linux-x86_64.zip'], 05:07:45 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:45 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:45 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:45 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:45 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:45 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:45 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:45 INFO - https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/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 05:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/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 05:07:46 INFO - Downloaded 21869080 bytes. 05:07:46 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 05:07:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:07:46 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 05:07:47 INFO - Return code: 0 05:07:47 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 05:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:47 INFO - https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/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 05:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/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 05:07:48 INFO - Downloaded 21869080 bytes. 05:07:48 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 05:07:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:07:48 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 05:07:49 INFO - Return code: 0 05:07: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')]} 05:07:49 INFO - https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/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 05:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/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 05:07:50 INFO - Downloaded 11132052 bytes. 05:07:50 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 05:07:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:50 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 05:07:50 INFO - Return code: 0 05:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:50 INFO - https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/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 05:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1JbsXQqTR0OT0slVh9jQFg/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 05:07:53 INFO - Downloaded 57745049 bytes. 05:07:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:07:53 INFO - mkdir: /builds/slave/test/properties 05:07:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:53 INFO - Contents: 05:07:53 INFO - build_url:https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:07:53 INFO - Running post-action listener: _resource_record_post_action 05:07:53 INFO - Running post-action listener: set_extra_try_arguments 05:07:53 INFO - ##### 05:07:53 INFO - ##### Running populate-webroot step. 05:07:53 INFO - ##### 05:07:53 INFO - Running pre-action listener: _resource_record_pre_action 05:07:53 INFO - Running main action method: populate_webroot 05:07:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:53 INFO - '--tppagecycles', 05:07:53 INFO - '7'], 05:07:53 INFO - 'tests': ['tsvgm']}}, 05:07:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:07:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:07:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:07:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:53 INFO - 'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:53 INFO - 'tests': ['damp', 'tps']}, 05:07:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:53 INFO - 'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['damp', 'tps']}, 05:07:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:07:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:53 INFO - 'other': {'tests': ['a11yr', 05:07:53 INFO - 'ts_paint', 05:07:53 INFO - 'tpaint', 05:07:53 INFO - 'sessionrestore', 05:07:53 INFO - 'sessionrestore_no_auto_restore']}, 05:07:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['a11yr', 05:07:53 INFO - 'ts_paint', 05:07:53 INFO - 'tpaint', 05:07:53 INFO - 'sessionrestore', 05:07:53 INFO - 'sessionrestore_no_auto_restore']}, 05:07:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['a11yr', 05:07:53 INFO - 'ts_paint', 05:07:53 INFO - 'tpaint', 05:07:53 INFO - 'sessionrestore', 05:07:53 INFO - 'sessionrestore_no_auto_restore']}, 05:07:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['a11yr', 05:07:53 INFO - 'ts_paint', 05:07:53 INFO - 'tpaint', 05:07:53 INFO - 'sessionrestore', 05:07:53 INFO - 'sessionrestore_no_auto_restore']}, 05:07:53 INFO - 'other_l64': {'tests': ['a11yr', 05:07:53 INFO - 'ts_paint', 05:07:53 INFO - 'tpaint', 05:07:53 INFO - 'sessionrestore', 05:07:53 INFO - 'sessionrestore_no_auto_restore']}, 05:07:53 INFO - 'other_nol64': {'tests': ['a11yr', 05:07:53 INFO - 'ts_paint', 05:07:53 INFO - 'tpaint', 05:07:53 INFO - 'sessionrestore', 05:07:53 INFO - 'sessionrestore_no_auto_restore']}, 05:07:53 INFO - 'svgr': {'tests': ['tsvgx', 05:07:53 INFO - 'tsvgr_opacity', 05:07:53 INFO - 'tart', 05:07:53 INFO - 'tscrollx', 05:07:53 INFO - 'cart']}, 05:07:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['tsvgx', 05:07:53 INFO - 'tsvgr_opacity', 05:07:53 INFO - 'tart', 05:07:53 INFO - 'tscrollx', 05:07:53 INFO - 'cart']}, 05:07:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:53 INFO - 'tests': ['tp5o']}, 05:07:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:53 INFO - 'talos_options': ['--e10s'], 05:07:53 INFO - 'tests': ['tp5o']}, 05:07:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:53 INFO - 'talos_options': ['--xperf_path', 05:07:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:53 INFO - 'tests': ['tp5n']}, 05:07:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:53 INFO - 'talos_options': ['--e10s', 05:07:53 INFO - '--xperf_path', 05:07:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:53 INFO - 'tests': ['tp5n']}}, 05:07:53 INFO - 'talos.zip': {'path': '', 05:07:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:53 INFO - Running post-action listener: _resource_record_post_action 05:07:53 INFO - ##### 05:07:53 INFO - ##### Running create-virtualenv step. 05:07:53 INFO - ##### 05:07:53 INFO - Running pre-action listener: _resource_record_pre_action 05:07:53 INFO - Running main action method: create_virtualenv 05:07:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:53 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 05:07:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:53 INFO - Using real prefix '/usr' 05:07:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:55 INFO - Installing pip.................done. 05:07:55 INFO - Return code: 0 05:07:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:55 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')]} 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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')]} 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:07:55 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 05:07:55 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 05:07:55 INFO - Using env: {'DISPLAY': ':0', 05:07:55 INFO - 'HOME': '/home/cltbld', 05:07:55 INFO - 'LANG': 'en_US.UTF-8', 05:07:55 INFO - 'LANGUAGE': 'en_US:en', 05:07:55 INFO - 'LOGNAME': 'cltbld', 05:07:55 INFO - 'MAIL': '/var/mail/cltbld', 05:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:55 INFO - 'MOZ_NO_REMOTE': '1', 05:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:55 INFO - 'NO_EM_RESTART': '1', 05:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:55 INFO - 'PWD': '/builds/slave/test', 05:07:55 INFO - 'SHELL': '/bin/bash', 05:07:55 INFO - 'SHLVL': '1', 05:07:55 INFO - 'TERM': 'linux', 05:07:55 INFO - 'TMOUT': '86400', 05:07:55 INFO - 'USER': 'cltbld', 05:07:55 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:55 INFO - '_': '/tools/buildbot/bin/python'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 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 05:07:55 INFO - Cleaning up... 05:07:55 INFO - Return code: 0 05:07:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:07:55 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')]} 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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')]} 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:07:55 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 05:07:55 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 05:07:55 INFO - Using env: {'DISPLAY': ':0', 05:07:55 INFO - 'HOME': '/home/cltbld', 05:07:55 INFO - 'LANG': 'en_US.UTF-8', 05:07:55 INFO - 'LANGUAGE': 'en_US:en', 05:07:55 INFO - 'LOGNAME': 'cltbld', 05:07:55 INFO - 'MAIL': '/var/mail/cltbld', 05:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:55 INFO - 'MOZ_NO_REMOTE': '1', 05:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:55 INFO - 'NO_EM_RESTART': '1', 05:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:55 INFO - 'PWD': '/builds/slave/test', 05:07:55 INFO - 'SHELL': '/bin/bash', 05:07:55 INFO - 'SHLVL': '1', 05:07:55 INFO - 'TERM': 'linux', 05:07:55 INFO - 'TMOUT': '86400', 05:07:55 INFO - 'USER': 'cltbld', 05:07:55 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:55 INFO - '_': '/tools/buildbot/bin/python'} 05:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:56 INFO - Downloading/unpacking psutil>=0.7.1 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:07:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:57 INFO - Installing collected packages: psutil 05:07:57 INFO - Running setup.py install for psutil 05:07:57 INFO - building 'psutil._psutil_linux' extension 05:07:57 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 05:07:58 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 05:07:58 INFO - building 'psutil._psutil_posix' extension 05:07:58 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 05:07:58 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 05:07:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:58 INFO - Successfully installed psutil 05:07:58 INFO - Cleaning up... 05:07:58 INFO - Return code: 0 05:07:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:07:58 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')]} 05:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:58 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')]} 05:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:58 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 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:07:58 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 05:07:58 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 05:07:58 INFO - Using env: {'DISPLAY': ':0', 05:07:58 INFO - 'HOME': '/home/cltbld', 05:07:58 INFO - 'LANG': 'en_US.UTF-8', 05:07:58 INFO - 'LANGUAGE': 'en_US:en', 05:07:58 INFO - 'LOGNAME': 'cltbld', 05:07:58 INFO - 'MAIL': '/var/mail/cltbld', 05:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:58 INFO - 'MOZ_NO_REMOTE': '1', 05:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:58 INFO - 'NO_EM_RESTART': '1', 05:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:58 INFO - 'PWD': '/builds/slave/test', 05:07:58 INFO - 'SHELL': '/bin/bash', 05:07:58 INFO - 'SHLVL': '1', 05:07:58 INFO - 'TERM': 'linux', 05:07:58 INFO - 'TMOUT': '86400', 05:07:58 INFO - 'USER': 'cltbld', 05:07:58 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:58 INFO - '_': '/tools/buildbot/bin/python'} 05:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:00 INFO - Installing collected packages: mozsystemmonitor 05:08:00 INFO - Running setup.py install for mozsystemmonitor 05:08:00 INFO - Successfully installed mozsystemmonitor 05:08:00 INFO - Cleaning up... 05:08:00 INFO - Return code: 0 05:08:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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', '--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 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:08:00 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 05:08:00 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 05:08:00 INFO - Using env: {'DISPLAY': ':0', 05:08:00 INFO - 'HOME': '/home/cltbld', 05:08:00 INFO - 'LANG': 'en_US.UTF-8', 05:08:00 INFO - 'LANGUAGE': 'en_US:en', 05:08:00 INFO - 'LOGNAME': 'cltbld', 05:08:00 INFO - 'MAIL': '/var/mail/cltbld', 05:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:00 INFO - 'MOZ_NO_REMOTE': '1', 05:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:00 INFO - 'NO_EM_RESTART': '1', 05:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:00 INFO - 'PWD': '/builds/slave/test', 05:08:00 INFO - 'SHELL': '/bin/bash', 05:08:00 INFO - 'SHLVL': '1', 05:08:00 INFO - 'TERM': 'linux', 05:08:00 INFO - 'TMOUT': '86400', 05:08:00 INFO - 'USER': 'cltbld', 05:08:00 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:00 INFO - '_': '/tools/buildbot/bin/python'} 05:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:03 INFO - Downloading docopt-0.6.1.tar.gz 05:08:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:03 INFO - Running setup.py install for blobuploader 05:08:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:03 INFO - Running setup.py install for requests 05:08:03 INFO - Running setup.py install for docopt 05:08:03 INFO - Successfully installed blobuploader requests docopt 05:08:03 INFO - Cleaning up... 05:08:03 INFO - Return code: 0 05:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:03 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 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:08:03 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 05:08:03 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 05:08:03 INFO - Using env: {'DISPLAY': ':0', 05:08:03 INFO - 'HOME': '/home/cltbld', 05:08:03 INFO - 'LANG': 'en_US.UTF-8', 05:08:03 INFO - 'LANGUAGE': 'en_US:en', 05:08:03 INFO - 'LOGNAME': 'cltbld', 05:08:03 INFO - 'MAIL': '/var/mail/cltbld', 05:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:03 INFO - 'MOZ_NO_REMOTE': '1', 05:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:03 INFO - 'NO_EM_RESTART': '1', 05:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:03 INFO - 'PWD': '/builds/slave/test', 05:08:03 INFO - 'SHELL': '/bin/bash', 05:08:03 INFO - 'SHLVL': '1', 05:08:03 INFO - 'TERM': 'linux', 05:08:03 INFO - 'TMOUT': '86400', 05:08:03 INFO - 'USER': 'cltbld', 05:08:03 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:03 INFO - '_': '/tools/buildbot/bin/python'} 05:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:03 INFO - Running setup.py (path:/tmp/pip-c8YAxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:04 INFO - Running setup.py (path:/tmp/pip-27rLb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:04 INFO - Running setup.py (path:/tmp/pip-4OF7BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:04 INFO - Running setup.py (path:/tmp/pip-aC9nF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:04 INFO - Running setup.py (path:/tmp/pip-f0627S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:04 INFO - Running setup.py (path:/tmp/pip-ybcoz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:04 INFO - Running setup.py (path:/tmp/pip-Hjd1fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:04 INFO - Running setup.py (path:/tmp/pip-TU65Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:04 INFO - Running setup.py (path:/tmp/pip-5cGuqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:04 INFO - Running setup.py (path:/tmp/pip-gAti5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:04 INFO - Running setup.py (path:/tmp/pip-IEyYR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:04 INFO - Running setup.py (path:/tmp/pip-KIj9TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:04 INFO - Running setup.py (path:/tmp/pip-fiFPsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:04 INFO - Running setup.py (path:/tmp/pip-Rp2HjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:05 INFO - Running setup.py (path:/tmp/pip-1cDG6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:05 INFO - Running setup.py (path:/tmp/pip-uiIFZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:05 INFO - Running setup.py (path:/tmp/pip-BkhXQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:05 INFO - Running setup.py install for manifestparser 05:08:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozcrash 05:08:05 INFO - Running setup.py install for mozdebug 05:08:05 INFO - Running setup.py install for mozdevice 05:08:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozfile 05:08:05 INFO - Running setup.py install for mozhttpd 05:08:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozinfo 05:08:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozInstall 05:08:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozleak 05:08:06 INFO - Running setup.py install for mozlog 05:08:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for moznetwork 05:08:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozprocess 05:08:06 INFO - Running setup.py install for mozprofile 05:08:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozrunner 05:08:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozscreenshot 05:08:06 INFO - Running setup.py install for moztest 05:08:06 INFO - Running setup.py install for mozversion 05:08:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:07 INFO - Cleaning up... 05:08:07 INFO - Return code: 0 05:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 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 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:08:07 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 05:08:07 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 05:08:07 INFO - Using env: {'DISPLAY': ':0', 05:08:07 INFO - 'HOME': '/home/cltbld', 05:08:07 INFO - 'LANG': 'en_US.UTF-8', 05:08:07 INFO - 'LANGUAGE': 'en_US:en', 05:08:07 INFO - 'LOGNAME': 'cltbld', 05:08:07 INFO - 'MAIL': '/var/mail/cltbld', 05:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:07 INFO - 'MOZ_NO_REMOTE': '1', 05:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:07 INFO - 'NO_EM_RESTART': '1', 05:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:07 INFO - 'PWD': '/builds/slave/test', 05:08:07 INFO - 'SHELL': '/bin/bash', 05:08:07 INFO - 'SHLVL': '1', 05:08:07 INFO - 'TERM': 'linux', 05:08:07 INFO - 'TMOUT': '86400', 05:08:07 INFO - 'USER': 'cltbld', 05:08:07 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:07 INFO - '_': '/tools/buildbot/bin/python'} 05:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:07 INFO - Running setup.py (path:/tmp/pip-7tk8TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:07 INFO - Running setup.py (path:/tmp/pip-aYc9kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:07 INFO - Running setup.py (path:/tmp/pip-t_3lg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:07 INFO - Running setup.py (path:/tmp/pip-kCe8of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:07 INFO - Running setup.py (path:/tmp/pip-gc391A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:07 INFO - Running setup.py (path:/tmp/pip-87LFC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:07 INFO - Running setup.py (path:/tmp/pip-JmwcRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:07 INFO - Running setup.py (path:/tmp/pip-ldfjbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:07 INFO - Running setup.py (path:/tmp/pip-XltNKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:07 INFO - Running setup.py (path:/tmp/pip-2UpH4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:07 INFO - Running setup.py (path:/tmp/pip-Oj_qU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:08 INFO - Running setup.py (path:/tmp/pip-Z8I76I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:08 INFO - Running setup.py (path:/tmp/pip-W5bubo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:08 INFO - Running setup.py (path:/tmp/pip-f8t736-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:08 INFO - Running setup.py (path:/tmp/pip-Vd2D2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:08 INFO - Running setup.py (path:/tmp/pip-kMS9gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:08 INFO - Running setup.py (path:/tmp/pip-ry88Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:08 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)) 05:08:08 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)) 05:08:08 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)) 05:08:08 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)) 05:08:08 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)) 05:08:08 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)) 05:08:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:10 INFO - Downloading blessings-1.5.1.tar.gz 05:08:10 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 05:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:10 INFO - Installing collected packages: blessings 05:08:10 INFO - Running setup.py install for blessings 05:08:10 INFO - Successfully installed blessings 05:08:10 INFO - Cleaning up... 05:08:10 INFO - Return code: 0 05:08:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:10 INFO - Reading from file tmpfile_stdout 05:08:10 INFO - Current package versions: 05:08:10 INFO - argparse == 1.2.1 05:08:10 INFO - blessings == 1.5.1 05:08:10 INFO - blobuploader == 1.2.4 05:08:10 INFO - docopt == 0.6.1 05:08:10 INFO - manifestparser == 1.1 05:08:10 INFO - mozInstall == 1.12 05:08:10 INFO - mozcrash == 0.16 05:08:10 INFO - mozdebug == 0.1 05:08:10 INFO - mozdevice == 0.47 05:08:10 INFO - mozfile == 1.2 05:08:10 INFO - mozhttpd == 0.7 05:08:10 INFO - mozinfo == 0.9 05:08:10 INFO - mozleak == 0.1 05:08:10 INFO - mozlog == 3.1 05:08:10 INFO - moznetwork == 0.27 05:08:10 INFO - mozprocess == 0.22 05:08:10 INFO - mozprofile == 0.27 05:08:10 INFO - mozrunner == 6.11 05:08:10 INFO - mozscreenshot == 0.1 05:08:10 INFO - mozsystemmonitor == 0.0 05:08:10 INFO - moztest == 0.7 05:08:10 INFO - mozversion == 1.4 05:08:10 INFO - psutil == 3.1.1 05:08:10 INFO - requests == 1.2.3 05:08:10 INFO - wsgiref == 0.1.2 05:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:10 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')]} 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:10 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')]} 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:10 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 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:08:10 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 05:08:10 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 05:08:10 INFO - Using env: {'DISPLAY': ':0', 05:08:10 INFO - 'HOME': '/home/cltbld', 05:08:10 INFO - 'LANG': 'en_US.UTF-8', 05:08:10 INFO - 'LANGUAGE': 'en_US:en', 05:08:10 INFO - 'LOGNAME': 'cltbld', 05:08:10 INFO - 'MAIL': '/var/mail/cltbld', 05:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:10 INFO - 'MOZ_NO_REMOTE': '1', 05:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:10 INFO - 'NO_EM_RESTART': '1', 05:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:10 INFO - 'PWD': '/builds/slave/test', 05:08:10 INFO - 'SHELL': '/bin/bash', 05:08:10 INFO - 'SHLVL': '1', 05:08:10 INFO - 'TERM': 'linux', 05:08:10 INFO - 'TMOUT': '86400', 05:08:10 INFO - 'USER': 'cltbld', 05:08:10 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:10 INFO - '_': '/tools/buildbot/bin/python'} 05:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 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)) 05:08:10 INFO - Cleaning up... 05:08:10 INFO - Return code: 0 05:08:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:10 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')]} 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:10 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')]} 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:10 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 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:08:10 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 05:08:10 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 05:08:10 INFO - Using env: {'DISPLAY': ':0', 05:08:10 INFO - 'HOME': '/home/cltbld', 05:08:10 INFO - 'LANG': 'en_US.UTF-8', 05:08:10 INFO - 'LANGUAGE': 'en_US:en', 05:08:10 INFO - 'LOGNAME': 'cltbld', 05:08:10 INFO - 'MAIL': '/var/mail/cltbld', 05:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:10 INFO - 'MOZ_NO_REMOTE': '1', 05:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:10 INFO - 'NO_EM_RESTART': '1', 05:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:10 INFO - 'PWD': '/builds/slave/test', 05:08:10 INFO - 'SHELL': '/bin/bash', 05:08:10 INFO - 'SHLVL': '1', 05:08:10 INFO - 'TERM': 'linux', 05:08:10 INFO - 'TMOUT': '86400', 05:08:10 INFO - 'USER': 'cltbld', 05:08:10 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:10 INFO - '_': '/tools/buildbot/bin/python'} 05:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:11 INFO - Downloading/unpacking jsonschema 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:12 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 05:08:12 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:12 INFO - warning: no files found matching '*.txt' 05:08:12 INFO - no previously-included directories found matching 'build' 05:08:12 INFO - no previously-included directories found matching 'dist' 05:08:12 INFO - no previously-included directories found matching '.git*' 05:08:12 INFO - Installing collected packages: jsonschema, functools32 05:08:13 INFO - Running setup.py install for functools32 05:08:13 INFO - warning: no files found matching '*.txt' 05:08:13 INFO - no previously-included directories found matching 'build' 05:08:13 INFO - no previously-included directories found matching 'dist' 05:08:13 INFO - no previously-included directories found matching '.git*' 05:08:13 INFO - Successfully installed jsonschema functools32 05:08:13 INFO - Cleaning up... 05:08:13 INFO - Return code: 0 05:08:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f12b48c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', '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 05:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:08:13 INFO - Using env: {'DISPLAY': ':0', 05:08:13 INFO - 'HOME': '/home/cltbld', 05:08:13 INFO - 'LANG': 'en_US.UTF-8', 05:08:13 INFO - 'LANGUAGE': 'en_US:en', 05:08:13 INFO - 'LOGNAME': 'cltbld', 05:08:13 INFO - 'MAIL': '/var/mail/cltbld', 05:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:13 INFO - 'MOZ_NO_REMOTE': '1', 05:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:13 INFO - 'NO_EM_RESTART': '1', 05:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:13 INFO - 'PWD': '/builds/slave/test', 05:08:13 INFO - 'SHELL': '/bin/bash', 05:08:13 INFO - 'SHLVL': '1', 05:08:13 INFO - 'TERM': 'linux', 05:08:13 INFO - 'TMOUT': '86400', 05:08:13 INFO - 'USER': 'cltbld', 05:08:13 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:13 INFO - '_': '/tools/buildbot/bin/python'} 05:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:13 INFO - Downloading/unpacking flake8 05:08:13 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 05:08:13 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 05:08:13 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 05:08:13 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 05:08:13 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 05:08:13 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 05:08:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:15 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 05:08:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:15 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 05:08:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:15 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 05:08:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:15 INFO - no previously-included directories found matching 'docs/_build' 05:08:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:15 INFO - Running setup.py install for pep8 05:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:15 INFO - no previously-included directories found matching 'docs/_build' 05:08:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:15 INFO - Cleaning up... 05:08:16 INFO - Return code: 0 05:08:16 INFO - Running post-action listener: _resource_record_post_action 05:08:16 INFO - Running post-action listener: _start_resource_monitoring 05:08:16 INFO - Starting resource monitoring. 05:08:16 INFO - ##### 05:08:16 INFO - ##### Running install step. 05:08:16 INFO - ##### 05:08:16 INFO - Running pre-action listener: _resource_record_pre_action 05:08:16 INFO - Running main action method: install 05:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:16 INFO - Reading from file tmpfile_stdout 05:08:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:16 INFO - Reading from file tmpfile_stdout 05:08:16 INFO - Output received: 05:08:16 INFO - Usage: mozinstall [options] installer 05:08:16 INFO - Options: 05:08:16 INFO - -h, --help show this help message and exit 05:08:16 INFO - -d DEST, --destination=DEST 05:08:16 INFO - Directory to install application into. [default: 05:08:16 INFO - "/builds/slave/test"] 05:08:16 INFO - --app=APP Application being installed. [default: firefox] 05:08:16 INFO - mkdir: /builds/slave/test/build/application 05:08:16 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'] 05:08:16 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 05:08:30 INFO - Reading from file tmpfile_stdout 05:08:30 INFO - Output received: 05:08:30 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:30 INFO - Running post-action listener: _resource_record_post_action 05:08:30 INFO - ##### 05:08:30 INFO - ##### Running run-tests step. 05:08:30 INFO - ##### 05:08:30 INFO - Running pre-action listener: _resource_record_pre_action 05:08:30 INFO - Running main action method: run_tests 05:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:30 INFO - Python 2.7.3 05:08:30 INFO - Return code: 0 05:08:30 INFO - grabbing minidump binary from tooltool 05:08:30 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')]} 05:08:30 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 0x21d00b0>, '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 0x21d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:30 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 05:08:30 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 05:08:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:30 INFO - Return code: 0 05:08:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:08:31 INFO - Return code: 0 05:08:31 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test/build 05:08:31 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 05:08:31 INFO - Using env: {'DISPLAY': ':0', 05:08:31 INFO - 'HOME': '/home/cltbld', 05:08:31 INFO - 'LANG': 'en_US.UTF-8', 05:08:31 INFO - 'LANGUAGE': 'en_US:en', 05:08:31 INFO - 'LOGNAME': 'cltbld', 05:08:31 INFO - 'MAIL': '/var/mail/cltbld', 05:08:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:31 INFO - 'MOZ_NO_REMOTE': '1', 05:08:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:31 INFO - 'NO_EM_RESTART': '1', 05:08:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:31 INFO - 'PWD': '/builds/slave/test', 05:08:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:31 INFO - 'SHELL': '/bin/bash', 05:08:31 INFO - 'SHLVL': '1', 05:08:31 INFO - 'TERM': 'linux', 05:08:31 INFO - 'TMOUT': '86400', 05:08:31 INFO - 'USER': 'cltbld', 05:08:31 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956', 05:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:31 INFO - '_': '/tools/buildbot/bin/python'} 05:08:31 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 05:08:32 INFO - mozversion INFO | application_buildid: 20151216033907 05:08:32 INFO - mozversion INFO | application_changeset: 2f6ab7e45670e267e186fcb205a0e6fc9038363c 05:08:32 INFO - mozversion INFO | application_display_name: Nightly 05:08:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:32 INFO - mozversion INFO | application_name: Firefox 05:08:32 INFO - mozversion INFO | application_remotingname: firefox 05:08:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:08:32 INFO - mozversion INFO | application_vendor: Mozilla 05:08:32 INFO - mozversion INFO | application_version: 46.0a1 05:08:32 INFO - mozversion INFO | platform_buildid: 20151216033907 05:08:32 INFO - mozversion INFO | platform_changeset: 2f6ab7e45670e267e186fcb205a0e6fc9038363c 05:08:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:32 INFO - mozversion INFO | platform_version: 46.0a1 05:08:32 INFO - 2015-12-16 05:08:32,073 DEBUG : using testdate: 1450271312 05:08:32 INFO - 2015-12-16 05:08:32,074 DEBUG : actual date: 1450271312 05:08:32 INFO - 2015-12-16 05:08:32,087 INFO : starting webserver on 'localhost:38488' 05:08:32 INFO - 2015-12-16 05:08:32,088 INFO : Starting test suite talos-linux64-ix-068.e 05:08:32 INFO - 2015-12-16 05:08:32,089 INFO : Starting test dromaeo_css 05:08:32 INFO - 2015-12-16 05:08:32,089 DEBUG : operating with platform_type : linux_ 05:08:32 INFO - 2015-12-16 05:08:32,089 INFO : Initialising browser for dromaeo_css test... 05:08:32 INFO - 2015-12-16 05:08:32,103 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZBXAB/profile http://localhost:38488/getInfo.html 05:08:36 INFO - 2015-12-16 05:08:36,695 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:08:36 INFO - 2015-12-16 05:08:36,695 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:08:36 INFO - 2015-12-16 05:08:36,695 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:08:36 INFO - 2015-12-16 05:08:36,695 DEBUG : BROWSER_OUTPUT: __metrics 05:08:36 INFO - 2015-12-16 05:08:36,820 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] 05:08:37 INFO - 2015-12-16 05:08:37,689 INFO : Browser initialized. 05:08:37 INFO - 2015-12-16 05:08:37,690 INFO : Running cycle 1/1 for dromaeo_css test... 05:08:37 INFO - 2015-12-16 05:08:37,690 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZBXAB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:08:49 INFO - 2015-12-16 05:08:49,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 142917632 05:08:49 INFO - 2015-12-16 05:08:49,699 DEBUG : BROWSER_OUTPUT: 05:09:39 INFO - 2015-12-16 05:09:39,356 DEBUG : BROWSER_OUTPUT: 1450271379354 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:11:51 INFO - 2015-12-16 05:11:51,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38488/tests/dromaeo/cssquery-ext.html) 05:11:52 INFO - 2015-12-16 05:11:52,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 147046400 05:11:52 INFO - 2015-12-16 05:11:52,434 DEBUG : BROWSER_OUTPUT: 05:14:54 INFO - 2015-12-16 05:14:54,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-ext.html (next: http://localhost:38488/tests/dromaeo/cssquery-jquery.html) 05:14:55 INFO - 2015-12-16 05:14:55,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 144932864 05:14:55 INFO - 2015-12-16 05:14:55,098 DEBUG : BROWSER_OUTPUT: 05:17:56 INFO - 2015-12-16 05:17:56,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38488/tests/dromaeo/cssquery-mootools.html) 05:17:57 INFO - 2015-12-16 05:17:57,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 145154048 05:17:57 INFO - 2015-12-16 05:17:57,501 DEBUG : BROWSER_OUTPUT: 05:20:59 INFO - 2015-12-16 05:20:59,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38488/tests/dromaeo/cssquery-prototype.html) 05:20:59 INFO - 2015-12-16 05:20:59,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 144023552 05:20:59 INFO - 2015-12-16 05:20:59,966 DEBUG : BROWSER_OUTPUT: 05:24:02 INFO - 2015-12-16 05:24:02,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38488/tests/dromaeo/cssquery-yui.html) 05:24:03 INFO - 2015-12-16 05:24:03,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 143867904 05:24:03 INFO - 2015-12-16 05:24:03,075 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-yui.html (next: http://localhost:38488/tests/dromaeo/cssquery-dojo.html) 05:27:05 INFO - 2015-12-16 05:27:05,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 147484672 05:27:05 INFO - 2015-12-16 05:27:05,692 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,692 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:27:05 INFO - 2015-12-16 05:27:05,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:27:05 INFO - 2015-12-16 05:27:05,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:27:05 INFO - 2015-12-16 05:27:05,692 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:27:05 INFO - 2015-12-16 05:27:05,693 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2675.8524287354603;2708.268767432792;2738.575520794276;2747.395572973945;2761.4201017786263;4632.768361581924;4779.259214821699;4783.593394561462;4796.136695394832;4821.807127714896;4753.0493901219725;4755.952440475594;4816.783244753986;4836.854894353166;4870.586000189988;4315.762633055181;4387.868363949071;4436.866893993185;4441.511433742286;4500.572445617661;4318.5033721122;4380.759058251795;4388.275934470808;4416.933745993812;4422.6240769534625;4184.100418410057;4278.4865816102265;4310.374995625648;4372.5627437256335;4377.474703035624;4391.165678521103;4392.736435813861;4432.401625780511;4442.2892337225885;4449.9110017799785;4374.212641724488;4391.363252328394;4402.647788176938;4406.449193850769;4409.955900440987;4492.550744925514;4537.4328208973875;4629.583337499641;4714.316424118484;4719.056188762227;5053.36832895888;5080.13637681595;5092.668976516515;5117.437081920985;5138.2549530318265;5144.228365745168;5149.433562308143;5157.742112894378;5161.741912904377;5165.509276618715;4624.884377890546;4722.858314250578;4752.881177970544;4774.546418090275;4777.211760059621;5096.362954630671;5169.431362550116;5189.974050129801;5199.142141546602;5253.868653283622;5064.442911279756;5083.2375143727995;5090.287359769635;5109.770060347293;5139.177731562932;4877.951220487821;5001.44984051754;5098.2352647103235;5194.246834209019;5196.610254230872;5056.974715126401;5072.163093089599;5075.984803039407;5082.263071854561;5124.180131178993;5049.267856160836;5056.26684130799;5059.215821547592;5074.49255074497;5115.18157094863;4071.75569465833;4161.0221597924465;4164.895877603084;4226.4928208615165;4283.443152390169;3709.4621279914263;3715.9442608360896;3717.386631205875;3759;3760.022394177479;4427.136708341843;4444.866654000385;4445.955540444619;4448.488423831236;4489.32660100981;4915.361003069578;4985.127602669519;5024.120778863684;5033.19468884984;5042.722650254272;4369.169857727022;4375.234333991539;4383.3863259143745;4394.494633117169;4474.552544745565;4466.0398014427055;4582.88542786433;4590.54094590545;4591.563801438858;4628.652851036186;4680.5085466025575;4797.376341075638;4935.210366341368;4937.802487900587;4946.455889852042;4962.503749625153;5038.992201559776;5053.267276244997;5055.140626093499;5056.974715126401;4858.562729354234;4875.1712208923855;4877.12211801879;4913.9017219656125;4955.776990035529;4783.904321913473;4881.877953051202;4934.55588996992;5065.924011139909;5093.821716239914;5130.692158470503;5144.588432925432;5160.045391602565;5168.793248270177;5214.713190774544;4949.529794669501;4954.083494553519;4967.3542439482635;4989.725565093955;5004.3494345734825;4783.282507623745;4847.830325938575;4883.951160488492;4969.503049695146;4991.80032798684;4887.437944636412;4888.706677599355;4897.583705385082;4900.411950565955;4910.43529994041;4987.326710893983;4988.326575912205;4996.450390456974;5048.798048078183;5057.241413787961;4645.6515761318715;4766.499517550746;4797.472278049342;4875.1224779540025;4899.877503062452 05:27:05 INFO - 2015-12-16 05:27:05,693 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.9176519404687;575.0023708865118;578.3869098755318;578.9913151302732;581.354696287121;32555.51166732498;33674.326513469714;33714.66285337146;33819.66180338196;33847.83076084622;39305.803470982675;40182;40183;40184;40243;7975.963124793769;8144.592770361458;8145.877811832827;8165.183481651847;8170.142135075821;7874.842503149934;7919.089304729943;7936.6825326986855;7939.642716077761;7994.5203287802915;7817.8827317590285;7859.331956783681;7928.722494712686;7962.124166341698;7965.8805117923275;7857.253560911733;7911.446198766089;7931.365490760725;7983.2415920487465;8001;7877.212278772135;8003.9199608003755;8009.51942883423;8012.759617211493;8022.919770802276;37109.81445092784;37113.814430927945;37149.257014859555;37296;37561.81219093914;2843.559248316514;2939.514980028293;2943.8528073596235;3480.564929383827;3511.2450823073164;28156.85921570379;28329.57505637417;28507.144785656463;28624.284392890135;29342.11973640794;3303.355845610107;3317.4857897026;3338.7662863599558;3351.6480769519094;3460.8615655373756;211681;212028;213273;213578;213668;38056.61943380586;38414.807925960195;38879.41680874789;55397;55711;38676;38932.80533597314;38945.61054389476;39154.216915662095;39294.21411571753;12754.553590624284;12814.935925320313;12926.289054101926;12948;12996.415161317764;10809.513571889283;10816.78366432667;10914.672559823219;10926.617568385069;10983.176261780398;13254.204747715168;13390.866091339156;13439.395227214798;13460.461581536629;13497.730045399234;5404.216388623706;5436.91844622331;5564.582656300794;5585.3297604287745;5607.859803504945;829.655692887445;878.5475480127611;893.4549924546021;993.9105480506789;1016.4511163971521;26111;26186.476270474483;30216.54675179874;31223.843880780903;32132.839335803637;932.5756780664781;940.4592359393376;948.3304497838562;969.3602222533094;990.4255531791543;13473.258970756702;13475.663108422368;13658.795118073236;13695.246761428018;13814.723705525834;297049;304500;305867;307515;307750;47367.50008749163;47764.28353574699;47772.761136194094;48114.27828582574;48292.7585362071;1234.3026190202506;1235.178606226867;1240.534799450188;1243.0801207106676;1249.6688377579949;24692.259232223063;25391.11131110402;25535.74464255408;25598.872005639852;25679.743202567734;38376.80811595924;38607.22785544329;38926.80536597299;38997.41503877387;39083.21833563256;240089;241749;242279;242487;242840;29501.11496655104;29758.702412975592;43116.78441607772;44646;44796.55203447924;38686.419703703905;45714.54285457103;46321.536784631724;47003.52996469991;47331;33369.499457508646;33844;33919.66080339264;33993.660063400035;34369.48445773265;33139.337213255116;33404.832975834965;33620.49569256512;33878.15304617404;34132.488012680325;33051.17372065718;33158.66841331556;33378;33398.666013339556;33460.49809252912;28189.43621127607;30102.69897300999;30323.24191895132;30752.56471058048;30922.69077309288;24790;25619.10333138331;25998.35004124912;26434.867825661517;27635.723642763314 05:27:05 INFO - 2015-12-16 05:27:05,693 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.55256613835877;343.2739755417292;343.56367413385016;344.71388747339694;345.17330992273503;12245.265284082961;12626.62120136395;14824.258787060644;15043.623909402271;15917.363305467796;9930.851037234448;10186.439745813977;10193.847092293603;14532.636684082903;15065.472708455207;4426.933595996063;4548.840790572331;4556.70381425208;4572.15415148197;4580.9770951145365;4560.5667461591265;4830.9275360869615;4850.854474365757;4875.195592727196;4876.658633895629;4839.5644392004715;4846.151923413407;4850.054239423313;4864.586510146642;4866.829660961867;4854.441739199984;4904.337914381548;4995.1757959936385;5003.274525193827;5009.148444764399;4507.346434766973;4517.909641807179;4521.434820647419;4523.819047238107;4527.253003254459;10920.836187457195;10951.83572246417;10961.342319460779;11063.834042489369;17506.562335941577;1875.6154988227518;1899.5441094137445;1912.3211260002638;1985.9375234249608;2003.4891102768847;9775.560099795526;12317.199382040139;12739.235645861185;13079.149855259473;13132.212067275994;1785.544686105035;1788.3293764838186;1800.6848801459823;1804.0889350877853;1812.646533925885;53302.466975330135;54727.72636136794;55564.72217638927;55621.443785562034;55995;9740.220782337396;9814.263930205263;9995;10045;10060.496975151213;12242.387880605935;12690.175138615961;12697.809532857014;12706.745865082647;12749.235045897276;7046.365827075588;7249.238829922888;7300.3064708853635;7307.817304567428;7319.451041171933;6918.93081069193;6949.652517374111;7001.054857594261;7028.894566581505;7040.753573624898;4284.635805956466;4327.37253098299;4339.284018137035;4352.216601011848;4372.737635741865;1639.6228867360574;1648.175912043978;1659.2533359988054;1695.7286834106483;1710.5723569107722;826.7065191856924;866.7919699272129;884.1291328041874;885.831691978522;896.1799953042893;15544.922275388777;15662.686746265012;15723.21383930799;15881.364745410285;16181.4336498222;819.0580832043198;821.4126899267053;876.9342299327576;886.5079880666163;912.1653686876566;8794.956025219833;9173.58718857653;9259.907400925904;9338.393004454689;9397.107274808883;445016;456499;456630;458592;459549;68082.65958670175;70720.23199419952;71136.64431677808;71157;71649.85050448494;1081.789051135021;1092.3718861654581;1106.8561087058793;1126.8985791278824;1127.639155470258;14312.71374572482;14609.707805844037;14647.194404307866;14701.41194352214;15022.699546009237;28677;30971.380572388876;31278.53082203723;33241.16897077592;33310.83344583261;36358.45462318014;36818.26363472769;37249.06877328089;41217;42424.36363454613;8055;8289.58552072406;8327.250547450758;8336.499810011419;8394.58027098655;9816.411015339103;9942.900570994487;15635.609109772347;16293.429729959395;16351.67296654084;13388.531401401295;13449.663758406117;13730.382132804247;13772.517961871286;13854.16874987504;12498.875011249771;12513.374331283218;12704.428300726304;13484.258365789976;13662.93168534151;13501.122427042212;13685.657858553217;13692.863071369158;13934.372953216927;14180.361883715052;8588.527630980356;8591.6992905248;8788.209061184523;8838.955805220932;8873.866891996497;13748.106373085717;14084;14091.788623170865;14336.784948225577;14386.496472623827 05:27:05 INFO - 2015-12-16 05:27:05,693 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1470.0150898897737;1681.1510187355386;1717.1414292853574;1732.1252767352494;1748.1521462090889;7030.824229394268;7122.750703725371;7230.240824713402;7268.127824661042;7358.595277259748;7056.96471517643;7239.420846332294;7266.527675701076;7298.160711518164;7324.121105467338;2090.8640938339;2118.9152433902627;2133.114757375687;2134.3063504361144;2135.1566131378095;2060.4745789823573;2069.968950465744;2072.1504183284856;2094;2123.203798575534;1723.8189990051053;1761.621251430942;2000.8799472031724;2075.29439990404;2118.279784873143;2058.176729308281;2071.54426026274;2071.6996035574834;2072.2125592274915;2073.782252863443;2015.4961259685078;2027.3107143571256;2064.040221297089;2065.555905480314;2068.338131797825;7131.786046418616;7178.5692858428665;7195.13658361;7229.602371869545;7249.78250652476;4122.56713045129;4200.579942005775;4210.221109094828;4211.7262377945335;4213.936790948138;2679.356954330966;2703.9459210815676;2726.7273272672574;2762.4751297253456;2765.1566272286946;842.4439869685978;858.8239410920809;860.8751730999032;870.6038752367657;876.2639382918316;9713.805723885484;9738.853917191247;9749.951250243703;9770.609175632966;9797.951010244904;3831.252905683365;3871.399933010388;3924.9607503925167;3989.401589761559;3990.082281075369;8613.913860861436;8620.655173792979;8637.309015278763;8662.826743465095;8697;4231.217224813419;4273.145370925828;4286.892827679333;4288.935665965013;4302.139572085595;3878.26313000529;3892.6107389260847;3907.1794923065904;3915.432262322004;3917.9020524487114;3238.951415728766;3329.267561136546;3336.332733453319;3344.6989770920736;3349.9832500837338;1025.6974192613197;1047.1361127070197;1047.2041248650928;1065.0521036277719;1071.5338827609858;834.0825092398435;892.9864603674876;1011.544804837826;1070.9665173107987;1186.1222695205659;6594;6653.4677225821815;6657.866842663119;6668.733250670016;6681.632510211888;545.664416383921;553.8698405874616;575.6200907401179;582.6882617799541;707.3174386716843;5243.2659427680155;5303.443138470482;5330.38700549434;5336.599755018312;5345.412004679482;8192.918070819334;8721.738347849574;8751.56242187888;8839.248663863515;8853.955730221436;8674.262687671493;8676;8707.608157632794;8711.695090671923;8716.564171791511;6705.698243578953;6741;6781.830454238683;6823.488238382042;6900.6204658743245;6483.578567393104;6579.80260592183;6584.111144995364;6595.538312318092;6609.801705948829;7500.212477689982;7700.807479813049;7705.576193309422;7734.651940662796;7785.221477852169;7690.115636701851;7994.5602991836;8002.599870006593;8062.959685201771;8103.108658047492;6126.172966649624;6283.308836027942;6332.113504109337;6383.170187875732;6406.615603063831;6833;6941.444684425335;6964.65176741171;6973.755918542826;6979.441644668313;6460.580062295936;6573.638449885302;6626.227240382282;6628.734850605922;6675.465962723068;5587.832365029056;5705.62913410627;5814.447627475383;6267.561270711007;6327.620342779448;6253.624782513064;6257.40554647326;6337.04944258365;6353.745850165941;6427.742890284337;5992.670403127696;5998.1002849572915;6030.427109424598;6047.365026672136;6050.878982420415;6158.32258451561;6172.567920245539;6213.440790328892;6223.502119830493;6225 05:27:05 INFO - 2015-12-16 05:27:05,693 DEBUG : BROWSER_OUTPUT: |4;prototype.html;297.2286915454396;302.63381308616573;304.0498442367601;304.5477465963046;310.6582758965139;5579.525740312073;5607.971960140204;5688.971555142219;5699.116636921273;5718.113692377678;5592.832215033555;5604.327480702311;5614.185943038257;5623.550115990721;5629.240052592899;4186.853460128896;4281.314989601664;4283.207606592782;4288.935665965013;4292.570742925714;4295.398644189816;4299.91400171998;4322.481302243719;4334.869953901372;4336.566343365654;4239.1945530349285;4254.87235382939;4272.764997925113;4276.679249056333;4288.871333859974;4260.467441569788;4261.76560289184;4267.530571637118;4267.637250833683;4271.273883439807;3717.498137751396;3721.8697345593046;3730.477733117366;3731.4962480065387;3732.869349572779;5277.076511610453;5397.082495975694;5397.73011349431;5397.865053373697;5399.62202645815;4915.459299477055;4915.803367865281;4919.557239848395;4920.114379411704;4925.433575138869;5858.47273745365;5881.764729410861;5882.411758824126;5892.705364731789;5898.321693005317;4012.8194231259663;4028.3353246714255;4029.073313137965;4038.172174704179;4056.4320995060716;6038.788642397539;6168.7224074916285;6196.473299769525;6206.596571222856;6227.782027629011;4139.275626765304;4153.7300075494995;4154.356074808409;4155.2728272552185;4157.792110394468;4219.45147130871;4230.407742915994;4232.25935461293;4232.6190642841675;4238.957610423856;4857.975710121426;4871.707697538159;4871.707697538159;4873.658843880894;4881.8535443936735;5677;5876.823695289148;5916.437938395846;5919.023361145449;5924.111383292455;1476.084827406993;1485.9554213373617;1497.4983380567414;1497.857703518164;1498.116111494202;985.3595163144014;1001.4942454060653;1006.0894890124449;1016.1007508355011;1024.134606257711;5143;5149.356330458692;5154.7938082476285;5159.535641792257;5166.070107380632;6008.188894499274;6128;6140.631562106288;6223.097650840603;6240.65825847445;5190.948090519047;5196.948030519722;5201.037808005531;5201.791928322825;5203.739813009334;3324.9002529923655;3347.330533893231;3350.380179666721;3357.8824741133944;3365.192353835062;5718.456746609066;5845.240118784531;5849.707514624251;5856.385079566669;5865.677387743715;6387.041943708388;6394.968025159845;6406.2953075161695;6419.133416988647;6426.421622053944;5750.539956803445;5788.507976821933;5850.736716847752;5857.47282744555;5861.531077513789;6094.268687757498;6154.969225153845;6167.167432396569;6183.876322473615;6222.6621276425785;5914.852128696817;6049.758009679564;6062.969685151546;6068.605540639845;6071.878562428815;5841.649501029951;5844.824655260349;5852.151438041546;5862.472377486047;5869.911951320648;4098.364753463218;4117.3206420940205;4121.793910304413;4122.484689413824;4129.421880936731;6082.878342433038;6197.442230199304;6198.163247961467;6213.440790328892;6217.658028808278;5931.584789064724;5940.376260492586;5949.6430214187285;5950.047992321208;5957.702114894151;5938.584299099021;5966.642001479925;5969.582129250911;5971.313298970674;5979.820605381671;5658.405867383865;5780.479756821906;5798.507126894093;5823.70881455934;5825.126231065205;5995;6002.549808764273;6018.518518518596;6021.187139736079;6023.1266466363;5757.769689212385;5812.505936995402;5819.15622234782;5819.388964158702;5826.883462330645 05:27:05 INFO - 2015-12-16 05:27:05,694 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.5556599389357;762.6225018615786;763.7340536997407;779.547862239901;809.6801763303494;11476.426178691063;11583.07335413167;11590.304581725102;11636.825447618292;11657.417129143541;11297.435128243596;13091.149075310099;13302.800457993138;13377.866221337783;13392.799108013387;803.48576910777;813.6663967773214;816.9183081691842;829.7261903571837;834.7746108550688;820.1183727492939;820.5938060659981;830.6511265268601;832.9625166867476;835.1648351648352;851.8509260879352;856.8629019356904;857.1086070486717;860.6944534690189;862.3575436299965;852.4714676900361;853.8420392227426;854.995725021374;855.9186877246683;858.0389963241147;635.6567453575063;637.9075034120073;640.5068097564896;644.0564572900677;644.561698045329;12364;12497.437615307334;12507.56223532172;12508.687282817911;12514.81227781584;11047.558097676083;11074.833877491845;11093.500792464358;11282.492287847066;11471.942640286745;9274.582643781046;9311.627534898596;9368.90631093687;9375.578098985494;9375.624975000992;2915.6938521455154;2989.9850500747575;3009.9548506772417;3011.849407529615;3024.485837407624;39702.60297397018;39782.80108599438;40278;40308.193836123406;40334.596654033376;8892.64429422816;8917.866232006525;9032.096790320915;9113.863292050624;9127.08729127082;15502.767458488132;15575.844241557666;15682.372705091897;15699.372025118868;15711.842881571038;6128.142060111588;6159.5688301818445;6265.530085243625;6299.275583307978;6321.96839015802;3416.3167366526795;3445.8277086145595;3466.7746596471147;3535.550424326014;3536.2573859489794;2495;2512.9748702512743;2519.899204031818;2523.470071285051;2525.4065294655743;450.49994506098204;470.934069230308;471.9946513925386;496.60767993285623;518.142474205191;553.5709824885665;600.4505877122472;618.9721462534196;621.8476473263988;623.865868838202;7809.609519524001;7959.920400795918;8084.231997960184;8233.629486673113;8388.8741668875;479.54203735432577;480.3011618095662;505.45663411832425;564.912438572022;631.8641492079225;3734.1247239625336;3827.2154208387215;3888.8250028748776;3939.212157568498;3987.2424239394422;50599.24101138486;51309;51584.74207628938;51609;51775;44742.55257447449;45015.77492112584;45122.77438612786;45867.31199032017;45945.5405445948;40845.38731919024;41407.585924140374;41704.791476042425;42502.78748606237;42577.148457030686;7533.232665791884;7785.883211751941;7853.410994175346;7976.282134607914;8001.759947201594;30014.84992575023;30406;31018.68981310158;31139.221519461287;31209.219769505944;36717.26565468729;39112;39316;39355.212895742494;39701.80149099236;9222.677206297747;9252.814943701223;9265.169346152376;9320;9379.718608441757;9852.211823054282;10133.847992280269;10336.793264134825;10503.422311772925;10592.735181620521;10110.443925584164;10136.645217417356;10263.384196948207;10364.378137311785;10562.471876405994;9706.563204655666;9798.706038818847;9948.502574871372;10128.645497407555;10240.846387304047;9944.602215911282;10013.349132306377;10462.163026957673;10828.620998265023;10902.78194436091;9435.15083642448;9634.470104144339;9667.323287370098;9712.660056897974;9735.269854761063;8920.86618700733;9170.541472926194;9313.301502387483;9358.344915855825;9432.669856554987 05:27:05 INFO - 2015-12-16 05:27:05,694 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:27:05 INFO - 2015-12-16 05:27:05,694 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:27:05 INFO - 2015-12-16 05:27:05,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 05:27:05 INFO - 2015-12-16 05:27:05,694 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:27:05 INFO - 2015-12-16 05:27:05,694 DEBUG : BROWSER_OUTPUT: __startTimestamp1450272425685__endTimestamp 05:27:05 INFO - 2015-12-16 05:27:05,694 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,695 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:27:05 INFO - 2015-12-16 05:27:05,695 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:27:05 INFO - 2015-12-16 05:27:05,695 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,695 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4701.42 Median:4858.56 stddev:490.31 (10.1%) stddev-sans-first:465.36 05:27:05 INFO - 2015-12-16 05:27:05,697 DEBUG : BROWSER_OUTPUT: Values: 2675.9 2708.3 2738.6 2747.4 2761.4 4632.8 4779.3 4783.6 4796.1 4821.8 4753.0 4756.0 4816.8 4836.9 4870.6 4315.8 4387.9 4436.9 4441.5 4500.6 4318.5 4380.8 4388.3 4416.9 4422.6 4184.1 4278.5 4310.4 4372.6 4377.5 4391.2 4392.7 4432.4 4442.3 4449.9 4374.2 4391.4 4402.6 4406.4 4410.0 4492.6 4537.4 4629.6 4714.3 4719.1 5053.4 5080.1 5092.7 5117.4 5138.3 5144.2 5149.4 5157.7 5161.7 5165.5 4624.9 4722.9 4752.9 4774.5 4777.2 5096.4 5169.4 5190.0 5199.1 5253.9 5064.4 5083.2 5090.3 5109.8 5139.2 4878.0 5001.4 5098.2 5194.2 5196.6 5057.0 5072.2 5076.0 5082.3 5124.2 5049.3 5056.3 5059.2 5074.5 5115.2 4071.8 4161.0 4164.9 4226.5 4283.4 3709.5 3715.9 3717.4 3759.0 3760.0 4427.1 4444.9 4446.0 4448.5 4489.3 4915.4 4985.1 5024.1 5033.2 5042.7 4369.2 4375.2 4383.4 4394.5 4474.6 4466.0 4582.9 4590.5 4591.6 4628.7 4680.5 4797.4 4935.2 4937.8 4946.5 4962.5 5039.0 5053.3 5055.1 5057.0 4858.6 4875.2 4877.1 4913.9 4955.8 4783.9 4881.9 4934.6 5065.9 5093.8 5130.7 5144.6 5160.0 5168.8 5214.7 4949.5 4954.1 4967.4 4989.7 5004.3 4783.3 4847.8 4884.0 4969.5 4991.8 4887.4 4888.7 4897.6 4900.4 4910.4 4987.3 4988.3 4996.5 5048.8 5057.2 4645.7 4766.5 4797.5 4875.1 4899.9 05:27:05 INFO - 2015-12-16 05:27:05,697 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,698 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40858.78 Median:33898.91 stddev:66832.28 (197.2%) stddev-sans-first:66951.29 05:27:05 INFO - 2015-12-16 05:27:05,698 DEBUG : BROWSER_OUTPUT: Values: 567.9 575.0 578.4 579.0 581.4 32555.5 33674.3 33714.7 33819.7 33847.8 39305.8 40182.0 40183.0 40184.0 40243.0 7976.0 8144.6 8145.9 8165.2 8170.1 7874.8 7919.1 7936.7 7939.6 7994.5 7817.9 7859.3 7928.7 7962.1 7965.9 7857.3 7911.4 7931.4 7983.2 8001.0 7877.2 8003.9 8009.5 8012.8 8022.9 37109.8 37113.8 37149.3 37296.0 37561.8 2843.6 2939.5 2943.9 3480.6 3511.2 28156.9 28329.6 28507.1 28624.3 29342.1 3303.4 3317.5 3338.8 3351.6 3460.9 211681.0 212028.0 213273.0 213578.0 213668.0 38056.6 38414.8 38879.4 55397.0 55711.0 38676.0 38932.8 38945.6 39154.2 39294.2 12754.6 12814.9 12926.3 12948.0 12996.4 10809.5 10816.8 10914.7 10926.6 10983.2 13254.2 13390.9 13439.4 13460.5 13497.7 5404.2 5436.9 5564.6 5585.3 5607.9 829.7 878.5 893.5 993.9 1016.5 26111.0 26186.5 30216.5 31223.8 32132.8 932.6 940.5 948.3 969.4 990.4 13473.3 13475.7 13658.8 13695.2 13814.7 297049.0 304500.0 305867.0 307515.0 307750.0 47367.5 47764.3 47772.8 48114.3 48292.8 1234.3 1235.2 1240.5 1243.1 1249.7 24692.3 25391.1 25535.7 25598.9 25679.7 38376.8 38607.2 38926.8 38997.4 39083.2 240089.0 241749.0 242279.0 242487.0 242840.0 29501.1 29758.7 43116.8 44646.0 44796.6 38686.4 45714.5 46321.5 47003.5 47331.0 33369.5 33844.0 33919.7 33993.7 34369.5 33139.3 33404.8 33620.5 33878.2 34132.5 33051.2 33158.7 33378.0 33398.7 33460.5 28189.4 30102.7 30323.2 30752.6 30922.7 24790.0 25619.1 25998.4 26434.9 27635.7 05:27:05 INFO - 2015-12-16 05:27:05,698 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,698 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24998.46 Median:39233.03 stddev:74387.91 (189.6%) stddev-sans-first:74573.55 05:27:05 INFO - 2015-12-16 05:27:05,699 DEBUG : BROWSER_OUTPUT: Values: 341.6 343.3 343.6 344.7 345.2 12245.3 12626.6 14824.3 15043.6 15917.4 9930.9 10186.4 10193.8 14532.6 15065.5 4426.9 4548.8 4556.7 4572.2 4581.0 4560.6 4830.9 4850.9 4875.2 4876.7 4839.6 4846.2 4850.1 4864.6 4866.8 4854.4 4904.3 4995.2 5003.3 5009.1 4507.3 4517.9 4521.4 4523.8 4527.3 10920.8 10951.8 10961.3 11063.8 17506.6 1875.6 1899.5 1912.3 1985.9 2003.5 9775.6 12317.2 12739.2 13079.1 13132.2 1785.5 1788.3 1800.7 1804.1 1812.6 53302.5 54727.7 55564.7 55621.4 55995.0 9740.2 9814.3 9995.0 10045.0 10060.5 12242.4 12690.2 12697.8 12706.7 12749.2 7046.4 7249.2 7300.3 7307.8 7319.5 6918.9 6949.7 7001.1 7028.9 7040.8 4284.6 4327.4 4339.3 4352.2 4372.7 1639.6 1648.2 1659.3 1695.7 1710.6 826.7 866.8 884.1 885.8 896.2 15544.9 15662.7 15723.2 15881.4 16181.4 819.1 821.4 876.9 886.5 912.2 8795.0 9173.6 9259.9 9338.4 9397.1 445016.0 456499.0 456630.0 458592.0 459549.0 68082.7 70720.2 71136.6 71157.0 71649.9 1081.8 1092.4 1106.9 1126.9 1127.6 14312.7 14609.7 14647.2 14701.4 15022.7 28677.0 30971.4 31278.5 33241.2 33310.8 36358.5 36818.3 37249.1 41217.0 42424.4 8055.0 8289.6 8327.3 8336.5 8394.6 9816.4 9942.9 15635.6 16293.4 16351.7 13388.5 13449.7 13730.4 13772.5 13854.2 12498.9 12513.4 12704.4 13484.3 13662.9 13501.1 13685.7 13692.9 13934.4 14180.4 8588.5 8591.7 8788.2 8839.0 8873.9 13748.1 14084.0 14091.8 14336.8 14386.5 05:27:05 INFO - 2015-12-16 05:27:05,700 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,700 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5013.52 Median:6239.31 stddev:2642.23 (42.3%) stddev-sans-first:2636.22 05:27:05 INFO - 2015-12-16 05:27:05,700 DEBUG : BROWSER_OUTPUT: Values: 1470.0 1681.2 1717.1 1732.1 1748.2 7030.8 7122.8 7230.2 7268.1 7358.6 7057.0 7239.4 7266.5 7298.2 7324.1 2090.9 2118.9 2133.1 2134.3 2135.2 2060.5 2070.0 2072.2 2094.0 2123.2 1723.8 1761.6 2000.9 2075.3 2118.3 2058.2 2071.5 2071.7 2072.2 2073.8 2015.5 2027.3 2064.0 2065.6 2068.3 7131.8 7178.6 7195.1 7229.6 7249.8 4122.6 4200.6 4210.2 4211.7 4213.9 2679.4 2703.9 2726.7 2762.5 2765.2 842.4 858.8 860.9 870.6 876.3 9713.8 9738.9 9750.0 9770.6 9798.0 3831.3 3871.4 3925.0 3989.4 3990.1 8613.9 8620.7 8637.3 8662.8 8697.0 4231.2 4273.1 4286.9 4288.9 4302.1 3878.3 3892.6 3907.2 3915.4 3917.9 3239.0 3329.3 3336.3 3344.7 3350.0 1025.7 1047.1 1047.2 1065.1 1071.5 834.1 893.0 1011.5 1071.0 1186.1 6594.0 6653.5 6657.9 6668.7 6681.6 545.7 553.9 575.6 582.7 707.3 5243.3 5303.4 5330.4 5336.6 5345.4 8192.9 8721.7 8751.6 8839.2 8854.0 8674.3 8676.0 8707.6 8711.7 8716.6 6705.7 6741.0 6781.8 6823.5 6900.6 6483.6 6579.8 6584.1 6595.5 6609.8 7500.2 7700.8 7705.6 7734.7 7785.2 7690.1 7994.6 8002.6 8063.0 8103.1 6126.2 6283.3 6332.1 6383.2 6406.6 6833.0 6941.4 6964.7 6973.8 6979.4 6460.6 6573.6 6626.2 6628.7 6675.5 5587.8 5705.6 5814.4 6267.6 6327.6 6253.6 6257.4 6337.0 6353.7 6427.7 5992.7 5998.1 6030.4 6047.4 6050.9 6158.3 6172.6 6213.4 6223.5 6225.0 05:27:05 INFO - 2015-12-16 05:27:05,700 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,700 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4893.78 Median:5598.58 stddev:1463.16 (26.1%) stddev-sans-first:1426.01 05:27:05 INFO - 2015-12-16 05:27:05,700 DEBUG : BROWSER_OUTPUT: Values: 297.2 302.6 304.0 304.5 310.7 5579.5 5608.0 5689.0 5699.1 5718.1 5592.8 5604.3 5614.2 5623.6 5629.2 4186.9 4281.3 4283.2 4288.9 4292.6 4295.4 4299.9 4322.5 4334.9 4336.6 4239.2 4254.9 4272.8 4276.7 4288.9 4260.5 4261.8 4267.5 4267.6 4271.3 3717.5 3721.9 3730.5 3731.5 3732.9 5277.1 5397.1 5397.7 5397.9 5399.6 4915.5 4915.8 4919.6 4920.1 4925.4 5858.5 5881.8 5882.4 5892.7 5898.3 4012.8 4028.3 4029.1 4038.2 4056.4 6038.8 6168.7 6196.5 6206.6 6227.8 4139.3 4153.7 4154.4 4155.3 4157.8 4219.5 4230.4 4232.3 4232.6 4239.0 4858.0 4871.7 4871.7 4873.7 4881.9 5677.0 5876.8 5916.4 5919.0 5924.1 1476.1 1486.0 1497.5 1497.9 1498.1 985.4 1001.5 1006.1 1016.1 1024.1 5143.0 5149.4 5154.8 5159.5 5166.1 6008.2 6128.0 6140.6 6223.1 6240.7 5190.9 5196.9 5201.0 5201.8 5203.7 3324.9 3347.3 3350.4 3357.9 3365.2 5718.5 5845.2 5849.7 5856.4 5865.7 6387.0 6395.0 6406.3 6419.1 6426.4 5750.5 5788.5 5850.7 5857.5 5861.5 6094.3 6155.0 6167.2 6183.9 6222.7 5914.9 6049.8 6063.0 6068.6 6071.9 5841.6 5844.8 5852.2 5862.5 5869.9 4098.4 4117.3 4121.8 4122.5 4129.4 6082.9 6197.4 6198.2 6213.4 6217.7 5931.6 5940.4 5949.6 5950.0 5957.7 5938.6 5966.6 5969.6 5971.3 5979.8 5658.4 5780.5 5798.5 5823.7 5825.1 5995.0 6002.5 6018.5 6021.2 6023.1 5757.8 5812.5 5819.2 5819.4 5826.9 05:27:05 INFO - 2015-12-16 05:27:05,701 DEBUG : BROWSER_OUTPUT: 05:27:05 INFO - 2015-12-16 05:27:05,701 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12247.03 Median:501.03 stddev:13982.60 (2790.8%) stddev-sans-first:13995.21 05:27:05 INFO - 2015-12-16 05:27:05,701 DEBUG : BROWSER_OUTPUT: Values: 759.6 762.6 763.7 779.5 809.7 11476.4 11583.1 11590.3 11636.8 11657.4 11297.4 13091.1 13302.8 13377.9 13392.8 803.5 813.7 816.9 829.7 834.8 820.1 820.6 830.7 833.0 835.2 851.9 856.9 857.1 860.7 862.4 852.5 853.8 855.0 855.9 858.0 635.7 637.9 640.5 644.1 644.6 12364.0 12497.4 12507.6 12508.7 12514.8 11047.6 11074.8 11093.5 11282.5 11471.9 9274.6 9311.6 9368.9 9375.6 9375.6 2915.7 2990.0 3010.0 3011.8 3024.5 39702.6 39782.8 40278.0 40308.2 40334.6 8892.6 8917.9 9032.1 9113.9 9127.1 15502.8 15575.8 15682.4 15699.4 15711.8 6128.1 6159.6 6265.5 6299.3 6322.0 3416.3 3445.8 3466.8 3535.6 3536.3 2495.0 2513.0 2519.9 2523.5 2525.4 450.5 470.9 472.0 496.6 518.1 553.6 600.5 619.0 621.8 623.9 7809.6 7959.9 8084.2 8233.6 8388.9 479.5 480.3 505.5 564.9 631.9 3734.1 3827.2 3888.8 3939.2 3987.2 50599.2 51309.0 51584.7 51609.0 51775.0 44742.6 45015.8 45122.8 45867.3 45945.5 40845.4 41407.6 41704.8 42502.8 42577.1 7533.2 7785.9 7853.4 7976.3 8001.8 30014.8 30406.0 31018.7 31139.2 31209.2 36717.3 39112.0 39316.0 39355.2 39701.8 9222.7 9252.8 9265.2 9320.0 9379.7 9852.2 10133.8 10336.8 10503.4 10592.7 10110.4 10136.6 10263.4 10364.4 10562.5 9706.6 9798.7 9948.5 10128.6 10240.8 9944.6 10013.3 10462.2 10828.6 10902.8 9435.2 9634.5 9667.3 9712.7 9735.3 8920.9 9170.5 9313.3 9358.3 9432.7 05:27:05 INFO - 2015-12-16 05:27:05,702 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:27:05 INFO - 2015-12-16 05:27:05,702 DEBUG : BROWSER_OUTPUT: 05:27:06 INFO - 2015-12-16 05:27:06,349 INFO : Browser exited with error code: 0 05:27:06 INFO - 2015-12-16 05:27:06,368 INFO : Completed test dromaeo_css (00:18:34) 05:27:06 INFO - 2015-12-16 05:27:06,368 INFO : Starting test kraken 05:27:06 INFO - 2015-12-16 05:27:06,368 DEBUG : operating with platform_type : linux_ 05:27:06 INFO - 2015-12-16 05:27:06,369 INFO : Initialising browser for kraken test... 05:27:06 INFO - 2015-12-16 05:27:06,375 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1tpRbg/profile http://localhost:38488/getInfo.html 05:27:10 INFO - 2015-12-16 05:27:10,981 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:27:10 INFO - 2015-12-16 05:27:10,981 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:27:10 INFO - 2015-12-16 05:27:10,981 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:27:10 INFO - 2015-12-16 05:27:10,981 DEBUG : BROWSER_OUTPUT: __metrics 05:27:11 INFO - 2015-12-16 05:27:11,118 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] 05:27:11 INFO - 2015-12-16 05:27:11,973 INFO : Browser initialized. 05:27:11 INFO - 2015-12-16 05:27:11,974 INFO : Running cycle 1/1 for kraken test... 05:27:11 INFO - 2015-12-16 05:27:11,974 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1tpRbg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:27:24 INFO - 2015-12-16 05:27:24,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 142893056 05:27:24 INFO - 2015-12-16 05:27:24,014 DEBUG : BROWSER_OUTPUT: 05:27:26 INFO - 2015-12-16 05:27:26,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38488/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:27 INFO - 2015-12-16 05:27:27,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 142331904 05:27:27 INFO - 2015-12-16 05:27:27,276 DEBUG : BROWSER_OUTPUT: 05:27:30 INFO - 2015-12-16 05:27:30,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38488/tests/kraken/driver.html?testName=audio-dft) 05:27:30 INFO - 2015-12-16 05:27:30,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 142573568 05:27:30 INFO - 2015-12-16 05:27:30,621 DEBUG : BROWSER_OUTPUT: 05:27:33 INFO - 2015-12-16 05:27:33,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38488/tests/kraken/driver.html?testName=audio-fft) 05:27:34 INFO - 2015-12-16 05:27:34,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 137871360 05:27:34 INFO - 2015-12-16 05:27:34,118 DEBUG : BROWSER_OUTPUT: 05:27:36 INFO - 2015-12-16 05:27:36,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38488/tests/kraken/driver.html?testName=audio-oscillator) 05:27:36 INFO - 2015-12-16 05:27:36,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 139173888 05:27:36 INFO - 2015-12-16 05:27:36,829 DEBUG : BROWSER_OUTPUT: 05:27:39 INFO - 2015-12-16 05:27:39,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:39 INFO - 2015-12-16 05:27:39,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 138563584 05:27:39 INFO - 2015-12-16 05:27:39,690 DEBUG : BROWSER_OUTPUT: 05:27:42 INFO - 2015-12-16 05:27:42,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38488/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:43 INFO - 2015-12-16 05:27:43,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 137986048 05:27:43 INFO - 2015-12-16 05:27:43,416 DEBUG : BROWSER_OUTPUT: 05:27:46 INFO - 2015-12-16 05:27:46,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38488/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:47 INFO - 2015-12-16 05:27:47,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 139411456 05:27:47 INFO - 2015-12-16 05:27:47,455 DEBUG : BROWSER_OUTPUT: 05:27:50 INFO - 2015-12-16 05:27:50,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38488/tests/kraken/driver.html?testName=json-parse-financial) 05:27:50 INFO - 2015-12-16 05:27:50,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 139689984 05:27:50 INFO - 2015-12-16 05:27:50,962 DEBUG : BROWSER_OUTPUT: 05:27:52 INFO - 2015-12-16 05:27:52,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:53 INFO - 2015-12-16 05:27:53,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 140959744 05:27:53 INFO - 2015-12-16 05:27:53,326 DEBUG : BROWSER_OUTPUT: 05:27:55 INFO - 2015-12-16 05:27:55,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:55 INFO - 2015-12-16 05:27:55,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 141099008 05:27:55 INFO - 2015-12-16 05:27:55,852 DEBUG : BROWSER_OUTPUT: 05:27:58 INFO - 2015-12-16 05:27:58,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:58 INFO - 2015-12-16 05:27:58,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 141860864 05:27:58 INFO - 2015-12-16 05:27:58,628 DEBUG : BROWSER_OUTPUT: 05:28:01 INFO - 2015-12-16 05:28:01,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:01 INFO - 2015-12-16 05:28:01,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 141983744 05:28:01 INFO - 2015-12-16 05:28:01,831 DEBUG : BROWSER_OUTPUT: 05:28:04 INFO - 2015-12-16 05:28:04,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:05 INFO - 2015-12-16 05:28:05,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 141598720 05:28:05 INFO - 2015-12-16 05:28:05,088 DEBUG : BROWSER_OUTPUT: 05:28:06 INFO - 2015-12-16 05:28:06,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38488/tests/kraken/driver.html?testName=ai-astar) 05:28:07 INFO - 2015-12-16 05:28:07,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 141443072 05:28:07 INFO - 2015-12-16 05:28:07,128 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,128 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:28:07 INFO - 2015-12-16 05:28:07,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:28:07 INFO - 2015-12-16 05:28:07,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:28:07 INFO - 2015-12-16 05:28:07,130 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:28:07 INFO - 2015-12-16 05:28:07,130 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;110;114;116;116;129;115;116;113;115 05:28:07 INFO - 2015-12-16 05:28:07,131 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;139;153;163;133;154;154;141;169;138 05:28:07 INFO - 2015-12-16 05:28:07,131 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;163;164;162;163;169;168;163;166;166 05:28:07 INFO - 2015-12-16 05:28:07,131 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;73;74;134;72;75;74;72;102 05:28:07 INFO - 2015-12-16 05:28:07,131 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;129;96;96;100;139;95;96;130 05:28:07 INFO - 2015-12-16 05:28:07,131 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;111;110;111;111;111;110;111 05:28:07 INFO - 2015-12-16 05:28:07,131 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;153;148;148;148;148;148;147;148;147 05:28:07 INFO - 2015-12-16 05:28:07,131 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;100;96;96;96;95;96;97;97;96 05:28:07 INFO - 2015-12-16 05:28:07,131 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;76;74;75;79;74;75;76;73;73 05:28:07 INFO - 2015-12-16 05:28:07,132 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;67;69;69;68;68;68;68;69 05:28:07 INFO - 2015-12-16 05:28:07,132 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;96;85;89;88;87;87;87;86;94 05:28:07 INFO - 2015-12-16 05:28:07,132 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;125;129;123;127;131;132;140;127;140 05:28:07 INFO - 2015-12-16 05:28:07,132 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;151;154;152;151;140;151;162;161;142 05:28:07 INFO - 2015-12-16 05:28:07,132 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;71;74;71;71;70;72;75;69;72 05:28:07 INFO - 2015-12-16 05:28:07,132 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:28:07 INFO - 2015-12-16 05:28:07,132 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:28:07 INFO - 2015-12-16 05:28:07,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,778 05:28:07 INFO - 2015-12-16 05:28:07,133 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:28:07 INFO - 2015-12-16 05:28:07,133 DEBUG : BROWSER_OUTPUT: __startTimestamp1450272487128__endTimestamp 05:28:07 INFO - 2015-12-16 05:28:07,133 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.00 Median:116.00 stddev:4.94 (4.3%) stddev-sans-first:5.24 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: Values: 116.0 110.0 114.0 116.0 116.0 129.0 115.0 116.0 113.0 115.0 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.00 Median:154.00 stddev:11.75 (7.6%) stddev-sans-first:12.26 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: Values: 156.0 139.0 153.0 163.0 133.0 154.0 154.0 141.0 169.0 138.0 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,141 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.90 Median:165.50 stddev:2.33 (1.4%) stddev-sans-first:2.47 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: Values: 165.0 163.0 164.0 162.0 163.0 169.0 168.0 163.0 166.0 166.0 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.30 Median:73.50 stddev:20.29 (27.6%) stddev-sans-first:21.30 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 74.0 134.0 72.0 75.0 74.0 72.0 102.0 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:95.50 stddev:17.82 (18.7%) stddev-sans-first:18.43 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 129.0 96.0 96.0 100.0 139.0 95.0 96.0 130.0 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 111.0 110.0 111.0 111.0 111.0 110.0 111.0 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.75 (1.2%) stddev-sans-first:1.80 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: Values: 147.0 153.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 147.0 05:28:07 INFO - 2015-12-16 05:28:07,142 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: Values: 96.0 100.0 96.0 96.0 96.0 95.0 96.0 97.0 97.0 96.0 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.90 Median:75.00 stddev:1.79 (2.4%) stddev-sans-first:1.87 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 74.0 75.0 79.0 74.0 75.0 76.0 73.0 73.0 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 67.0 69.0 69.0 68.0 68.0 68.0 68.0 69.0 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:87.50 stddev:3.63 (4.1%) stddev-sans-first:3.73 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: Values: 86.0 96.0 85.0 89.0 88.0 87.0 87.0 87.0 86.0 94.0 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:130.00 stddev:6.33 (4.9%) stddev-sans-first:6.09 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: Values: 122.0 125.0 129.0 123.0 127.0 131.0 132.0 140.0 127.0 140.0 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,143 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.50 stddev:7.13 (4.7%) stddev-sans-first:7.33 05:28:07 INFO - 2015-12-16 05:28:07,144 DEBUG : BROWSER_OUTPUT: Values: 146.0 151.0 154.0 152.0 151.0 140.0 151.0 162.0 161.0 142.0 05:28:07 INFO - 2015-12-16 05:28:07,144 DEBUG : BROWSER_OUTPUT: 05:28:07 INFO - 2015-12-16 05:28:07,144 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.81 (2.5%) stddev-sans-first:1.87 05:28:07 INFO - 2015-12-16 05:28:07,144 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 74.0 71.0 71.0 70.0 72.0 75.0 69.0 72.0 05:28:07 INFO - 2015-12-16 05:28:07,144 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:28:07 INFO - 2015-12-16 05:28:07,144 DEBUG : BROWSER_OUTPUT: 05:28:08 INFO - 2015-12-16 05:28:08,029 INFO : Browser exited with error code: 0 05:28:08 INFO - 2015-12-16 05:28:08,078 INFO : Completed test kraken (00:01:01) 05:28:08 INFO - 2015-12-16 05:28:08,079 INFO : Starting test v8_7 05:28:08 INFO - 2015-12-16 05:28:08,079 DEBUG : operating with platform_type : linux_ 05:28:08 INFO - 2015-12-16 05:28:08,079 INFO : Initialising browser for v8_7 test... 05:28:08 INFO - 2015-12-16 05:28:08,085 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphaPglt/profile http://localhost:38488/getInfo.html 05:28:12 INFO - 2015-12-16 05:28:12,638 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:28:12 INFO - 2015-12-16 05:28:12,638 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:28:12 INFO - 2015-12-16 05:28:12,639 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:28:12 INFO - 2015-12-16 05:28:12,639 DEBUG : BROWSER_OUTPUT: __metrics 05:28:12 INFO - 2015-12-16 05:28:12,743 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] 05:28:13 INFO - 2015-12-16 05:28:13,677 INFO : Browser initialized. 05:28:13 INFO - 2015-12-16 05:28:13,678 INFO : Running cycle 1/1 for v8_7 test... 05:28:13 INFO - 2015-12-16 05:28:13,678 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphaPglt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:28:25 INFO - 2015-12-16 05:28:25,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 142893056 05:28:25 INFO - 2015-12-16 05:28:25,676 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38488/tests/v8_7/run.html (next: http://localhost:38488/tests/v8_7/run.html) 05:28:47 INFO - 2015-12-16 05:28:47,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 138186752 05:28:47 INFO - 2015-12-16 05:28:47,390 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,390 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:28:47 INFO - 2015-12-16 05:28:47,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:28:47 INFO - 2015-12-16 05:28:47,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:28:47 INFO - 2015-12-16 05:28:47,392 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:28:47 INFO - 2015-12-16 05:28:47,392 DEBUG : BROWSER_OUTPUT: |0;Richards;165.8374792703151 05:28:47 INFO - 2015-12-16 05:28:47,392 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.63207722294413 05:28:47 INFO - 2015-12-16 05:28:47,392 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.39251040221916 05:28:47 INFO - 2015-12-16 05:28:47,392 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 05:28:47 INFO - 2015-12-16 05:28:47,393 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1104.9723756906078 05:28:47 INFO - 2015-12-16 05:28:47,393 DEBUG : BROWSER_OUTPUT: |5;Earley;748.502994011976 05:28:47 INFO - 2015-12-16 05:28:47,393 DEBUG : BROWSER_OUTPUT: |6;Boyer;12395.061728395061 05:28:47 INFO - 2015-12-16 05:28:47,393 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 05:28:47 INFO - 2015-12-16 05:28:47,394 DEBUG : BROWSER_OUTPUT: |8;Splay;600.9615384615385 05:28:47 INFO - 2015-12-16 05:28:47,394 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 05:28:47 INFO - 2015-12-16 05:28:47,394 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:28:47 INFO - 2015-12-16 05:28:47,394 DEBUG : BROWSER_OUTPUT: __startTimestamp1450272527390__endTimestamp 05:28:47 INFO - 2015-12-16 05:28:47,394 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,395 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:28:47 INFO - 2015-12-16 05:28:47,395 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:28:47 INFO - 2015-12-16 05:28:47,395 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,395 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.84 Median:165.84 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,395 DEBUG : BROWSER_OUTPUT: Values: 165.8 05:28:47 INFO - 2015-12-16 05:28:47,395 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,396 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.63 Median:185.63 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,396 DEBUG : BROWSER_OUTPUT: Values: 185.6 05:28:47 INFO - 2015-12-16 05:28:47,396 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,396 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.39 Median:277.39 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,396 DEBUG : BROWSER_OUTPUT: Values: 277.4 05:28:47 INFO - 2015-12-16 05:28:47,396 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,397 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,397 DEBUG : BROWSER_OUTPUT: Values: 5170.1 05:28:47 INFO - 2015-12-16 05:28:47,397 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,397 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,398 DEBUG : BROWSER_OUTPUT: Values: 1105.0 05:28:47 INFO - 2015-12-16 05:28:47,398 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,398 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:748.50 Median:748.50 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,398 DEBUG : BROWSER_OUTPUT: Values: 748.5 05:28:47 INFO - 2015-12-16 05:28:47,398 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,398 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,398 DEBUG : BROWSER_OUTPUT: Values: 12395.1 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: Values: 26394.7 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.96 Median:600.96 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: Values: 601.0 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: Values: 4845.4 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:28:47 INFO - 2015-12-16 05:28:47,399 DEBUG : BROWSER_OUTPUT: 05:28:48 INFO - 2015-12-16 05:28:48,325 INFO : Browser exited with error code: 0 05:28:48 INFO - 2015-12-16 05:28:48,337 INFO : Completed test v8_7 (00:00:40) 05:28:48 INFO - 2015-12-16 05:28:48,411 INFO : Completed test suite (00:20:16) 05:28:48 INFO - 2015-12-16 05:28:48,412 DEBUG : Working with test: dromaeo_css 05:28:48 INFO - 2015-12-16 05:28:48,412 DEBUG : Generating results file: dromaeo_css 05:28:48 INFO - 2015-12-16 05:28:48,413 DEBUG : Working with test: kraken 05:28:48 INFO - 2015-12-16 05:28:48,413 DEBUG : Generating results file: kraken 05:28:48 INFO - 2015-12-16 05:28:48,413 INFO : javascript benchmark 05:28:48 INFO - 2015-12-16 05:28:48,413 DEBUG : Working with test: v8_7 05:28:48 INFO - 2015-12-16 05:28:48,413 DEBUG : Generating results file: v8_7 05:28:48 INFO - 2015-12-16 05:28:48,414 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:28:48 INFO - 2015-12-16 05:28:48,466 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:28:48 INFO - 2015-12-16 05:28:48,467 DEBUG : process_Request line: dromaeo_css 6324.84 graph.html#tests=[[72,132,43]] 05:28:48 INFO - 2015-12-16 05:28:48,467 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:28:48 INFO - 2015-12-16 05:28:48,497 DEBUG : process_Request line: kraken 1559.70 graph.html#tests=[[232,132,43]] 05:28:48 INFO - 2015-12-16 05:28:48,497 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:28:48 INFO - 2015-12-16 05:28:48,526 DEBUG : process_Request line: v8_7 21152.48 graph.html#tests=[[230,132,43]] 05:28:48 INFO - 2015-12-16 05:28:48,528 INFO : javascript benchmark 05:28:48 INFO - 2015-12-16 05:28:48,531 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2675.8524287354603, 2708.268767432792, 2738.575520794276, 2747.395572973945, 2761.4201017786263, 4632.768361581924, 4779.259214821699, 4783.593394561462, 4796.136695394832, 4821.807127714896, 4753.0493901219725, 4755.952440475594, 4816.783244753986, 4836.854894353166, 4870.586000189988, 4315.762633055181, 4387.868363949071, 4436.866893993185, 4441.511433742286, 4500.572445617661, 4318.5033721122, 4380.759058251795, 4388.275934470808, 4416.933745993812, 4422.6240769534625, 4184.100418410057, 4278.4865816102265, 4310.374995625648, 4372.5627437256335, 4377.474703035624, 4391.165678521103, 4392.736435813861, 4432.401625780511, 4442.2892337225885, 4449.9110017799785, 4374.212641724488, 4391.363252328394, 4402.647788176938, 4406.449193850769, 4409.955900440987, 4492.550744925514, 4537.4328208973875, 4629.583337499641, 4714.316424118484, 4719.056188762227, 5053.36832895888, 5080.13637681595, 5092.668976516515, 5117.437081920985, 5138.2549530318265, 5144.228365745168, 5149.433562308143, 5157.742112894378, 5161.741912904377, 5165.509276618715, 4624.884377890546, 4722.858314250578, 4752.881177970544, 4774.546418090275, 4777.211760059621, 5096.362954630671, 5169.431362550116, 5189.974050129801, 5199.142141546602, 5253.868653283622, 5064.442911279756, 5083.2375143727995, 5090.287359769635, 5109.770060347293, 5139.177731562932, 4877.951220487821, 5001.44984051754, 5098.2352647103235, 5194.246834209019, 5196.610254230872, 5056.974715126401, 5072.163093089599, 5075.984803039407, 5082.263071854561, 5124.180131178993, 5049.267856160836, 5056.26684130799, 5059.215821547592, 5074.49255074497, 5115.18157094863, 4071.75569465833, 4161.0221597924465, 4164.895877603084, 4226.4928208615165, 4283.443152390169, 3709.4621279914263, 3715.9442608360896, 3717.386631205875, 3759.0, 3760.022394177479, 4427.136708341843, 4444.866654000385, 4445.955540444619, 4448.488423831236, 4489.32660100981, 4915.361003069578, 4985.127602669519, 5024.120778863684, 5033.19468884984, 5042.722650254272, 4369.169857727022, 4375.234333991539, 4383.3863259143745, 4394.494633117169, 4474.552544745565, 4466.0398014427055, 4582.88542786433, 4590.54094590545, 4591.563801438858, 4628.652851036186, 4680.5085466025575, 4797.376341075638, 4935.210366341368, 4937.802487900587, 4946.455889852042, 4962.503749625153, 5038.992201559776, 5053.267276244997, 5055.140626093499, 5056.974715126401, 4858.562729354234, 4875.1712208923855, 4877.12211801879, 4913.9017219656125, 4955.776990035529, 4783.904321913473, 4881.877953051202, 4934.55588996992, 5065.924011139909, 5093.821716239914, 5130.692158470503, 5144.588432925432, 5160.045391602565, 5168.793248270177, 5214.713190774544, 4949.529794669501, 4954.083494553519, 4967.3542439482635, 4989.725565093955, 5004.3494345734825, 4783.282507623745, 4847.830325938575, 4883.951160488492, 4969.503049695146, 4991.80032798684, 4887.437944636412, 4888.706677599355, 4897.583705385082, 4900.411950565955, 4910.43529994041, 4987.326710893983, 4988.326575912205, 4996.450390456974, 5048.798048078183, 5057.241413787961, 4645.6515761318715, 4766.499517550746, 4797.472278049342, 4875.1224779540025, 4899.877503062452], "unit": "score", "name": "dojo.html", "value": 4670.90463483227}, {"lowerIsBetter": false, "replicates": [567.9176519404687, 575.0023708865118, 578.3869098755318, 578.9913151302732, 581.354696287121, 32555.51166732498, 33674.326513469714, 33714.66285337146, 33819.66180338196, 33847.83076084622, 39305.803470982675, 40182.0, 40183.0, 40184.0, 40243.0, 7975.963124793769, 8144.592770361458, 8145.877811832827, 8165.183481651847, 8170.142135075821, 7874.842503149934, 7919.089304729943, 7936.6825326986855, 7939.642716077761, 7994.5203287802915, 7817.8827317590285, 7859.331956783681, 7928.722494712686, 7962.124166341698, 7965.8805117923275, 7857.253560911733, 7911.446198766089, 7931.365490760725, 7983.2415920487465, 8001.0, 7877.212278772135, 8003.9199608003755, 8009.51942883423, 8012.759617211493, 8022.919770802276, 37109.81445092784, 37113.814430927945, 37149.257014859555, 37296.0, 37561.81219093914, 2843.559248316514, 2939.514980028293, 2943.8528073596235, 3480.564929383827, 3511.2450823073164, 28156.85921570379, 28329.57505637417, 28507.144785656463, 28624.284392890135, 29342.11973640794, 3303.355845610107, 3317.4857897026, 3338.7662863599558, 3351.6480769519094, 3460.8615655373756, 211681.0, 212028.0, 213273.0, 213578.0, 213668.0, 38056.61943380586, 38414.807925960195, 38879.41680874789, 55397.0, 55711.0, 38676.0, 38932.80533597314, 38945.61054389476, 39154.216915662095, 39294.21411571753, 12754.553590624284, 12814.935925320313, 12926.289054101926, 12948.0, 12996.415161317764, 10809.513571889283, 10816.78366432667, 10914.672559823219, 10926.617568385069, 10983.176261780398, 13254.204747715168, 13390.866091339156, 13439.395227214798, 13460.461581536629, 13497.730045399234, 5404.216388623706, 5436.91844622331, 5564.582656300794, 5585.3297604287745, 5607.859803504945, 829.655692887445, 878.5475480127611, 893.4549924546021, 993.9105480506789, 1016.4511163971521, 26111.0, 26186.476270474483, 30216.54675179874, 31223.843880780903, 32132.839335803637, 932.5756780664781, 940.4592359393376, 948.3304497838562, 969.3602222533094, 990.4255531791543, 13473.258970756702, 13475.663108422368, 13658.795118073236, 13695.246761428018, 13814.723705525834, 297049.0, 304500.0, 305867.0, 307515.0, 307750.0, 47367.50008749163, 47764.28353574699, 47772.761136194094, 48114.27828582574, 48292.7585362071, 1234.3026190202506, 1235.178606226867, 1240.534799450188, 1243.0801207106676, 1249.6688377579949, 24692.259232223063, 25391.11131110402, 25535.74464255408, 25598.872005639852, 25679.743202567734, 38376.80811595924, 38607.22785544329, 38926.80536597299, 38997.41503877387, 39083.21833563256, 240089.0, 241749.0, 242279.0, 242487.0, 242840.0, 29501.11496655104, 29758.702412975592, 43116.78441607772, 44646.0, 44796.55203447924, 38686.419703703905, 45714.54285457103, 46321.536784631724, 47003.52996469991, 47331.0, 33369.499457508646, 33844.0, 33919.66080339264, 33993.660063400035, 34369.48445773265, 33139.337213255116, 33404.832975834965, 33620.49569256512, 33878.15304617404, 34132.488012680325, 33051.17372065718, 33158.66841331556, 33378.0, 33398.666013339556, 33460.49809252912, 28189.43621127607, 30102.69897300999, 30323.24191895132, 30752.56471058048, 30922.69077309288, 24790.0, 25619.10333138331, 25998.35004124912, 26434.867825661517, 27635.723642763314], "unit": "score", "name": "ext.html", "value": 16607.925042342133}, {"lowerIsBetter": false, "replicates": [341.55256613835877, 343.2739755417292, 343.56367413385016, 344.71388747339694, 345.17330992273503, 12245.265284082961, 12626.62120136395, 14824.258787060644, 15043.623909402271, 15917.363305467796, 9930.851037234448, 10186.439745813977, 10193.847092293603, 14532.636684082903, 15065.472708455207, 4426.933595996063, 4548.840790572331, 4556.70381425208, 4572.15415148197, 4580.9770951145365, 4560.5667461591265, 4830.9275360869615, 4850.854474365757, 4875.195592727196, 4876.658633895629, 4839.5644392004715, 4846.151923413407, 4850.054239423313, 4864.586510146642, 4866.829660961867, 4854.441739199984, 4904.337914381548, 4995.1757959936385, 5003.274525193827, 5009.148444764399, 4507.346434766973, 4517.909641807179, 4521.434820647419, 4523.819047238107, 4527.253003254459, 10920.836187457195, 10951.83572246417, 10961.342319460779, 11063.834042489369, 17506.562335941577, 1875.6154988227518, 1899.5441094137445, 1912.3211260002638, 1985.9375234249608, 2003.4891102768847, 9775.560099795526, 12317.199382040139, 12739.235645861185, 13079.149855259473, 13132.212067275994, 1785.544686105035, 1788.3293764838186, 1800.6848801459823, 1804.0889350877853, 1812.646533925885, 53302.466975330135, 54727.72636136794, 55564.72217638927, 55621.443785562034, 55995.0, 9740.220782337396, 9814.263930205263, 9995.0, 10045.0, 10060.496975151213, 12242.387880605935, 12690.175138615961, 12697.809532857014, 12706.745865082647, 12749.235045897276, 7046.365827075588, 7249.238829922888, 7300.3064708853635, 7307.817304567428, 7319.451041171933, 6918.93081069193, 6949.652517374111, 7001.054857594261, 7028.894566581505, 7040.753573624898, 4284.635805956466, 4327.37253098299, 4339.284018137035, 4352.216601011848, 4372.737635741865, 1639.6228867360574, 1648.175912043978, 1659.2533359988054, 1695.7286834106483, 1710.5723569107722, 826.7065191856924, 866.7919699272129, 884.1291328041874, 885.831691978522, 896.1799953042893, 15544.922275388777, 15662.686746265012, 15723.21383930799, 15881.364745410285, 16181.4336498222, 819.0580832043198, 821.4126899267053, 876.9342299327576, 886.5079880666163, 912.1653686876566, 8794.956025219833, 9173.58718857653, 9259.907400925904, 9338.393004454689, 9397.107274808883, 445016.0, 456499.0, 456630.0, 458592.0, 459549.0, 68082.65958670175, 70720.23199419952, 71136.64431677808, 71157.0, 71649.85050448494, 1081.789051135021, 1092.3718861654581, 1106.8561087058793, 1126.8985791278824, 1127.639155470258, 14312.71374572482, 14609.707805844037, 14647.194404307866, 14701.41194352214, 15022.699546009237, 28677.0, 30971.380572388876, 31278.53082203723, 33241.16897077592, 33310.83344583261, 36358.45462318014, 36818.26363472769, 37249.06877328089, 41217.0, 42424.36363454613, 8055.0, 8289.58552072406, 8327.250547450758, 8336.499810011419, 8394.58027098655, 9816.411015339103, 9942.900570994487, 15635.609109772347, 16293.429729959395, 16351.67296654084, 13388.531401401295, 13449.663758406117, 13730.382132804247, 13772.517961871286, 13854.16874987504, 12498.875011249771, 12513.374331283218, 12704.428300726304, 13484.258365789976, 13662.93168534151, 13501.122427042212, 13685.657858553217, 13692.863071369158, 13934.372953216927, 14180.361883715052, 8588.527630980356, 8591.6992905248, 8788.209061184523, 8838.955805220932, 8873.866891996497, 13748.106373085717, 14084.0, 14091.788623170865, 14336.784948225577, 14386.496472623827], "unit": "score", "name": "jquery.html", "value": 8064.029814311881}, {"lowerIsBetter": false, "replicates": [1470.0150898897737, 1681.1510187355386, 1717.1414292853574, 1732.1252767352494, 1748.1521462090889, 7030.824229394268, 7122.750703725371, 7230.240824713402, 7268.127824661042, 7358.595277259748, 7056.96471517643, 7239.420846332294, 7266.527675701076, 7298.160711518164, 7324.121105467338, 2090.8640938339, 2118.9152433902627, 2133.114757375687, 2134.3063504361144, 2135.1566131378095, 2060.4745789823573, 2069.968950465744, 2072.1504183284856, 2094.0, 2123.203798575534, 1723.8189990051053, 1761.621251430942, 2000.8799472031724, 2075.29439990404, 2118.279784873143, 2058.176729308281, 2071.54426026274, 2071.6996035574834, 2072.2125592274915, 2073.782252863443, 2015.4961259685078, 2027.3107143571256, 2064.040221297089, 2065.555905480314, 2068.338131797825, 7131.786046418616, 7178.5692858428665, 7195.13658361, 7229.602371869545, 7249.78250652476, 4122.56713045129, 4200.579942005775, 4210.221109094828, 4211.7262377945335, 4213.936790948138, 2679.356954330966, 2703.9459210815676, 2726.7273272672574, 2762.4751297253456, 2765.1566272286946, 842.4439869685978, 858.8239410920809, 860.8751730999032, 870.6038752367657, 876.2639382918316, 9713.805723885484, 9738.853917191247, 9749.951250243703, 9770.609175632966, 9797.951010244904, 3831.252905683365, 3871.399933010388, 3924.9607503925167, 3989.401589761559, 3990.082281075369, 8613.913860861436, 8620.655173792979, 8637.309015278763, 8662.826743465095, 8697.0, 4231.217224813419, 4273.145370925828, 4286.892827679333, 4288.935665965013, 4302.139572085595, 3878.26313000529, 3892.6107389260847, 3907.1794923065904, 3915.432262322004, 3917.9020524487114, 3238.951415728766, 3329.267561136546, 3336.332733453319, 3344.6989770920736, 3349.9832500837338, 1025.6974192613197, 1047.1361127070197, 1047.2041248650928, 1065.0521036277719, 1071.5338827609858, 834.0825092398435, 892.9864603674876, 1011.544804837826, 1070.9665173107987, 1186.1222695205659, 6594.0, 6653.4677225821815, 6657.866842663119, 6668.733250670016, 6681.632510211888, 545.664416383921, 553.8698405874616, 575.6200907401179, 582.6882617799541, 707.3174386716843, 5243.2659427680155, 5303.443138470482, 5330.38700549434, 5336.599755018312, 5345.412004679482, 8192.918070819334, 8721.738347849574, 8751.56242187888, 8839.248663863515, 8853.955730221436, 8674.262687671493, 8676.0, 8707.608157632794, 8711.695090671923, 8716.564171791511, 6705.698243578953, 6741.0, 6781.830454238683, 6823.488238382042, 6900.6204658743245, 6483.578567393104, 6579.80260592183, 6584.111144995364, 6595.538312318092, 6609.801705948829, 7500.212477689982, 7700.807479813049, 7705.576193309422, 7734.651940662796, 7785.221477852169, 7690.115636701851, 7994.5602991836, 8002.599870006593, 8062.959685201771, 8103.108658047492, 6126.172966649624, 6283.308836027942, 6332.113504109337, 6383.170187875732, 6406.615603063831, 6833.0, 6941.444684425335, 6964.65176741171, 6973.755918542826, 6979.441644668313, 6460.580062295936, 6573.638449885302, 6626.227240382282, 6628.734850605922, 6675.465962723068, 5587.832365029056, 5705.62913410627, 5814.447627475383, 6267.561270711007, 6327.620342779448, 6253.624782513064, 6257.40554647326, 6337.04944258365, 6353.745850165941, 6427.742890284337, 5992.670403127696, 5998.1002849572915, 6030.427109424598, 6047.365026672136, 6050.878982420415, 6158.32258451561, 6172.567920245539, 6213.440790328892, 6223.502119830493, 6225.0], "unit": "score", "name": "mootools.html", "value": 4052.6785989582368}, {"lowerIsBetter": false, "replicates": [297.2286915454396, 302.63381308616573, 304.0498442367601, 304.5477465963046, 310.6582758965139, 5579.525740312073, 5607.971960140204, 5688.971555142219, 5699.116636921273, 5718.113692377678, 5592.832215033555, 5604.327480702311, 5614.185943038257, 5623.550115990721, 5629.240052592899, 4186.853460128896, 4281.314989601664, 4283.207606592782, 4288.935665965013, 4292.570742925714, 4295.398644189816, 4299.91400171998, 4322.481302243719, 4334.869953901372, 4336.566343365654, 4239.1945530349285, 4254.87235382939, 4272.764997925113, 4276.679249056333, 4288.871333859974, 4260.467441569788, 4261.76560289184, 4267.530571637118, 4267.637250833683, 4271.273883439807, 3717.498137751396, 3721.8697345593046, 3730.477733117366, 3731.4962480065387, 3732.869349572779, 5277.076511610453, 5397.082495975694, 5397.73011349431, 5397.865053373697, 5399.62202645815, 4915.459299477055, 4915.803367865281, 4919.557239848395, 4920.114379411704, 4925.433575138869, 5858.47273745365, 5881.764729410861, 5882.411758824126, 5892.705364731789, 5898.321693005317, 4012.8194231259663, 4028.3353246714255, 4029.073313137965, 4038.172174704179, 4056.4320995060716, 6038.788642397539, 6168.7224074916285, 6196.473299769525, 6206.596571222856, 6227.782027629011, 4139.275626765304, 4153.7300075494995, 4154.356074808409, 4155.2728272552185, 4157.792110394468, 4219.45147130871, 4230.407742915994, 4232.25935461293, 4232.6190642841675, 4238.957610423856, 4857.975710121426, 4871.707697538159, 4871.707697538159, 4873.658843880894, 4881.8535443936735, 5677.0, 5876.823695289148, 5916.437938395846, 5919.023361145449, 5924.111383292455, 1476.084827406993, 1485.9554213373617, 1497.4983380567414, 1497.857703518164, 1498.116111494202, 985.3595163144014, 1001.4942454060653, 1006.0894890124449, 1016.1007508355011, 1024.134606257711, 5143.0, 5149.356330458692, 5154.7938082476285, 5159.535641792257, 5166.070107380632, 6008.188894499274, 6128.0, 6140.631562106288, 6223.097650840603, 6240.65825847445, 5190.948090519047, 5196.948030519722, 5201.037808005531, 5201.791928322825, 5203.739813009334, 3324.9002529923655, 3347.330533893231, 3350.380179666721, 3357.8824741133944, 3365.192353835062, 5718.456746609066, 5845.240118784531, 5849.707514624251, 5856.385079566669, 5865.677387743715, 6387.041943708388, 6394.968025159845, 6406.2953075161695, 6419.133416988647, 6426.421622053944, 5750.539956803445, 5788.507976821933, 5850.736716847752, 5857.47282744555, 5861.531077513789, 6094.268687757498, 6154.969225153845, 6167.167432396569, 6183.876322473615, 6222.6621276425785, 5914.852128696817, 6049.758009679564, 6062.969685151546, 6068.605540639845, 6071.878562428815, 5841.649501029951, 5844.824655260349, 5852.151438041546, 5862.472377486047, 5869.911951320648, 4098.364753463218, 4117.3206420940205, 4121.793910304413, 4122.484689413824, 4129.421880936731, 6082.878342433038, 6197.442230199304, 6198.163247961467, 6213.440790328892, 6217.658028808278, 5931.584789064724, 5940.376260492586, 5949.6430214187285, 5950.047992321208, 5957.702114894151, 5938.584299099021, 5966.642001479925, 5969.582129250911, 5971.313298970674, 5979.820605381671, 5658.405867383865, 5780.479756821906, 5798.507126894093, 5823.70881455934, 5825.126231065205, 5995.0, 6002.549808764273, 6018.518518518596, 6021.187139736079, 6023.1266466363, 5757.769689212385, 5812.505936995402, 5819.15622234782, 5819.388964158702, 5826.883462330645], "unit": "score", "name": "prototype.html", "value": 4416.901240813838}, {"lowerIsBetter": false, "replicates": [759.5556599389357, 762.6225018615786, 763.7340536997407, 779.547862239901, 809.6801763303494, 11476.426178691063, 11583.07335413167, 11590.304581725102, 11636.825447618292, 11657.417129143541, 11297.435128243596, 13091.149075310099, 13302.800457993138, 13377.866221337783, 13392.799108013387, 803.48576910777, 813.6663967773214, 816.9183081691842, 829.7261903571837, 834.7746108550688, 820.1183727492939, 820.5938060659981, 830.6511265268601, 832.9625166867476, 835.1648351648352, 851.8509260879352, 856.8629019356904, 857.1086070486717, 860.6944534690189, 862.3575436299965, 852.4714676900361, 853.8420392227426, 854.995725021374, 855.9186877246683, 858.0389963241147, 635.6567453575063, 637.9075034120073, 640.5068097564896, 644.0564572900677, 644.561698045329, 12364.0, 12497.437615307334, 12507.56223532172, 12508.687282817911, 12514.81227781584, 11047.558097676083, 11074.833877491845, 11093.500792464358, 11282.492287847066, 11471.942640286745, 9274.582643781046, 9311.627534898596, 9368.90631093687, 9375.578098985494, 9375.624975000992, 2915.6938521455154, 2989.9850500747575, 3009.9548506772417, 3011.849407529615, 3024.485837407624, 39702.60297397018, 39782.80108599438, 40278.0, 40308.193836123406, 40334.596654033376, 8892.64429422816, 8917.866232006525, 9032.096790320915, 9113.863292050624, 9127.08729127082, 15502.767458488132, 15575.844241557666, 15682.372705091897, 15699.372025118868, 15711.842881571038, 6128.142060111588, 6159.5688301818445, 6265.530085243625, 6299.275583307978, 6321.96839015802, 3416.3167366526795, 3445.8277086145595, 3466.7746596471147, 3535.550424326014, 3536.2573859489794, 2495.0, 2512.9748702512743, 2519.899204031818, 2523.470071285051, 2525.4065294655743, 450.49994506098204, 470.934069230308, 471.9946513925386, 496.60767993285623, 518.142474205191, 553.5709824885665, 600.4505877122472, 618.9721462534196, 621.8476473263988, 623.865868838202, 7809.609519524001, 7959.920400795918, 8084.231997960184, 8233.629486673113, 8388.8741668875, 479.54203735432577, 480.3011618095662, 505.45663411832425, 564.912438572022, 631.8641492079225, 3734.1247239625336, 3827.2154208387215, 3888.8250028748776, 3939.212157568498, 3987.2424239394422, 50599.24101138486, 51309.0, 51584.74207628938, 51609.0, 51775.0, 44742.55257447449, 45015.77492112584, 45122.77438612786, 45867.31199032017, 45945.5405445948, 40845.38731919024, 41407.585924140374, 41704.791476042425, 42502.78748606237, 42577.148457030686, 7533.232665791884, 7785.883211751941, 7853.410994175346, 7976.282134607914, 8001.759947201594, 30014.84992575023, 30406.0, 31018.68981310158, 31139.221519461287, 31209.219769505944, 36717.26565468729, 39112.0, 39316.0, 39355.212895742494, 39701.80149099236, 9222.677206297747, 9252.814943701223, 9265.169346152376, 9320.0, 9379.718608441757, 9852.211823054282, 10133.847992280269, 10336.793264134825, 10503.422311772925, 10592.735181620521, 10110.443925584164, 10136.645217417356, 10263.384196948207, 10364.378137311785, 10562.471876405994, 9706.563204655666, 9798.706038818847, 9948.502574871372, 10128.645497407555, 10240.846387304047, 9944.602215911282, 10013.349132306377, 10462.163026957673, 10828.620998265023, 10902.78194436091, 9435.15083642448, 9634.470104144339, 9667.323287370098, 9712.660056897974, 9735.269854761063, 8920.86618700733, 9170.541472926194, 9313.301502387483, 9358.344915855825, 9432.669856554987], "unit": "score", "name": "yui.html", "value": 5716.454451734837}], "name": "dromaeo_css", "value": 6324.840684392145}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 114.0, 116.0, 116.0, 129.0, 115.0, 116.0, 113.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [156.0, 139.0, 153.0, 163.0, 133.0, 154.0, 154.0, 141.0, 169.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 150.0}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 164.0, 162.0, 163.0, 169.0, 168.0, 163.0, 166.0, 166.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 74.0, 134.0, 72.0, 75.0, 74.0, 72.0, 102.0], "unit": "score", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 129.0, 96.0, 96.0, 100.0, 139.0, 95.0, 96.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 110.0, 111.0, 111.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [147.0, 153.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 100.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 74.0, 75.0, 79.0, 74.0, 75.0, 76.0, 73.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 74.9}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 67.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [86.0, 96.0, 85.0, 89.0, 88.0, 87.0, 87.0, 87.0, 86.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.5}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 129.0, 123.0, 127.0, 131.0, 132.0, 140.0, 127.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.6}, {"lowerIsBetter": true, "replicates": [146.0, 151.0, 154.0, 152.0, 151.0, 140.0, 151.0, 162.0, 161.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 74.0, 71.0, 71.0, 70.0, 72.0, 75.0, 69.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1559.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8374792703151], "unit": "score", "name": "Richards", "value": 212.87106}, {"lowerIsBetter": false, "replicates": [185.63207722294413], "unit": "score", "name": "DeltaBlue", "value": 356.1776659999999}, {"lowerIsBetter": false, "replicates": [277.39251040221916], "unit": "score", "name": "Encrypt", "value": 959.5825049999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [748.502994011976], "unit": "score", "name": "Earley", "value": 890.3945680000003}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [600.9615384615385], "unit": "score", "name": "Splay", "value": 135.60102399999994}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21152.482664204468}]} 05:28:48 INFO - RETURN: dromaeo_css: 6324.84 05:28:48 INFO - RETURN: kraken: 1559.70 05:28:48 INFO - RETURN: v8_7: 21152.48 05:28:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21152.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1559.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6324.84"}}} 05:28:48 INFO - Return code: 0 05:28:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:48 INFO - # TBPL SUCCESS # 05:28:48 INFO - Running post-action listener: _resource_record_post_action 05:28:48 INFO - Running post-run listener: _resource_record_post_run 05:28:49 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508264448; Read time: 1100; Write time: 518852 05:28:49 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 4096; Write bytes: 231251968; Read time: 1004; Write time: 353968 05:28:49 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276721664; Read time: 96; Write time: 164824 05:28:49 INFO - Running post-run listener: _upload_blobber_files 05:28:49 INFO - Blob upload gear active. 05:28:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:28:49 INFO - Copying logs to upload dir... 05:28:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.736059 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-16 05:28:48.443467) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:28:48.447453) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010067 build_url: 'https://queue.taskcluster.net/v1/task/1JbsXQqTR0OT0slVh9jQFg/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-16 05:28:48.497934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:28:48.498275) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450271261.902686-900266956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:28:48.548184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:28:48.548530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:28:48.548846) ========= ========= Total master_lag: 0.20 =========