builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1450268309.67 results: success (0) buildid: 20151216025907 builduid: c192c417865041439eebf397db31510d revision: 40038a66525f454aadc0f887bae55c6a60ef7290 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.671342) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.671839) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.672183) ========= 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=a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006053 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.695887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.696247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.709861) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.710185) ========= 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=a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.759242) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.759600) ========= 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:18:29.760025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:29.760337) ========= 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=a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 04:18:30-- 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% 15.6M=0.001s 2015-12-16 04:18:30 (15.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.419675 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:30.192518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:30.192885) ========= 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=a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019682 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:30.243475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:30.243894) ========= 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=a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 04:18:30,640 truncating revision to first 12 chars 2015-12-16 04:18:30,640 Setting DEBUG logging. 2015-12-16 04:18:30,640 attempt 1/10 2015-12-16 04:18:30,640 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:18:31,079 unpacking tar archive at: mozilla-central-40038a66525f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:30.963747) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:30.964115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:30.972895) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:18:30.973198) ========= 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:18:30.973662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-16 04:18:30.974007) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:18:31 INFO - MultiFileLogger online at 20151216 04:18:31 in /builds/slave/test 04:18:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:18:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:18:31 INFO - {'append_to_log': False, 04:18:31 INFO - 'base_work_dir': '/builds/slave/test', 04:18:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:18:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:18:31 INFO - 'branch': 'Firefox-Non-PGO', 04:18:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:18:31 INFO - 'config_files': ('talos/linux_config.py',), 04:18:31 INFO - 'default_actions': ('clobber', 04:18:31 INFO - 'read-buildbot-config', 04:18:31 INFO - 'download-and-extract', 04:18:31 INFO - 'populate-webroot', 04:18:31 INFO - 'create-virtualenv', 04:18:31 INFO - 'install', 04:18:31 INFO - 'run-tests'), 04:18:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:18:31 INFO - 'download_minidump_stackwalk': True, 04:18:31 INFO - 'download_symbols': 'ondemand', 04:18:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:18:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:18:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:18:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:18:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:18:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:18:31 INFO - 'installer_path': 'installer.exe', 04:18:31 INFO - 'log_level': 'info', 04:18:31 INFO - 'log_name': 'talos', 04:18:31 INFO - 'log_to_console': True, 04:18:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:18:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:18:31 INFO - 'opt_config_files': (), 04:18:31 INFO - 'pip_index': False, 04:18:31 INFO - 'sps_profile': False, 04:18:31 INFO - 'sps_profile_interval': 0, 04:18:31 INFO - 'suite': 'dromaeojs', 04:18:31 INFO - 'system_bits': '64', 04:18:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:18:31 INFO - 'title': 'talos-linux64-ix-033', 04:18:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:18:31 INFO - 'use_talos_json': True, 04:18:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:18:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:18:31 INFO - 'work_dir': 'build'} 04:18:31 INFO - ##### 04:18:31 INFO - ##### Running clobber step. 04:18:31 INFO - ##### 04:18:31 INFO - Running pre-action listener: _resource_record_pre_action 04:18:31 INFO - Running main action method: clobber 04:18:31 INFO - rmtree: /builds/slave/test/build 04:18:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:18:32 INFO - Running post-action listener: _resource_record_post_action 04:18:32 INFO - ##### 04:18:32 INFO - ##### Running read-buildbot-config step. 04:18:32 INFO - ##### 04:18:32 INFO - Running pre-action listener: _resource_record_pre_action 04:18:32 INFO - Running main action method: read_buildbot_config 04:18:32 INFO - Using buildbot properties: 04:18:32 INFO - { 04:18:32 INFO - "properties": { 04:18:32 INFO - "buildnumber": 408, 04:18:32 INFO - "product": "firefox", 04:18:32 INFO - "script_repo_revision": "production", 04:18:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:18:32 INFO - "repository": "", 04:18:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:18:32 INFO - "buildid": "20151216025907", 04:18:32 INFO - "slavename": "talos-linux64-ix-033", 04:18:32 INFO - "pgo_build": "False", 04:18:32 INFO - "basedir": "/builds/slave/test", 04:18:32 INFO - "project": "", 04:18:32 INFO - "platform": "ubuntu64_hw", 04:18:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:18:32 INFO - "slavebuilddir": "test", 04:18:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:18:32 INFO - "branch": "mozilla-central", 04:18:32 INFO - "repo_path": "mozilla-central", 04:18:32 INFO - "stage_platform": "linux64", 04:18:32 INFO - "builduid": "c192c417865041439eebf397db31510d", 04:18:32 INFO - "revision": "40038a66525f454aadc0f887bae55c6a60ef7290" 04:18:32 INFO - }, 04:18:32 INFO - "sourcestamp": { 04:18:32 INFO - "repository": "", 04:18:32 INFO - "hasPatch": false, 04:18:32 INFO - "project": "", 04:18:32 INFO - "branch": "mozilla-central-linux64-talos", 04:18:32 INFO - "changes": [ 04:18:32 INFO - { 04:18:32 INFO - "category": null, 04:18:32 INFO - "files": [ 04:18:32 INFO - { 04:18:32 INFO - "url": null, 04:18:32 INFO - "name": "https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:18:32 INFO - } 04:18:32 INFO - ], 04:18:32 INFO - "repository": "", 04:18:32 INFO - "rev": "40038a66525f454aadc0f887bae55c6a60ef7290", 04:18:32 INFO - "who": "cbook@mozilla.com", 04:18:32 INFO - "when": 1450268249, 04:18:32 INFO - "number": 7365658, 04:18:32 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:18:32 INFO - "project": "", 04:18:32 INFO - "at": "Wed 16 Dec 2015 04:17:29", 04:18:32 INFO - "branch": "mozilla-central-linux64-talos", 04:18:32 INFO - "revlink": "", 04:18:32 INFO - "properties": [ 04:18:32 INFO - [ 04:18:32 INFO - "buildid", 04:18:32 INFO - "20151216025907", 04:18:32 INFO - "Change" 04:18:32 INFO - ], 04:18:32 INFO - [ 04:18:32 INFO - "builduid", 04:18:32 INFO - "c192c417865041439eebf397db31510d", 04:18:32 INFO - "Change" 04:18:32 INFO - ], 04:18:32 INFO - [ 04:18:32 INFO - "pgo_build", 04:18:32 INFO - "False", 04:18:32 INFO - "Change" 04:18:32 INFO - ] 04:18:32 INFO - ], 04:18:32 INFO - "revision": "40038a66525f454aadc0f887bae55c6a60ef7290" 04:18:32 INFO - } 04:18:32 INFO - ], 04:18:32 INFO - "revision": "40038a66525f454aadc0f887bae55c6a60ef7290" 04:18:32 INFO - } 04:18:32 INFO - } 04:18:32 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:18:32 INFO - Running post-action listener: _resource_record_post_action 04:18:32 INFO - ##### 04:18:32 INFO - ##### Running download-and-extract step. 04:18:32 INFO - ##### 04:18:32 INFO - Running pre-action listener: _resource_record_pre_action 04:18:32 INFO - Running main action method: download_and_extract 04:18:32 INFO - mkdir: /builds/slave/test/build/tests 04:18:32 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:18:32 INFO - https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:18:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/test_packages.json 04:18:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/test_packages.json 04:18:32 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:18:32 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:18:33 INFO - Downloaded 1302 bytes. 04:18:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:18:33 INFO - Using the following test package requirements: 04:18:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:18:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:33 INFO - u'jsshell-linux-x86_64.zip'], 04:18:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:18:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:18:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:18:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:18:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:18:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:18: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:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:34 INFO - Downloaded 21868585 bytes. 04:18:34 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:18:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:18:34 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:18:35 INFO - Return code: 0 04:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:36 INFO - Downloaded 21868585 bytes. 04:18:36 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:18:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:18:36 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:18:38 INFO - Return code: 0 04:18:38 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:18:38 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:18:38 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:18:38 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:18:38 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:18:38 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:18:39 INFO - Downloaded 11132052 bytes. 04:18:39 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:18:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:18:39 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:18:39 INFO - Return code: 0 04:18: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:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:41 INFO - Downloaded 57738087 bytes. 04:18:41 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:18:41 INFO - mkdir: /builds/slave/test/properties 04:18:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:18:41 INFO - Writing to file /builds/slave/test/properties/build_url 04:18:41 INFO - Contents: 04:18:41 INFO - build_url:https://queue.taskcluster.net/v1/task/muOlS9VpQhuVUbLeWt2NPA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:18:41 INFO - Running post-action listener: _resource_record_post_action 04:18:41 INFO - Running post-action listener: set_extra_try_arguments 04:18:41 INFO - ##### 04:18:41 INFO - ##### Running populate-webroot step. 04:18:41 INFO - ##### 04:18:41 INFO - Running pre-action listener: _resource_record_pre_action 04:18:41 INFO - Running main action method: populate_webroot 04:18:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:18:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:18:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:18:41 INFO - '--tppagecycles', 04:18:41 INFO - '7'], 04:18:41 INFO - 'tests': ['tsvgm']}}, 04:18:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:18:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:18:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:18:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:18:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:41 INFO - 'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:41 INFO - 'tests': ['damp', 'tps']}, 04:18:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:41 INFO - 'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['damp', 'tps']}, 04:18:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:18:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:18:41 INFO - 'other': {'tests': ['a11yr', 04:18:41 INFO - 'ts_paint', 04:18:41 INFO - 'tpaint', 04:18:41 INFO - 'sessionrestore', 04:18:41 INFO - 'sessionrestore_no_auto_restore']}, 04:18:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['a11yr', 04:18:41 INFO - 'ts_paint', 04:18:41 INFO - 'tpaint', 04:18:41 INFO - 'sessionrestore', 04:18:41 INFO - 'sessionrestore_no_auto_restore']}, 04:18:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['a11yr', 04:18:41 INFO - 'ts_paint', 04:18:41 INFO - 'tpaint', 04:18:41 INFO - 'sessionrestore', 04:18:41 INFO - 'sessionrestore_no_auto_restore']}, 04:18:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['a11yr', 04:18:41 INFO - 'ts_paint', 04:18:41 INFO - 'tpaint', 04:18:41 INFO - 'sessionrestore', 04:18:41 INFO - 'sessionrestore_no_auto_restore']}, 04:18:41 INFO - 'other_l64': {'tests': ['a11yr', 04:18:41 INFO - 'ts_paint', 04:18:41 INFO - 'tpaint', 04:18:41 INFO - 'sessionrestore', 04:18:41 INFO - 'sessionrestore_no_auto_restore']}, 04:18:41 INFO - 'other_nol64': {'tests': ['a11yr', 04:18:41 INFO - 'ts_paint', 04:18:41 INFO - 'tpaint', 04:18:41 INFO - 'sessionrestore', 04:18:41 INFO - 'sessionrestore_no_auto_restore']}, 04:18:41 INFO - 'svgr': {'tests': ['tsvgx', 04:18:41 INFO - 'tsvgr_opacity', 04:18:41 INFO - 'tart', 04:18:41 INFO - 'tscrollx', 04:18:41 INFO - 'cart']}, 04:18:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['tsvgx', 04:18:41 INFO - 'tsvgr_opacity', 04:18:41 INFO - 'tart', 04:18:41 INFO - 'tscrollx', 04:18:41 INFO - 'cart']}, 04:18:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:41 INFO - 'tests': ['tp5o']}, 04:18:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:41 INFO - 'talos_options': ['--e10s'], 04:18:41 INFO - 'tests': ['tp5o']}, 04:18:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:41 INFO - 'talos_options': ['--xperf_path', 04:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:41 INFO - 'tests': ['tp5n']}, 04:18:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:41 INFO - 'talos_options': ['--e10s', 04:18:41 INFO - '--xperf_path', 04:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:41 INFO - 'tests': ['tp5n']}}, 04:18:41 INFO - 'talos.zip': {'path': '', 04:18:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:18:41 INFO - Running post-action listener: _resource_record_post_action 04:18:41 INFO - ##### 04:18:41 INFO - ##### Running create-virtualenv step. 04:18:41 INFO - ##### 04:18:41 INFO - Running pre-action listener: _resource_record_pre_action 04:18:41 INFO - Running main action method: create_virtualenv 04:18:41 INFO - Creating virtualenv /builds/slave/test/build/venv 04:18:41 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:18:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:18:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:18:41 INFO - Using real prefix '/usr' 04:18:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:18:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:18:43 INFO - Installing pip.................done. 04:18:43 INFO - Return code: 0 04:18:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:43 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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:18:43 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:18:43 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:18:43 INFO - Using env: {'DISPLAY': ':0', 04:18:43 INFO - 'HOME': '/home/cltbld', 04:18:43 INFO - 'LANG': 'en_US.UTF-8', 04:18:43 INFO - 'LANGUAGE': 'en_US:en', 04:18:43 INFO - 'LOGNAME': 'cltbld', 04:18:43 INFO - 'MAIL': '/var/mail/cltbld', 04:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:43 INFO - 'MOZ_NO_REMOTE': '1', 04:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:43 INFO - 'NO_EM_RESTART': '1', 04:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:43 INFO - 'PWD': '/builds/slave/test', 04:18:43 INFO - 'SHELL': '/bin/bash', 04:18:43 INFO - 'SHLVL': '1', 04:18:43 INFO - 'TERM': 'linux', 04:18:43 INFO - 'TMOUT': '86400', 04:18:43 INFO - 'USER': 'cltbld', 04:18:43 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:43 INFO - '_': '/tools/buildbot/bin/python'} 04:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:44 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:18:44 INFO - Cleaning up... 04:18:44 INFO - Return code: 0 04:18:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:44 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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:18:44 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:18:44 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:18:44 INFO - Using env: {'DISPLAY': ':0', 04:18:44 INFO - 'HOME': '/home/cltbld', 04:18:44 INFO - 'LANG': 'en_US.UTF-8', 04:18:44 INFO - 'LANGUAGE': 'en_US:en', 04:18:44 INFO - 'LOGNAME': 'cltbld', 04:18:44 INFO - 'MAIL': '/var/mail/cltbld', 04:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:44 INFO - 'MOZ_NO_REMOTE': '1', 04:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:44 INFO - 'NO_EM_RESTART': '1', 04:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:44 INFO - 'PWD': '/builds/slave/test', 04:18:44 INFO - 'SHELL': '/bin/bash', 04:18:44 INFO - 'SHLVL': '1', 04:18:44 INFO - 'TERM': 'linux', 04:18:44 INFO - 'TMOUT': '86400', 04:18:44 INFO - 'USER': 'cltbld', 04:18:44 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:44 INFO - '_': '/tools/buildbot/bin/python'} 04:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:44 INFO - Downloading/unpacking psutil>=0.7.1 04:18:44 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:18:44 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:18:44 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:18:44 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:18:44 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:18:44 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:18:45 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:18:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:46 INFO - Installing collected packages: psutil 04:18:46 INFO - Running setup.py install for psutil 04:18:46 INFO - building 'psutil._psutil_linux' extension 04:18:46 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:18:46 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:18:46 INFO - building 'psutil._psutil_posix' extension 04:18:46 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:18:46 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:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:46 INFO - Successfully installed psutil 04:18:46 INFO - Cleaning up... 04:18:46 INFO - Return code: 0 04:18:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:18:46 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:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 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:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:18:46 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:18:46 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:18:46 INFO - Using env: {'DISPLAY': ':0', 04:18:46 INFO - 'HOME': '/home/cltbld', 04:18:46 INFO - 'LANG': 'en_US.UTF-8', 04:18:46 INFO - 'LANGUAGE': 'en_US:en', 04:18:46 INFO - 'LOGNAME': 'cltbld', 04:18:46 INFO - 'MAIL': '/var/mail/cltbld', 04:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:46 INFO - 'MOZ_NO_REMOTE': '1', 04:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:46 INFO - 'NO_EM_RESTART': '1', 04:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:46 INFO - 'PWD': '/builds/slave/test', 04:18:46 INFO - 'SHELL': '/bin/bash', 04:18:46 INFO - 'SHLVL': '1', 04:18:46 INFO - 'TERM': 'linux', 04:18:46 INFO - 'TMOUT': '86400', 04:18:46 INFO - 'USER': 'cltbld', 04:18:46 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:46 INFO - '_': '/tools/buildbot/bin/python'} 04:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:18:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:18:48 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:18:48 INFO - Installing collected packages: mozsystemmonitor 04:18:48 INFO - Running setup.py install for mozsystemmonitor 04:18:48 INFO - Successfully installed mozsystemmonitor 04:18:48 INFO - Cleaning up... 04:18:48 INFO - Return code: 0 04:18:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:18:48 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:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:48 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:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:48 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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:18:48 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:18:48 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:18:48 INFO - Using env: {'DISPLAY': ':0', 04:18:48 INFO - 'HOME': '/home/cltbld', 04:18:48 INFO - 'LANG': 'en_US.UTF-8', 04:18:48 INFO - 'LANGUAGE': 'en_US:en', 04:18:48 INFO - 'LOGNAME': 'cltbld', 04:18:48 INFO - 'MAIL': '/var/mail/cltbld', 04:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:48 INFO - 'MOZ_NO_REMOTE': '1', 04:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:48 INFO - 'NO_EM_RESTART': '1', 04:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:48 INFO - 'PWD': '/builds/slave/test', 04:18:48 INFO - 'SHELL': '/bin/bash', 04:18:48 INFO - 'SHLVL': '1', 04:18:48 INFO - 'TERM': 'linux', 04:18:48 INFO - 'TMOUT': '86400', 04:18:48 INFO - 'USER': 'cltbld', 04:18:48 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:48 INFO - '_': '/tools/buildbot/bin/python'} 04:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:18:48 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:18:48 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:18:48 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:18:48 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:18:48 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:18:48 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:18:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:18:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:18:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:18:50 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:18:50 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:18:50 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:18:50 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:18:50 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:18:50 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:18:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18:51 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:18:51 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:18:51 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:18:51 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:18:51 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:18:51 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:18:51 INFO - Downloading docopt-0.6.1.tar.gz 04:18:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:51 INFO - Running setup.py install for blobuploader 04:18:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:51 INFO - Running setup.py install for requests 04:18:51 INFO - Running setup.py install for docopt 04:18:51 INFO - Successfully installed blobuploader requests docopt 04:18:51 INFO - Cleaning up... 04:18:51 INFO - Return code: 0 04:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:51 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:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:51 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:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:52 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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:18:52 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:18:52 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:18:52 INFO - Using env: {'DISPLAY': ':0', 04:18:52 INFO - 'HOME': '/home/cltbld', 04:18:52 INFO - 'LANG': 'en_US.UTF-8', 04:18:52 INFO - 'LANGUAGE': 'en_US:en', 04:18:52 INFO - 'LOGNAME': 'cltbld', 04:18:52 INFO - 'MAIL': '/var/mail/cltbld', 04:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:52 INFO - 'MOZ_NO_REMOTE': '1', 04:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:52 INFO - 'NO_EM_RESTART': '1', 04:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:52 INFO - 'PWD': '/builds/slave/test', 04:18:52 INFO - 'SHELL': '/bin/bash', 04:18:52 INFO - 'SHLVL': '1', 04:18:52 INFO - 'TERM': 'linux', 04:18:52 INFO - 'TMOUT': '86400', 04:18:52 INFO - 'USER': 'cltbld', 04:18:52 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:52 INFO - '_': '/tools/buildbot/bin/python'} 04:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:52 INFO - Running setup.py (path:/tmp/pip-TCyLfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:52 INFO - Running setup.py (path:/tmp/pip-cxiUhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:52 INFO - Running setup.py (path:/tmp/pip-8R_Rs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:52 INFO - Running setup.py (path:/tmp/pip-jZN_o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:52 INFO - Running setup.py (path:/tmp/pip-Zs_gFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:52 INFO - Running setup.py (path:/tmp/pip-Ckdhu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:52 INFO - Running setup.py (path:/tmp/pip-hXixkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:52 INFO - Running setup.py (path:/tmp/pip-gFIU2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:52 INFO - Running setup.py (path:/tmp/pip-ECBGvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:52 INFO - Running setup.py (path:/tmp/pip-f2_7iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:52 INFO - Running setup.py (path:/tmp/pip-lFEw3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:53 INFO - Running setup.py (path:/tmp/pip-9K6Asm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:53 INFO - Running setup.py (path:/tmp/pip-a_LMaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:53 INFO - Running setup.py (path:/tmp/pip-kTi_o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:53 INFO - Running setup.py (path:/tmp/pip-8ZjT9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:53 INFO - Running setup.py (path:/tmp/pip-Oc1CI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:53 INFO - Running setup.py (path:/tmp/pip-mEZltj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:18:53 INFO - Running setup.py install for manifestparser 04:18:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:18:53 INFO - Running setup.py install for mozcrash 04:18:53 INFO - Running setup.py install for mozdebug 04:18:53 INFO - Running setup.py install for mozdevice 04:18:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:18:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:18:53 INFO - Running setup.py install for mozfile 04:18:53 INFO - Running setup.py install for mozhttpd 04:18:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozinfo 04:18:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozInstall 04:18:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozleak 04:18:54 INFO - Running setup.py install for mozlog 04:18:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for moznetwork 04:18:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozprocess 04:18:54 INFO - Running setup.py install for mozprofile 04:18:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozrunner 04:18:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozscreenshot 04:18:54 INFO - Running setup.py install for moztest 04:18:55 INFO - Running setup.py install for mozversion 04:18:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:18:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:18:55 INFO - Cleaning up... 04:18:55 INFO - Return code: 0 04:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:18:55 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:18:55 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:18:55 INFO - Using env: {'DISPLAY': ':0', 04:18:55 INFO - 'HOME': '/home/cltbld', 04:18:55 INFO - 'LANG': 'en_US.UTF-8', 04:18:55 INFO - 'LANGUAGE': 'en_US:en', 04:18:55 INFO - 'LOGNAME': 'cltbld', 04:18:55 INFO - 'MAIL': '/var/mail/cltbld', 04:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:55 INFO - 'MOZ_NO_REMOTE': '1', 04:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:55 INFO - 'NO_EM_RESTART': '1', 04:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:55 INFO - 'PWD': '/builds/slave/test', 04:18:55 INFO - 'SHELL': '/bin/bash', 04:18:55 INFO - 'SHLVL': '1', 04:18:55 INFO - 'TERM': 'linux', 04:18:55 INFO - 'TMOUT': '86400', 04:18:55 INFO - 'USER': 'cltbld', 04:18:55 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:55 INFO - '_': '/tools/buildbot/bin/python'} 04:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:55 INFO - Running setup.py (path:/tmp/pip-Jf2TaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:55 INFO - Running setup.py (path:/tmp/pip-C83CxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:55 INFO - Running setup.py (path:/tmp/pip-g2WpI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:55 INFO - Running setup.py (path:/tmp/pip-3zVnIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:55 INFO - Running setup.py (path:/tmp/pip-8bKCEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:55 INFO - Running setup.py (path:/tmp/pip-S2Yzx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:55 INFO - Running setup.py (path:/tmp/pip-nzmEX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:55 INFO - Running setup.py (path:/tmp/pip-F_i4Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:56 INFO - Running setup.py (path:/tmp/pip-o20lKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:56 INFO - Running setup.py (path:/tmp/pip-Y4ZG6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:56 INFO - Running setup.py (path:/tmp/pip-jB5adb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:56 INFO - Running setup.py (path:/tmp/pip-oVgHtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:56 INFO - Running setup.py (path:/tmp/pip-FTE1pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:56 INFO - Running setup.py (path:/tmp/pip-gCzCvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:56 INFO - Running setup.py (path:/tmp/pip-hDl1Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:56 INFO - Running setup.py (path:/tmp/pip-Qu1nl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:56 INFO - Running setup.py (path:/tmp/pip-4AtJB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:56 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:18:56 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:18:56 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:18:56 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:18:56 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:18:56 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:18:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:58 INFO - Downloading blessings-1.5.1.tar.gz 04:18:58 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:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:18:58 INFO - Installing collected packages: blessings 04:18:58 INFO - Running setup.py install for blessings 04:18:58 INFO - Successfully installed blessings 04:18:58 INFO - Cleaning up... 04:18:58 INFO - Return code: 0 04:18:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:58 INFO - Reading from file tmpfile_stdout 04:18:58 INFO - Current package versions: 04:18:58 INFO - argparse == 1.2.1 04:18:58 INFO - blessings == 1.5.1 04:18:58 INFO - blobuploader == 1.2.4 04:18:58 INFO - docopt == 0.6.1 04:18:58 INFO - manifestparser == 1.1 04:18:58 INFO - mozInstall == 1.12 04:18:58 INFO - mozcrash == 0.16 04:18:58 INFO - mozdebug == 0.1 04:18:58 INFO - mozdevice == 0.47 04:18:58 INFO - mozfile == 1.2 04:18:58 INFO - mozhttpd == 0.7 04:18:58 INFO - mozinfo == 0.9 04:18:58 INFO - mozleak == 0.1 04:18:58 INFO - mozlog == 3.1 04:18:58 INFO - moznetwork == 0.27 04:18:58 INFO - mozprocess == 0.22 04:18:58 INFO - mozprofile == 0.27 04:18:58 INFO - mozrunner == 6.11 04:18:58 INFO - mozscreenshot == 0.1 04:18:58 INFO - mozsystemmonitor == 0.0 04:18:58 INFO - moztest == 0.7 04:18:58 INFO - mozversion == 1.4 04:18:58 INFO - psutil == 3.1.1 04:18:58 INFO - requests == 1.2.3 04:18:58 INFO - wsgiref == 0.1.2 04:18:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:18:58 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:18:58 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:18:58 INFO - Using env: {'DISPLAY': ':0', 04:18:58 INFO - 'HOME': '/home/cltbld', 04:18:58 INFO - 'LANG': 'en_US.UTF-8', 04:18:58 INFO - 'LANGUAGE': 'en_US:en', 04:18:58 INFO - 'LOGNAME': 'cltbld', 04:18:58 INFO - 'MAIL': '/var/mail/cltbld', 04:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:58 INFO - 'MOZ_NO_REMOTE': '1', 04:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:58 INFO - 'NO_EM_RESTART': '1', 04:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:58 INFO - 'PWD': '/builds/slave/test', 04:18:58 INFO - 'SHELL': '/bin/bash', 04:18:58 INFO - 'SHLVL': '1', 04:18:58 INFO - 'TERM': 'linux', 04:18:58 INFO - 'TMOUT': '86400', 04:18:58 INFO - 'USER': 'cltbld', 04:18:58 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:58 INFO - '_': '/tools/buildbot/bin/python'} 04:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 INFO - Cleaning up... 04:18:59 INFO - Return code: 0 04:18:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:18:59 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:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:59 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:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:59 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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:18:59 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:18:59 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:18:59 INFO - Using env: {'DISPLAY': ':0', 04:18:59 INFO - 'HOME': '/home/cltbld', 04:18:59 INFO - 'LANG': 'en_US.UTF-8', 04:18:59 INFO - 'LANGUAGE': 'en_US:en', 04:18:59 INFO - 'LOGNAME': 'cltbld', 04:18:59 INFO - 'MAIL': '/var/mail/cltbld', 04:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:59 INFO - 'MOZ_NO_REMOTE': '1', 04:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:59 INFO - 'NO_EM_RESTART': '1', 04:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:59 INFO - 'PWD': '/builds/slave/test', 04:18:59 INFO - 'SHELL': '/bin/bash', 04:18:59 INFO - 'SHLVL': '1', 04:18:59 INFO - 'TERM': 'linux', 04:18:59 INFO - 'TMOUT': '86400', 04:18:59 INFO - 'USER': 'cltbld', 04:18:59 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:59 INFO - '_': '/tools/buildbot/bin/python'} 04:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:59 INFO - Downloading/unpacking jsonschema 04:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:00 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:19:00 INFO - Downloading/unpacking functools32 (from jsonschema) 04:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:01 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:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:01 INFO - warning: no files found matching '*.txt' 04:19:01 INFO - no previously-included directories found matching 'build' 04:19:01 INFO - no previously-included directories found matching 'dist' 04:19:01 INFO - no previously-included directories found matching '.git*' 04:19:01 INFO - Installing collected packages: jsonschema, functools32 04:19:01 INFO - Running setup.py install for functools32 04:19:01 INFO - warning: no files found matching '*.txt' 04:19:01 INFO - no previously-included directories found matching 'build' 04:19:01 INFO - no previously-included directories found matching 'dist' 04:19:01 INFO - no previously-included directories found matching '.git*' 04:19:01 INFO - Successfully installed jsonschema functools32 04:19:01 INFO - Cleaning up... 04:19:01 INFO - Return code: 0 04:19:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:19:01 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:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:01 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:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:01 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 0x7f15d8b48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1286240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, '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': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', '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:19:01 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:19:01 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:19:01 INFO - Using env: {'DISPLAY': ':0', 04:19:01 INFO - 'HOME': '/home/cltbld', 04:19:01 INFO - 'LANG': 'en_US.UTF-8', 04:19:01 INFO - 'LANGUAGE': 'en_US:en', 04:19:01 INFO - 'LOGNAME': 'cltbld', 04:19:01 INFO - 'MAIL': '/var/mail/cltbld', 04:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:01 INFO - 'MOZ_NO_REMOTE': '1', 04:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:01 INFO - 'NO_EM_RESTART': '1', 04:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:01 INFO - 'PWD': '/builds/slave/test', 04:19:01 INFO - 'SHELL': '/bin/bash', 04:19:01 INFO - 'SHLVL': '1', 04:19:01 INFO - 'TERM': 'linux', 04:19:01 INFO - 'TMOUT': '86400', 04:19:01 INFO - 'USER': 'cltbld', 04:19:01 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:01 INFO - '_': '/tools/buildbot/bin/python'} 04:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:01 INFO - Downloading/unpacking flake8 04:19:01 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:19:01 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:19:01 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:19:01 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:19:01 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:19:01 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:19:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:19:03 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:19:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:19:03 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:19:03 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:19:03 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:19:03 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:19:03 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:19:03 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:19:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:19:03 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:19:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:19:03 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:19:03 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:19:03 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:19:03 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:19:03 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:19:03 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:19:03 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:19:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:19:03 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:19:03 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:19:03 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:19:03 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:19:03 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:19:03 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:19:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:19:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:19:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:19:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:19:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:19:03 INFO - no previously-included directories found matching 'docs/_build' 04:19:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:19:04 INFO - Running setup.py install for pep8 04:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:19:04 INFO - no previously-included directories found matching 'docs/_build' 04:19:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:19:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:19:04 INFO - Cleaning up... 04:19:04 INFO - Return code: 0 04:19:04 INFO - Running post-action listener: _resource_record_post_action 04:19:04 INFO - Running post-action listener: _start_resource_monitoring 04:19:04 INFO - Starting resource monitoring. 04:19:04 INFO - ##### 04:19:04 INFO - ##### Running install step. 04:19:04 INFO - ##### 04:19:04 INFO - Running pre-action listener: _resource_record_pre_action 04:19:04 INFO - Running main action method: install 04:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:04 INFO - Reading from file tmpfile_stdout 04:19:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:19:04 INFO - Reading from file tmpfile_stdout 04:19:04 INFO - Output received: 04:19:04 INFO - Usage: mozinstall [options] installer 04:19:04 INFO - Options: 04:19:04 INFO - -h, --help show this help message and exit 04:19:04 INFO - -d DEST, --destination=DEST 04:19:04 INFO - Directory to install application into. [default: 04:19:04 INFO - "/builds/slave/test"] 04:19:04 INFO - --app=APP Application being installed. [default: firefox] 04:19:04 INFO - mkdir: /builds/slave/test/build/application 04:19:04 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:19:04 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:19:19 INFO - Reading from file tmpfile_stdout 04:19:19 INFO - Output received: 04:19:19 INFO - /builds/slave/test/build/application/firefox/firefox 04:19:19 INFO - Running post-action listener: _resource_record_post_action 04:19:19 INFO - ##### 04:19:19 INFO - ##### Running run-tests step. 04:19:19 INFO - ##### 04:19:19 INFO - Running pre-action listener: _resource_record_pre_action 04:19:19 INFO - Running main action method: run_tests 04:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:19:19 INFO - Python 2.7.3 04:19:19 INFO - Return code: 0 04:19:19 INFO - grabbing minidump binary from tooltool 04:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:19 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 0x13150b0>, '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 0x1315fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:19:19 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:19:19 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:19:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:19:19 INFO - Return code: 0 04:19:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:19:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:19:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:19:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:19:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:19:20 INFO - Return code: 0 04:19:20 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', '--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-033', '--webServer', 'localhost'] in /builds/slave/test/build 04:19:20 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 --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-033 --webServer localhost 04:19:20 INFO - Using env: {'DISPLAY': ':0', 04:19:20 INFO - 'HOME': '/home/cltbld', 04:19:20 INFO - 'LANG': 'en_US.UTF-8', 04:19:20 INFO - 'LANGUAGE': 'en_US:en', 04:19:20 INFO - 'LOGNAME': 'cltbld', 04:19:20 INFO - 'MAIL': '/var/mail/cltbld', 04:19:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:19:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:20 INFO - 'MOZ_NO_REMOTE': '1', 04:19:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:20 INFO - 'NO_EM_RESTART': '1', 04:19:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:20 INFO - 'PWD': '/builds/slave/test', 04:19:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:19:20 INFO - 'SHELL': '/bin/bash', 04:19:20 INFO - 'SHLVL': '1', 04:19:20 INFO - 'TERM': 'linux', 04:19:20 INFO - 'TMOUT': '86400', 04:19:20 INFO - 'USER': 'cltbld', 04:19:20 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426', 04:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:20 INFO - '_': '/tools/buildbot/bin/python'} 04:19:20 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', '--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-033', '--webServer', 'localhost'] with output_timeout 3600 04:19:20 INFO - mozversion INFO | application_buildid: 20151216025907 04:19:20 INFO - mozversion INFO | application_changeset: 40038a66525f454aadc0f887bae55c6a60ef7290 04:19:20 INFO - mozversion INFO | application_display_name: Nightly 04:19:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:19:20 INFO - mozversion INFO | application_name: Firefox 04:19:20 INFO - mozversion INFO | application_remotingname: firefox 04:19:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:19:20 INFO - mozversion INFO | application_vendor: Mozilla 04:19:20 INFO - mozversion INFO | application_version: 46.0a1 04:19:20 INFO - mozversion INFO | platform_buildid: 20151216025907 04:19:20 INFO - mozversion INFO | platform_changeset: 40038a66525f454aadc0f887bae55c6a60ef7290 04:19:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:19:20 INFO - mozversion INFO | platform_version: 46.0a1 04:19:20 INFO - 2015-12-16 04:19:20,234 DEBUG : using testdate: 1450268360 04:19:20 INFO - 2015-12-16 04:19:20,234 DEBUG : actual date: 1450268360 04:19:20 INFO - 2015-12-16 04:19:20,243 INFO : starting webserver on 'localhost:51038' 04:19:20 INFO - 2015-12-16 04:19:20,244 INFO : Starting test suite talos-linux64-ix-033 04:19:20 INFO - 2015-12-16 04:19:20,245 INFO : Starting test dromaeo_css 04:19:20 INFO - 2015-12-16 04:19:20,245 DEBUG : operating with platform_type : linux_ 04:19:20 INFO - 2015-12-16 04:19:20,245 INFO : Initialising browser for dromaeo_css test... 04:19:20 INFO - 2015-12-16 04:19:20,262 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Ej2PG/profile http://localhost:51038/getInfo.html 04:19:25 INFO - 2015-12-16 04:19:25,417 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:19:25 INFO - 2015-12-16 04:19:25,417 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:19:25 INFO - 2015-12-16 04:19:25,417 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:19:25 INFO - 2015-12-16 04:19:25,417 DEBUG : BROWSER_OUTPUT: __metrics 04:19:25 INFO - 2015-12-16 04:19:25,574 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:19:25 INFO - 2015-12-16 04:19:25,650 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:19:25 ERROR - 2015-12-16 04:19:25,794 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:19:26 INFO - 2015-12-16 04:19:26,933 INFO : Browser initialized. 04:19:26 INFO - 2015-12-16 04:19:26,934 INFO : Running cycle 1/1 for dromaeo_css test... 04:19:26 INFO - 2015-12-16 04:19:26,934 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Ej2PG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:19:38 INFO - 2015-12-16 04:19:38,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 142794752 04:19:38 INFO - 2015-12-16 04:19:38,944 DEBUG : BROWSER_OUTPUT: 04:20:30 INFO - 2015-12-16 04:20:30,223 DEBUG : BROWSER_OUTPUT: 1450268430220 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:22:42 INFO - 2015-12-16 04:22:42,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51038/tests/dromaeo/cssquery-ext.html) 04:22:43 INFO - 2015-12-16 04:22:43,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 238194688 04:22:43 INFO - 2015-12-16 04:22:43,879 DEBUG : BROWSER_OUTPUT: 04:25:46 INFO - 2015-12-16 04:25:46,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/dromaeo/cssquery-ext.html (next: http://localhost:51038/tests/dromaeo/cssquery-jquery.html) 04:25:47 INFO - 2015-12-16 04:25:47,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 227794944 04:25:47 INFO - 2015-12-16 04:25:47,034 DEBUG : BROWSER_OUTPUT: 04:28:49 INFO - 2015-12-16 04:28:49,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51038/tests/dromaeo/cssquery-mootools.html) 04:28:49 INFO - 2015-12-16 04:28:49,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 219885568 04:28:49 INFO - 2015-12-16 04:28:49,719 DEBUG : BROWSER_OUTPUT: 04:31:51 INFO - 2015-12-16 04:31:51,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51038/tests/dromaeo/cssquery-prototype.html) 04:31:52 INFO - 2015-12-16 04:31:52,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 206356480 04:31:52 INFO - 2015-12-16 04:31:52,228 DEBUG : BROWSER_OUTPUT: 04:34:54 INFO - 2015-12-16 04:34:54,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51038/tests/dromaeo/cssquery-yui.html) 04:34:55 INFO - 2015-12-16 04:34:55,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 208633856 04:34:55 INFO - 2015-12-16 04:34:55,557 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/dromaeo/cssquery-yui.html (next: http://localhost:51038/tests/dromaeo/cssquery-dojo.html) 04:37:58 INFO - 2015-12-16 04:37:58,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 274788352 04:37:58 INFO - 2015-12-16 04:37:58,473 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,473 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:37:58 INFO - 2015-12-16 04:37:58,473 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:37:58 INFO - 2015-12-16 04:37:58,473 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:37:58 INFO - 2015-12-16 04:37:58,473 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:37:58 INFO - 2015-12-16 04:37:58,474 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2626.9080582179627;2713.375923537585;2714.2535802654265;2728.4406696627193;2745.862706864656;4527.52460991596;4659.836905708301;4734.715917044975;4734.881627959303;4764.571188593026;4642;4647.395838540993;4722.031983443395;4740.3600513930605;4796.544328288807;4296.97851510742;4341.17517671643;4360.8255669773325;4369.6285815705705;4376.496702879162;4201.726887752302;4436.467623885138;4447.84432544861;4495.280755079188;4496.437945256843;4253.1706317267835;4317.417148684919;4356.912861742779;4363.65090792739;4365.759883206422;4387.736735795863;4397.582229688174;4400.11997600478;4406.933895991563;4450.065486247891;4369.781510924473;4370.366296886934;4376.3654270130655;4412.735235885825;4427.712198707074;4394.165108629382;4522.977385113087;4528.8867778305475;4542.863714088583;4640.535946405333;5071;5117.1556693145585;5123.1546794778815;5125.1799712045895;5163.096458119814;5119.641625086246;5122.641415100945;5134.666246693953;5140.922886156711;5145.742712864342;4528.411306530163;4633.166030114544;4633.397658304432;4696.671233013724;4826.6621336506105;5184.196449550326;5204.0632686116105;5205.479452054764;5213.374395072616;5226.294450249244;4987.526185012418;4988.376452943382;4990.700557966534;4995.650304478724;5034.194528875436;4823.589994850477;4915.852524424273;4928.950710492849;4939.382577177853;4943.406791185081;5042.092423363756;5073.518015788494;5082.440931497532;5100.591952643854;5108.438071812097;5030.874228144253;5039.748012599355;5052.797888084509;5053.7220452875445;5093.9745301274;4085.5710150433774;4200;4200.684948628804;4222.282212023963;4286.271333873249;3642.2533380657433;3733.0667333166707;3739.2521495700967;3746.9695833645965;3764.284785890672;4311.590398912098;4325.134973005412;4345.956540434619;4348.760818154969;4381.18947994622;4839.491853355417;4957.157283261854;5033.521815427529;5038.345015148007;5094.2358646203365;4212.347086201644;4276.508201556799;4288.206681763883;4305.182015417061;4329.740215587075;4464.843730469418;4465.687401881837;4471.262241730143;4483.282674772021;4513.9322910155715;4650.930236046394;4794.2808578712775;4801.68789028712;4803.759812009315;4861.076395484846;4946.455889852042;4998.625103117353;5006.173981293192;5037.319961805109;5053.469385714594;4804.95195048045;4806.303086052572;4809.110314591811;4819.6867203633055;4870.464248932543;5022.121128802518;5023.2716256143385;5024.321716568216;5027.245913112916;5027.3464449621315;4836.12949669063;4902.558769710743;4951.9752401237765;4961.231009193581;5136.9743151284;4884.7069175849565;4886.779471737369;4889.095517329305;4893.486183950634;4939.9259011114145;4859.878503037452;4860.92708609364;4863.3434486343895;4910.435299940553;4912.70523768575;4656.41794775653;4767.737774422301;4785;4802.567768900815;4838.806447742191;4976.776045077908;4984.352034235526;4988.4263309719845;5009.824656137018;5015.0220706963255;4865.927011094907;4866.78099485531;4872;4878.756062196947;4919.114559379346 04:37:58 INFO - 2015-12-16 04:37:58,474 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.5583600627517;576.1962062922223;578.1010528627987;586.5014737473147;591.1310373750586;27358.726412735865;35572.64427355726;36295.27409451816;36446.8177659112;36475.452868207;39366.60633393665;39766;39890.601093989055;39976.00179986498;39988;6957.5129740918155;7092.716291348365;7943.920560794405;8111.107778144399;8115.797105072362;10210.132138768213;10468.528916198751;10474.528646210938;10479.05688488036;10479.895201048006;10119.342242754197;10211.183105351554;10220.693379198636;10226.897731022706;10229.948850255738;7216.314450127229;7396.852062958765;10066.547005384775;10116.94941525295;10415.895841041569;9832.754181145458;10071;10082.9495852521;10084.596616135346;10090.34412763168;29545.852270738724;36706.44940325897;37129.628703712886;37230.81384593087;37263;2458.8278820482574;3071.293602471444;3602.477640742104;3775.226078653897;3876.9224615507815;26315.473690526083;26656.305220485996;26729.33176670599;26833;26903.05839295615;3032.757379409642;3123.984380078085;3168.2871353945407;3265.200025993623;3269.1336795749144;169485;170741.14629426898;171161;171194;171562;48322.650961413645;48800.5119948796;48924.75537622289;48929.755351223015;48932.75533622309;51789.223161652604;51914.22128668073;52016.43950681486;52045;52048.73975630097;12540.498380064877;12678.429470673842;12692.365381730877;12692.80960785589;12721.55474558386;9673.661421850202;9726.076022777825;9770.609175633037;9774.120329170266;9786.1192492676;16947.20371138773;17918.820811791975;18210.27158913655;18215.362462313755;18266.086695665428;7391.81520461982;7634.961825190839;7676.117246516722;7731.884021739678;7786.104597971306;839.0393000014949;842.8103676672822;889.902110767815;968.5012218707371;997.5511020040866;25956;26492.47015059688;26589.202323930313;26599.468010639677;26617.600735988977;874.873143394217;931.6630635038741;960.3853533738413;976.7216343342113;993.9453330066771;13023.348832558335;13427.731445371039;13430.899783148947;13621.727565448635;13705.588832335046;255983;260251;260284;260731;260752;37353;37977.81011094927;37991.62008379936;38003.80998094992;45373.092538149715;1157.548556063136;1180.3298332858908;1184.1119160629528;1185.1703807335073;1188.5424111717052;25026.249212523653;25326;25650.8717456419;26195.345116372242;26709.332266693487;35465;35794;36620.81689591535;36674.44988325124;36904.815475923526;247803;253396;254369;254489;254549;25631.743682562937;26005;26031;26033.869830650725;26072.34819129537;35165.82417087898;35172.472412914336;35441.64558354383;35775.46336804898;36004.639953600126;30154.69845301519;31295.687043129277;32485;33235.66764332326;36125.81937090403;31232.843835780677;31374.843125784224;31591.21021974469;31797.682023179474;31885.20286992751;30950;31492.527612086295;31649.8417507911;31676.841615791775;31706.682933170374;27070;27106.457870842867;28575.571366429103;28813.27966800847;28843.42313153767;22425.887870560542;22489.550208996057;22657.773422265567;22813.31560053201;22820.543589128458 04:37:58 INFO - 2015-12-16 04:37:58,474 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.79760346188823;337.66739761335083;338.9711874490668;339.42636943565356;342.0900404922904;12082.69793255167;12525.185862918905;14442.494512692045;14893.52198792042;15699.52901412958;9911.108000279974;10202.489875506231;10218.693439196817;14735.92632036841;15167.848321516782;4420.314851198062;4555.04344087742;4562.931556026662;4563.201439748047;4563.361129441864;3265.75506836987;3388.542546756193;5142.640015198937;5272.499112584298;5326.041312563737;5196.480351964811;5283.101872681634;5285;5300.0459917214885;5310.522053015228;5813.517553023973;5820.621659592113;5840.299164100293;5852.502537284336;5853.414658534155;5019.096562618727;5127.743612819381;5151.871203219912;5168.095583272912;5172;19146.71279930802;19259.61480770377;19601.21595136193;19614.90192549028;19659.508512287306;1824.6989246774267;1845.723141528768;1847.5750577367146;1856.3873921605837;1967.2917749610128;8845.778855528599;8926.553672316359;8977.610461660379;8989.280857531381;9136.406133601295;1702.8978261304237;1769.265754711793;1778.8399044086095;1802.3961972739016;1804.1340156724714;54297;56881.71559142178;57406;57632;57991.71004144952;9318.114779095975;9370.344075914756;9434.481103539234;9464.574094165642;9508.144267015863;11813.645590632295;11902.464389102512;11913.344766037777;11914.880851191378;11916.404179790976;6415.775447859302;6605.1083103780375;6789.93210067893;6797.1843378794865;6843.3840954314355;5964.254468191476;5999.880002399927;6000.21997140369;6056.818295451144;6061.090836374491;3847.5960024197616;3929.8035098244973;3940.5468371137113;3989.341758609855;4080.8571699990953;1571.1437266689682;1646.3414634146436;1649.8734897369418;1675.3549883294775;1678.5048410718866;794.9364050875917;822.0792712162297;845.1632883445468;846.7096503956782;951.0822056715165;12774.552890648783;14899.180545069908;15240.542783716506;16067.196640167946;16352.918235408746;818.0224631565222;840.8528507511161;849;852.26705033671;870.7257213977576;8629.956850215834;8862.822743545094;8948.910510894937;8958.10418958112;8986.46081235115;417279;419497;425452;427616;427688;64160;66544.33455665382;67576.66211669009;68146;69166.04207265317;982.9262805289488;995.0397866059143;1034.4569101221769;1071.45891324882;1075.575147816608;13818.239996800272;14643.633909152357;14817.777733333793;14868.405263789327;15062.397504099714;33126.83436582898;33391.83304083464;33529.83235083809;33804.492932605535;34089.659103408645;42485.36271955985;44252;45176;45343.7732811347;46512;8722.258608018135;8835.646574136963;8957.910420895969;8963.148500892405;9044.41211321262;15901.840981590498;16123.435679751152;16303.510894673178;16453.25960331764;16651;13542.526011589547;13655.726885462434;13786.517471888435;13833.079971091944;14094;9040.276777857887;9291.953540232256;13502.527411540548;13535.932320338336;13845;8144.83710325802;8328;9494.632469064309;9521.143097121292;9707.320487566085;13733.381997810322;13736.175829450265;14233.43798116349;14706.117632942058;14741.262936853329;9133.40632858862;15216.695666086394;15381.077135371914;15902.920485397499;15935.760963585324 04:37:58 INFO - 2015-12-16 04:37:58,474 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1443.0908527627594;1656.7680524726536;1718.6047209141898;1732.6274850907052;1751.2819743905002;6169.537284703649;7260.673269702863;7325.963370183142;7386.667599958001;7388.556686598801;7244.0582724245905;7261.673224704888;7273.38176255019;7340.669669864856;7345.632718364087;1731.2122984042294;2054.188595504771;2083.854130210886;2083.8853863037525;2083.906224219914;1767.8320559546887;2006.829419499337;2068.317455239775;2069.2033567076633;2074.408793493855;1991.2831380702935;1994.8902810345426;2003.6794112941932;2003.7996200379991;2065.6694928811394;2057.639913015224;2087.2798884385015;2087.5824835032977;2096.0986775686374;2098.6012657595006;2044.1823270691693;2097.4966008158085;2101.0860275780083;2101.558672678739;2101.674240492726;7347.044884165024;7378.55728656277;7418.146913105008;7464.104307483137;7477.140128885193;4292.098659281554;4372.256716358227;4378.605925466692;4383.276759334706;4397.846075387346;2657.402084530984;2661.308059904419;2664.9600255996174;2689.4486630240754;2698.730126987305;773.9883901741479;794.4557977785236;801.7314199743093;809.7004108479841;815.1237419773707;9999.950000250024;10027.147692446079;10074.647387341407;10093;10093.747656308578;3903.863364782219;3955.6835453163676;4004.01901534126;4005.679545636342;4017.1563971565715;8734.956325218332;8752.51861147643;8757.430767000125;8761.474311541328;8762;4331.1337732453;4351.781501179675;4371.038371558252;4392.846250381222;4409.845655402046;3976.880693579197;3977.6420122188565;3978.42312864633;3980.0646847990697;3987.940180897289;2878.625778648762;2995.9101226963226;3277.6722327767034;3350.8492117854753;3378.1048022274117;1053.4048262731533;1064.9414282214552;1065.7069305940772;1067.0503252105632;1069.3316677076828;962.1148543340004;963.9710808675751;997.8453339732353;1052.347544522401;1237.047473445442;6939.653017349214;7011.298870112948;7013.754518591825;7014.964925175342;7019.5086343956455;963.1620490173594;965.35803690545;965.971020869375;1028.9794204116026;1045.0281238448165;5252.789888404497;5354.812581559627;5365.678059316453;5400.081986062379;5407.837764866981;7659.655315510815;7684.231576842383;7883.684652613946;7915;8029.156938521372;7870.921290787133;7879.093904200976;7886.684532618746;7890.842183156305;7937.722179723797;6275.3724627536885;6363.140975968277;6380.425761681471;6404.775832845921;6454.903176452357;6136.509079273558;6139.508839292936;6145.231846019247;6146.200993870768;6160.876782464416;6986.126734158231;7097.503174777716;7246.202917679157;7251.601161935933;7313;7335.193128755725;7355.521891077063;7425.034745483053;7440.55356678601;7456.96271518639;6113.938860611337;6135.294441139326;6137.202163718688;6152.876942461036;6173.9073913892225;5602.2717046783655;5962.701864906824;6359.682015899094;6401.167848179894;6428.292887782433;6603.471722262304;6616.669166541557;6656.966715166587;6660.400563949268;6791;6198.938010619836;6286.402791734778;6360.809175724736;6365.077063825626;6381.712822923072;6621.205455345389;6625.569337993015;6635.270120286861;6695.263521012587;6697.330266973264;6071.3625069368845;6092.238470191226;6093.878122437615;6140.938590614037;6176.598521096114;5985.700714964321;6079.939200608114;6116.418940200674;6156.722947467464;6349.460295874902 04:37:58 INFO - 2015-12-16 04:37:58,474 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.8786897372077;301.9048999565137;304.0740943826049;308.9536569514573;310.16565438969184;5276.129438642624;5326.520613144816;5332.066888294543;5361.651492652984;5363.785448582052;5023.346964894558;5129.0767661820855;5177.870553236171;5240.292560504331;5283.577313814895;4087.9591204088024;4089.284375234337;4104.322786740185;4108.938365924513;4115.382692596119;3882;4079.8368065277355;4092.0588264699136;4102.671786257107;4112.2186784511;3926.155876486555;3987.8604248851298;4072.6131017553284;4079.5104587449546;4107.7535347879075;4079.4492743479545;4089.9386509202386;4094.9181016379653;4097.364908439196;4104.261232978063;3587.7667951583326;3595.7662751921303;3598.3702852000797;3601.279744051174;3605.8197090145386;5030.798768049311;5056.418511871108;5064.442911279793;5070.706969722734;5075.390953085616;4602.723836569817;4681.672282940195;4704.670673052888;4705.411823522059;4709.811607535695;5511.759854032851;5531.225628412026;5549.250851135085;5554.861128471821;5559.58303127263;3900.64894159527;3906.5312162540677;3906.867008567512;3908.355121404965;3910.569837317893;5818.854528636775;5828.854278643025;5835.066389377722;5840.883182336372;5848.239728835224;3941.625545573166;4021.2962731521866;4051.2707712611423;4056.1684854605323;4066.207089617496;4100.610442008005;4107.507099148122;4108.424820525129;4110.568390319033;4117.464729585195;4674.415698037746;4675.2052151134385;4681;4693.741844198602;4698.436187657503;5572.442755724395;5578.135389014628;5582.0789569721355;5584.441555844383;5586.720663966786;1374.3746595299115;1427.757281262188;1435.9353829077716;1457.6210185351886;1457.7521821290406;936.6908920056501;957.9042095790365;960.0543464687278;970.7961328121173;971.5919313888184;4787.736674482937;4789.904201915942;4808.8797780055775;4809.78355973975;4815.783289751969;5638.069718496402;5687.40282270364;5700.629459085146;5728.684922329228;5732.426757324318;4723.149833030087;4783.760811959388;4852.126617208936;4862.586680132228;4865.343178670834;3101.8293993830557;3118.937621247562;3123.7813353065067;3133.3576616793503;3135.6550779414247;5490.094134467848;5492.0663487206475;5499.285092937973;5502.752376143083;5503.724813759296;5962.135490353874;5965.522758179335;5970.283565972111;5971.462568368867;5971.492423144082;5374.785008599612;5522.447755224445;5526.723663816793;5540.612157148961;5541.168824676331;5844.766209351578;5845.152452894222;5853.326867410132;5858.150568167677;5863.325717542367;5631.802886899103;5691.117876729114;5692.060809966475;5710.457506536873;5718.085106382959;5315.893682126259;5524.254225679642;5529.695866727368;5531.2532808072;5534.723263836872;3924.6860251179264;3937.625925537069;3939.5469521005452;3942.901427464222;3943.921121577495;5786.884262314646;5787.565932554991;5825.970870145622;5827.94172058274;5830.62100963436;5596.916046259228;5608.355039170548;5608.831735047955;5610;5612.522935550524;5463;5587.329520457572;5606.635568688022;5607.214989901336;5609;5509.47659972302;5518.392976772632;5522.088855338824;5523.613347065667;5528.834134975958;5670.744816483186;5671.291088613923;5677;5681.346645135863;5682.744276507485;5411;5523.25436066142;5527.751251193626;5530.861728456821;5544.556435485232 04:37:58 INFO - 2015-12-16 04:37:58,474 DEBUG : BROWSER_OUTPUT: |5;yui.html;748.8614606297836;755.6033082631616;771.4985259581272;807.4751411582474;820.9958950205248;12837.42231599578;13118.34408279587;13118.7376252475;13120.081594288404;13152.934235328834;13837.031407801433;13855.930720346385;13903.443862245524;13925.93037034816;13955.790663140036;627.5638431290255;636.9681515924209;786.0842118931438;809.3969992355703;812.8780682897553;788.7909703928464;799.940004499662;807.9313258373045;808.107041718901;809.6558962440939;802.7310850864967;842.8988521377444;847.559269180026;854.1202561361777;854.3891117850735;654.5320096131265;667.649484020888;823.045267489715;837.0875745437442;841.6633346661323;618.0235228339213;619.662284055191;620.3827191944044;620.6245221640887;620.9285932117774;11981.341026243554;12023.63929082129;12071.215371000944;12154.635360939186;12168.452419641137;10517.421541815198;11102.111831053577;11244.437778111062;11321.037711794508;11380.658580242523;9414.717558473258;9441.952790236004;9512.904870951272;9642.228621710317;9755.12203901645;3183.602049743782;3224.6134162310195;3253.7722359434847;3291.062047316503;3297.3075654112663;40059;40401.79799101015;40646.187076258306;40676.59323406787;40914.386284205466;9202.35583509148;9293.070692930653;9314.86027709585;9356.485393303297;9358.11097945694;15775.684486310209;15782.36870525189;15808.68382632341;15898.920505397631;15924;6259.937400626027;6302.306746257908;6320.304766475684;6343.746250150035;6503;3482.407990641597;3509.2455122148863;3563.6436356364156;3586.103474131467;3590.120420496995;2619.895204191849;2654.110872857614;2682.7585517303537;2693.9191824245304;2695.1644990053146;458.6468419317174;464.8977225010492;473.57378359476746;476.51395576511766;479.9928001079987;505.2698850161481;533.8398480455847;594.8650611278624;626.5457543281085;633.0978355842998;7963.163867793798;8708.78228044304;8826.735197944072;8831.072737362485;8923.776905577413;501.38079471852234;502.88861615829427;519.4467891695332;582.2692520886345;644.5391545045316;3421.4354631486026;3732.309522738302;3881.2431575843;3955.367141257385;3961.1087505311652;49945.500544994815;50316.74841625769;50363.748181259594;50384.49615503798;50489;43399.78300108479;44033.77983110064;44039.33940990888;44361.77819110884;44478.33282500765;39779.80110099431;40090.19819603592;40355.59644403577;40875.386869196984;41449.79275103605;7560.714678504777;7671;7759.844803103793;7931.524108553505;8858.247049000907;30656;31254.53118203183;31313.217169570944;31323.84338078295;32299.51550726788;42203.1559368817;42697.146057079306;42993.140137197704;43212.13575728531;43411.78294108509;10791.6222932197;10868.78262434731;10904.291221070922;11021;11035.006849383593;11273.492692828679;11480.253783504046;11535.480903359537;11594.188406811441;11606.071514279007;10856.131509479064;10883.67348979532;11071.612493562687;11302.265352752045;11408.657740267805;10882.455877206266;11042;11348.773024539298;11462.369569673749;11680.591179308683;10824.945875270574;11123.165762568002;11190.720231994264;11238;11307.830382544433;9148.833675177319;9426.81146377055;9557;9717.22262219035;9861.852072218779;8785.253253473526;9584.28117891147;9588.472634004918;9852.950735246279;9871.50642467888 04:37:58 INFO - 2015-12-16 04:37:58,474 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:37:58 INFO - 2015-12-16 04:37:58,474 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:37:58 INFO - 2015-12-16 04:37:58,475 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,824 04:37:58 INFO - 2015-12-16 04:37:58,475 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:37:58 INFO - 2015-12-16 04:37:58,475 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269478466__endTimestamp 04:37:58 INFO - 2015-12-16 04:37:58,475 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,475 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:37:58 INFO - 2015-12-16 04:37:58,475 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:37:58 INFO - 2015-12-16 04:37:58,475 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,475 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4658.55 Median:4804.95 stddev:484.76 (10.1%) stddev-sans-first:459.30 04:37:58 INFO - 2015-12-16 04:37:58,477 DEBUG : BROWSER_OUTPUT: Values: 2626.9 2713.4 2714.3 2728.4 2745.9 4527.5 4659.8 4734.7 4734.9 4764.6 4642.0 4647.4 4722.0 4740.4 4796.5 4297.0 4341.2 4360.8 4369.6 4376.5 4201.7 4436.5 4447.8 4495.3 4496.4 4253.2 4317.4 4356.9 4363.7 4365.8 4387.7 4397.6 4400.1 4406.9 4450.1 4369.8 4370.4 4376.4 4412.7 4427.7 4394.2 4523.0 4528.9 4542.9 4640.5 5071.0 5117.2 5123.2 5125.2 5163.1 5119.6 5122.6 5134.7 5140.9 5145.7 4528.4 4633.2 4633.4 4696.7 4826.7 5184.2 5204.1 5205.5 5213.4 5226.3 4987.5 4988.4 4990.7 4995.7 5034.2 4823.6 4915.9 4929.0 4939.4 4943.4 5042.1 5073.5 5082.4 5100.6 5108.4 5030.9 5039.7 5052.8 5053.7 5094.0 4085.6 4200.0 4200.7 4222.3 4286.3 3642.3 3733.1 3739.3 3747.0 3764.3 4311.6 4325.1 4346.0 4348.8 4381.2 4839.5 4957.2 5033.5 5038.3 5094.2 4212.3 4276.5 4288.2 4305.2 4329.7 4464.8 4465.7 4471.3 4483.3 4513.9 4650.9 4794.3 4801.7 4803.8 4861.1 4946.5 4998.6 5006.2 5037.3 5053.5 4805.0 4806.3 4809.1 4819.7 4870.5 5022.1 5023.3 5024.3 5027.2 5027.3 4836.1 4902.6 4952.0 4961.2 5137.0 4884.7 4886.8 4889.1 4893.5 4939.9 4859.9 4860.9 4863.3 4910.4 4912.7 4656.4 4767.7 4785.0 4802.6 4838.8 4976.8 4984.4 4988.4 5009.8 5015.0 4865.9 4866.8 4872.0 4878.8 4919.1 04:37:58 INFO - 2015-12-16 04:37:58,477 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,477 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38201.83 Median:31264.27 stddev:60190.05 (192.5%) stddev-sans-first:60292.58 04:37:58 INFO - 2015-12-16 04:37:58,477 DEBUG : BROWSER_OUTPUT: Values: 573.6 576.2 578.1 586.5 591.1 27358.7 35572.6 36295.3 36446.8 36475.5 39366.6 39766.0 39890.6 39976.0 39988.0 6957.5 7092.7 7943.9 8111.1 8115.8 10210.1 10468.5 10474.5 10479.1 10479.9 10119.3 10211.2 10220.7 10226.9 10229.9 7216.3 7396.9 10066.5 10116.9 10415.9 9832.8 10071.0 10082.9 10084.6 10090.3 29545.9 36706.4 37129.6 37230.8 37263.0 2458.8 3071.3 3602.5 3775.2 3876.9 26315.5 26656.3 26729.3 26833.0 26903.1 3032.8 3124.0 3168.3 3265.2 3269.1 169485.0 170741.1 171161.0 171194.0 171562.0 48322.7 48800.5 48924.8 48929.8 48932.8 51789.2 51914.2 52016.4 52045.0 52048.7 12540.5 12678.4 12692.4 12692.8 12721.6 9673.7 9726.1 9770.6 9774.1 9786.1 16947.2 17918.8 18210.3 18215.4 18266.1 7391.8 7635.0 7676.1 7731.9 7786.1 839.0 842.8 889.9 968.5 997.6 25956.0 26492.5 26589.2 26599.5 26617.6 874.9 931.7 960.4 976.7 993.9 13023.3 13427.7 13430.9 13621.7 13705.6 255983.0 260251.0 260284.0 260731.0 260752.0 37353.0 37977.8 37991.6 38003.8 45373.1 1157.5 1180.3 1184.1 1185.2 1188.5 25026.2 25326.0 25650.9 26195.3 26709.3 35465.0 35794.0 36620.8 36674.4 36904.8 247803.0 253396.0 254369.0 254489.0 254549.0 25631.7 26005.0 26031.0 26033.9 26072.3 35165.8 35172.5 35441.6 35775.5 36004.6 30154.7 31295.7 32485.0 33235.7 36125.8 31232.8 31374.8 31591.2 31797.7 31885.2 30950.0 31492.5 31649.8 31676.8 31706.7 27070.0 27106.5 28575.6 28813.3 28843.4 22425.9 22489.6 22657.8 22813.3 22820.5 04:37:58 INFO - 2015-12-16 04:37:58,477 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,477 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24410.59 Median:427652.00 stddev:69268.08 (16.2%) stddev-sans-first:69438.80 04:37:58 INFO - 2015-12-16 04:37:58,477 DEBUG : BROWSER_OUTPUT: Values: 331.8 337.7 339.0 339.4 342.1 12082.7 12525.2 14442.5 14893.5 15699.5 9911.1 10202.5 10218.7 14735.9 15167.8 4420.3 4555.0 4562.9 4563.2 4563.4 3265.8 3388.5 5142.6 5272.5 5326.0 5196.5 5283.1 5285.0 5300.0 5310.5 5813.5 5820.6 5840.3 5852.5 5853.4 5019.1 5127.7 5151.9 5168.1 5172.0 19146.7 19259.6 19601.2 19614.9 19659.5 1824.7 1845.7 1847.6 1856.4 1967.3 8845.8 8926.6 8977.6 8989.3 9136.4 1702.9 1769.3 1778.8 1802.4 1804.1 54297.0 56881.7 57406.0 57632.0 57991.7 9318.1 9370.3 9434.5 9464.6 9508.1 11813.6 11902.5 11913.3 11914.9 11916.4 6415.8 6605.1 6789.9 6797.2 6843.4 5964.3 5999.9 6000.2 6056.8 6061.1 3847.6 3929.8 3940.5 3989.3 4080.9 1571.1 1646.3 1649.9 1675.4 1678.5 794.9 822.1 845.2 846.7 951.1 12774.6 14899.2 15240.5 16067.2 16352.9 818.0 840.9 849.0 852.3 870.7 8630.0 8862.8 8948.9 8958.1 8986.5 417279.0 419497.0 425452.0 427616.0 427688.0 64160.0 66544.3 67576.7 68146.0 69166.0 982.9 995.0 1034.5 1071.5 1075.6 13818.2 14643.6 14817.8 14868.4 15062.4 33126.8 33391.8 33529.8 33804.5 34089.7 42485.4 44252.0 45176.0 45343.8 46512.0 8722.3 8835.6 8957.9 8963.1 9044.4 15901.8 16123.4 16303.5 16453.3 16651.0 13542.5 13655.7 13786.5 13833.1 14094.0 9040.3 9292.0 13502.5 13535.9 13845.0 8144.8 8328.0 9494.6 9521.1 9707.3 13733.4 13736.2 14233.4 14706.1 14741.3 9133.4 15216.7 15381.1 15902.9 15935.8 04:37:58 INFO - 2015-12-16 04:37:58,477 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,478 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4952.63 Median:6140.22 stddev:2555.52 (41.6%) stddev-sans-first:2549.07 04:37:58 INFO - 2015-12-16 04:37:58,479 DEBUG : BROWSER_OUTPUT: Values: 1443.1 1656.8 1718.6 1732.6 1751.3 6169.5 7260.7 7326.0 7386.7 7388.6 7244.1 7261.7 7273.4 7340.7 7345.6 1731.2 2054.2 2083.9 2083.9 2083.9 1767.8 2006.8 2068.3 2069.2 2074.4 1991.3 1994.9 2003.7 2003.8 2065.7 2057.6 2087.3 2087.6 2096.1 2098.6 2044.2 2097.5 2101.1 2101.6 2101.7 7347.0 7378.6 7418.1 7464.1 7477.1 4292.1 4372.3 4378.6 4383.3 4397.8 2657.4 2661.3 2665.0 2689.4 2698.7 774.0 794.5 801.7 809.7 815.1 10000.0 10027.1 10074.6 10093.0 10093.7 3903.9 3955.7 4004.0 4005.7 4017.2 8735.0 8752.5 8757.4 8761.5 8762.0 4331.1 4351.8 4371.0 4392.8 4409.8 3976.9 3977.6 3978.4 3980.1 3987.9 2878.6 2995.9 3277.7 3350.8 3378.1 1053.4 1064.9 1065.7 1067.1 1069.3 962.1 964.0 997.8 1052.3 1237.0 6939.7 7011.3 7013.8 7015.0 7019.5 963.2 965.4 966.0 1029.0 1045.0 5252.8 5354.8 5365.7 5400.1 5407.8 7659.7 7684.2 7883.7 7915.0 8029.2 7870.9 7879.1 7886.7 7890.8 7937.7 6275.4 6363.1 6380.4 6404.8 6454.9 6136.5 6139.5 6145.2 6146.2 6160.9 6986.1 7097.5 7246.2 7251.6 7313.0 7335.2 7355.5 7425.0 7440.6 7457.0 6113.9 6135.3 6137.2 6152.9 6173.9 5602.3 5962.7 6359.7 6401.2 6428.3 6603.5 6616.7 6657.0 6660.4 6791.0 6198.9 6286.4 6360.8 6365.1 6381.7 6621.2 6625.6 6635.3 6695.3 6697.3 6071.4 6092.2 6093.9 6140.9 6176.6 5985.7 6079.9 6116.4 6156.7 6349.5 04:37:58 INFO - 2015-12-16 04:37:58,479 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,479 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4627.05 Median:5299.74 stddev:1364.15 (25.7%) stddev-sans-first:1328.68 04:37:58 INFO - 2015-12-16 04:37:58,480 DEBUG : BROWSER_OUTPUT: Values: 295.9 301.9 304.1 309.0 310.2 5276.1 5326.5 5332.1 5361.7 5363.8 5023.3 5129.1 5177.9 5240.3 5283.6 4088.0 4089.3 4104.3 4108.9 4115.4 3882.0 4079.8 4092.1 4102.7 4112.2 3926.2 3987.9 4072.6 4079.5 4107.8 4079.4 4089.9 4094.9 4097.4 4104.3 3587.8 3595.8 3598.4 3601.3 3605.8 5030.8 5056.4 5064.4 5070.7 5075.4 4602.7 4681.7 4704.7 4705.4 4709.8 5511.8 5531.2 5549.3 5554.9 5559.6 3900.6 3906.5 3906.9 3908.4 3910.6 5818.9 5828.9 5835.1 5840.9 5848.2 3941.6 4021.3 4051.3 4056.2 4066.2 4100.6 4107.5 4108.4 4110.6 4117.5 4674.4 4675.2 4681.0 4693.7 4698.4 5572.4 5578.1 5582.1 5584.4 5586.7 1374.4 1427.8 1435.9 1457.6 1457.8 936.7 957.9 960.1 970.8 971.6 4787.7 4789.9 4808.9 4809.8 4815.8 5638.1 5687.4 5700.6 5728.7 5732.4 4723.1 4783.8 4852.1 4862.6 4865.3 3101.8 3118.9 3123.8 3133.4 3135.7 5490.1 5492.1 5499.3 5502.8 5503.7 5962.1 5965.5 5970.3 5971.5 5971.5 5374.8 5522.4 5526.7 5540.6 5541.2 5844.8 5845.2 5853.3 5858.2 5863.3 5631.8 5691.1 5692.1 5710.5 5718.1 5315.9 5524.3 5529.7 5531.3 5534.7 3924.7 3937.6 3939.5 3942.9 3943.9 5786.9 5787.6 5826.0 5827.9 5830.6 5596.9 5608.4 5608.8 5610.0 5612.5 5463.0 5587.3 5606.6 5607.2 5609.0 5509.5 5518.4 5522.1 5523.6 5528.8 5670.7 5671.3 5677.0 5681.3 5682.7 5411.0 5523.3 5527.8 5530.9 5544.6 04:37:58 INFO - 2015-12-16 04:37:58,480 DEBUG : BROWSER_OUTPUT: 04:37:58 INFO - 2015-12-16 04:37:58,480 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12553.24 Median:43722.78 stddev:13990.67 (32.0%) stddev-sans-first:14001.83 04:37:58 INFO - 2015-12-16 04:37:58,481 DEBUG : BROWSER_OUTPUT: Values: 748.9 755.6 771.5 807.5 821.0 12837.4 13118.3 13118.7 13120.1 13152.9 13837.0 13855.9 13903.4 13925.9 13955.8 627.6 637.0 786.1 809.4 812.9 788.8 799.9 807.9 808.1 809.7 802.7 842.9 847.6 854.1 854.4 654.5 667.6 823.0 837.1 841.7 618.0 619.7 620.4 620.6 620.9 11981.3 12023.6 12071.2 12154.6 12168.5 10517.4 11102.1 11244.4 11321.0 11380.7 9414.7 9442.0 9512.9 9642.2 9755.1 3183.6 3224.6 3253.8 3291.1 3297.3 40059.0 40401.8 40646.2 40676.6 40914.4 9202.4 9293.1 9314.9 9356.5 9358.1 15775.7 15782.4 15808.7 15898.9 15924.0 6259.9 6302.3 6320.3 6343.7 6503.0 3482.4 3509.2 3563.6 3586.1 3590.1 2619.9 2654.1 2682.8 2693.9 2695.2 458.6 464.9 473.6 476.5 480.0 505.3 533.8 594.9 626.5 633.1 7963.2 8708.8 8826.7 8831.1 8923.8 501.4 502.9 519.4 582.3 644.5 3421.4 3732.3 3881.2 3955.4 3961.1 49945.5 50316.7 50363.7 50384.5 50489.0 43399.8 44033.8 44039.3 44361.8 44478.3 39779.8 40090.2 40355.6 40875.4 41449.8 7560.7 7671.0 7759.8 7931.5 8858.2 30656.0 31254.5 31313.2 31323.8 32299.5 42203.2 42697.1 42993.1 43212.1 43411.8 10791.6 10868.8 10904.3 11021.0 11035.0 11273.5 11480.3 11535.5 11594.2 11606.1 10856.1 10883.7 11071.6 11302.3 11408.7 10882.5 11042.0 11348.8 11462.4 11680.6 10824.9 11123.2 11190.7 11238.0 11307.8 9148.8 9426.8 9557.0 9717.2 9861.9 8785.3 9584.3 9588.5 9853.0 9871.5 04:37:58 INFO - 2015-12-16 04:37:58,481 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:37:58 INFO - 2015-12-16 04:37:58,481 DEBUG : BROWSER_OUTPUT: 04:37:59 INFO - 2015-12-16 04:37:59,345 INFO : Browser exited with error code: 0 04:37:59 INFO - 2015-12-16 04:37:59,363 INFO : Completed test dromaeo_css (00:18:39) 04:37:59 INFO - 2015-12-16 04:37:59,363 INFO : Starting test kraken 04:37:59 INFO - 2015-12-16 04:37:59,363 DEBUG : operating with platform_type : linux_ 04:37:59 INFO - 2015-12-16 04:37:59,363 INFO : Initialising browser for kraken test... 04:37:59 INFO - 2015-12-16 04:37:59,370 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVEfQ79/profile http://localhost:51038/getInfo.html 04:38:04 INFO - 2015-12-16 04:38:04,622 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:38:04 INFO - 2015-12-16 04:38:04,622 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:38:04 INFO - 2015-12-16 04:38:04,622 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:38:04 INFO - 2015-12-16 04:38:04,622 DEBUG : BROWSER_OUTPUT: __metrics 04:38:04 INFO - 2015-12-16 04:38:04,771 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:38:04 INFO - 2015-12-16 04:38:04,835 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:38:05 INFO - 2015-12-16 04:38:05,890 INFO : Browser initialized. 04:38:05 INFO - 2015-12-16 04:38:05,890 INFO : Running cycle 1/1 for kraken test... 04:38:05 INFO - 2015-12-16 04:38:05,891 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVEfQ79/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:38:17 INFO - 2015-12-16 04:38:17,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 142454784 04:38:17 INFO - 2015-12-16 04:38:17,920 DEBUG : BROWSER_OUTPUT: 04:38:20 INFO - 2015-12-16 04:38:20,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51038/tests/kraken/driver.html?testName=audio-beat-detection) 04:38:21 INFO - 2015-12-16 04:38:21,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 178057216 04:38:21 INFO - 2015-12-16 04:38:21,163 DEBUG : BROWSER_OUTPUT: 04:38:23 INFO - 2015-12-16 04:38:23,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51038/tests/kraken/driver.html?testName=audio-dft) 04:38:24 INFO - 2015-12-16 04:38:24,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 167055360 04:38:24 INFO - 2015-12-16 04:38:24,481 DEBUG : BROWSER_OUTPUT: 04:38:27 INFO - 2015-12-16 04:38:27,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51038/tests/kraken/driver.html?testName=audio-fft) 04:38:28 INFO - 2015-12-16 04:38:28,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 154112000 04:38:28 INFO - 2015-12-16 04:38:28,048 DEBUG : BROWSER_OUTPUT: 04:38:30 INFO - 2015-12-16 04:38:30,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51038/tests/kraken/driver.html?testName=audio-oscillator) 04:38:30 INFO - 2015-12-16 04:38:30,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 154468352 04:38:30 INFO - 2015-12-16 04:38:30,668 DEBUG : BROWSER_OUTPUT: 04:38:32 INFO - 2015-12-16 04:38:32,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51038/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:38:33 INFO - 2015-12-16 04:38:33,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 156803072 04:38:33 INFO - 2015-12-16 04:38:33,501 DEBUG : BROWSER_OUTPUT: 04:38:36 INFO - 2015-12-16 04:38:36,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51038/tests/kraken/driver.html?testName=imaging-darkroom) 04:38:37 INFO - 2015-12-16 04:38:37,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 157102080 04:38:37 INFO - 2015-12-16 04:38:37,112 DEBUG : BROWSER_OUTPUT: 04:38:40 INFO - 2015-12-16 04:38:40,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51038/tests/kraken/driver.html?testName=imaging-desaturate) 04:38:41 INFO - 2015-12-16 04:38:41,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 158457856 04:38:41 INFO - 2015-12-16 04:38:41,088 DEBUG : BROWSER_OUTPUT: 04:38:43 INFO - 2015-12-16 04:38:43,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51038/tests/kraken/driver.html?testName=json-parse-financial) 04:38:44 INFO - 2015-12-16 04:38:44,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 157581312 04:38:44 INFO - 2015-12-16 04:38:44,522 DEBUG : BROWSER_OUTPUT: 04:38:46 INFO - 2015-12-16 04:38:46,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51038/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:38:46 INFO - 2015-12-16 04:38:46,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 168751104 04:38:46 INFO - 2015-12-16 04:38:46,878 DEBUG : BROWSER_OUTPUT: 04:38:48 INFO - 2015-12-16 04:38:48,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51038/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:38:49 INFO - 2015-12-16 04:38:49,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 167841792 04:38:49 INFO - 2015-12-16 04:38:49,362 DEBUG : BROWSER_OUTPUT: 04:38:51 INFO - 2015-12-16 04:38:51,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51038/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:38:52 INFO - 2015-12-16 04:38:52,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 179060736 04:38:52 INFO - 2015-12-16 04:38:52,082 DEBUG : BROWSER_OUTPUT: 04:38:54 INFO - 2015-12-16 04:38:54,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:38:55 INFO - 2015-12-16 04:38:55,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 184672256 04:38:55 INFO - 2015-12-16 04:38:55,205 DEBUG : BROWSER_OUTPUT: 04:38:57 INFO - 2015-12-16 04:38:57,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:38:58 INFO - 2015-12-16 04:38:58,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 182050816 04:38:58 INFO - 2015-12-16 04:38:58,383 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51038/tests/kraken/driver.html?testName=ai-astar) 04:39:00 INFO - 2015-12-16 04:39:00,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 240185344 04:39:00 INFO - 2015-12-16 04:39:00,416 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,418 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:39:00 INFO - 2015-12-16 04:39:00,418 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:39:00 INFO - 2015-12-16 04:39:00,418 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:39:00 INFO - 2015-12-16 04:39:00,419 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:39:00 INFO - 2015-12-16 04:39:00,419 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;106;111;113;111;101;113;111;112 04:39:00 INFO - 2015-12-16 04:39:00,419 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;132;149;168;130;163;151;129;174;132 04:39:00 INFO - 2015-12-16 04:39:00,419 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;160;161;163;160;163;161;163;163 04:39:00 INFO - 2015-12-16 04:39:00,420 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;91;96;73;73;74;119;91;72 04:39:00 INFO - 2015-12-16 04:39:00,420 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;97;132;95;95;96;131;96;95;133 04:39:00 INFO - 2015-12-16 04:39:00,420 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;109;109;110;109 04:39:00 INFO - 2015-12-16 04:39:00,420 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;147 04:39:00 INFO - 2015-12-16 04:39:00,420 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 04:39:00 INFO - 2015-12-16 04:39:00,421 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;71;71;71;71;71;71;71;71;69 04:39:00 INFO - 2015-12-16 04:39:00,421 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;68;69;70;70;70;68 04:39:00 INFO - 2015-12-16 04:39:00,421 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;84;83;91;83;83;84;83;84 04:39:00 INFO - 2015-12-16 04:39:00,421 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;125;137;125;126;120;133;125;127;128 04:39:00 INFO - 2015-12-16 04:39:00,421 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;141;142;148;147;139;147;141;144;140 04:39:00 INFO - 2015-12-16 04:39:00,421 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;72;69;72;70;70;77;70;72 04:39:00 INFO - 2015-12-16 04:39:00,422 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:39:00 INFO - 2015-12-16 04:39:00,422 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:39:00 INFO - 2015-12-16 04:39:00,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 04:39:00 INFO - 2015-12-16 04:39:00,422 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:39:00 INFO - 2015-12-16 04:39:00,422 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269540417__endTimestamp 04:39:00 INFO - 2015-12-16 04:39:00,422 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.82 (3.4%) stddev-sans-first:4.04 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 106.0 111.0 113.0 111.0 101.0 113.0 111.0 112.0 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:154.50 stddev:17.01 (11.0%) stddev-sans-first:17.70 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: Values: 158.0 132.0 149.0 168.0 130.0 163.0 151.0 129.0 174.0 132.0 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 160.0 161.0 163.0 160.0 163.0 161.0 163.0 163.0 04:39:00 INFO - 2015-12-16 04:39:00,426 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.30 Median:73.50 stddev:15.76 (21.4%) stddev-sans-first:16.18 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 91.0 96.0 73.0 73.0 74.0 119.0 91.0 72.0 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:95.50 stddev:17.54 (18.4%) stddev-sans-first:18.19 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 132.0 95.0 95.0 96.0 131.0 96.0 95.0 133.0 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,427 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.00 Median:71.00 stddev:0.94 (1.3%) stddev-sans-first:0.67 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 71.0 71.0 71.0 71.0 71.0 71.0 71.0 69.0 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 68.0 69.0 70.0 70.0 70.0 68.0 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:2.51 (3.0%) stddev-sans-first:2.55 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 84.0 83.0 91.0 83.0 83.0 84.0 83.0 84.0 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:126.50 stddev:5.23 (4.1%) stddev-sans-first:4.97 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: Values: 120.0 125.0 137.0 125.0 126.0 120.0 133.0 125.0 127.0 128.0 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:143.00 stddev:4.12 (2.9%) stddev-sans-first:3.38 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: Values: 135.0 141.0 142.0 148.0 147.0 139.0 147.0 141.0 144.0 140.0 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2015-12-16 04:39:00,428 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:2.35 (3.3%) stddev-sans-first:2.49 04:39:00 INFO - 2015-12-16 04:39:00,429 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 72.0 69.0 72.0 70.0 70.0 77.0 70.0 72.0 04:39:00 INFO - 2015-12-16 04:39:00,429 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:39:00 INFO - 2015-12-16 04:39:00,429 DEBUG : BROWSER_OUTPUT: 04:39:01 INFO - 2015-12-16 04:39:01,449 INFO : Browser exited with error code: 0 04:39:01 INFO - 2015-12-16 04:39:01,505 INFO : Completed test kraken (00:01:02) 04:39:01 INFO - 2015-12-16 04:39:01,505 INFO : Starting test v8_7 04:39:01 INFO - 2015-12-16 04:39:01,506 DEBUG : operating with platform_type : linux_ 04:39:01 INFO - 2015-12-16 04:39:01,506 INFO : Initialising browser for v8_7 test... 04:39:01 INFO - 2015-12-16 04:39:01,512 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK7ExdU/profile http://localhost:51038/getInfo.html 04:39:07 INFO - 2015-12-16 04:39:07,061 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:39:07 INFO - 2015-12-16 04:39:07,061 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:39:07 INFO - 2015-12-16 04:39:07,061 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:39:07 INFO - 2015-12-16 04:39:07,061 DEBUG : BROWSER_OUTPUT: __metrics 04:39:07 INFO - 2015-12-16 04:39:07,230 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:39:07 INFO - 2015-12-16 04:39:07,298 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:39:07 ERROR - 2015-12-16 04:39:07,314 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:39:08 INFO - 2015-12-16 04:39:08,383 INFO : Browser initialized. 04:39:08 INFO - 2015-12-16 04:39:08,383 INFO : Running cycle 1/1 for v8_7 test... 04:39:08 INFO - 2015-12-16 04:39:08,383 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK7ExdU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:39:20 INFO - 2015-12-16 04:39:20,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 143212544 04:39:20 INFO - 2015-12-16 04:39:20,356 DEBUG : BROWSER_OUTPUT: 04:39:41 INFO - 2015-12-16 04:39:41,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51038/tests/v8_7/run.html (next: http://localhost:51038/tests/v8_7/run.html) 04:39:41 INFO - 2015-12-16 04:39:41,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 441319424 04:39:41 INFO - 2015-12-16 04:39:41,999 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,000 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:39:42 INFO - 2015-12-16 04:39:42,000 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:39:42 INFO - 2015-12-16 04:39:42,000 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:39:42 INFO - 2015-12-16 04:39:42,000 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:39:42 INFO - 2015-12-16 04:39:42,000 DEBUG : BROWSER_OUTPUT: |0;Richards;165.56291390728478 04:39:42 INFO - 2015-12-16 04:39:42,001 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.11576400521125 04:39:42 INFO - 2015-12-16 04:39:42,001 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 04:39:42 INFO - 2015-12-16 04:39:42,001 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 04:39:42 INFO - 2015-12-16 04:39:42,001 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1994.0239043824702 04:39:42 INFO - 2015-12-16 04:39:42,001 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 04:39:42 INFO - 2015-12-16 04:39:42,001 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 04:39:42 INFO - 2015-12-16 04:39:42,002 DEBUG : BROWSER_OUTPUT: |7;RegExp;27243.243243243243 04:39:42 INFO - 2015-12-16 04:39:42,002 DEBUG : BROWSER_OUTPUT: |8;Splay;597.379392495533 04:39:42 INFO - 2015-12-16 04:39:42,002 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 04:39:42 INFO - 2015-12-16 04:39:42,002 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:39:42 INFO - 2015-12-16 04:39:42,002 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269581998__endTimestamp 04:39:42 INFO - 2015-12-16 04:39:42,002 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,003 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:39:42 INFO - 2015-12-16 04:39:42,003 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:39:42 INFO - 2015-12-16 04:39:42,003 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,003 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.56 Median:165.56 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,003 DEBUG : BROWSER_OUTPUT: Values: 165.6 04:39:42 INFO - 2015-12-16 04:39:42,004 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,004 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.12 Median:186.12 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,004 DEBUG : BROWSER_OUTPUT: Values: 186.1 04:39:42 INFO - 2015-12-16 04:39:42,004 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,004 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,004 DEBUG : BROWSER_OUTPUT: Values: 279.3 04:39:42 INFO - 2015-12-16 04:39:42,004 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,004 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: Values: 5175.3 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: Values: 1994.0 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: Values: 789.3 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: Values: 12132.5 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,005 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27243.24 Median:27243.24 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,006 DEBUG : BROWSER_OUTPUT: Values: 27243.2 04:39:42 INFO - 2015-12-16 04:39:42,006 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,007 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.38 Median:597.38 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,007 DEBUG : BROWSER_OUTPUT: Values: 597.4 04:39:42 INFO - 2015-12-16 04:39:42,007 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,007 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:39:42 INFO - 2015-12-16 04:39:42,007 DEBUG : BROWSER_OUTPUT: Values: 4835.7 04:39:42 INFO - 2015-12-16 04:39:42,007 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:39:42 INFO - 2015-12-16 04:39:42,007 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-16 04:39:42,881 INFO : Browser exited with error code: 0 04:39:42 INFO - 2015-12-16 04:39:42,895 INFO : Completed test v8_7 (00:00:41) 04:39:43 INFO - 2015-12-16 04:39:43,036 INFO : Completed test suite (00:20:22) 04:39:43 INFO - 2015-12-16 04:39:43,037 DEBUG : Working with test: dromaeo_css 04:39:43 INFO - 2015-12-16 04:39:43,037 DEBUG : Generating results file: dromaeo_css 04:39:43 INFO - 2015-12-16 04:39:43,038 DEBUG : Working with test: kraken 04:39:43 INFO - 2015-12-16 04:39:43,038 DEBUG : Generating results file: kraken 04:39:43 INFO - 2015-12-16 04:39:43,038 INFO : javascript benchmark 04:39:43 INFO - 2015-12-16 04:39:43,038 DEBUG : Working with test: v8_7 04:39:43 INFO - 2015-12-16 04:39:43,038 DEBUG : Generating results file: v8_7 04:39:43 INFO - 2015-12-16 04:39:43,039 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:39:43 INFO - 2015-12-16 04:39:43,097 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:39:43 INFO - 2015-12-16 04:39:43,097 DEBUG : process_Request line: dromaeo_css 6282.97 graph.html#tests=[[72,94,35]] 04:39:43 INFO - 2015-12-16 04:39:43,097 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:39:43 INFO - 2015-12-16 04:39:43,135 DEBUG : process_Request line: kraken 1524.80 graph.html#tests=[[232,94,35]] 04:39:43 INFO - 2015-12-16 04:39:43,135 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:39:43 INFO - 2015-12-16 04:39:43,169 DEBUG : process_Request line: v8_7 19809.50 graph.html#tests=[[230,94,35]] 04:39:43 INFO - 2015-12-16 04:39:43,170 INFO : javascript benchmark 04:39:43 INFO - 2015-12-16 04:39:43,174 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2626.9080582179627, 2713.375923537585, 2714.2535802654265, 2728.4406696627193, 2745.862706864656, 4527.52460991596, 4659.836905708301, 4734.715917044975, 4734.881627959303, 4764.571188593026, 4642.0, 4647.395838540993, 4722.031983443395, 4740.3600513930605, 4796.544328288807, 4296.97851510742, 4341.17517671643, 4360.8255669773325, 4369.6285815705705, 4376.496702879162, 4201.726887752302, 4436.467623885138, 4447.84432544861, 4495.280755079188, 4496.437945256843, 4253.1706317267835, 4317.417148684919, 4356.912861742779, 4363.65090792739, 4365.759883206422, 4387.736735795863, 4397.582229688174, 4400.11997600478, 4406.933895991563, 4450.065486247891, 4369.781510924473, 4370.366296886934, 4376.3654270130655, 4412.735235885825, 4427.712198707074, 4394.165108629382, 4522.977385113087, 4528.8867778305475, 4542.863714088583, 4640.535946405333, 5071.0, 5117.1556693145585, 5123.1546794778815, 5125.1799712045895, 5163.096458119814, 5119.641625086246, 5122.641415100945, 5134.666246693953, 5140.922886156711, 5145.742712864342, 4528.411306530163, 4633.166030114544, 4633.397658304432, 4696.671233013724, 4826.6621336506105, 5184.196449550326, 5204.0632686116105, 5205.479452054764, 5213.374395072616, 5226.294450249244, 4987.526185012418, 4988.376452943382, 4990.700557966534, 4995.650304478724, 5034.194528875436, 4823.589994850477, 4915.852524424273, 4928.950710492849, 4939.382577177853, 4943.406791185081, 5042.092423363756, 5073.518015788494, 5082.440931497532, 5100.591952643854, 5108.438071812097, 5030.874228144253, 5039.748012599355, 5052.797888084509, 5053.7220452875445, 5093.9745301274, 4085.5710150433774, 4200.0, 4200.684948628804, 4222.282212023963, 4286.271333873249, 3642.2533380657433, 3733.0667333166707, 3739.2521495700967, 3746.9695833645965, 3764.284785890672, 4311.590398912098, 4325.134973005412, 4345.956540434619, 4348.760818154969, 4381.18947994622, 4839.491853355417, 4957.157283261854, 5033.521815427529, 5038.345015148007, 5094.2358646203365, 4212.347086201644, 4276.508201556799, 4288.206681763883, 4305.182015417061, 4329.740215587075, 4464.843730469418, 4465.687401881837, 4471.262241730143, 4483.282674772021, 4513.9322910155715, 4650.930236046394, 4794.2808578712775, 4801.68789028712, 4803.759812009315, 4861.076395484846, 4946.455889852042, 4998.625103117353, 5006.173981293192, 5037.319961805109, 5053.469385714594, 4804.95195048045, 4806.303086052572, 4809.110314591811, 4819.6867203633055, 4870.464248932543, 5022.121128802518, 5023.2716256143385, 5024.321716568216, 5027.245913112916, 5027.3464449621315, 4836.12949669063, 4902.558769710743, 4951.9752401237765, 4961.231009193581, 5136.9743151284, 4884.7069175849565, 4886.779471737369, 4889.095517329305, 4893.486183950634, 4939.9259011114145, 4859.878503037452, 4860.92708609364, 4863.3434486343895, 4910.435299940553, 4912.70523768575, 4656.41794775653, 4767.737774422301, 4785.0, 4802.567768900815, 4838.806447742191, 4976.776045077908, 4984.352034235526, 4988.4263309719845, 5009.824656137018, 5015.0220706963255, 4865.927011094907, 4866.78099485531, 4872.0, 4878.756062196947, 4919.114559379346], "unit": "score", "name": "dojo.html", "value": 4628.504419575286}, {"lowerIsBetter": false, "replicates": [573.5583600627517, 576.1962062922223, 578.1010528627987, 586.5014737473147, 591.1310373750586, 27358.726412735865, 35572.64427355726, 36295.27409451816, 36446.8177659112, 36475.452868207, 39366.60633393665, 39766.0, 39890.601093989055, 39976.00179986498, 39988.0, 6957.5129740918155, 7092.716291348365, 7943.920560794405, 8111.107778144399, 8115.797105072362, 10210.132138768213, 10468.528916198751, 10474.528646210938, 10479.05688488036, 10479.895201048006, 10119.342242754197, 10211.183105351554, 10220.693379198636, 10226.897731022706, 10229.948850255738, 7216.314450127229, 7396.852062958765, 10066.547005384775, 10116.94941525295, 10415.895841041569, 9832.754181145458, 10071.0, 10082.9495852521, 10084.596616135346, 10090.34412763168, 29545.852270738724, 36706.44940325897, 37129.628703712886, 37230.81384593087, 37263.0, 2458.8278820482574, 3071.293602471444, 3602.477640742104, 3775.226078653897, 3876.9224615507815, 26315.473690526083, 26656.305220485996, 26729.33176670599, 26833.0, 26903.05839295615, 3032.757379409642, 3123.984380078085, 3168.2871353945407, 3265.200025993623, 3269.1336795749144, 169485.0, 170741.14629426898, 171161.0, 171194.0, 171562.0, 48322.650961413645, 48800.5119948796, 48924.75537622289, 48929.755351223015, 48932.75533622309, 51789.223161652604, 51914.22128668073, 52016.43950681486, 52045.0, 52048.73975630097, 12540.498380064877, 12678.429470673842, 12692.365381730877, 12692.80960785589, 12721.55474558386, 9673.661421850202, 9726.076022777825, 9770.609175633037, 9774.120329170266, 9786.1192492676, 16947.20371138773, 17918.820811791975, 18210.27158913655, 18215.362462313755, 18266.086695665428, 7391.81520461982, 7634.961825190839, 7676.117246516722, 7731.884021739678, 7786.104597971306, 839.0393000014949, 842.8103676672822, 889.902110767815, 968.5012218707371, 997.5511020040866, 25956.0, 26492.47015059688, 26589.202323930313, 26599.468010639677, 26617.600735988977, 874.873143394217, 931.6630635038741, 960.3853533738413, 976.7216343342113, 993.9453330066771, 13023.348832558335, 13427.731445371039, 13430.899783148947, 13621.727565448635, 13705.588832335046, 255983.0, 260251.0, 260284.0, 260731.0, 260752.0, 37353.0, 37977.81011094927, 37991.62008379936, 38003.80998094992, 45373.092538149715, 1157.548556063136, 1180.3298332858908, 1184.1119160629528, 1185.1703807335073, 1188.5424111717052, 25026.249212523653, 25326.0, 25650.8717456419, 26195.345116372242, 26709.332266693487, 35465.0, 35794.0, 36620.81689591535, 36674.44988325124, 36904.815475923526, 247803.0, 253396.0, 254369.0, 254489.0, 254549.0, 25631.743682562937, 26005.0, 26031.0, 26033.869830650725, 26072.34819129537, 35165.82417087898, 35172.472412914336, 35441.64558354383, 35775.46336804898, 36004.639953600126, 30154.69845301519, 31295.687043129277, 32485.0, 33235.66764332326, 36125.81937090403, 31232.843835780677, 31374.843125784224, 31591.21021974469, 31797.682023179474, 31885.20286992751, 30950.0, 31492.527612086295, 31649.8417507911, 31676.841615791775, 31706.682933170374, 27070.0, 27106.457870842867, 28575.571366429103, 28813.27966800847, 28843.42313153767, 22425.887870560542, 22489.550208996057, 22657.773422265567, 22813.31560053201, 22820.543589128458], "unit": "score", "name": "ext.html", "value": 16531.846426660155}, {"lowerIsBetter": false, "replicates": [331.79760346188823, 337.66739761335083, 338.9711874490668, 339.42636943565356, 342.0900404922904, 12082.69793255167, 12525.185862918905, 14442.494512692045, 14893.52198792042, 15699.52901412958, 9911.108000279974, 10202.489875506231, 10218.693439196817, 14735.92632036841, 15167.848321516782, 4420.314851198062, 4555.04344087742, 4562.931556026662, 4563.201439748047, 4563.361129441864, 3265.75506836987, 3388.542546756193, 5142.640015198937, 5272.499112584298, 5326.041312563737, 5196.480351964811, 5283.101872681634, 5285.0, 5300.0459917214885, 5310.522053015228, 5813.517553023973, 5820.621659592113, 5840.299164100293, 5852.502537284336, 5853.414658534155, 5019.096562618727, 5127.743612819381, 5151.871203219912, 5168.095583272912, 5172.0, 19146.71279930802, 19259.61480770377, 19601.21595136193, 19614.90192549028, 19659.508512287306, 1824.6989246774267, 1845.723141528768, 1847.5750577367146, 1856.3873921605837, 1967.2917749610128, 8845.778855528599, 8926.553672316359, 8977.610461660379, 8989.280857531381, 9136.406133601295, 1702.8978261304237, 1769.265754711793, 1778.8399044086095, 1802.3961972739016, 1804.1340156724714, 54297.0, 56881.71559142178, 57406.0, 57632.0, 57991.71004144952, 9318.114779095975, 9370.344075914756, 9434.481103539234, 9464.574094165642, 9508.144267015863, 11813.645590632295, 11902.464389102512, 11913.344766037777, 11914.880851191378, 11916.404179790976, 6415.775447859302, 6605.1083103780375, 6789.93210067893, 6797.1843378794865, 6843.3840954314355, 5964.254468191476, 5999.880002399927, 6000.21997140369, 6056.818295451144, 6061.090836374491, 3847.5960024197616, 3929.8035098244973, 3940.5468371137113, 3989.341758609855, 4080.8571699990953, 1571.1437266689682, 1646.3414634146436, 1649.8734897369418, 1675.3549883294775, 1678.5048410718866, 794.9364050875917, 822.0792712162297, 845.1632883445468, 846.7096503956782, 951.0822056715165, 12774.552890648783, 14899.180545069908, 15240.542783716506, 16067.196640167946, 16352.918235408746, 818.0224631565222, 840.8528507511161, 849.0, 852.26705033671, 870.7257213977576, 8629.956850215834, 8862.822743545094, 8948.910510894937, 8958.10418958112, 8986.46081235115, 417279.0, 419497.0, 425452.0, 427616.0, 427688.0, 64160.0, 66544.33455665382, 67576.66211669009, 68146.0, 69166.04207265317, 982.9262805289488, 995.0397866059143, 1034.4569101221769, 1071.45891324882, 1075.575147816608, 13818.239996800272, 14643.633909152357, 14817.777733333793, 14868.405263789327, 15062.397504099714, 33126.83436582898, 33391.83304083464, 33529.83235083809, 33804.492932605535, 34089.659103408645, 42485.36271955985, 44252.0, 45176.0, 45343.7732811347, 46512.0, 8722.258608018135, 8835.646574136963, 8957.910420895969, 8963.148500892405, 9044.41211321262, 15901.840981590498, 16123.435679751152, 16303.510894673178, 16453.25960331764, 16651.0, 13542.526011589547, 13655.726885462434, 13786.517471888435, 13833.079971091944, 14094.0, 9040.276777857887, 9291.953540232256, 13502.527411540548, 13535.932320338336, 13845.0, 8144.83710325802, 8328.0, 9494.632469064309, 9521.143097121292, 9707.320487566085, 13733.381997810322, 13736.175829450265, 14233.43798116349, 14706.117632942058, 14741.262936853329, 9133.40632858862, 15216.695666086394, 15381.077135371914, 15902.920485397499, 15935.760963585324], "unit": "score", "name": "jquery.html", "value": 8086.768863399415}, {"lowerIsBetter": false, "replicates": [1443.0908527627594, 1656.7680524726536, 1718.6047209141898, 1732.6274850907052, 1751.2819743905002, 6169.537284703649, 7260.673269702863, 7325.963370183142, 7386.667599958001, 7388.556686598801, 7244.0582724245905, 7261.673224704888, 7273.38176255019, 7340.669669864856, 7345.632718364087, 1731.2122984042294, 2054.188595504771, 2083.854130210886, 2083.8853863037525, 2083.906224219914, 1767.8320559546887, 2006.829419499337, 2068.317455239775, 2069.2033567076633, 2074.408793493855, 1991.2831380702935, 1994.8902810345426, 2003.6794112941932, 2003.7996200379991, 2065.6694928811394, 2057.639913015224, 2087.2798884385015, 2087.5824835032977, 2096.0986775686374, 2098.6012657595006, 2044.1823270691693, 2097.4966008158085, 2101.0860275780083, 2101.558672678739, 2101.674240492726, 7347.044884165024, 7378.55728656277, 7418.146913105008, 7464.104307483137, 7477.140128885193, 4292.098659281554, 4372.256716358227, 4378.605925466692, 4383.276759334706, 4397.846075387346, 2657.402084530984, 2661.308059904419, 2664.9600255996174, 2689.4486630240754, 2698.730126987305, 773.9883901741479, 794.4557977785236, 801.7314199743093, 809.7004108479841, 815.1237419773707, 9999.950000250024, 10027.147692446079, 10074.647387341407, 10093.0, 10093.747656308578, 3903.863364782219, 3955.6835453163676, 4004.01901534126, 4005.679545636342, 4017.1563971565715, 8734.956325218332, 8752.51861147643, 8757.430767000125, 8761.474311541328, 8762.0, 4331.1337732453, 4351.781501179675, 4371.038371558252, 4392.846250381222, 4409.845655402046, 3976.880693579197, 3977.6420122188565, 3978.42312864633, 3980.0646847990697, 3987.940180897289, 2878.625778648762, 2995.9101226963226, 3277.6722327767034, 3350.8492117854753, 3378.1048022274117, 1053.4048262731533, 1064.9414282214552, 1065.7069305940772, 1067.0503252105632, 1069.3316677076828, 962.1148543340004, 963.9710808675751, 997.8453339732353, 1052.347544522401, 1237.047473445442, 6939.653017349214, 7011.298870112948, 7013.754518591825, 7014.964925175342, 7019.5086343956455, 963.1620490173594, 965.35803690545, 965.971020869375, 1028.9794204116026, 1045.0281238448165, 5252.789888404497, 5354.812581559627, 5365.678059316453, 5400.081986062379, 5407.837764866981, 7659.655315510815, 7684.231576842383, 7883.684652613946, 7915.0, 8029.156938521372, 7870.921290787133, 7879.093904200976, 7886.684532618746, 7890.842183156305, 7937.722179723797, 6275.3724627536885, 6363.140975968277, 6380.425761681471, 6404.775832845921, 6454.903176452357, 6136.509079273558, 6139.508839292936, 6145.231846019247, 6146.200993870768, 6160.876782464416, 6986.126734158231, 7097.503174777716, 7246.202917679157, 7251.601161935933, 7313.0, 7335.193128755725, 7355.521891077063, 7425.034745483053, 7440.55356678601, 7456.96271518639, 6113.938860611337, 6135.294441139326, 6137.202163718688, 6152.876942461036, 6173.9073913892225, 5602.2717046783655, 5962.701864906824, 6359.682015899094, 6401.167848179894, 6428.292887782433, 6603.471722262304, 6616.669166541557, 6656.966715166587, 6660.400563949268, 6791.0, 6198.938010619836, 6286.402791734778, 6360.809175724736, 6365.077063825626, 6381.712822923072, 6621.205455345389, 6625.569337993015, 6635.270120286861, 6695.263521012587, 6697.330266973264, 6071.3625069368845, 6092.238470191226, 6093.878122437615, 6140.938590614037, 6176.598521096114, 5985.700714964321, 6079.939200608114, 6116.418940200674, 6156.722947467464, 6349.460295874902], "unit": "score", "name": "mootools.html", "value": 4067.0322975051845}, {"lowerIsBetter": false, "replicates": [295.8786897372077, 301.9048999565137, 304.0740943826049, 308.9536569514573, 310.16565438969184, 5276.129438642624, 5326.520613144816, 5332.066888294543, 5361.651492652984, 5363.785448582052, 5023.346964894558, 5129.0767661820855, 5177.870553236171, 5240.292560504331, 5283.577313814895, 4087.9591204088024, 4089.284375234337, 4104.322786740185, 4108.938365924513, 4115.382692596119, 3882.0, 4079.8368065277355, 4092.0588264699136, 4102.671786257107, 4112.2186784511, 3926.155876486555, 3987.8604248851298, 4072.6131017553284, 4079.5104587449546, 4107.7535347879075, 4079.4492743479545, 4089.9386509202386, 4094.9181016379653, 4097.364908439196, 4104.261232978063, 3587.7667951583326, 3595.7662751921303, 3598.3702852000797, 3601.279744051174, 3605.8197090145386, 5030.798768049311, 5056.418511871108, 5064.442911279793, 5070.706969722734, 5075.390953085616, 4602.723836569817, 4681.672282940195, 4704.670673052888, 4705.411823522059, 4709.811607535695, 5511.759854032851, 5531.225628412026, 5549.250851135085, 5554.861128471821, 5559.58303127263, 3900.64894159527, 3906.5312162540677, 3906.867008567512, 3908.355121404965, 3910.569837317893, 5818.854528636775, 5828.854278643025, 5835.066389377722, 5840.883182336372, 5848.239728835224, 3941.625545573166, 4021.2962731521866, 4051.2707712611423, 4056.1684854605323, 4066.207089617496, 4100.610442008005, 4107.507099148122, 4108.424820525129, 4110.568390319033, 4117.464729585195, 4674.415698037746, 4675.2052151134385, 4681.0, 4693.741844198602, 4698.436187657503, 5572.442755724395, 5578.135389014628, 5582.0789569721355, 5584.441555844383, 5586.720663966786, 1374.3746595299115, 1427.757281262188, 1435.9353829077716, 1457.6210185351886, 1457.7521821290406, 936.6908920056501, 957.9042095790365, 960.0543464687278, 970.7961328121173, 971.5919313888184, 4787.736674482937, 4789.904201915942, 4808.8797780055775, 4809.78355973975, 4815.783289751969, 5638.069718496402, 5687.40282270364, 5700.629459085146, 5728.684922329228, 5732.426757324318, 4723.149833030087, 4783.760811959388, 4852.126617208936, 4862.586680132228, 4865.343178670834, 3101.8293993830557, 3118.937621247562, 3123.7813353065067, 3133.3576616793503, 3135.6550779414247, 5490.094134467848, 5492.0663487206475, 5499.285092937973, 5502.752376143083, 5503.724813759296, 5962.135490353874, 5965.522758179335, 5970.283565972111, 5971.462568368867, 5971.492423144082, 5374.785008599612, 5522.447755224445, 5526.723663816793, 5540.612157148961, 5541.168824676331, 5844.766209351578, 5845.152452894222, 5853.326867410132, 5858.150568167677, 5863.325717542367, 5631.802886899103, 5691.117876729114, 5692.060809966475, 5710.457506536873, 5718.085106382959, 5315.893682126259, 5524.254225679642, 5529.695866727368, 5531.2532808072, 5534.723263836872, 3924.6860251179264, 3937.625925537069, 3939.5469521005452, 3942.901427464222, 3943.921121577495, 5786.884262314646, 5787.565932554991, 5825.970870145622, 5827.94172058274, 5830.62100963436, 5596.916046259228, 5608.355039170548, 5608.831735047955, 5610.0, 5612.522935550524, 5463.0, 5587.329520457572, 5606.635568688022, 5607.214989901336, 5609.0, 5509.47659972302, 5518.392976772632, 5522.088855338824, 5523.613347065667, 5528.834134975958, 5670.744816483186, 5671.291088613923, 5677.0, 5681.346645135863, 5682.744276507485, 5411.0, 5523.25436066142, 5527.751251193626, 5530.861728456821, 5544.556435485232], "unit": "score", "name": "prototype.html", "value": 4188.322414067545}, {"lowerIsBetter": false, "replicates": [748.8614606297836, 755.6033082631616, 771.4985259581272, 807.4751411582474, 820.9958950205248, 12837.42231599578, 13118.34408279587, 13118.7376252475, 13120.081594288404, 13152.934235328834, 13837.031407801433, 13855.930720346385, 13903.443862245524, 13925.93037034816, 13955.790663140036, 627.5638431290255, 636.9681515924209, 786.0842118931438, 809.3969992355703, 812.8780682897553, 788.7909703928464, 799.940004499662, 807.9313258373045, 808.107041718901, 809.6558962440939, 802.7310850864967, 842.8988521377444, 847.559269180026, 854.1202561361777, 854.3891117850735, 654.5320096131265, 667.649484020888, 823.045267489715, 837.0875745437442, 841.6633346661323, 618.0235228339213, 619.662284055191, 620.3827191944044, 620.6245221640887, 620.9285932117774, 11981.341026243554, 12023.63929082129, 12071.215371000944, 12154.635360939186, 12168.452419641137, 10517.421541815198, 11102.111831053577, 11244.437778111062, 11321.037711794508, 11380.658580242523, 9414.717558473258, 9441.952790236004, 9512.904870951272, 9642.228621710317, 9755.12203901645, 3183.602049743782, 3224.6134162310195, 3253.7722359434847, 3291.062047316503, 3297.3075654112663, 40059.0, 40401.79799101015, 40646.187076258306, 40676.59323406787, 40914.386284205466, 9202.35583509148, 9293.070692930653, 9314.86027709585, 9356.485393303297, 9358.11097945694, 15775.684486310209, 15782.36870525189, 15808.68382632341, 15898.920505397631, 15924.0, 6259.937400626027, 6302.306746257908, 6320.304766475684, 6343.746250150035, 6503.0, 3482.407990641597, 3509.2455122148863, 3563.6436356364156, 3586.103474131467, 3590.120420496995, 2619.895204191849, 2654.110872857614, 2682.7585517303537, 2693.9191824245304, 2695.1644990053146, 458.6468419317174, 464.8977225010492, 473.57378359476746, 476.51395576511766, 479.9928001079987, 505.2698850161481, 533.8398480455847, 594.8650611278624, 626.5457543281085, 633.0978355842998, 7963.163867793798, 8708.78228044304, 8826.735197944072, 8831.072737362485, 8923.776905577413, 501.38079471852234, 502.88861615829427, 519.4467891695332, 582.2692520886345, 644.5391545045316, 3421.4354631486026, 3732.309522738302, 3881.2431575843, 3955.367141257385, 3961.1087505311652, 49945.500544994815, 50316.74841625769, 50363.748181259594, 50384.49615503798, 50489.0, 43399.78300108479, 44033.77983110064, 44039.33940990888, 44361.77819110884, 44478.33282500765, 39779.80110099431, 40090.19819603592, 40355.59644403577, 40875.386869196984, 41449.79275103605, 7560.714678504777, 7671.0, 7759.844803103793, 7931.524108553505, 8858.247049000907, 30656.0, 31254.53118203183, 31313.217169570944, 31323.84338078295, 32299.51550726788, 42203.1559368817, 42697.146057079306, 42993.140137197704, 43212.13575728531, 43411.78294108509, 10791.6222932197, 10868.78262434731, 10904.291221070922, 11021.0, 11035.006849383593, 11273.492692828679, 11480.253783504046, 11535.480903359537, 11594.188406811441, 11606.071514279007, 10856.131509479064, 10883.67348979532, 11071.612493562687, 11302.265352752045, 11408.657740267805, 10882.455877206266, 11042.0, 11348.773024539298, 11462.369569673749, 11680.591179308683, 10824.945875270574, 11123.165762568002, 11190.720231994264, 11238.0, 11307.830382544433, 9148.833675177319, 9426.81146377055, 9557.0, 9717.22262219035, 9861.852072218779, 8785.253253473526, 9584.28117891147, 9588.472634004918, 9852.950735246279, 9871.50642467888], "unit": "score", "name": "yui.html", "value": 5835.671947901723}], "name": "dromaeo_css", "value": 6282.969299890103}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 111.0, 113.0, 111.0, 101.0, 113.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [158.0, 132.0, 149.0, 168.0, 130.0, 163.0, 151.0, 129.0, 174.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 161.0, 163.0, 160.0, 163.0, 161.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 91.0, 96.0, 73.0, 73.0, 74.0, 119.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 132.0, 95.0, 95.0, 96.0, 131.0, 96.0, 95.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 70.0, 70.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 83.0, 91.0, 83.0, 83.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 137.0, 125.0, 126.0, 120.0, 133.0, 125.0, 127.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [135.0, 141.0, 142.0, 148.0, 147.0, 139.0, 147.0, 141.0, 144.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 72.0, 69.0, 72.0, 70.0, 70.0, 77.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1524.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.56291390728478], "unit": "score", "name": "Richards", "value": 213.2240799999999}, {"lowerIsBetter": false, "replicates": [186.11576400521125], "unit": "score", "name": "DeltaBlue", "value": 355.2520139999999}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1994.0239043824702], "unit": "score", "name": "RayTrace", "value": 371.1033746253746}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [27243.243243243243], "unit": "score", "name": "RegExp", "value": 33.43893353174606}, {"lowerIsBetter": false, "replicates": [597.379392495533], "unit": "score", "name": "Splay", "value": 136.4141465603191}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19809.498251576464}]} 04:39:43 INFO - RETURN: dromaeo_css: 6282.97 04:39:43 INFO - RETURN: kraken: 1524.80 04:39:43 INFO - RETURN: v8_7: 19809.50 04:39:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19809.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1524.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6282.97"}}} 04:39:43 INFO - Return code: 0 04:39:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:39:43 ERROR - # TBPL SUCCESS # 04:39:43 INFO - Running post-action listener: _resource_record_post_action 04:39:43 INFO - Running post-run listener: _resource_record_post_run 04:39:44 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 8192; Write bytes: 504135680; Read time: 16; Write time: 1234772 04:39:44 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 231456768; Read time: 0; Write time: 631896 04:39:44 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 8192; Write bytes: 272674816; Read time: 16; Write time: 601856 04:39:44 INFO - Running post-run listener: _upload_blobber_files 04:39:44 INFO - Blob upload gear active. 04:39:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:39:44 INFO - Copying logs to upload dir... 04:39:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.064856 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-16 04:39:44.069700) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:39:44.073462) ========= 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=a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426 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.009867 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:39:44.124153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:39:44.124849) ========= 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=a194aa7faa1be204aaca7d660000020b-1450268309.315173-816030426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:39:44.176255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 04:39:44.176584) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 04:39:44.176892) ========= ========= Total master_lag: 0.24 =========