builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1450268469.74 results: success (0) buildid: 20151216025907 builduid: c192c417865041439eebf397db31510d revision: 40038a66525f454aadc0f887bae55c6a60ef7290 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.743759) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.744208) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.744512) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006200 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.767388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.767702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.781380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.781839) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.832439) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.832735) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.833088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:09.833388) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 04:21:09-- 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% 47.2M=0s 2015-12-16 04:21:09 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127127 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:10.002736) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:10.003064) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013976 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:10.052282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:21:10.052704) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 40038a66525f454aadc0f887bae55c6a60ef7290 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 40038a66525f454aadc0f887bae55c6a60ef7290 --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=23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 04:21:10,115 truncating revision to first 12 chars 2015-12-16 04:21:10,116 Setting DEBUG logging. 2015-12-16 04:21:10,116 attempt 1/10 2015-12-16 04:21:10,116 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/40038a66525f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 04:21:10,860 unpacking tar archive at: mozilla-central-40038a66525f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.036200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:21:11.102143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:11.102549) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:11.250159) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:11.250589) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:21:11.251067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-16 04:21:11.251383) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:11 INFO - MultiFileLogger online at 20151216 04:21:11 in /builds/slave/test 04:21:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:21:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:11 INFO - {'append_to_log': False, 04:21:11 INFO - 'base_work_dir': '/builds/slave/test', 04:21:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:21:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:11 INFO - 'branch': 'Firefox-Non-PGO', 04:21:11 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:11 INFO - 'config_files': ('talos/linux_config.py',), 04:21:11 INFO - 'default_actions': ('clobber', 04:21:11 INFO - 'read-buildbot-config', 04:21:11 INFO - 'download-and-extract', 04:21:11 INFO - 'populate-webroot', 04:21:11 INFO - 'create-virtualenv', 04:21:11 INFO - 'install', 04:21:11 INFO - 'run-tests'), 04:21:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:11 INFO - 'download_minidump_stackwalk': True, 04:21:11 INFO - 'download_symbols': 'ondemand', 04:21:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:11 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:11 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:11 INFO - 'installer_path': 'installer.exe', 04:21:11 INFO - 'log_level': 'info', 04:21:11 INFO - 'log_name': 'talos', 04:21:11 INFO - 'log_to_console': True, 04:21:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:11 INFO - 'opt_config_files': (), 04:21:11 INFO - 'pip_index': False, 04:21:11 INFO - 'sps_profile': False, 04:21:11 INFO - 'sps_profile_interval': 0, 04:21:11 INFO - 'suite': 'dromaeojs-e10s', 04:21:11 INFO - 'system_bits': '64', 04:21:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:11 INFO - 'title': 'talos-linux64-ix-030', 04:21:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:11 INFO - 'use_talos_json': True, 04:21:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:11 INFO - 'work_dir': 'build'} 04:21:11 INFO - ##### 04:21:11 INFO - ##### Running clobber step. 04:21:11 INFO - ##### 04:21:11 INFO - Running pre-action listener: _resource_record_pre_action 04:21:11 INFO - Running main action method: clobber 04:21:11 INFO - rmtree: /builds/slave/test/build 04:21:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:11 INFO - Running post-action listener: _resource_record_post_action 04:21:11 INFO - ##### 04:21:11 INFO - ##### Running read-buildbot-config step. 04:21:11 INFO - ##### 04:21:11 INFO - Running pre-action listener: _resource_record_pre_action 04:21:11 INFO - Running main action method: read_buildbot_config 04:21:11 INFO - Using buildbot properties: 04:21:11 INFO - { 04:21:11 INFO - "properties": { 04:21:11 INFO - "buildnumber": 122, 04:21:11 INFO - "product": "firefox", 04:21:11 INFO - "script_repo_revision": "production", 04:21:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:21:11 INFO - "repository": "", 04:21:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:21:11 INFO - "buildid": "20151216025907", 04:21:11 INFO - "slavename": "talos-linux64-ix-030", 04:21:11 INFO - "pgo_build": "False", 04:21:11 INFO - "basedir": "/builds/slave/test", 04:21:11 INFO - "project": "", 04:21:11 INFO - "platform": "ubuntu64_hw", 04:21:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:21:11 INFO - "slavebuilddir": "test", 04:21:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:21:11 INFO - "branch": "mozilla-central", 04:21:11 INFO - "repo_path": "mozilla-central", 04:21:11 INFO - "stage_platform": "linux64", 04:21:11 INFO - "builduid": "c192c417865041439eebf397db31510d", 04:21:11 INFO - "revision": "40038a66525f454aadc0f887bae55c6a60ef7290" 04:21:11 INFO - }, 04:21:11 INFO - "sourcestamp": { 04:21:11 INFO - "repository": "", 04:21:11 INFO - "hasPatch": false, 04:21:11 INFO - "project": "", 04:21:11 INFO - "branch": "mozilla-central-linux64-talos", 04:21:11 INFO - "changes": [ 04:21:11 INFO - { 04:21:11 INFO - "category": null, 04:21:11 INFO - "files": [ 04:21:11 INFO - { 04:21:11 INFO - "url": null, 04:21:11 INFO - "name": "https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:21:11 INFO - } 04:21:11 INFO - ], 04:21:11 INFO - "repository": "", 04:21:11 INFO - "rev": "40038a66525f454aadc0f887bae55c6a60ef7290", 04:21:11 INFO - "who": "cbook@mozilla.com", 04:21:11 INFO - "when": 1450268249, 04:21:11 INFO - "number": 7365658, 04:21:11 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:21:11 INFO - "project": "", 04:21:11 INFO - "at": "Wed 16 Dec 2015 04:17:29", 04:21:11 INFO - "branch": "mozilla-central-linux64-talos", 04:21:11 INFO - "revlink": "", 04:21:11 INFO - "properties": [ 04:21:11 INFO - [ 04:21:11 INFO - "buildid", 04:21:11 INFO - "20151216025907", 04:21:11 INFO - "Change" 04:21:11 INFO - ], 04:21:11 INFO - [ 04:21:11 INFO - "builduid", 04:21:11 INFO - "c192c417865041439eebf397db31510d", 04:21:11 INFO - "Change" 04:21:11 INFO - ], 04:21:11 INFO - [ 04:21:11 INFO - "pgo_build", 04:21:11 INFO - "False", 04:21:11 INFO - "Change" 04:21:11 INFO - ] 04:21:11 INFO - ], 04:21:11 INFO - "revision": "40038a66525f454aadc0f887bae55c6a60ef7290" 04:21:11 INFO - } 04:21:11 INFO - ], 04:21:11 INFO - "revision": "40038a66525f454aadc0f887bae55c6a60ef7290" 04:21:11 INFO - } 04:21:11 INFO - } 04:21:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:21:11 INFO - Running post-action listener: _resource_record_post_action 04:21:11 INFO - ##### 04:21:11 INFO - ##### Running download-and-extract step. 04:21:11 INFO - ##### 04:21:11 INFO - Running pre-action listener: _resource_record_pre_action 04:21:11 INFO - Running main action method: download_and_extract 04:21:11 INFO - mkdir: /builds/slave/test/build/tests 04:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:11 INFO - https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:21:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/test_packages.json 04:21:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/test_packages.json 04:21:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:21:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:21:12 INFO - Downloaded 1302 bytes. 04:21:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:21:12 INFO - Using the following test package requirements: 04:21:12 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:12 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:21:12 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'jsshell-linux-x86_64.zip'], 04:21:12 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:21:12 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:12 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:21:12 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:21:12 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:21:12 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:12 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:21:12 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:12 INFO - https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:21:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:21:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:21:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:21:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:21:13 INFO - Downloaded 21868585 bytes. 04:21:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:21:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:21:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:21:14 INFO - Return code: 0 04:21:14 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:14 INFO - https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:21:16 INFO - Downloaded 21868585 bytes. 04:21:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:21:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:21:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:21:17 INFO - Return code: 0 04:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:17 INFO - https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:21:18 INFO - Downloaded 11132052 bytes. 04:21:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:21:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:21:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:21:18 INFO - Return code: 0 04:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:18 INFO - https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:21:19 INFO - Downloaded 57738087 bytes. 04:21:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:21:19 INFO - mkdir: /builds/slave/test/properties 04:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:19 INFO - Contents: 04:21:19 INFO - build_url:https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:21:19 INFO - Running post-action listener: _resource_record_post_action 04:21:19 INFO - Running post-action listener: set_extra_try_arguments 04:21:19 INFO - ##### 04:21:19 INFO - ##### Running populate-webroot step. 04:21:19 INFO - ##### 04:21:19 INFO - Running pre-action listener: _resource_record_pre_action 04:21:19 INFO - Running main action method: populate_webroot 04:21:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:19 INFO - '--tppagecycles', 04:21:19 INFO - '7'], 04:21:19 INFO - 'tests': ['tsvgm']}}, 04:21:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:21:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:21:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:21:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:19 INFO - 'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:19 INFO - 'tests': ['damp', 'tps']}, 04:21:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:19 INFO - 'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['damp', 'tps']}, 04:21:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:21:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:19 INFO - 'other': {'tests': ['a11yr', 04:21:19 INFO - 'ts_paint', 04:21:19 INFO - 'tpaint', 04:21:19 INFO - 'sessionrestore', 04:21:19 INFO - 'sessionrestore_no_auto_restore']}, 04:21:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['a11yr', 04:21:19 INFO - 'ts_paint', 04:21:19 INFO - 'tpaint', 04:21:19 INFO - 'sessionrestore', 04:21:19 INFO - 'sessionrestore_no_auto_restore']}, 04:21:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['a11yr', 04:21:19 INFO - 'ts_paint', 04:21:19 INFO - 'tpaint', 04:21:19 INFO - 'sessionrestore', 04:21:19 INFO - 'sessionrestore_no_auto_restore']}, 04:21:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['a11yr', 04:21:19 INFO - 'ts_paint', 04:21:19 INFO - 'tpaint', 04:21:19 INFO - 'sessionrestore', 04:21:19 INFO - 'sessionrestore_no_auto_restore']}, 04:21:19 INFO - 'other_l64': {'tests': ['a11yr', 04:21:19 INFO - 'ts_paint', 04:21:19 INFO - 'tpaint', 04:21:19 INFO - 'sessionrestore', 04:21:19 INFO - 'sessionrestore_no_auto_restore']}, 04:21:19 INFO - 'other_nol64': {'tests': ['a11yr', 04:21:19 INFO - 'ts_paint', 04:21:19 INFO - 'tpaint', 04:21:19 INFO - 'sessionrestore', 04:21:19 INFO - 'sessionrestore_no_auto_restore']}, 04:21:19 INFO - 'svgr': {'tests': ['tsvgx', 04:21:19 INFO - 'tsvgr_opacity', 04:21:19 INFO - 'tart', 04:21:19 INFO - 'tscrollx', 04:21:19 INFO - 'cart']}, 04:21:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['tsvgx', 04:21:19 INFO - 'tsvgr_opacity', 04:21:19 INFO - 'tart', 04:21:19 INFO - 'tscrollx', 04:21:19 INFO - 'cart']}, 04:21:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:19 INFO - 'tests': ['tp5o']}, 04:21:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:19 INFO - 'talos_options': ['--e10s'], 04:21:19 INFO - 'tests': ['tp5o']}, 04:21:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:19 INFO - 'talos_options': ['--xperf_path', 04:21:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:19 INFO - 'tests': ['tp5n']}, 04:21:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:19 INFO - 'talos_options': ['--e10s', 04:21:19 INFO - '--xperf_path', 04:21:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:19 INFO - 'tests': ['tp5n']}}, 04:21:19 INFO - 'talos.zip': {'path': '', 04:21:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:19 INFO - Running post-action listener: _resource_record_post_action 04:21:19 INFO - ##### 04:21:19 INFO - ##### Running create-virtualenv step. 04:21:19 INFO - ##### 04:21:19 INFO - Running pre-action listener: _resource_record_pre_action 04:21:19 INFO - Running main action method: create_virtualenv 04:21:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:21:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:20 INFO - Using real prefix '/usr' 04:21:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:22 INFO - Installing pip.................done. 04:21:22 INFO - Return code: 0 04:21:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:22 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:21:22 INFO - Using env: {'DISPLAY': ':0', 04:21:22 INFO - 'HOME': '/home/cltbld', 04:21:22 INFO - 'LANG': 'en_US.UTF-8', 04:21:22 INFO - 'LANGUAGE': 'en_US:en', 04:21:22 INFO - 'LOGNAME': 'cltbld', 04:21:22 INFO - 'MAIL': '/var/mail/cltbld', 04:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:22 INFO - 'MOZ_NO_REMOTE': '1', 04:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:22 INFO - 'NO_EM_RESTART': '1', 04:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:22 INFO - 'PWD': '/builds/slave/test', 04:21:22 INFO - 'SHELL': '/bin/bash', 04:21:22 INFO - 'SHLVL': '1', 04:21:22 INFO - 'TERM': 'linux', 04:21:22 INFO - 'TMOUT': '86400', 04:21:22 INFO - 'USER': 'cltbld', 04:21:22 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:22 INFO - '_': '/tools/buildbot/bin/python'} 04:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:21:22 INFO - Cleaning up... 04:21:22 INFO - Return code: 0 04:21:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:22 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:21:22 INFO - Using env: {'DISPLAY': ':0', 04:21:22 INFO - 'HOME': '/home/cltbld', 04:21:22 INFO - 'LANG': 'en_US.UTF-8', 04:21:22 INFO - 'LANGUAGE': 'en_US:en', 04:21:22 INFO - 'LOGNAME': 'cltbld', 04:21:22 INFO - 'MAIL': '/var/mail/cltbld', 04:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:22 INFO - 'MOZ_NO_REMOTE': '1', 04:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:22 INFO - 'NO_EM_RESTART': '1', 04:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:22 INFO - 'PWD': '/builds/slave/test', 04:21:22 INFO - 'SHELL': '/bin/bash', 04:21:22 INFO - 'SHLVL': '1', 04:21:22 INFO - 'TERM': 'linux', 04:21:22 INFO - 'TMOUT': '86400', 04:21:22 INFO - 'USER': 'cltbld', 04:21:22 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:22 INFO - '_': '/tools/buildbot/bin/python'} 04:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:22 INFO - Downloading/unpacking psutil>=0.7.1 04:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:24 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:21:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:24 INFO - Installing collected packages: psutil 04:21:24 INFO - Running setup.py install for psutil 04:21:24 INFO - building 'psutil._psutil_linux' extension 04:21:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:21:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:21:25 INFO - building 'psutil._psutil_posix' extension 04:21:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:21:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:21:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:25 INFO - Successfully installed psutil 04:21:25 INFO - Cleaning up... 04:21:25 INFO - Return code: 0 04:21:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:25 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:21:25 INFO - Using env: {'DISPLAY': ':0', 04:21:25 INFO - 'HOME': '/home/cltbld', 04:21:25 INFO - 'LANG': 'en_US.UTF-8', 04:21:25 INFO - 'LANGUAGE': 'en_US:en', 04:21:25 INFO - 'LOGNAME': 'cltbld', 04:21:25 INFO - 'MAIL': '/var/mail/cltbld', 04:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:25 INFO - 'MOZ_NO_REMOTE': '1', 04:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:25 INFO - 'NO_EM_RESTART': '1', 04:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:25 INFO - 'PWD': '/builds/slave/test', 04:21:25 INFO - 'SHELL': '/bin/bash', 04:21:25 INFO - 'SHLVL': '1', 04:21:25 INFO - 'TERM': 'linux', 04:21:25 INFO - 'TMOUT': '86400', 04:21:25 INFO - 'USER': 'cltbld', 04:21:25 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:25 INFO - '_': '/tools/buildbot/bin/python'} 04:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:21:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:21:27 INFO - Installing collected packages: mozsystemmonitor 04:21:27 INFO - Running setup.py install for mozsystemmonitor 04:21:27 INFO - Successfully installed mozsystemmonitor 04:21:27 INFO - Cleaning up... 04:21:27 INFO - Return code: 0 04:21:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:27 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:21:27 INFO - Using env: {'DISPLAY': ':0', 04:21:27 INFO - 'HOME': '/home/cltbld', 04:21:27 INFO - 'LANG': 'en_US.UTF-8', 04:21:27 INFO - 'LANGUAGE': 'en_US:en', 04:21:27 INFO - 'LOGNAME': 'cltbld', 04:21:27 INFO - 'MAIL': '/var/mail/cltbld', 04:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:27 INFO - 'MOZ_NO_REMOTE': '1', 04:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:27 INFO - 'NO_EM_RESTART': '1', 04:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:27 INFO - 'PWD': '/builds/slave/test', 04:21:27 INFO - 'SHELL': '/bin/bash', 04:21:27 INFO - 'SHLVL': '1', 04:21:27 INFO - 'TERM': 'linux', 04:21:27 INFO - 'TMOUT': '86400', 04:21:27 INFO - 'USER': 'cltbld', 04:21:27 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:27 INFO - '_': '/tools/buildbot/bin/python'} 04:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:29 INFO - Downloading docopt-0.6.1.tar.gz 04:21:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:30 INFO - Running setup.py install for blobuploader 04:21:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:30 INFO - Running setup.py install for requests 04:21:30 INFO - Running setup.py install for docopt 04:21:30 INFO - Successfully installed blobuploader requests docopt 04:21:30 INFO - Cleaning up... 04:21:30 INFO - Return code: 0 04:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:30 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:21:30 INFO - Using env: {'DISPLAY': ':0', 04:21:30 INFO - 'HOME': '/home/cltbld', 04:21:30 INFO - 'LANG': 'en_US.UTF-8', 04:21:30 INFO - 'LANGUAGE': 'en_US:en', 04:21:30 INFO - 'LOGNAME': 'cltbld', 04:21:30 INFO - 'MAIL': '/var/mail/cltbld', 04:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:30 INFO - 'MOZ_NO_REMOTE': '1', 04:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:30 INFO - 'NO_EM_RESTART': '1', 04:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:30 INFO - 'PWD': '/builds/slave/test', 04:21:30 INFO - 'SHELL': '/bin/bash', 04:21:30 INFO - 'SHLVL': '1', 04:21:30 INFO - 'TERM': 'linux', 04:21:30 INFO - 'TMOUT': '86400', 04:21:30 INFO - 'USER': 'cltbld', 04:21:30 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:30 INFO - '_': '/tools/buildbot/bin/python'} 04:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:30 INFO - Running setup.py (path:/tmp/pip-CyMvAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:30 INFO - Running setup.py (path:/tmp/pip-1Vzffx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:31 INFO - Running setup.py (path:/tmp/pip-_ANNrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:31 INFO - Running setup.py (path:/tmp/pip-780RGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:31 INFO - Running setup.py (path:/tmp/pip-cQ3_GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:31 INFO - Running setup.py (path:/tmp/pip-gadNYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:31 INFO - Running setup.py (path:/tmp/pip-swXu8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:31 INFO - Running setup.py (path:/tmp/pip-FpXwRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:31 INFO - Running setup.py (path:/tmp/pip-21ZTYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:31 INFO - Running setup.py (path:/tmp/pip-2gDC84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:31 INFO - Running setup.py (path:/tmp/pip-ugOtjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:31 INFO - Running setup.py (path:/tmp/pip-dG4aGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:31 INFO - Running setup.py (path:/tmp/pip-j0fRca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:31 INFO - Running setup.py (path:/tmp/pip-PIzjPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:31 INFO - Running setup.py (path:/tmp/pip-W8mDKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:31 INFO - Running setup.py (path:/tmp/pip-28atUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:31 INFO - Running setup.py (path:/tmp/pip-E4rQZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:32 INFO - Running setup.py install for manifestparser 04:21:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Running setup.py install for mozcrash 04:21:32 INFO - Running setup.py install for mozdebug 04:21:32 INFO - Running setup.py install for mozdevice 04:21:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Running setup.py install for mozfile 04:21:32 INFO - Running setup.py install for mozhttpd 04:21:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Running setup.py install for mozinfo 04:21:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Running setup.py install for mozInstall 04:21:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Running setup.py install for mozleak 04:21:32 INFO - Running setup.py install for mozlog 04:21:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for moznetwork 04:21:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozprocess 04:21:33 INFO - Running setup.py install for mozprofile 04:21:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozrunner 04:21:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozscreenshot 04:21:33 INFO - Running setup.py install for moztest 04:21:33 INFO - Running setup.py install for mozversion 04:21:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:33 INFO - Cleaning up... 04:21:33 INFO - Return code: 0 04:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:33 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:21:33 INFO - Using env: {'DISPLAY': ':0', 04:21:33 INFO - 'HOME': '/home/cltbld', 04:21:33 INFO - 'LANG': 'en_US.UTF-8', 04:21:33 INFO - 'LANGUAGE': 'en_US:en', 04:21:33 INFO - 'LOGNAME': 'cltbld', 04:21:33 INFO - 'MAIL': '/var/mail/cltbld', 04:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:33 INFO - 'MOZ_NO_REMOTE': '1', 04:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:33 INFO - 'NO_EM_RESTART': '1', 04:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:33 INFO - 'PWD': '/builds/slave/test', 04:21:33 INFO - 'SHELL': '/bin/bash', 04:21:33 INFO - 'SHLVL': '1', 04:21:33 INFO - 'TERM': 'linux', 04:21:33 INFO - 'TMOUT': '86400', 04:21:33 INFO - 'USER': 'cltbld', 04:21:33 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:33 INFO - '_': '/tools/buildbot/bin/python'} 04:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:34 INFO - Running setup.py (path:/tmp/pip-ohhC7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:34 INFO - Running setup.py (path:/tmp/pip-G0km6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:34 INFO - Running setup.py (path:/tmp/pip-H6Bgsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:34 INFO - Running setup.py (path:/tmp/pip-6uHsbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:34 INFO - Running setup.py (path:/tmp/pip-dc0pVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:34 INFO - Running setup.py (path:/tmp/pip-ovvsu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:34 INFO - Running setup.py (path:/tmp/pip-2C1nCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:34 INFO - Running setup.py (path:/tmp/pip-8z6peN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:34 INFO - Running setup.py (path:/tmp/pip-LCSrWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:34 INFO - Running setup.py (path:/tmp/pip-uNRzAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:34 INFO - Running setup.py (path:/tmp/pip-m5oKNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:34 INFO - Running setup.py (path:/tmp/pip-DihkW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:34 INFO - Running setup.py (path:/tmp/pip-lSNacI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:34 INFO - Running setup.py (path:/tmp/pip-tegLNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:35 INFO - Running setup.py (path:/tmp/pip-7YpCyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:35 INFO - Running setup.py (path:/tmp/pip-3uBqpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:35 INFO - Running setup.py (path:/tmp/pip-GTn9xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:21:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:36 INFO - Downloading blessings-1.5.1.tar.gz 04:21:36 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:36 INFO - Installing collected packages: blessings 04:21:36 INFO - Running setup.py install for blessings 04:21:37 INFO - Successfully installed blessings 04:21:37 INFO - Cleaning up... 04:21:37 INFO - Return code: 0 04:21:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:37 INFO - Reading from file tmpfile_stdout 04:21:37 INFO - Current package versions: 04:21:37 INFO - argparse == 1.2.1 04:21:37 INFO - blessings == 1.5.1 04:21:37 INFO - blobuploader == 1.2.4 04:21:37 INFO - docopt == 0.6.1 04:21:37 INFO - manifestparser == 1.1 04:21:37 INFO - mozInstall == 1.12 04:21:37 INFO - mozcrash == 0.16 04:21:37 INFO - mozdebug == 0.1 04:21:37 INFO - mozdevice == 0.47 04:21:37 INFO - mozfile == 1.2 04:21:37 INFO - mozhttpd == 0.7 04:21:37 INFO - mozinfo == 0.9 04:21:37 INFO - mozleak == 0.1 04:21:37 INFO - mozlog == 3.1 04:21:37 INFO - moznetwork == 0.27 04:21:37 INFO - mozprocess == 0.22 04:21:37 INFO - mozprofile == 0.27 04:21:37 INFO - mozrunner == 6.11 04:21:37 INFO - mozscreenshot == 0.1 04:21:37 INFO - mozsystemmonitor == 0.0 04:21:37 INFO - moztest == 0.7 04:21:37 INFO - mozversion == 1.4 04:21:37 INFO - psutil == 3.1.1 04:21:37 INFO - requests == 1.2.3 04:21:37 INFO - wsgiref == 0.1.2 04:21:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:37 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:21:37 INFO - Using env: {'DISPLAY': ':0', 04:21:37 INFO - 'HOME': '/home/cltbld', 04:21:37 INFO - 'LANG': 'en_US.UTF-8', 04:21:37 INFO - 'LANGUAGE': 'en_US:en', 04:21:37 INFO - 'LOGNAME': 'cltbld', 04:21:37 INFO - 'MAIL': '/var/mail/cltbld', 04:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:37 INFO - 'MOZ_NO_REMOTE': '1', 04:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:37 INFO - 'NO_EM_RESTART': '1', 04:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:37 INFO - 'PWD': '/builds/slave/test', 04:21:37 INFO - 'SHELL': '/bin/bash', 04:21:37 INFO - 'SHLVL': '1', 04:21:37 INFO - 'TERM': 'linux', 04:21:37 INFO - 'TMOUT': '86400', 04:21:37 INFO - 'USER': 'cltbld', 04:21:37 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:37 INFO - '_': '/tools/buildbot/bin/python'} 04:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:37 INFO - Cleaning up... 04:21:37 INFO - Return code: 0 04:21:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:37 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:21:37 INFO - Using env: {'DISPLAY': ':0', 04:21:37 INFO - 'HOME': '/home/cltbld', 04:21:37 INFO - 'LANG': 'en_US.UTF-8', 04:21:37 INFO - 'LANGUAGE': 'en_US:en', 04:21:37 INFO - 'LOGNAME': 'cltbld', 04:21:37 INFO - 'MAIL': '/var/mail/cltbld', 04:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:37 INFO - 'MOZ_NO_REMOTE': '1', 04:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:37 INFO - 'NO_EM_RESTART': '1', 04:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:37 INFO - 'PWD': '/builds/slave/test', 04:21:37 INFO - 'SHELL': '/bin/bash', 04:21:37 INFO - 'SHLVL': '1', 04:21:37 INFO - 'TERM': 'linux', 04:21:37 INFO - 'TMOUT': '86400', 04:21:37 INFO - 'USER': 'cltbld', 04:21:37 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:37 INFO - '_': '/tools/buildbot/bin/python'} 04:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:37 INFO - Downloading/unpacking jsonschema 04:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:21:39 INFO - Downloading/unpacking functools32 (from jsonschema) 04:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:39 INFO - warning: no files found matching '*.txt' 04:21:39 INFO - no previously-included directories found matching 'build' 04:21:39 INFO - no previously-included directories found matching 'dist' 04:21:39 INFO - no previously-included directories found matching '.git*' 04:21:39 INFO - Installing collected packages: jsonschema, functools32 04:21:39 INFO - Running setup.py install for functools32 04:21:39 INFO - warning: no files found matching '*.txt' 04:21:39 INFO - no previously-included directories found matching 'build' 04:21:39 INFO - no previously-included directories found matching 'dist' 04:21:39 INFO - no previously-included directories found matching '.git*' 04:21:39 INFO - Successfully installed jsonschema functools32 04:21:39 INFO - Cleaning up... 04:21:39 INFO - Return code: 0 04:21:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:39 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 0x7f7dc63e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:21:39 INFO - Using env: {'DISPLAY': ':0', 04:21:39 INFO - 'HOME': '/home/cltbld', 04:21:39 INFO - 'LANG': 'en_US.UTF-8', 04:21:39 INFO - 'LANGUAGE': 'en_US:en', 04:21:39 INFO - 'LOGNAME': 'cltbld', 04:21:39 INFO - 'MAIL': '/var/mail/cltbld', 04:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:39 INFO - 'MOZ_NO_REMOTE': '1', 04:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:39 INFO - 'NO_EM_RESTART': '1', 04:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:39 INFO - 'PWD': '/builds/slave/test', 04:21:39 INFO - 'SHELL': '/bin/bash', 04:21:39 INFO - 'SHLVL': '1', 04:21:39 INFO - 'TERM': 'linux', 04:21:39 INFO - 'TMOUT': '86400', 04:21:39 INFO - 'USER': 'cltbld', 04:21:39 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:39 INFO - '_': '/tools/buildbot/bin/python'} 04:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:40 INFO - Downloading/unpacking flake8 04:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:21:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:21:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:21:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:21:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:21:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:21:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:42 INFO - no previously-included directories found matching 'docs/_build' 04:21:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:21:42 INFO - Running setup.py install for pep8 04:21:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:42 INFO - no previously-included directories found matching 'docs/_build' 04:21:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:21:42 INFO - Cleaning up... 04:21:42 INFO - Return code: 0 04:21:42 INFO - Running post-action listener: _resource_record_post_action 04:21:42 INFO - Running post-action listener: _start_resource_monitoring 04:21:42 INFO - Starting resource monitoring. 04:21:42 INFO - ##### 04:21:42 INFO - ##### Running install step. 04:21:42 INFO - ##### 04:21:42 INFO - Running pre-action listener: _resource_record_pre_action 04:21:42 INFO - Running main action method: install 04:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:42 INFO - Reading from file tmpfile_stdout 04:21:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:42 INFO - Reading from file tmpfile_stdout 04:21:42 INFO - Output received: 04:21:42 INFO - Usage: mozinstall [options] installer 04:21:42 INFO - Options: 04:21:42 INFO - -h, --help show this help message and exit 04:21:42 INFO - -d DEST, --destination=DEST 04:21:42 INFO - Directory to install application into. [default: 04:21:42 INFO - "/builds/slave/test"] 04:21:42 INFO - --app=APP Application being installed. [default: firefox] 04:21:42 INFO - mkdir: /builds/slave/test/build/application 04:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:21:57 INFO - Reading from file tmpfile_stdout 04:21:57 INFO - Output received: 04:21:57 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:57 INFO - Running post-action listener: _resource_record_post_action 04:21:57 INFO - ##### 04:21:57 INFO - ##### Running run-tests step. 04:21:57 INFO - ##### 04:21:57 INFO - Running pre-action listener: _resource_record_pre_action 04:21:57 INFO - Running main action method: run_tests 04:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:57 INFO - Python 2.7.3 04:21:57 INFO - Return code: 0 04:21:57 INFO - grabbing minidump binary from tooltool 04:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:57 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 0x27750b0>, '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 0x2775fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:21:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:21:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:57 INFO - Return code: 0 04:21:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:21:58 INFO - Return code: 0 04:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 04:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 04:21:58 INFO - Using env: {'DISPLAY': ':0', 04:21:58 INFO - 'HOME': '/home/cltbld', 04:21:58 INFO - 'LANG': 'en_US.UTF-8', 04:21:58 INFO - 'LANGUAGE': 'en_US:en', 04:21:58 INFO - 'LOGNAME': 'cltbld', 04:21:58 INFO - 'MAIL': '/var/mail/cltbld', 04:21:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:58 INFO - 'MOZ_NO_REMOTE': '1', 04:21:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:58 INFO - 'NO_EM_RESTART': '1', 04:21:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:58 INFO - 'PWD': '/builds/slave/test', 04:21:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:58 INFO - 'SHELL': '/bin/bash', 04:21:58 INFO - 'SHLVL': '1', 04:21:58 INFO - 'TERM': 'linux', 04:21:58 INFO - 'TMOUT': '86400', 04:21:58 INFO - 'USER': 'cltbld', 04:21:58 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610', 04:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:58 INFO - '_': '/tools/buildbot/bin/python'} 04:21:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 04:21:58 INFO - mozversion INFO | application_buildid: 20151216025907 04:21:58 INFO - mozversion INFO | application_changeset: 40038a66525f454aadc0f887bae55c6a60ef7290 04:21:58 INFO - mozversion INFO | application_display_name: Nightly 04:21:58 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:58 INFO - mozversion INFO | application_name: Firefox 04:21:58 INFO - mozversion INFO | application_remotingname: firefox 04:21:58 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:21:58 INFO - mozversion INFO | application_vendor: Mozilla 04:21:58 INFO - mozversion INFO | application_version: 46.0a1 04:21:58 INFO - mozversion INFO | platform_buildid: 20151216025907 04:21:58 INFO - mozversion INFO | platform_changeset: 40038a66525f454aadc0f887bae55c6a60ef7290 04:21:58 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:21:58 INFO - mozversion INFO | platform_version: 46.0a1 04:21:58 INFO - 2015-12-16 04:21:58,731 DEBUG : using testdate: 1450268518 04:21:58 INFO - 2015-12-16 04:21:58,731 DEBUG : actual date: 1450268518 04:21:58 INFO - 2015-12-16 04:21:58,743 INFO : starting webserver on 'localhost:43513' 04:21:58 INFO - 2015-12-16 04:21:58,744 INFO : Starting test suite talos-linux64-ix-030.e 04:21:58 INFO - 2015-12-16 04:21:58,744 INFO : Starting test dromaeo_css 04:21:58 INFO - 2015-12-16 04:21:58,744 DEBUG : operating with platform_type : linux_ 04:21:58 INFO - 2015-12-16 04:21:58,745 INFO : Initialising browser for dromaeo_css test... 04:21:58 INFO - 2015-12-16 04:21:58,756 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP2iU94/profile http://localhost:43513/getInfo.html 04:22:03 INFO - 2015-12-16 04:22:03,899 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:22:03 INFO - 2015-12-16 04:22:03,899 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:22:03 INFO - 2015-12-16 04:22:03,899 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:22:03 INFO - 2015-12-16 04:22:03,899 DEBUG : BROWSER_OUTPUT: __metrics 04:22:04 INFO - 2015-12-16 04:22:04,028 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:22:04 INFO - 2015-12-16 04:22:04,953 INFO : Browser initialized. 04:22:04 INFO - 2015-12-16 04:22:04,954 INFO : Running cycle 1/1 for dromaeo_css test... 04:22:04 INFO - 2015-12-16 04:22:04,954 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP2iU94/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:22:17 INFO - 2015-12-16 04:22:17,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 142454784 04:22:17 INFO - 2015-12-16 04:22:17,071 DEBUG : BROWSER_OUTPUT: 04:23:06 INFO - 2015-12-16 04:23:06,708 DEBUG : BROWSER_OUTPUT: 1450268586707 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:25:18 INFO - 2015-12-16 04:25:18,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43513/tests/dromaeo/cssquery-ext.html) 04:25:19 INFO - 2015-12-16 04:25:19,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 146395136 04:25:19 INFO - 2015-12-16 04:25:19,952 DEBUG : BROWSER_OUTPUT: 04:28:22 INFO - 2015-12-16 04:28:22,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/dromaeo/cssquery-ext.html (next: http://localhost:43513/tests/dromaeo/cssquery-jquery.html) 04:28:22 INFO - 2015-12-16 04:28:22,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 147177472 04:28:22 INFO - 2015-12-16 04:28:22,659 DEBUG : BROWSER_OUTPUT: 04:31:24 INFO - 2015-12-16 04:31:24,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43513/tests/dromaeo/cssquery-mootools.html) 04:31:25 INFO - 2015-12-16 04:31:25,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 144588800 04:31:25 INFO - 2015-12-16 04:31:25,150 DEBUG : BROWSER_OUTPUT: 04:34:26 INFO - 2015-12-16 04:34:26,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43513/tests/dromaeo/cssquery-prototype.html) 04:34:27 INFO - 2015-12-16 04:34:27,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 143659008 04:34:27 INFO - 2015-12-16 04:34:27,554 DEBUG : BROWSER_OUTPUT: 04:37:30 INFO - 2015-12-16 04:37:30,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43513/tests/dromaeo/cssquery-yui.html) 04:37:30 INFO - 2015-12-16 04:37:30,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 143609856 04:37:30 INFO - 2015-12-16 04:37:30,725 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/dromaeo/cssquery-yui.html (next: http://localhost:43513/tests/dromaeo/cssquery-dojo.html) 04:40:33 INFO - 2015-12-16 04:40:33,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 147365888 04:40:33 INFO - 2015-12-16 04:40:33,486 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,486 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:40:33 INFO - 2015-12-16 04:40:33,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:40:33 INFO - 2015-12-16 04:40:33,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:40:33 INFO - 2015-12-16 04:40:33,486 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:40:33 INFO - 2015-12-16 04:40:33,486 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2659.8005149613778;2712.1863440967704;2738.671359436868;2741.2598598378427;2763.1434255380827;4649.51180126087;4729.4797572267025;4742.834000809968;4770.403699537558;4786.3059856320815;4645.721256724591;4712.929306060412;4720.339152518642;4724.3622111015;4741.573258406743;4431.93352099718;4483.5516448355065;4532.886677833064;4548.454185497745;4577.198990176722;4338.978305108486;4349.064951035542;4358.8910277243;4408.272635015219;4443.155800397914;4251.107267473803;4264.445622069111;4383.517813040563;4386.692931494765;4388.978055109736;4377.802998865027;4380.189664912002;4404.779761011969;4407.316865885793;4434.268345722952;4392.1874453226255;4394.6923715339935;4406.6694997874965;4431;4443.866683999485;4466.932996005063;4516.36770852081;4546.408966834323;4555.316702494619;4578.061497393026;5126.231065340229;5133.845984620468;5141.974290128563;5142.382914050338;5151.356080489939;5170.586353091781;5246.554042906358;5256.842294731164;5261;5271.499207575274;4620.953790462119;4691.39011928454;4712.787924543404;4726.432828060655;4847.297141914438;5286.418493965661;5320.228566857784;5321.86695332612;5323;5336.973315133477;5082.085224659523;5086.745662716849;5094.898102037939;5107.157319042391;5147.047796157723;4947.752612369367;4978.626603004789;5011.7494125294315;5049.8737531562;5175.223716442564;5017.67385119966;5030.471800460972;5046.873828154252;5061.44324124346;5090.312807770903;4954.380702412199;5008.098542262355;5009.89980200394;5012.398512178562;5017.657664817269;4034.616711412411;4122.855700050483;4131.5455299916985;4194.790260486963;4226.302660061056;3751.981240093782;3754.9436758448646;3760.9247815043545;3776.5656949451163;3800.8859734208017;4202.789860506962;4464.732116073046;4479.708818926824;4480.081583275421;4503.211937910853;4967.453580106186;5122.436531981479;5152.6650767699975;5157.819476318311;5201.3238279024245;4390.824367025347;4400.427944367212;4417.734935903856;4423.093265880487;4440.511543730187;4377.058932329564;4485.820567177341;4492.483364413134;4506.481754598263;4533.025399539115;4801.5438533339275;4861.927071093865;4871.098846713369;4900.705957642553;4921.089598424232;5164.509371609691;5170.586353091669;5172.250023746611;5177.844664660066;5222.503862133091;4586.839460618862;4691.249400095969;4754.5245475452175;4862.708237505761;4930.334404855299;4927.162382394929;4963.726995015164;4994.2508623706735;4997.950020499894;5034.748262586929;5077.289179514797;5166.689998600096;5167.095758242368;5171.431142574239;5208.635395522277;4833.854984350475;4963.404391473046;4989.575886049726;4992.750362481934;4997.525235102659;4843.903121937612;4856.8785780354365;4864.562189402971;4910.410750709938;4965.47862474435;4895.919234325469;4898.779554919965;4901.264810278487;4903.460619331942;4919.9754001231195;4773.331733557374;5020.0461912238015;5032.144535428913;5044;5077.416097148875;4767.189577771718;4828.420589529279;4877.341558889504;4877.634177436636;4916.188828843344 04:40:33 INFO - 2015-12-16 04:40:33,488 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.1253132581845;563.5942121672396;569.7151424287856;573.6185436684605;576.5560518400831;33965.66034339656;34743.82628086859;34952.650473495254;34983.300333993306;35082;37821.05447363817;37909.43135852965;38155.80922095386;38399.42400863989;38400.231995360075;7744.45788794786;7895.171007044264;7915.564643944581;7919.247671471201;7935.682572697086;7826.530408175499;7854.7250846220395;7913.169117242693;7921.287084162424;7921.485103468285;7871.173526779691;7944.721934732285;7973.681052757912;7980.481268717544;7981.720639777609;7883.054033515958;7959.602019899011;7961.840763184704;7988.680452781882;8006.359491240745;7812.062552493737;7916.327112195413;7921.96039019807;7951.403644726669;7952.125266220711;35788.82105589481;35967.4604880927;36480;36511.08722281938;36567.4514882277;3022.8941987030566;3040.1639549123947;3081.3529158876663;3356.8992930212135;3407.727381809449;26995;27064.729352706418;27424.17727468179;27547.173584792487;27682.307942301402;2808.8314701117997;2849.1167738001286;2853.985730071357;2906.6221391219005;2941.7205365490245;194721.02639486853;195611;195710;196193;196441;50742.49257507452;51402.74298628483;51533.16567588744;51645.22532162021;51783.22325165125;62252;62882.371176288565;62950.370496294454;62987.685061575314;63190;14088;14316.427342906376;14346.56960291193;14384.424623014962;14444.422223110958;10762.40806755636;10765.300255483526;10801.783964320826;10858.565657373616;10905.073068789083;18175.45473635793;18288.542786430447;18362.357317493825;18386.540336491427;18443.631127377645;7446.888296675555;7719.768406947801;7733.883991740128;7830.569318687527;7864.528128312205;808.9797755056171;810.2383759266271;847.7703639428264;943.9150476457014;1029.5109822834095;25599.488010240064;26184.73815261823;26237.475250495267;26416;26425.339366515607;908.0783005249676;949.240607513986;970.7961328121173;997.5162046407487;1109.7669489407153;12335.383230838423;12345.074119441078;12345.876541234653;12345.93827030859;12367.567135150226;251336;257097;257348;258766;259078;43008;43486.13027739491;43488;43499.56500435018;43672.78163609162;1232.4101908537887;1240.231056744806;1241.6150993192139;1251.5932321995388;1259.5339724302066;23537.293881183592;25342;26199.73800261973;26224.60663090017;26397.60403593986;36238.45642315315;36582.63417365792;36593.26813463662;36593.45109823408;36615;157125;159834;159835;160278.1986090062;160967;26001.349966250997;28371.858140709166;28935.855320724102;28945.421091577628;28981.42037159287;33320.50019249762;33338;33376.49935250924;34083.82958085194;34141.317173655894;30900.22749431282;31368.843155784074;31446.842765786023;31848.6815131855;31953.201169970936;31234.68765312409;31365;33669;35301.646983529834;35960;31519.36961260808;31623.051308460785;31693.36613267768;31958.201044974063;32198.19504512406;27726.168214953585;28875.7112428873;29106.27234319159;29151.416971660874;29204.7079529202;23116.884415578486;23164.884175579013;23204.3038708839;23461.178858739862;23562.646560301953 04:40:33 INFO - 2015-12-16 04:40:33,489 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.56991126579817;334.86605357856854;336.8080194289253;337.6050021474874;338.61905356473966;14991.850081499182;15392.076475411483;15665.608359790982;15877;16307.776916731233;9973.301868869183;10208.234382421311;13561.93219033906;14783.482578109768;14818.036827606198;4426.269665505188;4545;4547.24970379887;4630.259158534635;4791.856244312677;4916.434610019858;4951.3810773653295;4951.455339912607;4952.950470495303;4965.28003439501;3142.120206342228;3232.3212125453565;4839.7338146401935;4977.0792403405485;5155.020546096249;5098.898022039557;5103.260027296058;5114.795408183668;5118.667286626357;5128.461511541291;4667.323238130486;4814.374131362901;4938.185199442088;4939.703617782944;4940.184869496528;17613.119344032875;17816.376426824998;17846.375376861877;18139.274429022957;18434.078296085143;1787.1600347836495;1825.771778527684;1860.4604664647236;1872.9906350468298;1895.4218963216213;8721.563921803885;8756.124387561256;8793.648254069829;8862.778430539289;9215.308851836073;1687.0481121128323;1761.4363403710818;1807.3764551229804;1813.637272545483;1828.6342731453763;53688;55037.72481137609;55999.720001399735;56362.154567681515;56737.43262567404;9338;9580.233581313478;9690.46702431359;9752.609895604097;9757.609695612096;12276.263424194576;12286.815697764541;12346.938265308796;12364.134510584352;12365.258084514779;7104.289571042855;7122.216556178816;7131.251218622074;7181.030560874216;7223.674934627954;6830.31696830313;6873.4157596603845;6880.449564034865;6883.449324054063;6913.89629155563;4047.1905618876344;4054.533728621246;4060.5330387005283;4078.3066878630702;4120.196561670446;1658.5604814724109;1672.916354182286;1681.1678219281534;1683.6632673465356;1741.9651606967789;365.65628309389086;366.58209641009273;368.77688998156265;782.6595430987538;880.300161371711;9554.522273886278;15111.47109851172;15942.123183224801;15964.76052859208;16235.431759888348;832.3258160889699;833.8248967716726;839.6809212499211;850.1243718969471;860.3418384935529;6485.416312531895;8022.9598852005365;8229.46508476959;8368.665253389918;8899.866502002475;478960;483603.6558537619;490032;492485;494192;70881.2911870885;71200;73083.63458182782;73416.63291683508;73892;1054.2093429927554;1074.7420619051527;1074.957001719938;1085.5060947268973;1085.6037546295545;13773.311334433038;14339.856601433852;14373.928130359282;14423.855761442252;14530.418783248551;29192;29256.56115158317;32644.34711305713;32734.181645459055;34265.65734342625;39386.40920386139;39772;41045.58954410418;41441.79279103585;42722.57277427186;8373.413861029669;8711.303095752452;8786.472811631322;8791.780205494913;8983.550822458981;10164.085232329126;10173.694789156338;10187.643432480125;12163;15943.601409964844;12872;13081.869181308446;13340.733185336432;13572.253526055767;13681.79477307861;11776.411179441166;13074.411651475897;13246.07277490605;13346.19922804635;13419.932900335436;13477.460901563827;13809.24049177305;13953.790693139814;14136.575902722934;14559.344829482487;8834.337424693045;8911.197992180734;8936.955315223382;8978.326625502983;9147.496887670975;12791.552295669608;12976.35118244065;13433.731325373634;13837.584872453843;14022.929885350508 04:40:33 INFO - 2015-12-16 04:40:33,490 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1356.6269275949112;1374.5670113914116;1425.3158483927714;1606.269147537871;1610.2914717524282;5698.715064246791;5953.404659534044;7236.746713865015;7416.406687465003;7436.888446673291;6986.476014298935;7125.85748285034;7205.387542058931;7215.062041934541;7248.2389349118375;2068.5449201175716;2096.1929657081982;2100.306898723418;2103.169248146981;2108.2410332280365;2044.2947183221765;2061.505238742706;2078.5219399538114;2087.9164833406644;2088.9686654700117;2033.2070492507933;2047.2936836791282;2077.542940553076;2079.9584008319825;2087.342487116561;2006.799320067989;2027.006766684314;2036.7555893292827;2037.898105094754;2039.6226698060907;2041.652919003773;2062.1957436599737;2064.349729835112;2087.759907610629;2089.895505224748;7168.856622867514;7230.096237970254;7256.274372562754;7271.781846544613;7280.417566594712;4239.745615263063;4303.397524346594;4304.4834619845815;4305.97847010763;4329.935050974238;2655.495455863399;2704.8377097374023;2726.6864310604337;2728.6452761140927;2736.781057515394;819.8811172379972;832.0015980823036;835.1564919431357;842.4987132656059;851.5529347092764;9874.703758887174;9955.153811925995;9969.302148849583;9990.200783937267;10025.649102281459;3832.7317087803585;3857.691384689218;3924.156306394139;3926.1362500249897;3939.3106206413763;8515.74452766418;8522.232999030117;8565.057843637194;8580.01329847063;8587.441816281922;4326.480822301344;4328.632066274402;4338.869833904988;4343.739375637472;4349.586789255016;3763.096856754414;3863.8068096595057;3870.8838734838;3911.8435262589746;3918.7060970427333;3134.8119112852846;3140.905772826819;3151.4642510773224;3152.2277042124824;3207.743380529552;905.0451773379148;910.267234875918;927.5640448988964;929.920956718673;936.840737074699;949.378157306965;989.6882482018285;1160.3560024186488;1161.4947497838468;1162.1980833225048;6851;6970.163580370388;6971.581705097609;7006.054182685374;7018.5788852669;1125.9324440533594;1140.1505878120688;1158.988410115888;1159.750653609478;1165.2833507393061;5002.09962206799;5149.0474262261605;5150.150225212873;5152.793888244503;5156.329677141947;8561.486310821247;8627.266682332072;8732.8690069649;8826.955865220632;8835.911640883638;8592;8597.785055373666;8631.223189912938;8638.09300023501;8692.695755648521;6807.5575087619145;6848.623325717033;6891.000804883364;6891.310868913069;6917.7232910684015;6588.7364505421165;6608.504362172953;6630.569013014138;6635.701393437404;6640.800775976729;7370.6683199255085;7592.126905405949;7672.462927595015;7798.323360477524;7834.529928204326;7845.490043147177;7864.5281283123195;7885.881711774443;8048.637811298388;8064.677412903418;5412.675239485643;5491.752871120889;6120.693965301806;6144.662043587646;6188.907166392598;6796.93203067963;6988.860222795617;6999.475039371966;7013.824654383681;7021.192562855337;6470.579412338183;6551.115599394211;6565.835854103686;6778.593284402951;6795.116634837439;6267.2792628848265;6566.507511936719;6586.341365863567;6592.80221593353;6661.267260601427;6532.869342613216;6582.243042050225;6585.736570537317;6618.569792963442;6647.667616619053;6054.8183554493435;6057.212562366864;6071.817845464643;6148.415900489446;6186.19579454668;6134.754609815557;6213.254409470893;6216.720247588779;6251.749930002931;6258.061290806416 04:40:33 INFO - 2015-12-16 04:40:33,490 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.3100000997715;307.79993004547043;312.7669885934978;312.89361617050196;314.41989529318397;5502.917456238155;5558.833235002957;5574.498295153436;5689.886202275952;5754.136879468082;5562.415946325638;5625.606207565462;5627.887442251153;5636.379998200195;5642.15367694846;4164.500259968793;4289.528151903288;4294.892627684301;4302.182585308781;4303.074838909633;4275.5296917339065;4283.828646854122;4293.957060429402;4296.505901821283;4308.418363520932;4246.68149888758;4248.107897341562;4249.915001699964;4255.510616279121;4257.425247591582;4235.25882970479;4239.427677263591;4246.4691913510815;4248.851290204859;4255.234057869582;3695.9445608315896;3697.9830546599633;3708.6662200401825;3711.851525938959;3717.498137751396;5138.460461651547;5319.281896943901;5320.973395133038;5325.440828713007;5336;4821;4821.807127714922;4826;4828.420589529243;4831.9033619327765;5777.826665200051;5809.796657116981;5811.128330750379;5827.009408400582;5835.066389377722;3959.4060890866313;3960.920781584352;3967.4247234151176;3969.920601587952;3972.980135099335;5996.8500787480225;6166.784162554334;6186.412290832363;6194.194754681863;6204.81385558434;4104.630583247522;4121.660460350398;4123.814428350672;4139.110091330378;4139.793010349531;4172.331067572934;4173.6661067114555;4179.080602267496;4194.8112334945;4205.11692544563;4855.854324370274;4865.927011094836;4876.4879687633;4881.389826271716;4890.706557606555;5779.33537643168;5892.793752218738;5897.469227769521;5900.76396944126;5907.9704601476715;1451.5500194939602;1491.5749011531661;1491.61963699256;1492.6119209005738;1492.634304595381;976.8034158156344;980.9901900980899;982.5185659027168;1005.8440941654055;1008.0977525115128;5113.744312784346;5113.795448182105;5116.616253780981;5120.385553733501;5120.769565369567;5980.491658209101;6130.693465326805;6131.601445906002;6182.721777520022;6189.6286222826775;5161.587073034223;5167.121589329748;5175.922361164586;5184.662996905189;5186.170212765939;3258.853351599184;3319.93360132796;3326.367990081925;3338.599368075798;3344.6153692325693;5648.265725455664;5788.82633520995;5792.9710351447975;5793.768249269982;5807.01280782268;6353.649149814598;6366.872662546816;6371.171747672773;6372.808815735535;6378.608021991753;5785.82642520725;5798.159266906275;5800.651960882361;5804.912926306109;5811.767529298865;6012.6993650316435;6151.815445536641;6152.938470615237;6156.722947467285;6161.537884658579;5989.431004054608;5996.910046349221;6004.279486461478;6009.909851352146;6017;5767.452092051249;5777.537796976316;5792.855178620568;5794.275715535558;5806.390329015392;4075.3886916961505;4086.8569600063856;4129.236091323115;4131.049858532494;4137.81379837902;5917.792877249276;6155.322914479314;6165.660888651168;6173.876522469615;6174.876502469836;5895.086261629454;5903.940960590339;5925.585209035326;5931.199288096224;5936.970315148396;5818.185454036354;5854.356020837789;5860.062390017747;5875.3243377012195;5889.970550147394;5648.887022259614;5742.339630942495;5759.424057594207;5779.711014449176;5786.566007549535;5911.438413350725;5942.554308426972;5952.76188952437;5961.225040744675;5965.28416590012;5634.549236061187;5732.455416735404;5793.9420605795085;5796.652200867961;5798.246227990503 04:40:33 INFO - 2015-12-16 04:40:33,492 DEBUG : BROWSER_OUTPUT: |5;yui.html;770.5915864591765;780.0911937592705;782.2451334462243;785.9724909628164;796.8286818334057;10699;11014.50434730437;11016.944915275433;11043.061339786107;11047.33715977041;11559.422028898563;11636.650900472978;11708.473118709657;13323.733525329488;13538.93230533846;789.5894135049771;801.4670244287571;802.8153524689325;803.2329125684986;803.6745118227127;801.3148757812045;808.4017826808179;809.0938149272823;810.8864758933754;811.9350451963828;833.9499630022218;841.6843683618642;845.1084106267884;845.1590667286059;849.2441726863066;837.8533756592572;840.7309660908512;842.1410161635098;843.0389356134012;845.0915266088979;618.5175563060819;619.4672581579838;621.9160413344185;622.2035794183453;624.6470744029609;12175.573854915036;12227.816582751177;12344.38278086092;12352.876471235262;12366.62900112998;10517.52671129801;10874.945625271903;11291.548338066468;11293.378864162467;11447.067104180467;9316.068393160698;9346.252299815998;9356.859647105299;9383.577739001761;9423.34036617437;3184.8726050957935;3251.6910893465083;3256.9837150814333;3319.6348401675796;3343.264481813997;37133.81433092844;38312;38380.232395352214;38611.8069409654;39111.60888391108;9153.22197613197;9196.310276729271;9279.814403712024;9284.860727089099;9387.718368448957;15728.370865165494;15799.052056876624;15864.286107124975;15913.681726365408;15954.28205730745;6259.812205633838;6302.4958003359625;6353.078803573456;6360.491160707133;6421.614703117828;3516.4725291206523;3553.058439513531;3564.821758912044;3573.9642603574152;3607.286003412863;2587.3402282417865;2614.2810727050214;2614.307208589725;2618.16218809979;2618.8297760645496;463.54340974140445;470.2053529535075;472.8014234021719;482.17788670317026;482.93721816163674;526.3263023330144;540.108820446259;543.120145364512;594.669958173218;635.6535688050024;7752.147263800977;7791.376689864797;7951.880721789178;8023;8122.675092996214;464.33599952068863;477.12685785014037;512.0731476028401;562.4122791682702;595.9493443057302;3604.5314109165643;3641.49569623283;3990.4014397840556;4032.959670403317;4083.8366465341055;41320.79339603343;41461.37807932883;52730.472695273325;52847.73576132172;55015;43204.567954320686;43320.3501947471;43837.78081109638;44218.557814421445;44271.77864110659;35388.82305588507;35631.643683562834;40614.18771624551;42959.140817183485;43295.35056974148;7908.683652654059;8068.435209535511;8071.919280807117;8223.917760822314;8482.236598706146;30311;31088.533671995392;31105.53341699831;31395;32037.35925281528;36858.44712329264;37388.439173411876;38771.224575508895;39073.609263907;39131;10136.391816491034;10202.081812636601;10211.795764084825;10298.764148302253;10408.895911040792;11037.889621103686;11072.633459019775;11166.385848778395;11305.491252893804;11343.48954297075;10688.358698478116;10875.782484350428;10953.780924381308;11231.831522527333;11251.549938002388;10226.795464090825;10331.741706457398;10552.155827533932;10698.8930110701;10728.463576821285;10164.390136591828;10335.379877207391;10580.629677961235;10854.18593605467;10862.728431789268;9039.096090390909;9192.724218273463;9288.489133097744;9295.67465138717;9332.16010559053;9179.632814687604;9190.448573085636;9314.906850931404;9438.38650487716;9455.574499147417 04:40:33 INFO - 2015-12-16 04:40:33,492 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:40:33 INFO - 2015-12-16 04:40:33,492 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:40:33 INFO - 2015-12-16 04:40:33,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 04:40:33 INFO - 2015-12-16 04:40:33,492 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:40:33 INFO - 2015-12-16 04:40:33,493 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269633485__endTimestamp 04:40:33 INFO - 2015-12-16 04:40:33,493 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,493 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:40:33 INFO - 2015-12-16 04:40:33,493 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:40:33 INFO - 2015-12-16 04:40:33,493 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,493 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4704.53 Median:4843.90 stddev:499.87 (10.3%) stddev-sans-first:474.97 04:40:33 INFO - 2015-12-16 04:40:33,494 DEBUG : BROWSER_OUTPUT: Values: 2659.8 2712.2 2738.7 2741.3 2763.1 4649.5 4729.5 4742.8 4770.4 4786.3 4645.7 4712.9 4720.3 4724.4 4741.6 4431.9 4483.6 4532.9 4548.5 4577.2 4339.0 4349.1 4358.9 4408.3 4443.2 4251.1 4264.4 4383.5 4386.7 4389.0 4377.8 4380.2 4404.8 4407.3 4434.3 4392.2 4394.7 4406.7 4431.0 4443.9 4466.9 4516.4 4546.4 4555.3 4578.1 5126.2 5133.8 5142.0 5142.4 5151.4 5170.6 5246.6 5256.8 5261.0 5271.5 4621.0 4691.4 4712.8 4726.4 4847.3 5286.4 5320.2 5321.9 5323.0 5337.0 5082.1 5086.7 5094.9 5107.2 5147.0 4947.8 4978.6 5011.7 5049.9 5175.2 5017.7 5030.5 5046.9 5061.4 5090.3 4954.4 5008.1 5009.9 5012.4 5017.7 4034.6 4122.9 4131.5 4194.8 4226.3 3752.0 3754.9 3760.9 3776.6 3800.9 4202.8 4464.7 4479.7 4480.1 4503.2 4967.5 5122.4 5152.7 5157.8 5201.3 4390.8 4400.4 4417.7 4423.1 4440.5 4377.1 4485.8 4492.5 4506.5 4533.0 4801.5 4861.9 4871.1 4900.7 4921.1 5164.5 5170.6 5172.3 5177.8 5222.5 4586.8 4691.2 4754.5 4862.7 4930.3 4927.2 4963.7 4994.3 4998.0 5034.7 5077.3 5166.7 5167.1 5171.4 5208.6 4833.9 4963.4 4989.6 4992.8 4997.5 4843.9 4856.9 4864.6 4910.4 4965.5 4895.9 4898.8 4901.3 4903.5 4920.0 4773.3 5020.0 5032.1 5044.0 5077.4 4767.2 4828.4 4877.3 4877.6 4916.2 04:40:33 INFO - 2015-12-16 04:40:33,495 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,495 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36616.29 Median:32078.20 stddev:54145.78 (168.8%) stddev-sans-first:54229.98 04:40:33 INFO - 2015-12-16 04:40:33,495 DEBUG : BROWSER_OUTPUT: Values: 557.1 563.6 569.7 573.6 576.6 33965.7 34743.8 34952.7 34983.3 35082.0 37821.1 37909.4 38155.8 38399.4 38400.2 7744.5 7895.2 7915.6 7919.2 7935.7 7826.5 7854.7 7913.2 7921.3 7921.5 7871.2 7944.7 7973.7 7980.5 7981.7 7883.1 7959.6 7961.8 7988.7 8006.4 7812.1 7916.3 7922.0 7951.4 7952.1 35788.8 35967.5 36480.0 36511.1 36567.5 3022.9 3040.2 3081.4 3356.9 3407.7 26995.0 27064.7 27424.2 27547.2 27682.3 2808.8 2849.1 2854.0 2906.6 2941.7 194721.0 195611.0 195710.0 196193.0 196441.0 50742.5 51402.7 51533.2 51645.2 51783.2 62252.0 62882.4 62950.4 62987.7 63190.0 14088.0 14316.4 14346.6 14384.4 14444.4 10762.4 10765.3 10801.8 10858.6 10905.1 18175.5 18288.5 18362.4 18386.5 18443.6 7446.9 7719.8 7733.9 7830.6 7864.5 809.0 810.2 847.8 943.9 1029.5 25599.5 26184.7 26237.5 26416.0 26425.3 908.1 949.2 970.8 997.5 1109.8 12335.4 12345.1 12345.9 12345.9 12367.6 251336.0 257097.0 257348.0 258766.0 259078.0 43008.0 43486.1 43488.0 43499.6 43672.8 1232.4 1240.2 1241.6 1251.6 1259.5 23537.3 25342.0 26199.7 26224.6 26397.6 36238.5 36582.6 36593.3 36593.5 36615.0 157125.0 159834.0 159835.0 160278.2 160967.0 26001.3 28371.9 28935.9 28945.4 28981.4 33320.5 33338.0 33376.5 34083.8 34141.3 30900.2 31368.8 31446.8 31848.7 31953.2 31234.7 31365.0 33669.0 35301.6 35960.0 31519.4 31623.1 31693.4 31958.2 32198.2 27726.2 28875.7 29106.3 29151.4 29204.7 23116.9 23164.9 23204.3 23461.2 23562.6 04:40:33 INFO - 2015-12-16 04:40:33,495 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,495 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25985.14 Median:4050.86 stddev:79726.15 (1968.1%) stddev-sans-first:79926.53 04:40:33 INFO - 2015-12-16 04:40:33,495 DEBUG : BROWSER_OUTPUT: Values: 329.6 334.9 336.8 337.6 338.6 14991.9 15392.1 15665.6 15877.0 16307.8 9973.3 10208.2 13561.9 14783.5 14818.0 4426.3 4545.0 4547.2 4630.3 4791.9 4916.4 4951.4 4951.5 4953.0 4965.3 3142.1 3232.3 4839.7 4977.1 5155.0 5098.9 5103.3 5114.8 5118.7 5128.5 4667.3 4814.4 4938.2 4939.7 4940.2 17613.1 17816.4 17846.4 18139.3 18434.1 1787.2 1825.8 1860.5 1873.0 1895.4 8721.6 8756.1 8793.6 8862.8 9215.3 1687.0 1761.4 1807.4 1813.6 1828.6 53688.0 55037.7 55999.7 56362.2 56737.4 9338.0 9580.2 9690.5 9752.6 9757.6 12276.3 12286.8 12346.9 12364.1 12365.3 7104.3 7122.2 7131.3 7181.0 7223.7 6830.3 6873.4 6880.4 6883.4 6913.9 4047.2 4054.5 4060.5 4078.3 4120.2 1658.6 1672.9 1681.2 1683.7 1742.0 365.7 366.6 368.8 782.7 880.3 9554.5 15111.5 15942.1 15964.8 16235.4 832.3 833.8 839.7 850.1 860.3 6485.4 8023.0 8229.5 8368.7 8899.9 478960.0 483603.7 490032.0 492485.0 494192.0 70881.3 71200.0 73083.6 73416.6 73892.0 1054.2 1074.7 1075.0 1085.5 1085.6 13773.3 14339.9 14373.9 14423.9 14530.4 29192.0 29256.6 32644.3 32734.2 34265.7 39386.4 39772.0 41045.6 41441.8 42722.6 8373.4 8711.3 8786.5 8791.8 8983.6 10164.1 10173.7 10187.6 12163.0 15943.6 12872.0 13081.9 13340.7 13572.3 13681.8 11776.4 13074.4 13246.1 13346.2 13419.9 13477.5 13809.2 13953.8 14136.6 14559.3 8834.3 8911.2 8937.0 8978.3 9147.5 12791.6 12976.4 13433.7 13837.6 14022.9 04:40:33 INFO - 2015-12-16 04:40:33,495 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,497 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5032.25 Median:6262.67 stddev:2642.72 (42.2%) stddev-sans-first:2635.70 04:40:33 INFO - 2015-12-16 04:40:33,497 DEBUG : BROWSER_OUTPUT: Values: 1356.6 1374.6 1425.3 1606.3 1610.3 5698.7 5953.4 7236.7 7416.4 7436.9 6986.5 7125.9 7205.4 7215.1 7248.2 2068.5 2096.2 2100.3 2103.2 2108.2 2044.3 2061.5 2078.5 2087.9 2089.0 2033.2 2047.3 2077.5 2080.0 2087.3 2006.8 2027.0 2036.8 2037.9 2039.6 2041.7 2062.2 2064.3 2087.8 2089.9 7168.9 7230.1 7256.3 7271.8 7280.4 4239.7 4303.4 4304.5 4306.0 4329.9 2655.5 2704.8 2726.7 2728.6 2736.8 819.9 832.0 835.2 842.5 851.6 9874.7 9955.2 9969.3 9990.2 10025.6 3832.7 3857.7 3924.2 3926.1 3939.3 8515.7 8522.2 8565.1 8580.0 8587.4 4326.5 4328.6 4338.9 4343.7 4349.6 3763.1 3863.8 3870.9 3911.8 3918.7 3134.8 3140.9 3151.5 3152.2 3207.7 905.0 910.3 927.6 929.9 936.8 949.4 989.7 1160.4 1161.5 1162.2 6851.0 6970.2 6971.6 7006.1 7018.6 1125.9 1140.2 1159.0 1159.8 1165.3 5002.1 5149.0 5150.2 5152.8 5156.3 8561.5 8627.3 8732.9 8827.0 8835.9 8592.0 8597.8 8631.2 8638.1 8692.7 6807.6 6848.6 6891.0 6891.3 6917.7 6588.7 6608.5 6630.6 6635.7 6640.8 7370.7 7592.1 7672.5 7798.3 7834.5 7845.5 7864.5 7885.9 8048.6 8064.7 5412.7 5491.8 6120.7 6144.7 6188.9 6796.9 6988.9 6999.5 7013.8 7021.2 6470.6 6551.1 6565.8 6778.6 6795.1 6267.3 6566.5 6586.3 6592.8 6661.3 6532.9 6582.2 6585.7 6618.6 6647.7 6054.8 6057.2 6071.8 6148.4 6186.2 6134.8 6213.3 6216.7 6251.7 6258.1 04:40:33 INFO - 2015-12-16 04:40:33,497 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,497 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4858.97 Median:5600.05 stddev:1452.40 (25.9%) stddev-sans-first:1415.62 04:40:33 INFO - 2015-12-16 04:40:33,498 DEBUG : BROWSER_OUTPUT: Values: 301.3 307.8 312.8 312.9 314.4 5502.9 5558.8 5574.5 5689.9 5754.1 5562.4 5625.6 5627.9 5636.4 5642.2 4164.5 4289.5 4294.9 4302.2 4303.1 4275.5 4283.8 4294.0 4296.5 4308.4 4246.7 4248.1 4249.9 4255.5 4257.4 4235.3 4239.4 4246.5 4248.9 4255.2 3695.9 3698.0 3708.7 3711.9 3717.5 5138.5 5319.3 5321.0 5325.4 5336.0 4821.0 4821.8 4826.0 4828.4 4831.9 5777.8 5809.8 5811.1 5827.0 5835.1 3959.4 3960.9 3967.4 3969.9 3973.0 5996.9 6166.8 6186.4 6194.2 6204.8 4104.6 4121.7 4123.8 4139.1 4139.8 4172.3 4173.7 4179.1 4194.8 4205.1 4855.9 4865.9 4876.5 4881.4 4890.7 5779.3 5892.8 5897.5 5900.8 5908.0 1451.6 1491.6 1491.6 1492.6 1492.6 976.8 981.0 982.5 1005.8 1008.1 5113.7 5113.8 5116.6 5120.4 5120.8 5980.5 6130.7 6131.6 6182.7 6189.6 5161.6 5167.1 5175.9 5184.7 5186.2 3258.9 3319.9 3326.4 3338.6 3344.6 5648.3 5788.8 5793.0 5793.8 5807.0 6353.6 6366.9 6371.2 6372.8 6378.6 5785.8 5798.2 5800.7 5804.9 5811.8 6012.7 6151.8 6152.9 6156.7 6161.5 5989.4 5996.9 6004.3 6009.9 6017.0 5767.5 5777.5 5792.9 5794.3 5806.4 4075.4 4086.9 4129.2 4131.0 4137.8 5917.8 6155.3 6165.7 6173.9 6174.9 5895.1 5903.9 5925.6 5931.2 5937.0 5818.2 5854.4 5860.1 5875.3 5890.0 5648.9 5742.3 5759.4 5779.7 5786.6 5911.4 5942.6 5952.8 5961.2 5965.3 5634.5 5732.5 5793.9 5796.7 5798.2 04:40:33 INFO - 2015-12-16 04:40:33,498 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-16 04:40:33,498 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12082.93 Median:43081.85 stddev:13459.50 (31.2%) stddev-sans-first:13470.44 04:40:33 INFO - 2015-12-16 04:40:33,499 DEBUG : BROWSER_OUTPUT: Values: 770.6 780.1 782.2 786.0 796.8 10699.0 11014.5 11016.9 11043.1 11047.3 11559.4 11636.7 11708.5 13323.7 13538.9 789.6 801.5 802.8 803.2 803.7 801.3 808.4 809.1 810.9 811.9 833.9 841.7 845.1 845.2 849.2 837.9 840.7 842.1 843.0 845.1 618.5 619.5 621.9 622.2 624.6 12175.6 12227.8 12344.4 12352.9 12366.6 10517.5 10874.9 11291.5 11293.4 11447.1 9316.1 9346.3 9356.9 9383.6 9423.3 3184.9 3251.7 3257.0 3319.6 3343.3 37133.8 38312.0 38380.2 38611.8 39111.6 9153.2 9196.3 9279.8 9284.9 9387.7 15728.4 15799.1 15864.3 15913.7 15954.3 6259.8 6302.5 6353.1 6360.5 6421.6 3516.5 3553.1 3564.8 3574.0 3607.3 2587.3 2614.3 2614.3 2618.2 2618.8 463.5 470.2 472.8 482.2 482.9 526.3 540.1 543.1 594.7 635.7 7752.1 7791.4 7951.9 8023.0 8122.7 464.3 477.1 512.1 562.4 595.9 3604.5 3641.5 3990.4 4033.0 4083.8 41320.8 41461.4 52730.5 52847.7 55015.0 43204.6 43320.4 43837.8 44218.6 44271.8 35388.8 35631.6 40614.2 42959.1 43295.4 7908.7 8068.4 8071.9 8223.9 8482.2 30311.0 31088.5 31105.5 31395.0 32037.4 36858.4 37388.4 38771.2 39073.6 39131.0 10136.4 10202.1 10211.8 10298.8 10408.9 11037.9 11072.6 11166.4 11305.5 11343.5 10688.4 10875.8 10953.8 11231.8 11251.5 10226.8 10331.7 10552.2 10698.9 10728.5 10164.4 10335.4 10580.6 10854.2 10862.7 9039.1 9192.7 9288.5 9295.7 9332.2 9179.6 9190.4 9314.9 9438.4 9455.6 04:40:33 INFO - 2015-12-16 04:40:33,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:40:33 INFO - 2015-12-16 04:40:33,499 DEBUG : BROWSER_OUTPUT: 04:40:34 INFO - 2015-12-16 04:40:34,103 INFO : Browser exited with error code: 0 04:40:34 INFO - 2015-12-16 04:40:34,123 INFO : Completed test dromaeo_css (00:18:35) 04:40:34 INFO - 2015-12-16 04:40:34,123 INFO : Starting test kraken 04:40:34 INFO - 2015-12-16 04:40:34,123 DEBUG : operating with platform_type : linux_ 04:40:34 INFO - 2015-12-16 04:40:34,123 INFO : Initialising browser for kraken test... 04:40:34 INFO - 2015-12-16 04:40:34,129 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp53_HR_/profile http://localhost:43513/getInfo.html 04:40:39 INFO - 2015-12-16 04:40:39,132 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:40:39 INFO - 2015-12-16 04:40:39,133 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:40:39 INFO - 2015-12-16 04:40:39,133 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:40:39 INFO - 2015-12-16 04:40:39,133 DEBUG : BROWSER_OUTPUT: __metrics 04:40:39 INFO - 2015-12-16 04:40:39,262 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:40:40 INFO - 2015-12-16 04:40:40,201 INFO : Browser initialized. 04:40:40 INFO - 2015-12-16 04:40:40,202 INFO : Running cycle 1/1 for kraken test... 04:40:40 INFO - 2015-12-16 04:40:40,202 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp53_HR_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:40:52 INFO - 2015-12-16 04:40:52,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 142725120 04:40:52 INFO - 2015-12-16 04:40:52,269 DEBUG : BROWSER_OUTPUT: 04:40:54 INFO - 2015-12-16 04:40:54,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43513/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:55 INFO - 2015-12-16 04:40:55,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 143388672 04:40:55 INFO - 2015-12-16 04:40:55,452 DEBUG : BROWSER_OUTPUT: 04:40:58 INFO - 2015-12-16 04:40:58,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43513/tests/kraken/driver.html?testName=audio-dft) 04:40:58 INFO - 2015-12-16 04:40:58,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 142831616 04:40:58 INFO - 2015-12-16 04:40:58,803 DEBUG : BROWSER_OUTPUT: 04:41:01 INFO - 2015-12-16 04:41:01,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43513/tests/kraken/driver.html?testName=audio-fft) 04:41:02 INFO - 2015-12-16 04:41:02,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 137924608 04:41:02 INFO - 2015-12-16 04:41:02,293 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-16 04:41:04,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43513/tests/kraken/driver.html?testName=audio-oscillator) 04:41:04 INFO - 2015-12-16 04:41:04,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 138928128 04:41:04 INFO - 2015-12-16 04:41:04,890 DEBUG : BROWSER_OUTPUT: 04:41:07 INFO - 2015-12-16 04:41:07,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43513/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:07 INFO - 2015-12-16 04:41:07,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 139755520 04:41:07 INFO - 2015-12-16 04:41:07,763 DEBUG : BROWSER_OUTPUT: 04:41:10 INFO - 2015-12-16 04:41:10,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43513/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:11 INFO - 2015-12-16 04:41:11,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 141156352 04:41:11 INFO - 2015-12-16 04:41:11,388 DEBUG : BROWSER_OUTPUT: 04:41:14 INFO - 2015-12-16 04:41:14,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43513/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:15 INFO - 2015-12-16 04:41:15,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 138645504 04:41:15 INFO - 2015-12-16 04:41:15,465 DEBUG : BROWSER_OUTPUT: 04:41:18 INFO - 2015-12-16 04:41:18,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43513/tests/kraken/driver.html?testName=json-parse-financial) 04:41:18 INFO - 2015-12-16 04:41:18,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 139329536 04:41:18 INFO - 2015-12-16 04:41:18,963 DEBUG : BROWSER_OUTPUT: 04:41:20 INFO - 2015-12-16 04:41:20,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43513/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:21 INFO - 2015-12-16 04:41:21,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 140599296 04:41:21 INFO - 2015-12-16 04:41:21,318 DEBUG : BROWSER_OUTPUT: 04:41:23 INFO - 2015-12-16 04:41:23,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43513/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:23 INFO - 2015-12-16 04:41:23,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 139395072 04:41:23 INFO - 2015-12-16 04:41:23,856 DEBUG : BROWSER_OUTPUT: 04:41:25 INFO - 2015-12-16 04:41:25,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43513/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:26 INFO - 2015-12-16 04:41:26,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 139816960 04:41:26 INFO - 2015-12-16 04:41:26,581 DEBUG : BROWSER_OUTPUT: 04:41:29 INFO - 2015-12-16 04:41:29,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:29 INFO - 2015-12-16 04:41:29,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 140468224 04:41:29 INFO - 2015-12-16 04:41:29,754 DEBUG : BROWSER_OUTPUT: 04:41:32 INFO - 2015-12-16 04:41:32,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:32 INFO - 2015-12-16 04:41:32,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 140926976 04:41:32 INFO - 2015-12-16 04:41:32,979 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43513/tests/kraken/driver.html?testName=ai-astar) 04:41:34 INFO - 2015-12-16 04:41:34,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 141242368 04:41:34 INFO - 2015-12-16 04:41:34,974 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,974 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:41:34 INFO - 2015-12-16 04:41:34,974 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:41:34 INFO - 2015-12-16 04:41:34,975 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:41:34 INFO - 2015-12-16 04:41:34,975 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:41:34 INFO - 2015-12-16 04:41:34,975 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;113;113;114;127;113;114;112;113 04:41:34 INFO - 2015-12-16 04:41:34,975 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;128;158;167;132;158;163;139;176;142 04:41:34 INFO - 2015-12-16 04:41:34,975 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;164;163;163;165;164;162;163;162 04:41:34 INFO - 2015-12-16 04:41:34,976 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;71;72;72;123;73;78;72;72 04:41:34 INFO - 2015-12-16 04:41:34,976 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;131;95;95;94;135;104;95;137 04:41:34 INFO - 2015-12-16 04:41:34,976 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;111;110;110;109;109;110 04:41:34 INFO - 2015-12-16 04:41:34,976 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;149;147;148;148;147;148;150 04:41:34 INFO - 2015-12-16 04:41:34,976 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;95;95;95;96;96;100;96;96 04:41:34 INFO - 2015-12-16 04:41:34,977 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;76;73;74;73;73;73;72;71 04:41:34 INFO - 2015-12-16 04:41:34,977 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;67;68;69;68;68;68;68;72;68 04:41:34 INFO - 2015-12-16 04:41:34,977 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;86;88;85;86;85;85;86;87 04:41:34 INFO - 2015-12-16 04:41:34,977 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;124;124;129;129;126;126;122;130;138 04:41:34 INFO - 2015-12-16 04:41:34,977 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;155;148;137;151;154;157;155;153;136 04:41:34 INFO - 2015-12-16 04:41:34,978 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;72;71;70;68;69;75;69;69 04:41:34 INFO - 2015-12-16 04:41:34,978 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:41:34 INFO - 2015-12-16 04:41:34,978 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:41:34 INFO - 2015-12-16 04:41:34,978 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,800 04:41:34 INFO - 2015-12-16 04:41:34,978 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:41:34 INFO - 2015-12-16 04:41:34,979 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269694969__endTimestamp 04:41:34 INFO - 2015-12-16 04:41:34,979 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,980 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:41:34 INFO - 2015-12-16 04:41:34,980 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:41:34 INFO - 2015-12-16 04:41:34,981 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,981 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.10 Median:113.50 stddev:5.02 (4.4%) stddev-sans-first:5.32 04:41:34 INFO - 2015-12-16 04:41:34,981 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 113.0 113.0 114.0 127.0 113.0 114.0 112.0 113.0 04:41:34 INFO - 2015-12-16 04:41:34,981 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,981 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.80 Median:158.00 stddev:15.80 (10.0%) stddev-sans-first:16.72 04:41:34 INFO - 2015-12-16 04:41:34,981 DEBUG : BROWSER_OUTPUT: Values: 155.0 128.0 158.0 167.0 132.0 158.0 163.0 139.0 176.0 142.0 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 164.0 163.0 163.0 165.0 164.0 162.0 163.0 162.0 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.10 Median:72.50 stddev:15.90 (21.9%) stddev-sans-first:16.79 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 71.0 72.0 72.0 123.0 73.0 78.0 72.0 72.0 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.50 Median:94.50 stddev:18.80 (19.9%) stddev-sans-first:19.29 04:41:34 INFO - 2015-12-16 04:41:34,982 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 131.0 95.0 95.0 94.0 135.0 104.0 95.0 137.0 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 111.0 110.0 110.0 109.0 109.0 110.0 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 149.0 147.0 148.0 148.0 147.0 148.0 150.0 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.48 (1.5%) stddev-sans-first:1.56 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 95.0 95.0 95.0 96.0 96.0 100.0 96.0 96.0 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.00 stddev:1.29 (1.8%) stddev-sans-first:1.36 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 76.0 73.0 74.0 73.0 73.0 73.0 72.0 71.0 04:41:34 INFO - 2015-12-16 04:41:34,983 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,984 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.42 04:41:34 INFO - 2015-12-16 04:41:34,984 DEBUG : BROWSER_OUTPUT: Values: 70.0 67.0 68.0 69.0 68.0 68.0 68.0 68.0 72.0 68.0 04:41:34 INFO - 2015-12-16 04:41:34,984 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,984 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.05 04:41:34 INFO - 2015-12-16 04:41:34,984 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 86.0 88.0 85.0 86.0 85.0 85.0 86.0 87.0 04:41:34 INFO - 2015-12-16 04:41:34,984 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,985 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:127.50 stddev:4.81 (3.8%) stddev-sans-first:4.75 04:41:34 INFO - 2015-12-16 04:41:34,985 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 124.0 129.0 129.0 126.0 126.0 122.0 130.0 138.0 04:41:34 INFO - 2015-12-16 04:41:34,985 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,985 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:153.50 stddev:7.87 (5.1%) stddev-sans-first:7.84 04:41:34 INFO - 2015-12-16 04:41:34,985 DEBUG : BROWSER_OUTPUT: Values: 141.0 155.0 148.0 137.0 151.0 154.0 157.0 155.0 153.0 136.0 04:41:34 INFO - 2015-12-16 04:41:34,985 DEBUG : BROWSER_OUTPUT: 04:41:34 INFO - 2015-12-16 04:41:34,986 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.01 (2.9%) stddev-sans-first:2.12 04:41:34 INFO - 2015-12-16 04:41:34,986 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 72.0 71.0 70.0 68.0 69.0 75.0 69.0 69.0 04:41:34 INFO - 2015-12-16 04:41:34,986 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:41:34 INFO - 2015-12-16 04:41:34,986 DEBUG : BROWSER_OUTPUT: 04:41:35 INFO - 2015-12-16 04:41:35,909 INFO : Browser exited with error code: 0 04:41:35 INFO - 2015-12-16 04:41:35,965 INFO : Completed test kraken (00:01:01) 04:41:35 INFO - 2015-12-16 04:41:35,965 INFO : Starting test v8_7 04:41:35 INFO - 2015-12-16 04:41:35,965 DEBUG : operating with platform_type : linux_ 04:41:35 INFO - 2015-12-16 04:41:35,965 INFO : Initialising browser for v8_7 test... 04:41:35 INFO - 2015-12-16 04:41:35,971 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmhlxGG/profile http://localhost:43513/getInfo.html 04:41:40 INFO - 2015-12-16 04:41:40,873 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:41:40 INFO - 2015-12-16 04:41:40,874 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:41:40 INFO - 2015-12-16 04:41:40,874 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:41:40 INFO - 2015-12-16 04:41:40,874 DEBUG : BROWSER_OUTPUT: __metrics 04:41:40 INFO - 2015-12-16 04:41:40,978 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:41:41 INFO - 2015-12-16 04:41:41,922 INFO : Browser initialized. 04:41:41 INFO - 2015-12-16 04:41:41,922 INFO : Running cycle 1/1 for v8_7 test... 04:41:41 INFO - 2015-12-16 04:41:41,923 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmhlxGG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:41:53 INFO - 2015-12-16 04:41:53,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 142618624 04:41:53 INFO - 2015-12-16 04:41:53,970 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43513/tests/v8_7/run.html (next: http://localhost:43513/tests/v8_7/run.html) 04:42:15 INFO - 2015-12-16 04:42:15,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 137289728 04:42:15 INFO - 2015-12-16 04:42:15,642 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,642 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:42:15 INFO - 2015-12-16 04:42:15,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:42:15 INFO - 2015-12-16 04:42:15,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:42:15 INFO - 2015-12-16 04:42:15,642 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:42:15 INFO - 2015-12-16 04:42:15,642 DEBUG : BROWSER_OUTPUT: |0;Richards;168.54879487611663 04:42:15 INFO - 2015-12-16 04:42:15,642 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.71779141104295 04:42:15 INFO - 2015-12-16 04:42:15,643 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 04:42:15 INFO - 2015-12-16 04:42:15,643 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 04:42:15 INFO - 2015-12-16 04:42:15,643 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1086.9565217391305 04:42:15 INFO - 2015-12-16 04:42:15,643 DEBUG : BROWSER_OUTPUT: |5;Earley;696.5901183020181 04:42:15 INFO - 2015-12-16 04:42:15,643 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 04:42:15 INFO - 2015-12-16 04:42:15,643 DEBUG : BROWSER_OUTPUT: |7;RegExp;28250 04:42:15 INFO - 2015-12-16 04:42:15,643 DEBUG : BROWSER_OUTPUT: |8;Splay;602.0469596628537 04:42:15 INFO - 2015-12-16 04:42:15,643 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:42:15 INFO - 2015-12-16 04:42:15,644 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:42:15 INFO - 2015-12-16 04:42:15,644 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269735635__endTimestamp 04:42:15 INFO - 2015-12-16 04:42:15,644 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,644 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:42:15 INFO - 2015-12-16 04:42:15,644 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:42:15 INFO - 2015-12-16 04:42:15,644 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,644 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.55 Median:168.55 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,645 DEBUG : BROWSER_OUTPUT: Values: 168.5 04:42:15 INFO - 2015-12-16 04:42:15,645 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,645 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.72 Median:191.72 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,645 DEBUG : BROWSER_OUTPUT: Values: 191.7 04:42:15 INFO - 2015-12-16 04:42:15,645 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,645 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,645 DEBUG : BROWSER_OUTPUT: Values: 278.1 04:42:15 INFO - 2015-12-16 04:42:15,646 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,646 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,646 DEBUG : BROWSER_OUTPUT: Values: 5196.9 04:42:15 INFO - 2015-12-16 04:42:15,646 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,646 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,646 DEBUG : BROWSER_OUTPUT: Values: 1087.0 04:42:15 INFO - 2015-12-16 04:42:15,646 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,646 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:696.59 Median:696.59 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,647 DEBUG : BROWSER_OUTPUT: Values: 696.6 04:42:15 INFO - 2015-12-16 04:42:15,647 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,647 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,647 DEBUG : BROWSER_OUTPUT: Values: 12120.5 04:42:15 INFO - 2015-12-16 04:42:15,647 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,647 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28250.00 Median:28250.00 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,647 DEBUG : BROWSER_OUTPUT: Values: 28250.0 04:42:15 INFO - 2015-12-16 04:42:15,648 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,648 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.05 Median:602.05 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,648 DEBUG : BROWSER_OUTPUT: Values: 602.0 04:42:15 INFO - 2015-12-16 04:42:15,648 DEBUG : BROWSER_OUTPUT: 04:42:15 INFO - 2015-12-16 04:42:15,648 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:42:15 INFO - 2015-12-16 04:42:15,648 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:42:15 INFO - 2015-12-16 04:42:15,648 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:42:15 INFO - 2015-12-16 04:42:15,648 DEBUG : BROWSER_OUTPUT: 04:42:16 INFO - 2015-12-16 04:42:16,558 INFO : Browser exited with error code: 0 04:42:16 INFO - 2015-12-16 04:42:16,574 INFO : Completed test v8_7 (00:00:40) 04:42:16 INFO - 2015-12-16 04:42:16,653 INFO : Completed test suite (00:20:17) 04:42:16 INFO - 2015-12-16 04:42:16,653 DEBUG : Working with test: dromaeo_css 04:42:16 INFO - 2015-12-16 04:42:16,653 DEBUG : Generating results file: dromaeo_css 04:42:16 INFO - 2015-12-16 04:42:16,654 DEBUG : Working with test: kraken 04:42:16 INFO - 2015-12-16 04:42:16,655 DEBUG : Generating results file: kraken 04:42:16 INFO - 2015-12-16 04:42:16,655 INFO : javascript benchmark 04:42:16 INFO - 2015-12-16 04:42:16,655 DEBUG : Working with test: v8_7 04:42:16 INFO - 2015-12-16 04:42:16,655 DEBUG : Generating results file: v8_7 04:42:16 INFO - 2015-12-16 04:42:16,656 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:42:16 INFO - 2015-12-16 04:42:16,711 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:42:16 INFO - 2015-12-16 04:42:16,711 DEBUG : process_Request line: dromaeo_css 6288.35 graph.html#tests=[[72,94,43]] 04:42:16 INFO - 2015-12-16 04:42:16,711 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:42:16 INFO - 2015-12-16 04:42:16,748 DEBUG : process_Request line: kraken 1541.90 graph.html#tests=[[232,94,43]] 04:42:16 INFO - 2015-12-16 04:42:16,748 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:42:16 INFO - 2015-12-16 04:42:16,783 DEBUG : process_Request line: v8_7 21130.35 graph.html#tests=[[230,94,43]] 04:42:16 INFO - 2015-12-16 04:42:16,784 INFO : javascript benchmark 04:42:16 INFO - 2015-12-16 04:42:16,788 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2659.8005149613778, 2712.1863440967704, 2738.671359436868, 2741.2598598378427, 2763.1434255380827, 4649.51180126087, 4729.4797572267025, 4742.834000809968, 4770.403699537558, 4786.3059856320815, 4645.721256724591, 4712.929306060412, 4720.339152518642, 4724.3622111015, 4741.573258406743, 4431.93352099718, 4483.5516448355065, 4532.886677833064, 4548.454185497745, 4577.198990176722, 4338.978305108486, 4349.064951035542, 4358.8910277243, 4408.272635015219, 4443.155800397914, 4251.107267473803, 4264.445622069111, 4383.517813040563, 4386.692931494765, 4388.978055109736, 4377.802998865027, 4380.189664912002, 4404.779761011969, 4407.316865885793, 4434.268345722952, 4392.1874453226255, 4394.6923715339935, 4406.6694997874965, 4431.0, 4443.866683999485, 4466.932996005063, 4516.36770852081, 4546.408966834323, 4555.316702494619, 4578.061497393026, 5126.231065340229, 5133.845984620468, 5141.974290128563, 5142.382914050338, 5151.356080489939, 5170.586353091781, 5246.554042906358, 5256.842294731164, 5261.0, 5271.499207575274, 4620.953790462119, 4691.39011928454, 4712.787924543404, 4726.432828060655, 4847.297141914438, 5286.418493965661, 5320.228566857784, 5321.86695332612, 5323.0, 5336.973315133477, 5082.085224659523, 5086.745662716849, 5094.898102037939, 5107.157319042391, 5147.047796157723, 4947.752612369367, 4978.626603004789, 5011.7494125294315, 5049.8737531562, 5175.223716442564, 5017.67385119966, 5030.471800460972, 5046.873828154252, 5061.44324124346, 5090.312807770903, 4954.380702412199, 5008.098542262355, 5009.89980200394, 5012.398512178562, 5017.657664817269, 4034.616711412411, 4122.855700050483, 4131.5455299916985, 4194.790260486963, 4226.302660061056, 3751.981240093782, 3754.9436758448646, 3760.9247815043545, 3776.5656949451163, 3800.8859734208017, 4202.789860506962, 4464.732116073046, 4479.708818926824, 4480.081583275421, 4503.211937910853, 4967.453580106186, 5122.436531981479, 5152.6650767699975, 5157.819476318311, 5201.3238279024245, 4390.824367025347, 4400.427944367212, 4417.734935903856, 4423.093265880487, 4440.511543730187, 4377.058932329564, 4485.820567177341, 4492.483364413134, 4506.481754598263, 4533.025399539115, 4801.5438533339275, 4861.927071093865, 4871.098846713369, 4900.705957642553, 4921.089598424232, 5164.509371609691, 5170.586353091669, 5172.250023746611, 5177.844664660066, 5222.503862133091, 4586.839460618862, 4691.249400095969, 4754.5245475452175, 4862.708237505761, 4930.334404855299, 4927.162382394929, 4963.726995015164, 4994.2508623706735, 4997.950020499894, 5034.748262586929, 5077.289179514797, 5166.689998600096, 5167.095758242368, 5171.431142574239, 5208.635395522277, 4833.854984350475, 4963.404391473046, 4989.575886049726, 4992.750362481934, 4997.525235102659, 4843.903121937612, 4856.8785780354365, 4864.562189402971, 4910.410750709938, 4965.47862474435, 4895.919234325469, 4898.779554919965, 4901.264810278487, 4903.460619331942, 4919.9754001231195, 4773.331733557374, 5020.0461912238015, 5032.144535428913, 5044.0, 5077.416097148875, 4767.189577771718, 4828.420589529279, 4877.341558889504, 4877.634177436636, 4916.188828843344], "unit": "score", "name": "dojo.html", "value": 4673.092381548443}, {"lowerIsBetter": false, "replicates": [557.1253132581845, 563.5942121672396, 569.7151424287856, 573.6185436684605, 576.5560518400831, 33965.66034339656, 34743.82628086859, 34952.650473495254, 34983.300333993306, 35082.0, 37821.05447363817, 37909.43135852965, 38155.80922095386, 38399.42400863989, 38400.231995360075, 7744.45788794786, 7895.171007044264, 7915.564643944581, 7919.247671471201, 7935.682572697086, 7826.530408175499, 7854.7250846220395, 7913.169117242693, 7921.287084162424, 7921.485103468285, 7871.173526779691, 7944.721934732285, 7973.681052757912, 7980.481268717544, 7981.720639777609, 7883.054033515958, 7959.602019899011, 7961.840763184704, 7988.680452781882, 8006.359491240745, 7812.062552493737, 7916.327112195413, 7921.96039019807, 7951.403644726669, 7952.125266220711, 35788.82105589481, 35967.4604880927, 36480.0, 36511.08722281938, 36567.4514882277, 3022.8941987030566, 3040.1639549123947, 3081.3529158876663, 3356.8992930212135, 3407.727381809449, 26995.0, 27064.729352706418, 27424.17727468179, 27547.173584792487, 27682.307942301402, 2808.8314701117997, 2849.1167738001286, 2853.985730071357, 2906.6221391219005, 2941.7205365490245, 194721.02639486853, 195611.0, 195710.0, 196193.0, 196441.0, 50742.49257507452, 51402.74298628483, 51533.16567588744, 51645.22532162021, 51783.22325165125, 62252.0, 62882.371176288565, 62950.370496294454, 62987.685061575314, 63190.0, 14088.0, 14316.427342906376, 14346.56960291193, 14384.424623014962, 14444.422223110958, 10762.40806755636, 10765.300255483526, 10801.783964320826, 10858.565657373616, 10905.073068789083, 18175.45473635793, 18288.542786430447, 18362.357317493825, 18386.540336491427, 18443.631127377645, 7446.888296675555, 7719.768406947801, 7733.883991740128, 7830.569318687527, 7864.528128312205, 808.9797755056171, 810.2383759266271, 847.7703639428264, 943.9150476457014, 1029.5109822834095, 25599.488010240064, 26184.73815261823, 26237.475250495267, 26416.0, 26425.339366515607, 908.0783005249676, 949.240607513986, 970.7961328121173, 997.5162046407487, 1109.7669489407153, 12335.383230838423, 12345.074119441078, 12345.876541234653, 12345.93827030859, 12367.567135150226, 251336.0, 257097.0, 257348.0, 258766.0, 259078.0, 43008.0, 43486.13027739491, 43488.0, 43499.56500435018, 43672.78163609162, 1232.4101908537887, 1240.231056744806, 1241.6150993192139, 1251.5932321995388, 1259.5339724302066, 23537.293881183592, 25342.0, 26199.73800261973, 26224.60663090017, 26397.60403593986, 36238.45642315315, 36582.63417365792, 36593.26813463662, 36593.45109823408, 36615.0, 157125.0, 159834.0, 159835.0, 160278.1986090062, 160967.0, 26001.349966250997, 28371.858140709166, 28935.855320724102, 28945.421091577628, 28981.42037159287, 33320.50019249762, 33338.0, 33376.49935250924, 34083.82958085194, 34141.317173655894, 30900.22749431282, 31368.843155784074, 31446.842765786023, 31848.6815131855, 31953.201169970936, 31234.68765312409, 31365.0, 33669.0, 35301.646983529834, 35960.0, 31519.36961260808, 31623.051308460785, 31693.36613267768, 31958.201044974063, 32198.19504512406, 27726.168214953585, 28875.7112428873, 29106.27234319159, 29151.416971660874, 29204.7079529202, 23116.884415578486, 23164.884175579013, 23204.3038708839, 23461.178858739862, 23562.646560301953], "unit": "score", "name": "ext.html", "value": 16227.775006058993}, {"lowerIsBetter": false, "replicates": [329.56991126579817, 334.86605357856854, 336.8080194289253, 337.6050021474874, 338.61905356473966, 14991.850081499182, 15392.076475411483, 15665.608359790982, 15877.0, 16307.776916731233, 9973.301868869183, 10208.234382421311, 13561.93219033906, 14783.482578109768, 14818.036827606198, 4426.269665505188, 4545.0, 4547.24970379887, 4630.259158534635, 4791.856244312677, 4916.434610019858, 4951.3810773653295, 4951.455339912607, 4952.950470495303, 4965.28003439501, 3142.120206342228, 3232.3212125453565, 4839.7338146401935, 4977.0792403405485, 5155.020546096249, 5098.898022039557, 5103.260027296058, 5114.795408183668, 5118.667286626357, 5128.461511541291, 4667.323238130486, 4814.374131362901, 4938.185199442088, 4939.703617782944, 4940.184869496528, 17613.119344032875, 17816.376426824998, 17846.375376861877, 18139.274429022957, 18434.078296085143, 1787.1600347836495, 1825.771778527684, 1860.4604664647236, 1872.9906350468298, 1895.4218963216213, 8721.563921803885, 8756.124387561256, 8793.648254069829, 8862.778430539289, 9215.308851836073, 1687.0481121128323, 1761.4363403710818, 1807.3764551229804, 1813.637272545483, 1828.6342731453763, 53688.0, 55037.72481137609, 55999.720001399735, 56362.154567681515, 56737.43262567404, 9338.0, 9580.233581313478, 9690.46702431359, 9752.609895604097, 9757.609695612096, 12276.263424194576, 12286.815697764541, 12346.938265308796, 12364.134510584352, 12365.258084514779, 7104.289571042855, 7122.216556178816, 7131.251218622074, 7181.030560874216, 7223.674934627954, 6830.31696830313, 6873.4157596603845, 6880.449564034865, 6883.449324054063, 6913.89629155563, 4047.1905618876344, 4054.533728621246, 4060.5330387005283, 4078.3066878630702, 4120.196561670446, 1658.5604814724109, 1672.916354182286, 1681.1678219281534, 1683.6632673465356, 1741.9651606967789, 365.65628309389086, 366.58209641009273, 368.77688998156265, 782.6595430987538, 880.300161371711, 9554.522273886278, 15111.47109851172, 15942.123183224801, 15964.76052859208, 16235.431759888348, 832.3258160889699, 833.8248967716726, 839.6809212499211, 850.1243718969471, 860.3418384935529, 6485.416312531895, 8022.9598852005365, 8229.46508476959, 8368.665253389918, 8899.866502002475, 478960.0, 483603.6558537619, 490032.0, 492485.0, 494192.0, 70881.2911870885, 71200.0, 73083.63458182782, 73416.63291683508, 73892.0, 1054.2093429927554, 1074.7420619051527, 1074.957001719938, 1085.5060947268973, 1085.6037546295545, 13773.311334433038, 14339.856601433852, 14373.928130359282, 14423.855761442252, 14530.418783248551, 29192.0, 29256.56115158317, 32644.34711305713, 32734.181645459055, 34265.65734342625, 39386.40920386139, 39772.0, 41045.58954410418, 41441.79279103585, 42722.57277427186, 8373.413861029669, 8711.303095752452, 8786.472811631322, 8791.780205494913, 8983.550822458981, 10164.085232329126, 10173.694789156338, 10187.643432480125, 12163.0, 15943.601409964844, 12872.0, 13081.869181308446, 13340.733185336432, 13572.253526055767, 13681.79477307861, 11776.411179441166, 13074.411651475897, 13246.07277490605, 13346.19922804635, 13419.932900335436, 13477.460901563827, 13809.24049177305, 13953.790693139814, 14136.575902722934, 14559.344829482487, 8834.337424693045, 8911.197992180734, 8936.955315223382, 8978.326625502983, 9147.496887670975, 12791.552295669608, 12976.35118244065, 13433.731325373634, 13837.584872453843, 14022.929885350508], "unit": "score", "name": "jquery.html", "value": 7907.4786529034445}, {"lowerIsBetter": false, "replicates": [1356.6269275949112, 1374.5670113914116, 1425.3158483927714, 1606.269147537871, 1610.2914717524282, 5698.715064246791, 5953.404659534044, 7236.746713865015, 7416.406687465003, 7436.888446673291, 6986.476014298935, 7125.85748285034, 7205.387542058931, 7215.062041934541, 7248.2389349118375, 2068.5449201175716, 2096.1929657081982, 2100.306898723418, 2103.169248146981, 2108.2410332280365, 2044.2947183221765, 2061.505238742706, 2078.5219399538114, 2087.9164833406644, 2088.9686654700117, 2033.2070492507933, 2047.2936836791282, 2077.542940553076, 2079.9584008319825, 2087.342487116561, 2006.799320067989, 2027.006766684314, 2036.7555893292827, 2037.898105094754, 2039.6226698060907, 2041.652919003773, 2062.1957436599737, 2064.349729835112, 2087.759907610629, 2089.895505224748, 7168.856622867514, 7230.096237970254, 7256.274372562754, 7271.781846544613, 7280.417566594712, 4239.745615263063, 4303.397524346594, 4304.4834619845815, 4305.97847010763, 4329.935050974238, 2655.495455863399, 2704.8377097374023, 2726.6864310604337, 2728.6452761140927, 2736.781057515394, 819.8811172379972, 832.0015980823036, 835.1564919431357, 842.4987132656059, 851.5529347092764, 9874.703758887174, 9955.153811925995, 9969.302148849583, 9990.200783937267, 10025.649102281459, 3832.7317087803585, 3857.691384689218, 3924.156306394139, 3926.1362500249897, 3939.3106206413763, 8515.74452766418, 8522.232999030117, 8565.057843637194, 8580.01329847063, 8587.441816281922, 4326.480822301344, 4328.632066274402, 4338.869833904988, 4343.739375637472, 4349.586789255016, 3763.096856754414, 3863.8068096595057, 3870.8838734838, 3911.8435262589746, 3918.7060970427333, 3134.8119112852846, 3140.905772826819, 3151.4642510773224, 3152.2277042124824, 3207.743380529552, 905.0451773379148, 910.267234875918, 927.5640448988964, 929.920956718673, 936.840737074699, 949.378157306965, 989.6882482018285, 1160.3560024186488, 1161.4947497838468, 1162.1980833225048, 6851.0, 6970.163580370388, 6971.581705097609, 7006.054182685374, 7018.5788852669, 1125.9324440533594, 1140.1505878120688, 1158.988410115888, 1159.750653609478, 1165.2833507393061, 5002.09962206799, 5149.0474262261605, 5150.150225212873, 5152.793888244503, 5156.329677141947, 8561.486310821247, 8627.266682332072, 8732.8690069649, 8826.955865220632, 8835.911640883638, 8592.0, 8597.785055373666, 8631.223189912938, 8638.09300023501, 8692.695755648521, 6807.5575087619145, 6848.623325717033, 6891.000804883364, 6891.310868913069, 6917.7232910684015, 6588.7364505421165, 6608.504362172953, 6630.569013014138, 6635.701393437404, 6640.800775976729, 7370.6683199255085, 7592.126905405949, 7672.462927595015, 7798.323360477524, 7834.529928204326, 7845.490043147177, 7864.5281283123195, 7885.881711774443, 8048.637811298388, 8064.677412903418, 5412.675239485643, 5491.752871120889, 6120.693965301806, 6144.662043587646, 6188.907166392598, 6796.93203067963, 6988.860222795617, 6999.475039371966, 7013.824654383681, 7021.192562855337, 6470.579412338183, 6551.115599394211, 6565.835854103686, 6778.593284402951, 6795.116634837439, 6267.2792628848265, 6566.507511936719, 6586.341365863567, 6592.80221593353, 6661.267260601427, 6532.869342613216, 6582.243042050225, 6585.736570537317, 6618.569792963442, 6647.667616619053, 6054.8183554493435, 6057.212562366864, 6071.817845464643, 6148.415900489446, 6186.19579454668, 6134.754609815557, 6213.254409470893, 6216.720247588779, 6251.749930002931, 6258.061290806416], "unit": "score", "name": "mootools.html", "value": 4110.635424792287}, {"lowerIsBetter": false, "replicates": [301.3100000997715, 307.79993004547043, 312.7669885934978, 312.89361617050196, 314.41989529318397, 5502.917456238155, 5558.833235002957, 5574.498295153436, 5689.886202275952, 5754.136879468082, 5562.415946325638, 5625.606207565462, 5627.887442251153, 5636.379998200195, 5642.15367694846, 4164.500259968793, 4289.528151903288, 4294.892627684301, 4302.182585308781, 4303.074838909633, 4275.5296917339065, 4283.828646854122, 4293.957060429402, 4296.505901821283, 4308.418363520932, 4246.68149888758, 4248.107897341562, 4249.915001699964, 4255.510616279121, 4257.425247591582, 4235.25882970479, 4239.427677263591, 4246.4691913510815, 4248.851290204859, 4255.234057869582, 3695.9445608315896, 3697.9830546599633, 3708.6662200401825, 3711.851525938959, 3717.498137751396, 5138.460461651547, 5319.281896943901, 5320.973395133038, 5325.440828713007, 5336.0, 4821.0, 4821.807127714922, 4826.0, 4828.420589529243, 4831.9033619327765, 5777.826665200051, 5809.796657116981, 5811.128330750379, 5827.009408400582, 5835.066389377722, 3959.4060890866313, 3960.920781584352, 3967.4247234151176, 3969.920601587952, 3972.980135099335, 5996.8500787480225, 6166.784162554334, 6186.412290832363, 6194.194754681863, 6204.81385558434, 4104.630583247522, 4121.660460350398, 4123.814428350672, 4139.110091330378, 4139.793010349531, 4172.331067572934, 4173.6661067114555, 4179.080602267496, 4194.8112334945, 4205.11692544563, 4855.854324370274, 4865.927011094836, 4876.4879687633, 4881.389826271716, 4890.706557606555, 5779.33537643168, 5892.793752218738, 5897.469227769521, 5900.76396944126, 5907.9704601476715, 1451.5500194939602, 1491.5749011531661, 1491.61963699256, 1492.6119209005738, 1492.634304595381, 976.8034158156344, 980.9901900980899, 982.5185659027168, 1005.8440941654055, 1008.0977525115128, 5113.744312784346, 5113.795448182105, 5116.616253780981, 5120.385553733501, 5120.769565369567, 5980.491658209101, 6130.693465326805, 6131.601445906002, 6182.721777520022, 6189.6286222826775, 5161.587073034223, 5167.121589329748, 5175.922361164586, 5184.662996905189, 5186.170212765939, 3258.853351599184, 3319.93360132796, 3326.367990081925, 3338.599368075798, 3344.6153692325693, 5648.265725455664, 5788.82633520995, 5792.9710351447975, 5793.768249269982, 5807.01280782268, 6353.649149814598, 6366.872662546816, 6371.171747672773, 6372.808815735535, 6378.608021991753, 5785.82642520725, 5798.159266906275, 5800.651960882361, 5804.912926306109, 5811.767529298865, 6012.6993650316435, 6151.815445536641, 6152.938470615237, 6156.722947467285, 6161.537884658579, 5989.431004054608, 5996.910046349221, 6004.279486461478, 6009.909851352146, 6017.0, 5767.452092051249, 5777.537796976316, 5792.855178620568, 5794.275715535558, 5806.390329015392, 4075.3886916961505, 4086.8569600063856, 4129.236091323115, 4131.049858532494, 4137.81379837902, 5917.792877249276, 6155.322914479314, 6165.660888651168, 6173.876522469615, 6174.876502469836, 5895.086261629454, 5903.940960590339, 5925.585209035326, 5931.199288096224, 5936.970315148396, 5818.185454036354, 5854.356020837789, 5860.062390017747, 5875.3243377012195, 5889.970550147394, 5648.887022259614, 5742.339630942495, 5759.424057594207, 5779.711014449176, 5786.566007549535, 5911.438413350725, 5942.554308426972, 5952.76188952437, 5961.225040744675, 5965.28416590012, 5634.549236061187, 5732.455416735404, 5793.9420605795085, 5796.652200867961, 5798.246227990503], "unit": "score", "name": "prototype.html", "value": 4387.933763672606}, {"lowerIsBetter": false, "replicates": [770.5915864591765, 780.0911937592705, 782.2451334462243, 785.9724909628164, 796.8286818334057, 10699.0, 11014.50434730437, 11016.944915275433, 11043.061339786107, 11047.33715977041, 11559.422028898563, 11636.650900472978, 11708.473118709657, 13323.733525329488, 13538.93230533846, 789.5894135049771, 801.4670244287571, 802.8153524689325, 803.2329125684986, 803.6745118227127, 801.3148757812045, 808.4017826808179, 809.0938149272823, 810.8864758933754, 811.9350451963828, 833.9499630022218, 841.6843683618642, 845.1084106267884, 845.1590667286059, 849.2441726863066, 837.8533756592572, 840.7309660908512, 842.1410161635098, 843.0389356134012, 845.0915266088979, 618.5175563060819, 619.4672581579838, 621.9160413344185, 622.2035794183453, 624.6470744029609, 12175.573854915036, 12227.816582751177, 12344.38278086092, 12352.876471235262, 12366.62900112998, 10517.52671129801, 10874.945625271903, 11291.548338066468, 11293.378864162467, 11447.067104180467, 9316.068393160698, 9346.252299815998, 9356.859647105299, 9383.577739001761, 9423.34036617437, 3184.8726050957935, 3251.6910893465083, 3256.9837150814333, 3319.6348401675796, 3343.264481813997, 37133.81433092844, 38312.0, 38380.232395352214, 38611.8069409654, 39111.60888391108, 9153.22197613197, 9196.310276729271, 9279.814403712024, 9284.860727089099, 9387.718368448957, 15728.370865165494, 15799.052056876624, 15864.286107124975, 15913.681726365408, 15954.28205730745, 6259.812205633838, 6302.4958003359625, 6353.078803573456, 6360.491160707133, 6421.614703117828, 3516.4725291206523, 3553.058439513531, 3564.821758912044, 3573.9642603574152, 3607.286003412863, 2587.3402282417865, 2614.2810727050214, 2614.307208589725, 2618.16218809979, 2618.8297760645496, 463.54340974140445, 470.2053529535075, 472.8014234021719, 482.17788670317026, 482.93721816163674, 526.3263023330144, 540.108820446259, 543.120145364512, 594.669958173218, 635.6535688050024, 7752.147263800977, 7791.376689864797, 7951.880721789178, 8023.0, 8122.675092996214, 464.33599952068863, 477.12685785014037, 512.0731476028401, 562.4122791682702, 595.9493443057302, 3604.5314109165643, 3641.49569623283, 3990.4014397840556, 4032.959670403317, 4083.8366465341055, 41320.79339603343, 41461.37807932883, 52730.472695273325, 52847.73576132172, 55015.0, 43204.567954320686, 43320.3501947471, 43837.78081109638, 44218.557814421445, 44271.77864110659, 35388.82305588507, 35631.643683562834, 40614.18771624551, 42959.140817183485, 43295.35056974148, 7908.683652654059, 8068.435209535511, 8071.919280807117, 8223.917760822314, 8482.236598706146, 30311.0, 31088.533671995392, 31105.53341699831, 31395.0, 32037.35925281528, 36858.44712329264, 37388.439173411876, 38771.224575508895, 39073.609263907, 39131.0, 10136.391816491034, 10202.081812636601, 10211.795764084825, 10298.764148302253, 10408.895911040792, 11037.889621103686, 11072.633459019775, 11166.385848778395, 11305.491252893804, 11343.48954297075, 10688.358698478116, 10875.782484350428, 10953.780924381308, 11231.831522527333, 11251.549938002388, 10226.795464090825, 10331.741706457398, 10552.155827533932, 10698.8930110701, 10728.463576821285, 10164.390136591828, 10335.379877207391, 10580.629677961235, 10854.18593605467, 10862.728431789268, 9039.096090390909, 9192.724218273463, 9288.489133097744, 9295.67465138717, 9332.16010559053, 9179.632814687604, 9190.448573085636, 9314.906850931404, 9438.38650487716, 9455.574499147417], "unit": "score", "name": "yui.html", "value": 5716.232908229021}], "name": "dromaeo_css", "value": 6288.352186909825}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 113.0, 113.0, 114.0, 127.0, 113.0, 114.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [155.0, 128.0, 158.0, 167.0, 132.0, 158.0, 163.0, 139.0, 176.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 151.8}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 164.0, 163.0, 163.0, 165.0, 164.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 71.0, 72.0, 72.0, 123.0, 73.0, 78.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 78.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 131.0, 95.0, 95.0, 94.0, 135.0, 104.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 148.0, 147.0, 148.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 100.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 76.0, 73.0, 74.0, 73.0, 73.0, 73.0, 72.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 72.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 88.0, 85.0, 86.0, 85.0, 85.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 124.0, 129.0, 129.0, 126.0, 126.0, 122.0, 130.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [141.0, 155.0, 148.0, 137.0, 151.0, 154.0, 157.0, 155.0, 153.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 72.0, 71.0, 70.0, 68.0, 69.0, 75.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1541.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.54879487611663], "unit": "score", "name": "Richards", "value": 209.44676600000008}, {"lowerIsBetter": false, "replicates": [191.71779141104295], "unit": "score", "name": "DeltaBlue", "value": 344.87148800000006}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1086.9565217391305], "unit": "score", "name": "RayTrace", "value": 680.7898799999998}, {"lowerIsBetter": false, "replicates": [696.5901183020181], "unit": "score", "name": "Earley", "value": 956.7505804195806}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [28250.0], "unit": "score", "name": "RegExp", "value": 32.24725663716814}, {"lowerIsBetter": false, "replicates": [602.0469596628537], "unit": "score", "name": "Splay", "value": 135.35655099999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21130.352221946272}]} 04:42:16 INFO - RETURN: dromaeo_css: 6288.35 04:42:16 INFO - RETURN: kraken: 1541.90 04:42:16 INFO - RETURN: v8_7: 21130.35 04:42:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21130.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1541.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6288.35"}}} 04:42:16 INFO - Return code: 0 04:42:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:42:16 INFO - # TBPL SUCCESS # 04:42:16 INFO - Running post-action listener: _resource_record_post_action 04:42:16 INFO - Running post-run listener: _resource_record_post_run 04:42:17 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509206528; Read time: 16; Write time: 591528 04:42:17 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235253760; Read time: 0; Write time: 401624 04:42:18 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273952768; Read time: 16; Write time: 189904 04:42:18 INFO - Running post-run listener: _upload_blobber_files 04:42:18 INFO - Blob upload gear active. 04:42:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:42:18 INFO - Copying logs to upload dir... 04:42:18 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.767609 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-16 04:42:18.042663) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:42:18.045666) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010140 build_url: 'https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/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 04:42:18.096300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:42:18.096632) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450268469.85709-1033649610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:42:18.146115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 04:42:18.146440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 04:42:18.146740) ========= ========= Total master_lag: 0.26 =========