builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1449658436.03 results: success (0) buildid: 20151209015042 builduid: f6f0446e4eeb4d4091fd6bdc33e67cd4 revision: 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.031808) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.032261) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.032798) ========= 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=928fd09416829678a2f67a56000001ac-1449657811.931297-661670290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.094051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.094342) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.190047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.190336) ========= 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=928fd09416829678a2f67a56000001ac-1449657811.931297-661670290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.248854) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.249121) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.249480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.249779) ========= 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=928fd09416829678a2f67a56000001ac-1449657811.931297-661670290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 02:53:57-- 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% 231M=0s 2015-12-09 02:53:57 (231 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.368828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.369137) ========= 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=928fd09416829678a2f67a56000001ac-1449657811.931297-661670290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022356 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.419882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 02:53:56.420225) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb --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=928fd09416829678a2f67a56000001ac-1449657811.931297-661670290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 02:53:57,575 truncating revision to first 12 chars 2015-12-09 02:53:57,575 Setting DEBUG logging. 2015-12-09 02:53:57,575 attempt 1/10 2015-12-09 02:53:57,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/965cfbe44aa5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 02:53:58,359 unpacking tar archive at: fx-team-965cfbe44aa5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.099761 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 02:53:57.545067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:57.545388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:57.561859) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:57.562149) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:57.562548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-09 02:53:57.562832) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=928fd09416829678a2f67a56000001ac-1449657811.931297-661670290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:53:58 INFO - MultiFileLogger online at 20151209 02:53:58 in /builds/slave/test 02:53:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:53:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:53:58 INFO - {'append_to_log': False, 02:53:58 INFO - 'base_work_dir': '/builds/slave/test', 02:53:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:53:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:53:58 INFO - 'branch': 'Fx-Team-Non-PGO', 02:53:58 INFO - 'buildbot_json_path': 'buildprops.json', 02:53:58 INFO - 'config_files': ('talos/linux_config.py',), 02:53:58 INFO - 'default_actions': ('clobber', 02:53:58 INFO - 'read-buildbot-config', 02:53:58 INFO - 'download-and-extract', 02:53:58 INFO - 'populate-webroot', 02:53:58 INFO - 'create-virtualenv', 02:53:58 INFO - 'install', 02:53:58 INFO - 'run-tests'), 02:53:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:53:58 INFO - 'download_minidump_stackwalk': True, 02:53:58 INFO - 'download_symbols': 'ondemand', 02:53:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:53:58 INFO - 'tooltool.py': '/tools/tooltool.py', 02:53:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:53:58 INFO - '/tools/misc-python/virtualenv.py')}, 02:53:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:53:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:53:58 INFO - 'installer_path': 'installer.exe', 02:53:58 INFO - 'log_level': 'info', 02:53:58 INFO - 'log_name': 'talos', 02:53:58 INFO - 'log_to_console': True, 02:53:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:53:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:53:58 INFO - 'opt_config_files': (), 02:53:58 INFO - 'pip_index': False, 02:53:58 INFO - 'sps_profile': False, 02:53:58 INFO - 'sps_profile_interval': 0, 02:53:58 INFO - 'suite': 'dromaeojs-e10s', 02:53:58 INFO - 'system_bits': '64', 02:53:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:53:58 INFO - 'title': 'talos-linux64-ix-012', 02:53:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:53:58 INFO - 'use_talos_json': True, 02:53:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:53:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:53:58 INFO - 'work_dir': 'build'} 02:53:58 INFO - ##### 02:53:58 INFO - ##### Running clobber step. 02:53:58 INFO - ##### 02:53:58 INFO - Running pre-action listener: _resource_record_pre_action 02:53:58 INFO - Running main action method: clobber 02:53:58 INFO - rmtree: /builds/slave/test/build 02:53:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:53:59 INFO - Running post-action listener: _resource_record_post_action 02:53:59 INFO - ##### 02:53:59 INFO - ##### Running read-buildbot-config step. 02:53:59 INFO - ##### 02:53:59 INFO - Running pre-action listener: _resource_record_pre_action 02:53:59 INFO - Running main action method: read_buildbot_config 02:53:59 INFO - Using buildbot properties: 02:53:59 INFO - { 02:53:59 INFO - "properties": { 02:53:59 INFO - "buildnumber": 550, 02:53:59 INFO - "product": "firefox", 02:53:59 INFO - "script_repo_revision": "production", 02:53:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:53:59 INFO - "repository": "", 02:53:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:53:59 INFO - "buildid": "20151209015042", 02:53:59 INFO - "slavename": "talos-linux64-ix-012", 02:53:59 INFO - "pgo_build": "False", 02:53:59 INFO - "basedir": "/builds/slave/test", 02:53:59 INFO - "project": "", 02:53:59 INFO - "platform": "ubuntu64_hw", 02:53:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:53:59 INFO - "slavebuilddir": "test", 02:53:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:53:59 INFO - "branch": "fx-team", 02:53:59 INFO - "repo_path": "integration/fx-team", 02:53:59 INFO - "stage_platform": "linux64", 02:53:59 INFO - "builduid": "f6f0446e4eeb4d4091fd6bdc33e67cd4", 02:53:59 INFO - "revision": "965cfbe44aa5394498843bb8f6136ccc3dd1e0fb" 02:53:59 INFO - }, 02:53:59 INFO - "sourcestamp": { 02:53:59 INFO - "repository": "", 02:53:59 INFO - "hasPatch": false, 02:53:59 INFO - "project": "", 02:53:59 INFO - "branch": "fx-team-linux64-talos", 02:53:59 INFO - "changes": [ 02:53:59 INFO - { 02:53:59 INFO - "category": null, 02:53:59 INFO - "files": [ 02:53:59 INFO - { 02:53:59 INFO - "url": null, 02:53:59 INFO - "name": "https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 02:53:59 INFO - } 02:53:59 INFO - ], 02:53:59 INFO - "repository": "", 02:53:59 INFO - "rev": "965cfbe44aa5394498843bb8f6136ccc3dd1e0fb", 02:53:59 INFO - "who": "cbook@mozilla.com", 02:53:59 INFO - "when": 1449658378, 02:53:59 INFO - "number": 7140206, 02:53:59 INFO - "comments": "Bug 1225236 - Removed the 360 value limit for the hue-rotate field in the CSS filter popup. r=pbro", 02:53:59 INFO - "project": "", 02:53:59 INFO - "at": "Wed 09 Dec 2015 02:52:58", 02:53:59 INFO - "branch": "fx-team-linux64-talos", 02:53:59 INFO - "revlink": "", 02:53:59 INFO - "properties": [ 02:53:59 INFO - [ 02:53:59 INFO - "buildid", 02:53:59 INFO - "20151209015042", 02:53:59 INFO - "Change" 02:53:59 INFO - ], 02:53:59 INFO - [ 02:53:59 INFO - "builduid", 02:53:59 INFO - "f6f0446e4eeb4d4091fd6bdc33e67cd4", 02:53:59 INFO - "Change" 02:53:59 INFO - ], 02:53:59 INFO - [ 02:53:59 INFO - "pgo_build", 02:53:59 INFO - "False", 02:53:59 INFO - "Change" 02:53:59 INFO - ] 02:53:59 INFO - ], 02:53:59 INFO - "revision": "965cfbe44aa5394498843bb8f6136ccc3dd1e0fb" 02:53:59 INFO - } 02:53:59 INFO - ], 02:53:59 INFO - "revision": "965cfbe44aa5394498843bb8f6136ccc3dd1e0fb" 02:53:59 INFO - } 02:53:59 INFO - } 02:53:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 02:53:59 INFO - Running post-action listener: _resource_record_post_action 02:53:59 INFO - ##### 02:53:59 INFO - ##### Running download-and-extract step. 02:53:59 INFO - ##### 02:53:59 INFO - Running pre-action listener: _resource_record_pre_action 02:53:59 INFO - Running main action method: download_and_extract 02:53:59 INFO - mkdir: /builds/slave/test/build/tests 02:53: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')]} 02:53:59 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:53:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json 02:53:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json 02:53:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:53:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:54:05 INFO - Downloaded 1302 bytes. 02:54:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:54:05 INFO - Using the following test package requirements: 02:54:05 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:54:05 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:54:05 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:05 INFO - u'jsshell-linux-x86_64.zip'], 02:54:05 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:54:05 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:54:05 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:54:05 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:54:05 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:54:05 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:54:05 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:54:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:54:05 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')]} 02:54:05 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:54:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:54:06 INFO - Downloaded 21859668 bytes. 02:54:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:54:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:54:07 INFO - Return code: 0 02:54:07 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:07 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:54:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:54:12 INFO - Downloaded 21859668 bytes. 02:54:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:54:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:54:13 INFO - Return code: 0 02:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:13 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:54:14 INFO - Downloaded 11132038 bytes. 02:54:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:54:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:54:14 INFO - Return code: 0 02:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:14 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:54:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:54:17 INFO - Downloaded 57729465 bytes. 02:54:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:17 INFO - mkdir: /builds/slave/test/properties 02:54:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:54:17 INFO - Writing to file /builds/slave/test/properties/build_url 02:54:17 INFO - Contents: 02:54:17 INFO - build_url:https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:17 INFO - Running post-action listener: _resource_record_post_action 02:54:17 INFO - Running post-action listener: set_extra_try_arguments 02:54:17 INFO - ##### 02:54:17 INFO - ##### Running populate-webroot step. 02:54:17 INFO - ##### 02:54:17 INFO - Running pre-action listener: _resource_record_pre_action 02:54:17 INFO - Running main action method: populate_webroot 02:54:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:54:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:54:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:54:17 INFO - '--tppagecycles', 02:54:17 INFO - '7'], 02:54:17 INFO - 'tests': ['tsvgm']}}, 02:54:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:54:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:54:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:54:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:54:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:17 INFO - 'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:17 INFO - 'tests': ['damp', 'tps']}, 02:54:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:17 INFO - 'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['damp', 'tps']}, 02:54:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:54:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:54:17 INFO - 'other': {'tests': ['a11yr', 02:54:17 INFO - 'ts_paint', 02:54:17 INFO - 'tpaint', 02:54:17 INFO - 'sessionrestore', 02:54:17 INFO - 'sessionrestore_no_auto_restore']}, 02:54:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['a11yr', 02:54:17 INFO - 'ts_paint', 02:54:17 INFO - 'tpaint', 02:54:17 INFO - 'sessionrestore', 02:54:17 INFO - 'sessionrestore_no_auto_restore']}, 02:54:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['a11yr', 02:54:17 INFO - 'ts_paint', 02:54:17 INFO - 'tpaint', 02:54:17 INFO - 'sessionrestore', 02:54:17 INFO - 'sessionrestore_no_auto_restore']}, 02:54:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['a11yr', 02:54:17 INFO - 'ts_paint', 02:54:17 INFO - 'tpaint', 02:54:17 INFO - 'sessionrestore', 02:54:17 INFO - 'sessionrestore_no_auto_restore']}, 02:54:17 INFO - 'other_l64': {'tests': ['a11yr', 02:54:17 INFO - 'ts_paint', 02:54:17 INFO - 'tpaint', 02:54:17 INFO - 'sessionrestore', 02:54:17 INFO - 'sessionrestore_no_auto_restore']}, 02:54:17 INFO - 'other_nol64': {'tests': ['a11yr', 02:54:17 INFO - 'ts_paint', 02:54:17 INFO - 'tpaint', 02:54:17 INFO - 'sessionrestore', 02:54:17 INFO - 'sessionrestore_no_auto_restore']}, 02:54:17 INFO - 'svgr': {'tests': ['tsvgx', 02:54:17 INFO - 'tsvgr_opacity', 02:54:17 INFO - 'tart', 02:54:17 INFO - 'tscrollx', 02:54:17 INFO - 'cart']}, 02:54:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['tsvgx', 02:54:17 INFO - 'tsvgr_opacity', 02:54:17 INFO - 'tart', 02:54:17 INFO - 'tscrollx', 02:54:17 INFO - 'cart']}, 02:54:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:17 INFO - 'tests': ['tp5o']}, 02:54:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:17 INFO - 'talos_options': ['--e10s'], 02:54:17 INFO - 'tests': ['tp5o']}, 02:54:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:17 INFO - 'talos_options': ['--xperf_path', 02:54:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:17 INFO - 'tests': ['tp5n']}, 02:54:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:17 INFO - 'talos_options': ['--e10s', 02:54:17 INFO - '--xperf_path', 02:54:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:17 INFO - 'tests': ['tp5n']}}, 02:54:17 INFO - 'talos.zip': {'path': '', 02:54:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:54:17 INFO - Running post-action listener: _resource_record_post_action 02:54:17 INFO - ##### 02:54:17 INFO - ##### Running create-virtualenv step. 02:54:17 INFO - ##### 02:54:17 INFO - Running pre-action listener: _resource_record_pre_action 02:54:17 INFO - Running main action method: create_virtualenv 02:54:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:54:17 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 02:54:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:54:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:54:17 INFO - Using real prefix '/usr' 02:54:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:54:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:54:19 INFO - Installing pip.................done. 02:54:19 INFO - Return code: 0 02:54:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:54: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')]} 02:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54: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')]} 02:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:19 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 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:19 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 02:54:19 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 02:54:19 INFO - Using env: {'DISPLAY': ':0', 02:54:19 INFO - 'HOME': '/home/cltbld', 02:54:19 INFO - 'LANG': 'en_US.UTF-8', 02:54:19 INFO - 'LANGUAGE': 'en_US:en', 02:54:19 INFO - 'LOGNAME': 'cltbld', 02:54:19 INFO - 'MAIL': '/var/mail/cltbld', 02:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:19 INFO - 'MOZ_NO_REMOTE': '1', 02:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:19 INFO - 'NO_EM_RESTART': '1', 02:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:19 INFO - 'PWD': '/builds/slave/test', 02:54:19 INFO - 'SHELL': '/bin/bash', 02:54:19 INFO - 'SHLVL': '1', 02:54:19 INFO - 'TERM': 'linux', 02:54:19 INFO - 'TMOUT': '86400', 02:54:19 INFO - 'USER': 'cltbld', 02:54:19 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:19 INFO - '_': '/tools/buildbot/bin/python'} 02:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:19 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 02:54:19 INFO - Cleaning up... 02:54:19 INFO - Return code: 0 02:54:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:54: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')]} 02:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54: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')]} 02:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:19 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 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:19 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 02:54:19 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 02:54:19 INFO - Using env: {'DISPLAY': ':0', 02:54:19 INFO - 'HOME': '/home/cltbld', 02:54:19 INFO - 'LANG': 'en_US.UTF-8', 02:54:19 INFO - 'LANGUAGE': 'en_US:en', 02:54:19 INFO - 'LOGNAME': 'cltbld', 02:54:19 INFO - 'MAIL': '/var/mail/cltbld', 02:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:19 INFO - 'MOZ_NO_REMOTE': '1', 02:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:19 INFO - 'NO_EM_RESTART': '1', 02:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:19 INFO - 'PWD': '/builds/slave/test', 02:54:19 INFO - 'SHELL': '/bin/bash', 02:54:19 INFO - 'SHLVL': '1', 02:54:19 INFO - 'TERM': 'linux', 02:54:19 INFO - 'TMOUT': '86400', 02:54:19 INFO - 'USER': 'cltbld', 02:54:19 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:19 INFO - '_': '/tools/buildbot/bin/python'} 02:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:20 INFO - Downloading/unpacking psutil>=0.7.1 02:54:20 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 02:54:20 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 02:54:20 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 02:54:20 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 02:54:20 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 02:54:20 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 02:54:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:54:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:54:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:21 INFO - Installing collected packages: psutil 02:54:21 INFO - Running setup.py install for psutil 02:54:21 INFO - building 'psutil._psutil_linux' extension 02:54:21 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 02:54:22 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 02:54:22 INFO - building 'psutil._psutil_posix' extension 02:54:22 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 02:54:22 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 02:54:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:22 INFO - Successfully installed psutil 02:54:22 INFO - Cleaning up... 02:54:22 INFO - Return code: 0 02:54:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:54:22 INFO - Using env: {'DISPLAY': ':0', 02:54:22 INFO - 'HOME': '/home/cltbld', 02:54:22 INFO - 'LANG': 'en_US.UTF-8', 02:54:22 INFO - 'LANGUAGE': 'en_US:en', 02:54:22 INFO - 'LOGNAME': 'cltbld', 02:54:22 INFO - 'MAIL': '/var/mail/cltbld', 02:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:22 INFO - 'MOZ_NO_REMOTE': '1', 02:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:22 INFO - 'NO_EM_RESTART': '1', 02:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:22 INFO - 'PWD': '/builds/slave/test', 02:54:22 INFO - 'SHELL': '/bin/bash', 02:54:22 INFO - 'SHLVL': '1', 02:54:22 INFO - 'TERM': 'linux', 02:54:22 INFO - 'TMOUT': '86400', 02:54:22 INFO - 'USER': 'cltbld', 02:54:22 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:22 INFO - '_': '/tools/buildbot/bin/python'} 02:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:54:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:54:24 INFO - Installing collected packages: mozsystemmonitor 02:54:24 INFO - Running setup.py install for mozsystemmonitor 02:54:24 INFO - Successfully installed mozsystemmonitor 02:54:24 INFO - Cleaning up... 02:54:24 INFO - Return code: 0 02:54:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:54:24 INFO - Using env: {'DISPLAY': ':0', 02:54:24 INFO - 'HOME': '/home/cltbld', 02:54:24 INFO - 'LANG': 'en_US.UTF-8', 02:54:24 INFO - 'LANGUAGE': 'en_US:en', 02:54:24 INFO - 'LOGNAME': 'cltbld', 02:54:24 INFO - 'MAIL': '/var/mail/cltbld', 02:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:24 INFO - 'MOZ_NO_REMOTE': '1', 02:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:24 INFO - 'NO_EM_RESTART': '1', 02:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:24 INFO - 'PWD': '/builds/slave/test', 02:54:24 INFO - 'SHELL': '/bin/bash', 02:54:24 INFO - 'SHLVL': '1', 02:54:24 INFO - 'TERM': 'linux', 02:54:24 INFO - 'TMOUT': '86400', 02:54:24 INFO - 'USER': 'cltbld', 02:54:24 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:24 INFO - '_': '/tools/buildbot/bin/python'} 02:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:24 INFO - Downloading/unpacking blobuploader==1.2.4 02:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:26 INFO - Downloading blobuploader-1.2.4.tar.gz 02:54:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:54:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:54:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:27 INFO - Downloading docopt-0.6.1.tar.gz 02:54:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:54:27 INFO - Installing collected packages: blobuploader, requests, docopt 02:54:27 INFO - Running setup.py install for blobuploader 02:54:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:54:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:54:27 INFO - Running setup.py install for requests 02:54:27 INFO - Running setup.py install for docopt 02:54:27 INFO - Successfully installed blobuploader requests docopt 02:54:27 INFO - Cleaning up... 02:54:27 INFO - Return code: 0 02:54:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:27 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 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:27 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 02:54:27 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 02:54:27 INFO - Using env: {'DISPLAY': ':0', 02:54:27 INFO - 'HOME': '/home/cltbld', 02:54:27 INFO - 'LANG': 'en_US.UTF-8', 02:54:27 INFO - 'LANGUAGE': 'en_US:en', 02:54:27 INFO - 'LOGNAME': 'cltbld', 02:54:27 INFO - 'MAIL': '/var/mail/cltbld', 02:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:27 INFO - 'MOZ_NO_REMOTE': '1', 02:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:27 INFO - 'NO_EM_RESTART': '1', 02:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:27 INFO - 'PWD': '/builds/slave/test', 02:54:27 INFO - 'SHELL': '/bin/bash', 02:54:27 INFO - 'SHLVL': '1', 02:54:27 INFO - 'TERM': 'linux', 02:54:27 INFO - 'TMOUT': '86400', 02:54:27 INFO - 'USER': 'cltbld', 02:54:27 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:27 INFO - '_': '/tools/buildbot/bin/python'} 02:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:27 INFO - Running setup.py (path:/tmp/pip-jCd4Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:28 INFO - Running setup.py (path:/tmp/pip-uSKH4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:28 INFO - Running setup.py (path:/tmp/pip-ucLmCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:28 INFO - Running setup.py (path:/tmp/pip-MK2bWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:28 INFO - Running setup.py (path:/tmp/pip-sjDVGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:28 INFO - Running setup.py (path:/tmp/pip-ZKnqQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:28 INFO - Running setup.py (path:/tmp/pip-MSxsZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:28 INFO - Running setup.py (path:/tmp/pip-DzN5xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:28 INFO - Running setup.py (path:/tmp/pip-jWNjyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:28 INFO - Running setup.py (path:/tmp/pip-geFqAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:28 INFO - Running setup.py (path:/tmp/pip-lsB4DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:28 INFO - Running setup.py (path:/tmp/pip-HsKU0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:28 INFO - Running setup.py (path:/tmp/pip-TgyqDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:28 INFO - Running setup.py (path:/tmp/pip-gjZX_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:28 INFO - Running setup.py (path:/tmp/pip-6TTefX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:29 INFO - Running setup.py (path:/tmp/pip-rBsFU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:29 INFO - Running setup.py (path:/tmp/pip-yDG62U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:54:29 INFO - Running setup.py install for manifestparser 02:54:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Running setup.py install for mozcrash 02:54:29 INFO - Running setup.py install for mozdebug 02:54:29 INFO - Running setup.py install for mozdevice 02:54:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Running setup.py install for mozfile 02:54:29 INFO - Running setup.py install for mozhttpd 02:54:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Running setup.py install for mozinfo 02:54:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Running setup.py install for mozInstall 02:54:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:54:29 INFO - Running setup.py install for mozleak 02:54:30 INFO - Running setup.py install for mozlog 02:54:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:54:30 INFO - Running setup.py install for moznetwork 02:54:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:54:30 INFO - Running setup.py install for mozprocess 02:54:30 INFO - Running setup.py install for mozprofile 02:54:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:54:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:54:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:54:30 INFO - Running setup.py install for mozrunner 02:54:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:54:30 INFO - Running setup.py install for mozscreenshot 02:54:30 INFO - Running setup.py install for moztest 02:54:30 INFO - Running setup.py install for mozversion 02:54:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:54:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:54:30 INFO - Cleaning up... 02:54:30 INFO - Return code: 0 02:54:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:30 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 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:30 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 02:54:30 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 02:54:30 INFO - Using env: {'DISPLAY': ':0', 02:54:30 INFO - 'HOME': '/home/cltbld', 02:54:30 INFO - 'LANG': 'en_US.UTF-8', 02:54:30 INFO - 'LANGUAGE': 'en_US:en', 02:54:30 INFO - 'LOGNAME': 'cltbld', 02:54:30 INFO - 'MAIL': '/var/mail/cltbld', 02:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:30 INFO - 'MOZ_NO_REMOTE': '1', 02:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:30 INFO - 'NO_EM_RESTART': '1', 02:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:30 INFO - 'PWD': '/builds/slave/test', 02:54:30 INFO - 'SHELL': '/bin/bash', 02:54:30 INFO - 'SHLVL': '1', 02:54:30 INFO - 'TERM': 'linux', 02:54:30 INFO - 'TMOUT': '86400', 02:54:30 INFO - 'USER': 'cltbld', 02:54:30 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:30 INFO - '_': '/tools/buildbot/bin/python'} 02:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:31 INFO - Running setup.py (path:/tmp/pip-PU5g_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:31 INFO - Running setup.py (path:/tmp/pip-rjUVy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:31 INFO - Running setup.py (path:/tmp/pip-PPje62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:31 INFO - Running setup.py (path:/tmp/pip-qpp6cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:31 INFO - Running setup.py (path:/tmp/pip-_RqbMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:31 INFO - Running setup.py (path:/tmp/pip-Umu62_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:31 INFO - Running setup.py (path:/tmp/pip-m6xl1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:31 INFO - Running setup.py (path:/tmp/pip-bP02On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:31 INFO - Running setup.py (path:/tmp/pip-4sCZuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:31 INFO - Running setup.py (path:/tmp/pip-JI5vhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:31 INFO - Running setup.py (path:/tmp/pip-Y5UiQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:31 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)) 02:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:31 INFO - Running setup.py (path:/tmp/pip-7__R3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:32 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)) 02:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:32 INFO - Running setup.py (path:/tmp/pip-ce9SZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:32 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)) 02:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:32 INFO - Running setup.py (path:/tmp/pip-o_HTcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:32 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)) 02:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:32 INFO - Running setup.py (path:/tmp/pip-zTUZXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:32 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)) 02:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:32 INFO - Running setup.py (path:/tmp/pip-LEhuvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:32 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)) 02:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:32 INFO - Running setup.py (path:/tmp/pip-QhwzJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:32 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)) 02:54:32 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)) 02:54:32 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)) 02:54:32 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)) 02:54:32 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)) 02:54:32 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)) 02:54:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:54:32 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 02:54:32 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 02:54:32 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 02:54:32 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 02:54:32 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 02:54:32 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 02:54:34 INFO - Downloading blessings-1.5.1.tar.gz 02:54:34 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 02:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:54:34 INFO - Installing collected packages: blessings 02:54:34 INFO - Running setup.py install for blessings 02:54:34 INFO - Successfully installed blessings 02:54:34 INFO - Cleaning up... 02:54:34 INFO - Return code: 0 02:54:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:34 INFO - Reading from file tmpfile_stdout 02:54:34 INFO - Current package versions: 02:54:34 INFO - argparse == 1.2.1 02:54:34 INFO - blessings == 1.5.1 02:54:34 INFO - blobuploader == 1.2.4 02:54:34 INFO - docopt == 0.6.1 02:54:34 INFO - manifestparser == 1.1 02:54:34 INFO - mozInstall == 1.12 02:54:34 INFO - mozcrash == 0.16 02:54:34 INFO - mozdebug == 0.1 02:54:34 INFO - mozdevice == 0.47 02:54:34 INFO - mozfile == 1.2 02:54:34 INFO - mozhttpd == 0.7 02:54:34 INFO - mozinfo == 0.9 02:54:34 INFO - mozleak == 0.1 02:54:34 INFO - mozlog == 3.1 02:54:34 INFO - moznetwork == 0.27 02:54:34 INFO - mozprocess == 0.22 02:54:34 INFO - mozprofile == 0.27 02:54:34 INFO - mozrunner == 6.11 02:54:34 INFO - mozscreenshot == 0.1 02:54:34 INFO - mozsystemmonitor == 0.0 02:54:34 INFO - moztest == 0.7 02:54:34 INFO - mozversion == 1.4 02:54:34 INFO - psutil == 3.1.1 02:54:34 INFO - requests == 1.2.3 02:54:34 INFO - wsgiref == 0.1.2 02:54:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:34 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')]} 02:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:34 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')]} 02:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:34 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 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:34 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 02:54:34 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 02:54:34 INFO - Using env: {'DISPLAY': ':0', 02:54:34 INFO - 'HOME': '/home/cltbld', 02:54:34 INFO - 'LANG': 'en_US.UTF-8', 02:54:34 INFO - 'LANGUAGE': 'en_US:en', 02:54:34 INFO - 'LOGNAME': 'cltbld', 02:54:34 INFO - 'MAIL': '/var/mail/cltbld', 02:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:34 INFO - 'MOZ_NO_REMOTE': '1', 02:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:34 INFO - 'NO_EM_RESTART': '1', 02:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:34 INFO - 'PWD': '/builds/slave/test', 02:54:34 INFO - 'SHELL': '/bin/bash', 02:54:34 INFO - 'SHLVL': '1', 02:54:34 INFO - 'TERM': 'linux', 02:54:34 INFO - 'TMOUT': '86400', 02:54:34 INFO - 'USER': 'cltbld', 02:54:34 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:34 INFO - '_': '/tools/buildbot/bin/python'} 02:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 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)) 02:54:34 INFO - Cleaning up... 02:54:34 INFO - Return code: 0 02:54:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:54:34 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')]} 02:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:34 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')]} 02:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:34 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 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:34 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 02:54:34 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 02:54:34 INFO - Using env: {'DISPLAY': ':0', 02:54:34 INFO - 'HOME': '/home/cltbld', 02:54:34 INFO - 'LANG': 'en_US.UTF-8', 02:54:34 INFO - 'LANGUAGE': 'en_US:en', 02:54:34 INFO - 'LOGNAME': 'cltbld', 02:54:34 INFO - 'MAIL': '/var/mail/cltbld', 02:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:34 INFO - 'MOZ_NO_REMOTE': '1', 02:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:34 INFO - 'NO_EM_RESTART': '1', 02:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:34 INFO - 'PWD': '/builds/slave/test', 02:54:34 INFO - 'SHELL': '/bin/bash', 02:54:34 INFO - 'SHLVL': '1', 02:54:34 INFO - 'TERM': 'linux', 02:54:34 INFO - 'TMOUT': '86400', 02:54:34 INFO - 'USER': 'cltbld', 02:54:34 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:34 INFO - '_': '/tools/buildbot/bin/python'} 02:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:34 INFO - Downloading/unpacking jsonschema 02:54:34 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 02:54:34 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 02:54:34 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 02:54:34 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 02:54:34 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 02:54:34 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 02:54:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:54:36 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 02:54:36 INFO - Downloading/unpacking functools32 (from jsonschema) 02:54:36 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 02:54:36 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 02:54:36 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 02:54:36 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 02:54:36 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 02:54:36 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 02:54:36 INFO - Downloading functools32-3.2.3-2.tar.gz 02:54:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:54:36 INFO - warning: no files found matching '*.txt' 02:54:36 INFO - no previously-included directories found matching 'build' 02:54:36 INFO - no previously-included directories found matching 'dist' 02:54:36 INFO - no previously-included directories found matching '.git*' 02:54:36 INFO - Installing collected packages: jsonschema, functools32 02:54:36 INFO - Running setup.py install for functools32 02:54:37 INFO - warning: no files found matching '*.txt' 02:54:37 INFO - no previously-included directories found matching 'build' 02:54:37 INFO - no previously-included directories found matching 'dist' 02:54:37 INFO - no previously-included directories found matching '.git*' 02:54:37 INFO - Successfully installed jsonschema functools32 02:54:37 INFO - Cleaning up... 02:54:37 INFO - Return code: 0 02:54:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6051854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, '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': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', '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 02:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:54:37 INFO - Using env: {'DISPLAY': ':0', 02:54:37 INFO - 'HOME': '/home/cltbld', 02:54:37 INFO - 'LANG': 'en_US.UTF-8', 02:54:37 INFO - 'LANGUAGE': 'en_US:en', 02:54:37 INFO - 'LOGNAME': 'cltbld', 02:54:37 INFO - 'MAIL': '/var/mail/cltbld', 02:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:37 INFO - 'MOZ_NO_REMOTE': '1', 02:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:37 INFO - 'NO_EM_RESTART': '1', 02:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:37 INFO - 'PWD': '/builds/slave/test', 02:54:37 INFO - 'SHELL': '/bin/bash', 02:54:37 INFO - 'SHLVL': '1', 02:54:37 INFO - 'TERM': 'linux', 02:54:37 INFO - 'TMOUT': '86400', 02:54:37 INFO - 'USER': 'cltbld', 02:54:37 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:37 INFO - '_': '/tools/buildbot/bin/python'} 02:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:37 INFO - Downloading/unpacking flake8 02:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:54:38 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 02:54:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:54:38 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 02:54:38 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 02:54:38 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 02:54:38 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 02:54:38 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 02:54:38 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 02:54:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:54:39 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 02:54:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:39 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 02:54:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:54:39 INFO - no previously-included directories found matching 'docs/_build' 02:54:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:54:39 INFO - Running setup.py install for pep8 02:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:54:39 INFO - no previously-included directories found matching 'docs/_build' 02:54:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:54:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:54:39 INFO - Cleaning up... 02:54:39 INFO - Return code: 0 02:54:39 INFO - Running post-action listener: _resource_record_post_action 02:54:39 INFO - Running post-action listener: _start_resource_monitoring 02:54:39 INFO - Starting resource monitoring. 02:54:39 INFO - ##### 02:54:39 INFO - ##### Running install step. 02:54:39 INFO - ##### 02:54:39 INFO - Running pre-action listener: _resource_record_pre_action 02:54:39 INFO - Running main action method: install 02:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:40 INFO - Reading from file tmpfile_stdout 02:54:40 INFO - Detecting whether we're running mozinstall >=1.0... 02:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:54:40 INFO - Reading from file tmpfile_stdout 02:54:40 INFO - Output received: 02:54:40 INFO - Usage: mozinstall [options] installer 02:54:40 INFO - Options: 02:54:40 INFO - -h, --help show this help message and exit 02:54:40 INFO - -d DEST, --destination=DEST 02:54:40 INFO - Directory to install application into. [default: 02:54:40 INFO - "/builds/slave/test"] 02:54:40 INFO - --app=APP Application being installed. [default: firefox] 02:54:40 INFO - mkdir: /builds/slave/test/build/application 02:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:54:54 INFO - Reading from file tmpfile_stdout 02:54:54 INFO - Output received: 02:54:54 INFO - /builds/slave/test/build/application/firefox/firefox 02:54:54 INFO - Running post-action listener: _resource_record_post_action 02:54:54 INFO - ##### 02:54:54 INFO - ##### Running run-tests step. 02:54:54 INFO - ##### 02:54:54 INFO - Running pre-action listener: _resource_record_pre_action 02:54:54 INFO - Running main action method: run_tests 02:54:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:54:54 INFO - Python 2.7.3 02:54:54 INFO - Return code: 0 02:54:54 INFO - grabbing minidump binary from tooltool 02:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:54 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 0x1e630b0>, '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 0x1e63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:54:54 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 02:54:54 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 02:54:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:54:54 INFO - Return code: 0 02:54:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:54:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:54:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:54:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:54:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:54:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:54:55 INFO - Return code: 0 02:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] in /builds/slave/test/build 02:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost 02:54:55 INFO - Using env: {'DISPLAY': ':0', 02:54:55 INFO - 'HOME': '/home/cltbld', 02:54:55 INFO - 'LANG': 'en_US.UTF-8', 02:54:55 INFO - 'LANGUAGE': 'en_US:en', 02:54:55 INFO - 'LOGNAME': 'cltbld', 02:54:55 INFO - 'MAIL': '/var/mail/cltbld', 02:54:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:55 INFO - 'MOZ_NO_REMOTE': '1', 02:54:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:55 INFO - 'NO_EM_RESTART': '1', 02:54:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:55 INFO - 'PWD': '/builds/slave/test', 02:54:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:55 INFO - 'SHELL': '/bin/bash', 02:54:55 INFO - 'SHLVL': '1', 02:54:55 INFO - 'TERM': 'linux', 02:54:55 INFO - 'TMOUT': '86400', 02:54:55 INFO - 'USER': 'cltbld', 02:54:55 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449657811.931297-661670290', 02:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:55 INFO - '_': '/tools/buildbot/bin/python'} 02:54:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] with output_timeout 3600 02:54:55 INFO - mozversion INFO | application_buildid: 20151209015042 02:54:55 INFO - mozversion INFO | application_changeset: 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb 02:54:55 INFO - mozversion INFO | application_display_name: Nightly 02:54:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:54:55 INFO - mozversion INFO | application_name: Firefox 02:54:55 INFO - mozversion INFO | application_remotingname: firefox 02:54:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:54:55 INFO - mozversion INFO | application_vendor: Mozilla 02:54:55 INFO - mozversion INFO | application_version: 45.0a1 02:54:55 INFO - mozversion INFO | platform_buildid: 20151209015042 02:54:55 INFO - mozversion INFO | platform_changeset: 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb 02:54:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:54:55 INFO - mozversion INFO | platform_version: 45.0a1 02:54:55 INFO - 2015-12-09 02:54:55,948 DEBUG : using testdate: 1449658495 02:54:55 INFO - 2015-12-09 02:54:55,948 DEBUG : actual date: 1449658495 02:54:55 INFO - 2015-12-09 02:54:55,999 INFO : starting webserver on 'localhost:46324' 02:54:56 INFO - 2015-12-09 02:54:56,000 INFO : Starting test suite talos-linux64-ix-012.e 02:54:56 INFO - 2015-12-09 02:54:56,000 INFO : Starting test dromaeo_css 02:54:56 INFO - 2015-12-09 02:54:56,000 DEBUG : operating with platform_type : linux_ 02:54:56 INFO - 2015-12-09 02:54:56,001 INFO : Initialising browser for dromaeo_css test... 02:54:56 INFO - 2015-12-09 02:54:56,018 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWT2NYv/profile http://localhost:46324/getInfo.html 02:55:00 INFO - 2015-12-09 02:55:00,640 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:55:00 INFO - 2015-12-09 02:55:00,640 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:55:00 INFO - 2015-12-09 02:55:00,640 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:55:00 INFO - 2015-12-09 02:55:00,640 DEBUG : BROWSER_OUTPUT: __metrics 02:55:00 INFO - 2015-12-09 02:55:00,749 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] 02:55:01 INFO - 2015-12-09 02:55:01,669 INFO : Browser initialized. 02:55:01 INFO - 2015-12-09 02:55:01,670 INFO : Running cycle 1/1 for dromaeo_css test... 02:55:01 INFO - 2015-12-09 02:55:01,670 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWT2NYv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:55:13 INFO - 2015-12-09 02:55:13,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 142671872 02:55:13 INFO - 2015-12-09 02:55:13,766 DEBUG : BROWSER_OUTPUT: 02:56:03 INFO - 2015-12-09 02:56:03,392 DEBUG : BROWSER_OUTPUT: 1449658563391 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] 02:58:16 INFO - 2015-12-09 02:58:16,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46324/tests/dromaeo/cssquery-ext.html) 02:58:17 INFO - 2015-12-09 02:58:17,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 146378752 02:58:17 INFO - 2015-12-09 02:58:17,191 DEBUG : BROWSER_OUTPUT: 03:01:19 INFO - 2015-12-09 03:01:19,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/dromaeo/cssquery-ext.html (next: http://localhost:46324/tests/dromaeo/cssquery-jquery.html) 03:01:19 INFO - 2015-12-09 03:01:19,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 144261120 03:01:19 INFO - 2015-12-09 03:01:19,747 DEBUG : BROWSER_OUTPUT: 03:04:21 INFO - 2015-12-09 03:04:21,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46324/tests/dromaeo/cssquery-mootools.html) 03:04:22 INFO - 2015-12-09 03:04:22,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 144052224 03:04:22 INFO - 2015-12-09 03:04:22,192 DEBUG : BROWSER_OUTPUT: 03:07:23 INFO - 2015-12-09 03:07:23,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46324/tests/dromaeo/cssquery-prototype.html) 03:07:24 INFO - 2015-12-09 03:07:24,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 143986688 03:07:24 INFO - 2015-12-09 03:07:24,565 DEBUG : BROWSER_OUTPUT: 03:10:27 INFO - 2015-12-09 03:10:27,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46324/tests/dromaeo/cssquery-yui.html) 03:10:27 INFO - 2015-12-09 03:10:27,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 144457728 03:10:27 INFO - 2015-12-09 03:10:27,815 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/dromaeo/cssquery-yui.html (next: http://localhost:46324/tests/dromaeo/cssquery-dojo.html) 03:13:30 INFO - 2015-12-09 03:13:30,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 146591744 03:13:30 INFO - 2015-12-09 03:13:30,702 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,703 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:13:30 INFO - 2015-12-09 03:13:30,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:13:30 INFO - 2015-12-09 03:13:30,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:13:30 INFO - 2015-12-09 03:13:30,703 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:13:30 INFO - 2015-12-09 03:13:30,703 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2677.06860987219;2709.7696695780855;2747.6153338532595;2755.2423083651993;2766.7233276672328;4568.29191475321;4805.063012712522;4813.2780082987565;4819.879503012422;4852.854414367565;4646.837360692376;4727.810887564493;4759.500252473493;4762.714237145765;4790.473047964721;4347.67392445567;4431.911361772763;4480.641548676114;4486.259767138418;4514.796834142471;4463.821447142111;4466.798994045275;4476.283794592866;4495.505494395614;4563.338315944186;4135.1729654069;4257.936130958038;4458.286674132156;4497.9325310120375;4539.387182730338;4285.914281714379;4333.71830830995;4337.522872484055;4350.195213885441;4400.471943366784;4364.061726728737;4371.475422949235;4431.512533621299;4444.355568442557;4458.8439404620685;4482.686211965164;4585.922308257557;4620.314033855043;4717.221658426355;4744.454387745384;5117.411497677777;5153.330067091291;5175.689458632456;5190.7404629768735;5203.9219411708855;5147.305113809625;5209.7916083356995;5220.190870415092;5228.79084836606;5240.606954478391;4590.059037897223;4681.274402467623;4703.482616912137;4736.455307639666;4805.975970120162;5326.6537675050995;5340.813071542478;5352.277442545284;5353.705546194997;5353.732313384393;5080.77136528857;5085.491450854959;5096.719680417613;5100.5409513143995;5151.922721159186;4847.127517046895;4949.331840201527;4967.155583550805;4970.602351811846;5179.533841954242;4907.901841963141;4965.702057876539;4974.129527332702;4975.601951843843;4994.101061808837;4959.082569724613;5035.395752509649;5045.066662667418;5052.317937078521;5061.417936937226;4291.420658211102;4302.978485107555;4310.80601372939;4345.478542574848;4355.542668019875;3598.9640103599154;3694.353488139565;3725.6646901778427;3755.230177813596;3790.938537209586;4260.318349064135;4267;4280.850170244026;4302.698811083194;4375.190589740908;5163.3545806774155;5165.560927321219;5170.45710200431;5190.325257716473;5222.2427747976335;4400.889977750582;4413.117376524708;4415.359772832921;4426.313921342197;4472.08322293929;4360.716553424018;4432.13573353193;4463.66522510813;4477.194105061055;4516.299973504112;4860.73265970375;4866.513348665176;4867;4867.123917694707;4910.533499317559;4898;5101.285819985279;5163.741812909415;5183.248428977702;5222.086134926297;4676.766161691834;4780.426348838162;4834.347363106076;4835.58897493717;4846.781894814671;5009.5491405773655;5081.7713202905215;5103.668261563135;5104.438511763778;5125.846224613268;4853.296272040464;4988.950110498994;5130.79476820923;5157.149070403341;5183.766730497212;4861.975690121527;4921.729304888266;4935.8025678972435;4942.085714142895;4963;4990.525900039491;4991.026749783758;5008.098542262428;5015;5076.060928728197;4607.746573938465;4812.278158276146;4853.805847766191;4935.81540430287;4963.553280204655;4970.279309500174;4980.228064649985;4998.925016124834;5016.197408414636;5053.191489361684;4900.509949005071;4902.044101400193;4908.092002979461;4912.92630610534;4953.133201689618 03:13:30 INFO - 2015-12-09 03:13:30,707 DEBUG : BROWSER_OUTPUT: |1;ext.html;501.6363136725874;538.7764077907668;542.1677724692597;544.7385255077561;564.074917135897;25035.123770668008;34675.306493870135;35513.289734205304;35570.466443003344;35674.643253567454;39007.41488877669;39616.405753913714;39673.60326396742;39682.60317396825;39706.205875882464;7912.169222231669;7965.243301886311;8086.959565202165;8094.635741391651;8095.069067057276;7764.883526747103;7836.529808211497;7875;7887.250711182429;7900.486468379566;7767.6504557294775;7809.219078092174;7846.68613255472;7876.921230787705;7884.842303153933;7880.605969701492;7891.487053341543;7937.563434011127;7942.722004729807;7975.601219939009;7766.883496747553;7805.726799561988;7819.687212511492;7891.487053341514;7928.80177995549;36733.44899826505;36900.26199475995;36931.26137477235;37298.254034919424;37408.81295593505;2712.562341958765;2763.088180900298;2823.8023338366324;2950.4246671898986;3113.844307784602;27797;28056.158315250574;28100.437991240266;28296.858515707496;28978.13065608035;3406.148462884279;3455.550778398792;3478.130467383154;3501.1947252132154;3570.410882204433;220449;221307;222787;223171.99999999837;223403;51642.741786290826;52320.476795232324;55977.96198342169;60206;61682;55547;55586.16620750692;55735.72132139395;55752.72123639356;55920.16119758207;12132.757344853053;12142.392880355947;12269;12299.262044277371;12310.446029928675;9318.767030824283;9330.30022748283;9371.344005919656;9383.5308234588;9397;19111.235550578098;19210.8078919209;19342.8065719341;19379.80620193808;19395.903020484806;7683.500572462772;7807.765767026998;7900.170482099412;7916;7950.562719050392;776.2160218179679;817.4441379861751;823.074041703084;895.3956079646213;977.6333874796951;26305.473890522084;26517;26562.070327538444;26625.866870665523;26685.599716004275;910.5629297936895;916.2440986186423;922.9077092290852;926.1849572376266;998.3760149906309;13353.666158345924;13455.596332110052;15672.921635391978;15753.606159846095;16223.269952851913;311660;312440;315350;316092;317089;48010.27984580234;48149.27776083362;48718.75640621774;48859.75570122198;48908.26637600439;1168.8305195746568;1171.1860257121218;1174.2602160638744;1191.0412118244897;1318.6835159561829;26949;27298.863505682344;27359.316017099733;27591.86204068967;27651.86174069117;39219.60780392159;39787.602123979545;39820.80089599534;39824.21230513836;39869.60130398659;247503;248311;249637;250180;250374;29048.854755726086;41531;41974;42026.159476810906;42593.36109958415;37278.8136059318;37925.24149517049;38166.427503586914;38944.2211155781;38953.22093558056;32167.19582010375;32753.508697370034;32795.34409311753;33293.667063329056;33363.666363337026;32596.83701581477;33095.17262068371;33339.33321333608;33453.49819752657;33804.3239135211;32866.50700239451;32961;33380.33239335151;33495.49756753699;33500;28555.714442856137;29816.70183298226;30221.697783022766;30247.40939064954;30379.69620303857;23687.763122368557;23820.761792381854;24083.63874541848;24190.395240118432;24329.513409731353 03:13:30 INFO - 2015-12-09 03:13:30,707 DEBUG : BROWSER_OUTPUT: |2;jquery.html;281.5284398632291;282.3829931599454;284.46804475630574;284.69253206536945;288.60605273801264;12700.745985080293;13152.605421837336;15334.769978450318;15857.841421585781;15902.125383103925;9125.133112354333;9174.724758257245;11740.471678774455;12033.338166400845;12597.307148106851;4389.1002344519375;4484.798184081724;4521.344405061264;4524.936639889624;4532;3371.3088816792497;3849.441830934513;4504.774761261924;4540.9091818163615;4541.705613900039;5107.38711354638;5142.691438513682;5147.1249887519025;5157.432682404932;5161.845144645647;5025.547700706954;5114.053900028507;5117.872053198663;5124.256982737501;5166.225066240057;4950.331705219785;4955.331030310898;4971.055499455092;4987.650864439491;4994.175960966436;10816.296940698909;11400.885991140149;16755.413560525445;16876.915615421844;17399.391021314193;1687.4600127959059;1699.328765137776;1754.7280171573427;1764.7970483394317;1767.540439485743;8193.180681931819;8314.70898518555;8357.080721120672;8399.202075802788;8474.957625211897;1753.2723919573361;1753.8947663140252;1759.6359236594892;1775.5649865782837;1778.0309731196528;53554.19668704973;56536.43463565353;56824.43175568233;56992.43007569954;57456.71271643657;9517.428954262767;9681.177099946442;9838.557264923096;9849.704508864745;9880.555375008142;12196.512139514498;12219.51121955112;12257.69355766113;12272.754544909052;12279.263244205376;6521.967390163114;6566.179227596551;6800.547467960682;6805.829854253584;6893.414059804973;6509.707063182168;6519.641419721961;6526.967365163144;6551.246606640298;6615.272320044791;3842.5974519300253;3906.43356713275;4013.678905687538;4050.7772072535704;4132.938005929914;1654.4374912529797;1684.3936182974119;1710.4783041172313;1779.6173822627939;1784.3754685860106;807.3258828877836;837.623069618674;867.5618812499773;920.2499962530517;924.4176169013613;15692.450764223197;15788.842111578737;15791.447299344467;16377.754333685005;16424.917875410785;780.149636895775;817.554432834095;820.1183727492969;825.9008918929767;840.7393707950555;9018.86471702925;9238.722838314727;9297.302702297355;9466.100720431548;9557.665481708245;328113;333613;469664;476200;481944;65504.344956550776;65829.34170658232;76880.23119768842;79403.60298198472;79481.60259198667;385.77046657238895;396.7084193118056;396.8591150141716;397.2809215320222;397.30669980882965;9254.4910029949;9348.298877584073;9398.530073496435;9599.232061434928;9606.759831004281;33327.50008749822;33630.159246019044;34387.65612343844;35649.643503564635;35905.28189436145;46323;47713.52286477091;47948.28077578909;48498.75750621224;48895.5110448891;8296.25333719944;8616.0522342541;8916.10838916129;9209.125133112344;9222.907770922473;15296.31166597528;15557.611059723598;15981.200939952723;16352;16393;12932.676683082998;13177;13521.661958451117;13538.323083845571;13937.512187073404;11090.279131856403;11212.383318917538;12810.103292769416;13641.249731264876;14071.718565628425;13529.458821647024;13610.59168224955;13953.23257220822;13960.860391396362;13963.092398994033;8201.58992050407;8353.122922093093;8437.367197460339;8464.57677116154;8610.095939926217;8151.1441298662785;8162.102168761313;8214.014318281845;12444.440000199831;13177.538786142439 03:13:30 INFO - 2015-12-09 03:13:30,710 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1484.970300593989;1643.3098098798503;1689.5100420877945;1701.6766814305288;1714.751361052647;6919.515633905628;6935.583864968093;7120.572765634059;7120.928790712098;7126.429885609152;7104.467164962635;7116.288371162881;7189.496735228536;7205.459590530718;7219.747308844191;2055.989720051405;2101.086027578001;2102.0330647901983;2102.6530622447276;2109.2512158183854;2086.0821238654944;2088.1438610169835;2107.283523601975;2152.1929276521305;2154.7306586676664;2035.4911272181955;2055.332017094443;2081.3339731285996;2093.874367537945;2105.8315334773183;2026.868253563521;2112.1849158114883;2117.100232401231;2118.8940552972367;2133.4772980619846;2068.844836637243;2101.3800928726064;2106.4839114417064;2109.156337465011;2111.4510227341;6807.5575087619145;6959.269276725972;6988.126484189476;7008.649567521604;7026.859462810767;4065.0447144920918;4118.4440100586635;4136.069384388518;4145.7719825409595;4146.66826653867;2708.8103832731717;2735.39821239327;2764.115483045426;2781.721827817202;2794.9580756288674;795.0657976877204;800.1798156889236;819.3281509162489;833.3874602167463;833.8415701016787;9035.638574457014;9113.81772364549;9115.22520585751;9136.862947055799;9187.77030574241;3648.7993160375904;3670.871519496805;3694;3709.0541911812315;3748.11919198988;7423.183449820515;7432.070991126109;7433.219511951275;7478.513896596813;7488.588127653032;3983.8008099595486;3993.1614360983936;4018.095928416083;4035.435039094529;4056.1684854604737;3633.5276414066;3663.505426767352;3676.2647470506004;3689.6679298862696;3706.703463722896;3045.8629361678777;3053.4198502284494;3062.127293721279;3075.2773098321877;3088.119885832572;889.4396530185942;898.2993265253114;899.3165194452264;904.7104926423613;908.5094049213483;863.1325517854516;867.2411639815161;872.0146234754686;911.1116661255355;940.2478017585904;6491.350864913471;6555.3772391622715;6573.112629795012;6581.3418658133805;6589.538732288694;1003;1013.366645846346;1029.891861354562;1051.4269723000982;1059.7032830807232;5074.23886417033;5127.1540195867265;5138.717370544656;5153.072446959508;5153.948460515422;8052.677892884219;8066.11272759996;8233.217844304781;8245.505269683837;8358.832823343499;8020.5588692621295;8029.156938521488;8045.637946292431;8064.556449395222;8103.027636683636;6631.1379520662;6652.201735791639;6708.899366509506;6717.16035495563;6797.320267973163;6303.842403939938;6492.188476440445;6544.640044797582;6554.213494380705;6564.277929427663;7244.348008679244;7515.549067055994;7521.323080922743;7592.924070759222;7638.961805190938;7542.622868856645;7597.050368703912;7668.846623067619;7866.881996769938;7886.250806173404;6105.5420843437805;6166.784162554289;6172.845678858064;6177.104319873503;6199.132121502903;6531.738730450728;6532.314107018885;6577;6625.834354140992;6657.101291325609;6202.503799696104;6216.222972128484;6291.779787707408;6298.464630506458;6434.935650643621;5884.117382392504;6103.05402662588;6132.41742034506;6175.876482470236;6276.121343012073;6340.175777148941;6347.238331400077;6349.904751428825;6357.841053973502;6373;5726.455986681259;5764.3371012332445;5770.6249093808765;5828.213191219131;5838.211841401357;5977.252843394575;5979.581429300081;5983.401659833982;5992.760289588367;5996.280446346466 03:13:30 INFO - 2015-12-09 03:13:30,711 DEBUG : BROWSER_OUTPUT: |4;prototype.html;253.2162955652256;254.67656076782498;260.91389841352355;262.5746291008565;263.3311389071758;5487.368952570456;5510.6142570020065;5548.223248745169;5548.334199896013;5748.252727145476;5543.667379957195;5600.887982240363;5610.158476228557;5613.158026296048;5623.887522249553;3956.1494278730065;4010.498687664042;4045.858394956177;4125.834966601333;4148.087420767426;4104.240715467633;4119.052617897885;4122.793860306988;4126.1541384016355;4144.088300573869;4062.837486500536;4069.104796944682;4071.1043570414463;4092.0997380576227;4097.8770636880945;4116.485439320085;4117.07365842686;4121.031557583965;4122.443470131524;4124.8556300529635;3377.6960073593496;3430.125318043908;3516.191276006533;3523.5243242162237;3536.6816986471085;5259.079661059338;5275.129603615399;5298.894022119574;5301.681899086028;5317.521423071903;4692.648051396159;4706.599939005188;4712.034033023257;4713.151632706112;4719.622430205575;5790.04464263396;5798.507126894219;5814.563907706939;5825.271841019872;5828.300603927513;3661.1945372018113;3813.3707938190164;3827.311084004878;3829.100161462054;3834.6740527055235;6145.201123853871;6149.29283132441;6208.751649933997;6215.533834962396;6218.906716399258;3914.178022615226;3917.4319723639915;3929.410588411704;3935.74417662851;3939.113699417608;3984.641382275551;3987.7009224308295;3989.4614227079555;3990.2618015667194;3994.9201015979515;4542.409486766765;4691.554302341272;4694.037722266927;4709.7174169549935;4712.31671407644;5752.6836024019085;5884.382139875252;5902.557308201902;5904.616199947076;5913.733881975236;1379.048456564967;1381.9239941803298;1386.5355106039387;1388.590365842079;1388.9097208681605;897.1387468030764;902.702108304258;906.1618003346878;917.2249449215402;920.2959735802117;5066.189409694505;5067.391912970394;5077.39071311445;5082.440931497532;5088.669236499616;6076.453119219292;6107.48086412651;6123.265208174958;6128.1114238435175;6130.325664176937;5055.16589762685;5071.670341427869;5073.086844367976;5084.56781173597;5085.974570127126;3188.9681103188673;3256.1859535116223;3277.770556061053;3283.3761585298716;3283.4910588858766;5652.85867853307;5656.321241451053;5657.745401456944;5663.660180389107;5682.062459694104;6155.753769849156;6177.96911015442;6204.069389591507;6208.50331973441;6208.565400422018;5526.198701188225;5651.660900345993;5662.830115096472;5666.348369937427;5675.3757086720425;5998.520118390606;6016.578839481194;6016.969915150396;6027.367126451835;6037.78867739627;5871;5871.73577189036;5888.764449421975;5902.5277977762535;5905.8228253150755;5646.237757902631;5661.631993920382;5666.518345940642;5675.177099320493;5689.203511508475;3814.694824413985;3867.43922131295;3898.8050597469446;3902.043999220209;3914.4911161548816;5993.460588547052;6000.969995149996;6025.18659980897;6049.243844519435;6198.380161983766;5907.202527658711;5912.970435147797;5931.584789064724;5935.139404786368;5952.315483719254;5868.647881127146;5884.941150588439;5924.081767326072;5933.910991335047;5939.227900372924;5606.859828504157;5769.048107062287;5789.623674461147;5798.768049277982;5803.65178089316;5940.702964851826;5949.553783466171;5957.344692083954;5974.641521508724;5980.641161530322;5766.509846663081;5788.652680839163;5827.708614569339;5832.037713777179;5835.183074369506 03:13:30 INFO - 2015-12-09 03:13:30,711 DEBUG : BROWSER_OUTPUT: |5;yui.html;727.1201845766623;743.7991742229598;788.601756113163;796.4623878881757;805.2430715127783;11659.183857130005;11838.940805295972;11868.643940681794;14516.346764395601;14727.410903563872;13397.732045359087;13451.730965380686;13510.72978540431;13538.661533461669;13542.45830166792;782.7573452229813;797.5374282915924;797.8085259537698;799.4403917257914;800.4836880212259;779.1701837542998;802.2258520527689;807.1766797866202;807.4186585658316;808.337163525909;833.7873842170238;836.6862426590029;836.9204925532065;839.8698201778703;844.0673056272822;830.6967956695823;831.268483734313;831.629924683516;839.290799274612;840.0381563110235;621.6332363905318;621.7761605821901;622.7384498510636;623.1742940603673;623.5479277523805;11830.112741544333;11881.40592970348;11907.642770716893;11957.88042119585;11986.340751258676;10533.36799792015;10808.891911080946;10979.28634638746;11254.662360129209;11448.198626096177;9187.494687792168;9460.763480912963;9576.23390128795;9650.324477286593;9657.213415518152;3091.7217450429343;3148.8740450381956;3156.305612765188;3157.068664743906;3208.406444807718;38476;38545.807270963465;38772.418413723535;39070.21859562793;39199;8872.689455869013;9079.773005674911;9091.31815113869;9198.264138868875;9378.718638440858;15180.696386072217;15195.772063419057;15209.391624334903;15261.771073433907;15274;6182.227221597301;6215.782447614402;6234.781782637677;6368.872622547523;6539.444147247537;3666.046827824785;3743.288775132716;3747.5877653458097;3753.6621704046765;3774.5281839770028;2640.8943642254094;2661.294756889426;2668.066176838091;2670.105514652574;2670.4258584404056;464.12512414099666;467.16377683946035;467.60054404479246;473.6305681568382;473.9976300118477;453.76631035016993;473.5477618873967;474.3690891114809;476.3236204589491;479.7673128532659;7400.5189662671755;7506.28690274423;8198.754037378889;8301.335893128535;8637;421.4058177969049;445.46099219944233;486.4575997762469;499.90751710932864;559.8600349912522;3334.433146365124;3364.9495257571157;3448.137965508623;3499.3876071687355;3584.6953008994005;45096;45367.773161133984;45762.54237457583;47817.76091119592;49137.262941055196;39120;39538.40692389617;39660.40509392361;41238.79380603078;44538.77730611391;39933.60066399299;40099.19057689515;40374.39438408426;40464;41198.38202426966;7688.384929205762;7740.535567865721;8054.23484768946;8095.797605059921;8221.136780637948;30922.845385772926;31491.527627085154;31690;31997.520037199927;32168.19579510531;35684.821575891954;35837.46243806397;36996.44505332476;38319;38382;10288.639897603547;10474.371537707762;10477.37135771856;10520.78958420812;10630.25588208818;10895.400752958347;11070.723231919266;11118.444077796239;11554.133439992202;11555.191136620691;9617.807643847224;9831.410115393099;10025.699229023141;10529.684109476728;11027.117830573696;10302.742431439274;10622.787544248917;10904;11021.44892755375;11087.22389432732;9743.512824358895;9765.9023409765;10438.582456701646;10693.09108725767;10711.517981690688;8860.556972151495;8885.333599980157;9095.545222738969;9097.135772101905;9203.86194207074;8116.350691944512;8390.244877961013;8523;8883.822323553622;8967.08172606077 03:13:30 INFO - 2015-12-09 03:13:30,711 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:13:30 INFO - 2015-12-09 03:13:30,711 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:13:30 INFO - 2015-12-09 03:13:30,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,327 03:13:30 INFO - 2015-12-09 03:13:30,711 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:13:30 INFO - 2015-12-09 03:13:30,711 DEBUG : BROWSER_OUTPUT: __startTimestamp1449659610700__endTimestamp 03:13:30 INFO - 2015-12-09 03:13:30,711 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,712 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:13:30 INFO - 2015-12-09 03:13:30,712 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:13:30 INFO - 2015-12-09 03:13:30,712 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,712 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4711.24 Median:4852.85 stddev:500.20 (10.3%) stddev-sans-first:475.60 03:13:30 INFO - 2015-12-09 03:13:30,713 DEBUG : BROWSER_OUTPUT: Values: 2677.1 2709.8 2747.6 2755.2 2766.7 4568.3 4805.1 4813.3 4819.9 4852.9 4646.8 4727.8 4759.5 4762.7 4790.5 4347.7 4431.9 4480.6 4486.3 4514.8 4463.8 4466.8 4476.3 4495.5 4563.3 4135.2 4257.9 4458.3 4497.9 4539.4 4285.9 4333.7 4337.5 4350.2 4400.5 4364.1 4371.5 4431.5 4444.4 4458.8 4482.7 4585.9 4620.3 4717.2 4744.5 5117.4 5153.3 5175.7 5190.7 5203.9 5147.3 5209.8 5220.2 5228.8 5240.6 4590.1 4681.3 4703.5 4736.5 4806.0 5326.7 5340.8 5352.3 5353.7 5353.7 5080.8 5085.5 5096.7 5100.5 5151.9 4847.1 4949.3 4967.2 4970.6 5179.5 4907.9 4965.7 4974.1 4975.6 4994.1 4959.1 5035.4 5045.1 5052.3 5061.4 4291.4 4303.0 4310.8 4345.5 4355.5 3599.0 3694.4 3725.7 3755.2 3790.9 4260.3 4267.0 4280.9 4302.7 4375.2 5163.4 5165.6 5170.5 5190.3 5222.2 4400.9 4413.1 4415.4 4426.3 4472.1 4360.7 4432.1 4463.7 4477.2 4516.3 4860.7 4866.5 4867.0 4867.1 4910.5 4898.0 5101.3 5163.7 5183.2 5222.1 4676.8 4780.4 4834.3 4835.6 4846.8 5009.5 5081.8 5103.7 5104.4 5125.8 4853.3 4989.0 5130.8 5157.1 5183.8 4862.0 4921.7 4935.8 4942.1 4963.0 4990.5 4991.0 5008.1 5015.0 5076.1 4607.7 4812.3 4853.8 4935.8 4963.6 4970.3 4980.2 4998.9 5016.2 5053.2 4900.5 4902.0 4908.1 4912.9 4953.1 03:13:30 INFO - 2015-12-09 03:13:30,713 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,713 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42284.15 Median:20151.93 stddev:69239.77 (343.6%) stddev-sans-first:69362.94 03:13:30 INFO - 2015-12-09 03:13:30,714 DEBUG : BROWSER_OUTPUT: Values: 501.6 538.8 542.2 544.7 564.1 25035.1 34675.3 35513.3 35570.5 35674.6 39007.4 39616.4 39673.6 39682.6 39706.2 7912.2 7965.2 8087.0 8094.6 8095.1 7764.9 7836.5 7875.0 7887.3 7900.5 7767.7 7809.2 7846.7 7876.9 7884.8 7880.6 7891.5 7937.6 7942.7 7975.6 7766.9 7805.7 7819.7 7891.5 7928.8 36733.4 36900.3 36931.3 37298.3 37408.8 2712.6 2763.1 2823.8 2950.4 3113.8 27797.0 28056.2 28100.4 28296.9 28978.1 3406.1 3455.6 3478.1 3501.2 3570.4 220449.0 221307.0 222787.0 223172.0 223403.0 51642.7 52320.5 55978.0 60206.0 61682.0 55547.0 55586.2 55735.7 55752.7 55920.2 12132.8 12142.4 12269.0 12299.3 12310.4 9318.8 9330.3 9371.3 9383.5 9397.0 19111.2 19210.8 19342.8 19379.8 19395.9 7683.5 7807.8 7900.2 7916.0 7950.6 776.2 817.4 823.1 895.4 977.6 26305.5 26517.0 26562.1 26625.9 26685.6 910.6 916.2 922.9 926.2 998.4 13353.7 13455.6 15672.9 15753.6 16223.3 311660.0 312440.0 315350.0 316092.0 317089.0 48010.3 48149.3 48718.8 48859.8 48908.3 1168.8 1171.2 1174.3 1191.0 1318.7 26949.0 27298.9 27359.3 27591.9 27651.9 39219.6 39787.6 39820.8 39824.2 39869.6 247503.0 248311.0 249637.0 250180.0 250374.0 29048.9 41531.0 41974.0 42026.2 42593.4 37278.8 37925.2 38166.4 38944.2 38953.2 32167.2 32753.5 32795.3 33293.7 33363.7 32596.8 33095.2 33339.3 33453.5 33804.3 32866.5 32961.0 33380.3 33495.5 33500.0 28555.7 29816.7 30221.7 30247.4 30379.7 23687.8 23820.8 24083.6 24190.4 24329.5 03:13:30 INFO - 2015-12-09 03:13:30,714 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,714 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24085.17 Median:4541.31 stddev:69615.26 (1532.9%) stddev-sans-first:69787.61 03:13:30 INFO - 2015-12-09 03:13:30,714 DEBUG : BROWSER_OUTPUT: Values: 281.5 282.4 284.5 284.7 288.6 12700.7 13152.6 15334.8 15857.8 15902.1 9125.1 9174.7 11740.5 12033.3 12597.3 4389.1 4484.8 4521.3 4524.9 4532.0 3371.3 3849.4 4504.8 4540.9 4541.7 5107.4 5142.7 5147.1 5157.4 5161.8 5025.5 5114.1 5117.9 5124.3 5166.2 4950.3 4955.3 4971.1 4987.7 4994.2 10816.3 11400.9 16755.4 16876.9 17399.4 1687.5 1699.3 1754.7 1764.8 1767.5 8193.2 8314.7 8357.1 8399.2 8475.0 1753.3 1753.9 1759.6 1775.6 1778.0 53554.2 56536.4 56824.4 56992.4 57456.7 9517.4 9681.2 9838.6 9849.7 9880.6 12196.5 12219.5 12257.7 12272.8 12279.3 6522.0 6566.2 6800.5 6805.8 6893.4 6509.7 6519.6 6527.0 6551.2 6615.3 3842.6 3906.4 4013.7 4050.8 4132.9 1654.4 1684.4 1710.5 1779.6 1784.4 807.3 837.6 867.6 920.2 924.4 15692.5 15788.8 15791.4 16377.8 16424.9 780.1 817.6 820.1 825.9 840.7 9018.9 9238.7 9297.3 9466.1 9557.7 328113.0 333613.0 469664.0 476200.0 481944.0 65504.3 65829.3 76880.2 79403.6 79481.6 385.8 396.7 396.9 397.3 397.3 9254.5 9348.3 9398.5 9599.2 9606.8 33327.5 33630.2 34387.7 35649.6 35905.3 46323.0 47713.5 47948.3 48498.8 48895.5 8296.3 8616.1 8916.1 9209.1 9222.9 15296.3 15557.6 15981.2 16352.0 16393.0 12932.7 13177.0 13521.7 13538.3 13937.5 11090.3 11212.4 12810.1 13641.2 14071.7 13529.5 13610.6 13953.2 13960.9 13963.1 8201.6 8353.1 8437.4 8464.6 8610.1 8151.1 8162.1 8214.0 12444.4 13177.5 03:13:30 INFO - 2015-12-09 03:13:30,714 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,714 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4846.06 Median:6246.17 stddev:2479.67 (39.7%) stddev-sans-first:2473.76 03:13:30 INFO - 2015-12-09 03:13:30,715 DEBUG : BROWSER_OUTPUT: Values: 1485.0 1643.3 1689.5 1701.7 1714.8 6919.5 6935.6 7120.6 7120.9 7126.4 7104.5 7116.3 7189.5 7205.5 7219.7 2056.0 2101.1 2102.0 2102.7 2109.3 2086.1 2088.1 2107.3 2152.2 2154.7 2035.5 2055.3 2081.3 2093.9 2105.8 2026.9 2112.2 2117.1 2118.9 2133.5 2068.8 2101.4 2106.5 2109.2 2111.5 6807.6 6959.3 6988.1 7008.6 7026.9 4065.0 4118.4 4136.1 4145.8 4146.7 2708.8 2735.4 2764.1 2781.7 2795.0 795.1 800.2 819.3 833.4 833.8 9035.6 9113.8 9115.2 9136.9 9187.8 3648.8 3670.9 3694.0 3709.1 3748.1 7423.2 7432.1 7433.2 7478.5 7488.6 3983.8 3993.2 4018.1 4035.4 4056.2 3633.5 3663.5 3676.3 3689.7 3706.7 3045.9 3053.4 3062.1 3075.3 3088.1 889.4 898.3 899.3 904.7 908.5 863.1 867.2 872.0 911.1 940.2 6491.4 6555.4 6573.1 6581.3 6589.5 1003.0 1013.4 1029.9 1051.4 1059.7 5074.2 5127.2 5138.7 5153.1 5153.9 8052.7 8066.1 8233.2 8245.5 8358.8 8020.6 8029.2 8045.6 8064.6 8103.0 6631.1 6652.2 6708.9 6717.2 6797.3 6303.8 6492.2 6544.6 6554.2 6564.3 7244.3 7515.5 7521.3 7592.9 7639.0 7542.6 7597.1 7668.8 7866.9 7886.3 6105.5 6166.8 6172.8 6177.1 6199.1 6531.7 6532.3 6577.0 6625.8 6657.1 6202.5 6216.2 6291.8 6298.5 6434.9 5884.1 6103.1 6132.4 6175.9 6276.1 6340.2 6347.2 6349.9 6357.8 6373.0 5726.5 5764.3 5770.6 5828.2 5838.2 5977.3 5979.6 5983.4 5992.8 5996.3 03:13:30 INFO - 2015-12-09 03:13:30,716 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,716 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4769.65 Median:5574.61 stddev:1480.48 (26.6%) stddev-sans-first:1445.30 03:13:30 INFO - 2015-12-09 03:13:30,716 DEBUG : BROWSER_OUTPUT: Values: 253.2 254.7 260.9 262.6 263.3 5487.4 5510.6 5548.2 5548.3 5748.3 5543.7 5600.9 5610.2 5613.2 5623.9 3956.1 4010.5 4045.9 4125.8 4148.1 4104.2 4119.1 4122.8 4126.2 4144.1 4062.8 4069.1 4071.1 4092.1 4097.9 4116.5 4117.1 4121.0 4122.4 4124.9 3377.7 3430.1 3516.2 3523.5 3536.7 5259.1 5275.1 5298.9 5301.7 5317.5 4692.6 4706.6 4712.0 4713.2 4719.6 5790.0 5798.5 5814.6 5825.3 5828.3 3661.2 3813.4 3827.3 3829.1 3834.7 6145.2 6149.3 6208.8 6215.5 6218.9 3914.2 3917.4 3929.4 3935.7 3939.1 3984.6 3987.7 3989.5 3990.3 3994.9 4542.4 4691.6 4694.0 4709.7 4712.3 5752.7 5884.4 5902.6 5904.6 5913.7 1379.0 1381.9 1386.5 1388.6 1388.9 897.1 902.7 906.2 917.2 920.3 5066.2 5067.4 5077.4 5082.4 5088.7 6076.5 6107.5 6123.3 6128.1 6130.3 5055.2 5071.7 5073.1 5084.6 5086.0 3189.0 3256.2 3277.8 3283.4 3283.5 5652.9 5656.3 5657.7 5663.7 5682.1 6155.8 6178.0 6204.1 6208.5 6208.6 5526.2 5651.7 5662.8 5666.3 5675.4 5998.5 6016.6 6017.0 6027.4 6037.8 5871.0 5871.7 5888.8 5902.5 5905.8 5646.2 5661.6 5666.5 5675.2 5689.2 3814.7 3867.4 3898.8 3902.0 3914.5 5993.5 6001.0 6025.2 6049.2 6198.4 5907.2 5913.0 5931.6 5935.1 5952.3 5868.6 5884.9 5924.1 5933.9 5939.2 5606.9 5769.0 5789.6 5798.8 5803.7 5940.7 5949.6 5957.3 5974.6 5980.6 5766.5 5788.7 5827.7 5832.0 5835.2 03:13:30 INFO - 2015-12-09 03:13:30,716 DEBUG : BROWSER_OUTPUT: 03:13:30 INFO - 2015-12-09 03:13:30,717 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11958.66 Median:433.43 stddev:13125.07 (3028.2%) stddev-sans-first:13134.79 03:13:30 INFO - 2015-12-09 03:13:30,717 DEBUG : BROWSER_OUTPUT: Values: 727.1 743.8 788.6 796.5 805.2 11659.2 11838.9 11868.6 14516.3 14727.4 13397.7 13451.7 13510.7 13538.7 13542.5 782.8 797.5 797.8 799.4 800.5 779.2 802.2 807.2 807.4 808.3 833.8 836.7 836.9 839.9 844.1 830.7 831.3 831.6 839.3 840.0 621.6 621.8 622.7 623.2 623.5 11830.1 11881.4 11907.6 11957.9 11986.3 10533.4 10808.9 10979.3 11254.7 11448.2 9187.5 9460.8 9576.2 9650.3 9657.2 3091.7 3148.9 3156.3 3157.1 3208.4 38476.0 38545.8 38772.4 39070.2 39199.0 8872.7 9079.8 9091.3 9198.3 9378.7 15180.7 15195.8 15209.4 15261.8 15274.0 6182.2 6215.8 6234.8 6368.9 6539.4 3666.0 3743.3 3747.6 3753.7 3774.5 2640.9 2661.3 2668.1 2670.1 2670.4 464.1 467.2 467.6 473.6 474.0 453.8 473.5 474.4 476.3 479.8 7400.5 7506.3 8198.8 8301.3 8637.0 421.4 445.5 486.5 499.9 559.9 3334.4 3364.9 3448.1 3499.4 3584.7 45096.0 45367.8 45762.5 47817.8 49137.3 39120.0 39538.4 39660.4 41238.8 44538.8 39933.6 40099.2 40374.4 40464.0 41198.4 7688.4 7740.5 8054.2 8095.8 8221.1 30922.8 31491.5 31690.0 31997.5 32168.2 35684.8 35837.5 36996.4 38319.0 38382.0 10288.6 10474.4 10477.4 10520.8 10630.3 10895.4 11070.7 11118.4 11554.1 11555.2 9617.8 9831.4 10025.7 10529.7 11027.1 10302.7 10622.8 10904.0 11021.4 11087.2 9743.5 9765.9 10438.6 10693.1 10711.5 8860.6 8885.3 9095.5 9097.1 9203.9 8116.4 8390.2 8523.0 8883.8 8967.1 03:13:30 INFO - 2015-12-09 03:13:30,718 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:13:30 INFO - 2015-12-09 03:13:30,718 DEBUG : BROWSER_OUTPUT: 03:13:31 INFO - 2015-12-09 03:13:31,418 INFO : Browser exited with error code: 0 03:13:31 INFO - 2015-12-09 03:13:31,439 INFO : Completed test dromaeo_css (00:18:35) 03:13:31 INFO - 2015-12-09 03:13:31,439 INFO : Starting test kraken 03:13:31 INFO - 2015-12-09 03:13:31,439 DEBUG : operating with platform_type : linux_ 03:13:31 INFO - 2015-12-09 03:13:31,439 INFO : Initialising browser for kraken test... 03:13:31 INFO - 2015-12-09 03:13:31,445 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp72KnIl/profile http://localhost:46324/getInfo.html 03:13:35 INFO - 2015-12-09 03:13:35,943 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:13:35 INFO - 2015-12-09 03:13:35,943 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:13:35 INFO - 2015-12-09 03:13:35,943 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:13:35 INFO - 2015-12-09 03:13:35,943 DEBUG : BROWSER_OUTPUT: __metrics 03:13:36 INFO - 2015-12-09 03:13:36,080 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] 03:13:36 INFO - 2015-12-09 03:13:36,949 INFO : Browser initialized. 03:13:36 INFO - 2015-12-09 03:13:36,950 INFO : Running cycle 1/1 for kraken test... 03:13:36 INFO - 2015-12-09 03:13:36,950 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp72KnIl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:13:48 INFO - 2015-12-09 03:13:48,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 143536128 03:13:48 INFO - 2015-12-09 03:13:48,987 DEBUG : BROWSER_OUTPUT: 03:13:51 INFO - 2015-12-09 03:13:51,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46324/tests/kraken/driver.html?testName=audio-beat-detection) 03:13:52 INFO - 2015-12-09 03:13:52,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 143134720 03:13:52 INFO - 2015-12-09 03:13:52,230 DEBUG : BROWSER_OUTPUT: 03:13:54 INFO - 2015-12-09 03:13:54,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46324/tests/kraken/driver.html?testName=audio-dft) 03:13:55 INFO - 2015-12-09 03:13:55,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 143446016 03:13:55 INFO - 2015-12-09 03:13:55,603 DEBUG : BROWSER_OUTPUT: 03:13:58 INFO - 2015-12-09 03:13:58,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46324/tests/kraken/driver.html?testName=audio-fft) 03:13:59 INFO - 2015-12-09 03:13:59,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 139190272 03:13:59 INFO - 2015-12-09 03:13:59,081 DEBUG : BROWSER_OUTPUT: 03:14:01 INFO - 2015-12-09 03:14:01,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46324/tests/kraken/driver.html?testName=audio-oscillator) 03:14:01 INFO - 2015-12-09 03:14:01,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 139800576 03:14:01 INFO - 2015-12-09 03:14:01,781 DEBUG : BROWSER_OUTPUT: 03:14:04 INFO - 2015-12-09 03:14:04,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:14:04 INFO - 2015-12-09 03:14:04,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 141373440 03:14:04 INFO - 2015-12-09 03:14:04,637 DEBUG : BROWSER_OUTPUT: 03:14:07 INFO - 2015-12-09 03:14:07,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46324/tests/kraken/driver.html?testName=imaging-darkroom) 03:14:08 INFO - 2015-12-09 03:14:08,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 139472896 03:14:08 INFO - 2015-12-09 03:14:08,279 DEBUG : BROWSER_OUTPUT: 03:14:11 INFO - 2015-12-09 03:14:11,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46324/tests/kraken/driver.html?testName=imaging-desaturate) 03:14:12 INFO - 2015-12-09 03:14:12,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 138125312 03:14:12 INFO - 2015-12-09 03:14:12,359 DEBUG : BROWSER_OUTPUT: 03:14:15 INFO - 2015-12-09 03:14:15,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46324/tests/kraken/driver.html?testName=json-parse-financial) 03:14:15 INFO - 2015-12-09 03:14:15,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 137863168 03:14:15 INFO - 2015-12-09 03:14:15,864 DEBUG : BROWSER_OUTPUT: 03:14:17 INFO - 2015-12-09 03:14:17,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:14:18 INFO - 2015-12-09 03:14:18,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 141213696 03:14:18 INFO - 2015-12-09 03:14:18,208 DEBUG : BROWSER_OUTPUT: 03:14:20 INFO - 2015-12-09 03:14:20,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46324/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:14:20 INFO - 2015-12-09 03:14:20,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 139399168 03:14:20 INFO - 2015-12-09 03:14:20,740 DEBUG : BROWSER_OUTPUT: 03:14:22 INFO - 2015-12-09 03:14:22,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:14:23 INFO - 2015-12-09 03:14:23,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 141639680 03:14:23 INFO - 2015-12-09 03:14:23,510 DEBUG : BROWSER_OUTPUT: 03:14:26 INFO - 2015-12-09 03:14:26,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:14:26 INFO - 2015-12-09 03:14:26,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 141910016 03:14:26 INFO - 2015-12-09 03:14:26,688 DEBUG : BROWSER_OUTPUT: 03:14:29 INFO - 2015-12-09 03:14:29,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:14:29 INFO - 2015-12-09 03:14:29,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 139464704 03:14:29 INFO - 2015-12-09 03:14:29,905 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46324/tests/kraken/driver.html?testName=ai-astar) 03:14:31 INFO - 2015-12-09 03:14:31,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 141111296 03:14:31 INFO - 2015-12-09 03:14:31,927 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,928 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:14:31 INFO - 2015-12-09 03:14:31,928 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:14:31 INFO - 2015-12-09 03:14:31,928 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:14:31 INFO - 2015-12-09 03:14:31,928 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:14:31 INFO - 2015-12-09 03:14:31,928 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;110;117;113;114;127;113;113;113;114 03:14:31 INFO - 2015-12-09 03:14:31,929 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;130;151;175;131;151;153;135;166;132 03:14:31 INFO - 2015-12-09 03:14:31,929 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;164;164;164;164;169;162;167;162 03:14:31 INFO - 2015-12-09 03:14:31,929 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;74;75;159;72;79;72;74;154 03:14:31 INFO - 2015-12-09 03:14:31,929 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;137;94;95;94;140;94;96;141 03:14:31 INFO - 2015-12-09 03:14:31,930 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;110;110;111;109;111;109;111;110 03:14:31 INFO - 2015-12-09 03:14:31,930 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;149;148;147;148;149;147;147;147 03:14:31 INFO - 2015-12-09 03:14:31,930 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;97;97;97;95;96;96;98;96 03:14:31 INFO - 2015-12-09 03:14:31,930 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;75;74;73;76;74;73;80;71;71 03:14:31 INFO - 2015-12-09 03:14:31,930 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;67;68;68;68;68;69;73;69 03:14:31 INFO - 2015-12-09 03:14:31,930 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;84;86;84;85;85;95;85 03:14:31 INFO - 2015-12-09 03:14:31,930 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;127;130;126;131;126;127;120;123;125 03:14:31 INFO - 2015-12-09 03:14:31,931 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;149;153;149;152;136;147;139;150;157 03:14:31 INFO - 2015-12-09 03:14:31,931 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;71;71;70;72;73;72;71;71 03:14:31 INFO - 2015-12-09 03:14:31,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:14:31 INFO - 2015-12-09 03:14:31,931 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:14:31 INFO - 2015-12-09 03:14:31,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,805 03:14:31 INFO - 2015-12-09 03:14:31,931 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:14:31 INFO - 2015-12-09 03:14:31,931 DEBUG : BROWSER_OUTPUT: __startTimestamp1449659671927__endTimestamp 03:14:31 INFO - 2015-12-09 03:14:31,932 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,935 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:14:31 INFO - 2015-12-09 03:14:31,935 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:14:31 INFO - 2015-12-09 03:14:31,935 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,935 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.00 Median:114.00 stddev:4.62 (4.1%) stddev-sans-first:4.88 03:14:31 INFO - 2015-12-09 03:14:31,935 DEBUG : BROWSER_OUTPUT: Values: 116.0 110.0 117.0 113.0 114.0 127.0 113.0 113.0 113.0 114.0 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:152.00 stddev:16.08 (10.6%) stddev-sans-first:16.31 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: Values: 162.0 130.0 151.0 175.0 131.0 151.0 153.0 135.0 166.0 132.0 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 164.0 164.0 164.0 164.0 169.0 162.0 167.0 162.0 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.50 Median:73.50 stddev:34.86 (47.4%) stddev-sans-first:36.40 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 75.0 159.0 72.0 79.0 72.0 74.0 154.0 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.00 stddev:21.72 (23.1%) stddev-sans-first:22.45 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 137.0 94.0 95.0 94.0 140.0 94.0 96.0 141.0 03:14:31 INFO - 2015-12-09 03:14:31,936 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:111.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 110.0 110.0 111.0 109.0 111.0 109.0 111.0 110.0 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 149.0 148.0 147.0 148.0 149.0 147.0 147.0 147.0 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:0.88 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 97.0 97.0 97.0 95.0 96.0 96.0 98.0 96.0 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:74.00 stddev:2.60 (3.5%) stddev-sans-first:2.76 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 74.0 73.0 76.0 74.0 73.0 80.0 71.0 71.0 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:1.64 (2.4%) stddev-sans-first:1.73 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 67.0 68.0 68.0 68.0 68.0 69.0 73.0 69.0 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,937 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:3.21 (3.8%) stddev-sans-first:3.38 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 84.0 86.0 84.0 85.0 85.0 95.0 85.0 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.00 stddev:3.20 (2.5%) stddev-sans-first:3.33 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: Values: 128.0 127.0 130.0 126.0 131.0 126.0 127.0 120.0 123.0 125.0 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:149.50 stddev:7.17 (4.8%) stddev-sans-first:6.65 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: Values: 137.0 149.0 153.0 149.0 152.0 136.0 147.0 139.0 150.0 157.0 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 71.0 70.0 72.0 73.0 72.0 71.0 71.0 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:14:31 INFO - 2015-12-09 03:14:31,938 DEBUG : BROWSER_OUTPUT: 03:14:32 INFO - 2015-12-09 03:14:32,866 INFO : Browser exited with error code: 0 03:14:32 INFO - 2015-12-09 03:14:32,922 INFO : Completed test kraken (00:01:01) 03:14:32 INFO - 2015-12-09 03:14:32,922 INFO : Starting test v8_7 03:14:32 INFO - 2015-12-09 03:14:32,922 DEBUG : operating with platform_type : linux_ 03:14:32 INFO - 2015-12-09 03:14:32,922 INFO : Initialising browser for v8_7 test... 03:14:32 INFO - 2015-12-09 03:14:32,928 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRD9UgV/profile http://localhost:46324/getInfo.html 03:14:37 INFO - 2015-12-09 03:14:37,415 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:14:37 INFO - 2015-12-09 03:14:37,415 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:14:37 INFO - 2015-12-09 03:14:37,415 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:14:37 INFO - 2015-12-09 03:14:37,415 DEBUG : BROWSER_OUTPUT: __metrics 03:14:37 INFO - 2015-12-09 03:14:37,524 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] 03:14:38 INFO - 2015-12-09 03:14:38,450 INFO : Browser initialized. 03:14:38 INFO - 2015-12-09 03:14:38,451 INFO : Running cycle 1/1 for v8_7 test... 03:14:38 INFO - 2015-12-09 03:14:38,451 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRD9UgV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:14:50 INFO - 2015-12-09 03:14:50,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 143319040 03:14:50 INFO - 2015-12-09 03:14:50,472 DEBUG : BROWSER_OUTPUT: 03:15:11 INFO - 2015-12-09 03:15:11,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46324/tests/v8_7/run.html (next: http://localhost:46324/tests/v8_7/run.html) 03:15:12 INFO - 2015-12-09 03:15:12,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 138403840 03:15:12 INFO - 2015-12-09 03:15:12,247 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,248 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:15:12 INFO - 2015-12-09 03:15:12,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:15:12 INFO - 2015-12-09 03:15:12,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:15:12 INFO - 2015-12-09 03:15:12,249 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:15:12 INFO - 2015-12-09 03:15:12,249 DEBUG : BROWSER_OUTPUT: |0;Richards;166.66666666666666 03:15:12 INFO - 2015-12-09 03:15:12,249 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.16803670426305 03:15:12 INFO - 2015-12-09 03:15:12,249 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 03:15:12 INFO - 2015-12-09 03:15:12,249 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5213.541666666667 03:15:12 INFO - 2015-12-09 03:15:12,250 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1076.4262648008612 03:15:12 INFO - 2015-12-09 03:15:12,250 DEBUG : BROWSER_OUTPUT: |5;Earley;722.0216606498195 03:15:12 INFO - 2015-12-09 03:15:12,250 DEBUG : BROWSER_OUTPUT: |6;Boyer;12419.753086419752 03:15:12 INFO - 2015-12-09 03:15:12,250 DEBUG : BROWSER_OUTPUT: |7;RegExp;26102.5641025641 03:15:12 INFO - 2015-12-09 03:15:12,251 DEBUG : BROWSER_OUTPUT: |8;Splay;599.1611743559017 03:15:12 INFO - 2015-12-09 03:15:12,251 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 03:15:12 INFO - 2015-12-09 03:15:12,251 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:15:12 INFO - 2015-12-09 03:15:12,251 DEBUG : BROWSER_OUTPUT: __startTimestamp1449659712247__endTimestamp 03:15:12 INFO - 2015-12-09 03:15:12,251 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,252 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:15:12 INFO - 2015-12-09 03:15:12,252 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:15:12 INFO - 2015-12-09 03:15:12,252 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,252 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.67 Median:166.67 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,253 DEBUG : BROWSER_OUTPUT: Values: 166.7 03:15:12 INFO - 2015-12-09 03:15:12,253 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,253 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.17 Median:191.17 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,253 DEBUG : BROWSER_OUTPUT: Values: 191.2 03:15:12 INFO - 2015-12-09 03:15:12,253 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,253 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: Values: 279.6 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: Values: 5213.5 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1076.43 Median:1076.43 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: Values: 1076.4 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:722.02 Median:722.02 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,255 DEBUG : BROWSER_OUTPUT: Values: 722.0 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: Values: 12419.8 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26102.56 Median:26102.56 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: Values: 26102.6 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.16 Median:599.16 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: Values: 599.2 03:15:12 INFO - 2015-12-09 03:15:12,256 DEBUG : BROWSER_OUTPUT: 03:15:12 INFO - 2015-12-09 03:15:12,257 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 03:15:12 INFO - 2015-12-09 03:15:12,257 DEBUG : BROWSER_OUTPUT: Values: 4835.7 03:15:12 INFO - 2015-12-09 03:15:12,257 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:15:12 INFO - 2015-12-09 03:15:12,257 DEBUG : BROWSER_OUTPUT: 03:15:13 INFO - 2015-12-09 03:15:13,169 INFO : Browser exited with error code: 0 03:15:13 INFO - 2015-12-09 03:15:13,181 INFO : Completed test v8_7 (00:00:40) 03:15:13 INFO - 2015-12-09 03:15:13,215 INFO : Completed test suite (00:20:17) 03:15:13 INFO - 2015-12-09 03:15:13,215 DEBUG : Working with test: dromaeo_css 03:15:13 INFO - 2015-12-09 03:15:13,215 DEBUG : Generating results file: dromaeo_css 03:15:13 INFO - 2015-12-09 03:15:13,216 DEBUG : Working with test: kraken 03:15:13 INFO - 2015-12-09 03:15:13,216 DEBUG : Generating results file: kraken 03:15:13 INFO - 2015-12-09 03:15:13,217 INFO : javascript benchmark 03:15:13 INFO - 2015-12-09 03:15:13,217 DEBUG : Working with test: v8_7 03:15:13 INFO - 2015-12-09 03:15:13,217 DEBUG : Generating results file: v8_7 03:15:13 INFO - 2015-12-09 03:15:13,217 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:15:13 INFO - 2015-12-09 03:15:13,371 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:15:13 INFO - 2015-12-09 03:15:13,371 DEBUG : process_Request line: dromaeo_css 6213.52 graph.html#tests=[[72,132,43]] 03:15:13 INFO - 2015-12-09 03:15:13,371 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:15:13 INFO - 2015-12-09 03:15:13,502 DEBUG : process_Request line: kraken 1554.30 graph.html#tests=[[232,132,43]] 03:15:13 INFO - 2015-12-09 03:15:13,502 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:15:13 INFO - 2015-12-09 03:15:13,534 DEBUG : process_Request line: v8_7 21206.55 graph.html#tests=[[230,132,43]] 03:15:13 INFO - 2015-12-09 03:15:13,536 INFO : javascript benchmark 03:15:13 INFO - 2015-12-09 03:15:13,538 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2677.06860987219, 2709.7696695780855, 2747.6153338532595, 2755.2423083651993, 2766.7233276672328, 4568.29191475321, 4805.063012712522, 4813.2780082987565, 4819.879503012422, 4852.854414367565, 4646.837360692376, 4727.810887564493, 4759.500252473493, 4762.714237145765, 4790.473047964721, 4347.67392445567, 4431.911361772763, 4480.641548676114, 4486.259767138418, 4514.796834142471, 4463.821447142111, 4466.798994045275, 4476.283794592866, 4495.505494395614, 4563.338315944186, 4135.1729654069, 4257.936130958038, 4458.286674132156, 4497.9325310120375, 4539.387182730338, 4285.914281714379, 4333.71830830995, 4337.522872484055, 4350.195213885441, 4400.471943366784, 4364.061726728737, 4371.475422949235, 4431.512533621299, 4444.355568442557, 4458.8439404620685, 4482.686211965164, 4585.922308257557, 4620.314033855043, 4717.221658426355, 4744.454387745384, 5117.411497677777, 5153.330067091291, 5175.689458632456, 5190.7404629768735, 5203.9219411708855, 5147.305113809625, 5209.7916083356995, 5220.190870415092, 5228.79084836606, 5240.606954478391, 4590.059037897223, 4681.274402467623, 4703.482616912137, 4736.455307639666, 4805.975970120162, 5326.6537675050995, 5340.813071542478, 5352.277442545284, 5353.705546194997, 5353.732313384393, 5080.77136528857, 5085.491450854959, 5096.719680417613, 5100.5409513143995, 5151.922721159186, 4847.127517046895, 4949.331840201527, 4967.155583550805, 4970.602351811846, 5179.533841954242, 4907.901841963141, 4965.702057876539, 4974.129527332702, 4975.601951843843, 4994.101061808837, 4959.082569724613, 5035.395752509649, 5045.066662667418, 5052.317937078521, 5061.417936937226, 4291.420658211102, 4302.978485107555, 4310.80601372939, 4345.478542574848, 4355.542668019875, 3598.9640103599154, 3694.353488139565, 3725.6646901778427, 3755.230177813596, 3790.938537209586, 4260.318349064135, 4267.0, 4280.850170244026, 4302.698811083194, 4375.190589740908, 5163.3545806774155, 5165.560927321219, 5170.45710200431, 5190.325257716473, 5222.2427747976335, 4400.889977750582, 4413.117376524708, 4415.359772832921, 4426.313921342197, 4472.08322293929, 4360.716553424018, 4432.13573353193, 4463.66522510813, 4477.194105061055, 4516.299973504112, 4860.73265970375, 4866.513348665176, 4867.0, 4867.123917694707, 4910.533499317559, 4898.0, 5101.285819985279, 5163.741812909415, 5183.248428977702, 5222.086134926297, 4676.766161691834, 4780.426348838162, 4834.347363106076, 4835.58897493717, 4846.781894814671, 5009.5491405773655, 5081.7713202905215, 5103.668261563135, 5104.438511763778, 5125.846224613268, 4853.296272040464, 4988.950110498994, 5130.79476820923, 5157.149070403341, 5183.766730497212, 4861.975690121527, 4921.729304888266, 4935.8025678972435, 4942.085714142895, 4963.0, 4990.525900039491, 4991.026749783758, 5008.098542262428, 5015.0, 5076.060928728197, 4607.746573938465, 4812.278158276146, 4853.805847766191, 4935.81540430287, 4963.553280204655, 4970.279309500174, 4980.228064649985, 4998.925016124834, 5016.197408414636, 5053.191489361684, 4900.509949005071, 4902.044101400193, 4908.092002979461, 4912.92630610534, 4953.133201689618], "unit": "ms", "name": "dojo.html", "value": 4679.895681546086}, {"lowerIsBetter": false, "replicates": [501.6363136725874, 538.7764077907668, 542.1677724692597, 544.7385255077561, 564.074917135897, 25035.123770668008, 34675.306493870135, 35513.289734205304, 35570.466443003344, 35674.643253567454, 39007.41488877669, 39616.405753913714, 39673.60326396742, 39682.60317396825, 39706.205875882464, 7912.169222231669, 7965.243301886311, 8086.959565202165, 8094.635741391651, 8095.069067057276, 7764.883526747103, 7836.529808211497, 7875.0, 7887.250711182429, 7900.486468379566, 7767.6504557294775, 7809.219078092174, 7846.68613255472, 7876.921230787705, 7884.842303153933, 7880.605969701492, 7891.487053341543, 7937.563434011127, 7942.722004729807, 7975.601219939009, 7766.883496747553, 7805.726799561988, 7819.687212511492, 7891.487053341514, 7928.80177995549, 36733.44899826505, 36900.26199475995, 36931.26137477235, 37298.254034919424, 37408.81295593505, 2712.562341958765, 2763.088180900298, 2823.8023338366324, 2950.4246671898986, 3113.844307784602, 27797.0, 28056.158315250574, 28100.437991240266, 28296.858515707496, 28978.13065608035, 3406.148462884279, 3455.550778398792, 3478.130467383154, 3501.1947252132154, 3570.410882204433, 220449.0, 221307.0, 222787.0, 223171.99999999837, 223403.0, 51642.741786290826, 52320.476795232324, 55977.96198342169, 60206.0, 61682.0, 55547.0, 55586.16620750692, 55735.72132139395, 55752.72123639356, 55920.16119758207, 12132.757344853053, 12142.392880355947, 12269.0, 12299.262044277371, 12310.446029928675, 9318.767030824283, 9330.30022748283, 9371.344005919656, 9383.5308234588, 9397.0, 19111.235550578098, 19210.8078919209, 19342.8065719341, 19379.80620193808, 19395.903020484806, 7683.500572462772, 7807.765767026998, 7900.170482099412, 7916.0, 7950.562719050392, 776.2160218179679, 817.4441379861751, 823.074041703084, 895.3956079646213, 977.6333874796951, 26305.473890522084, 26517.0, 26562.070327538444, 26625.866870665523, 26685.599716004275, 910.5629297936895, 916.2440986186423, 922.9077092290852, 926.1849572376266, 998.3760149906309, 13353.666158345924, 13455.596332110052, 15672.921635391978, 15753.606159846095, 16223.269952851913, 311660.0, 312440.0, 315350.0, 316092.0, 317089.0, 48010.27984580234, 48149.27776083362, 48718.75640621774, 48859.75570122198, 48908.26637600439, 1168.8305195746568, 1171.1860257121218, 1174.2602160638744, 1191.0412118244897, 1318.6835159561829, 26949.0, 27298.863505682344, 27359.316017099733, 27591.86204068967, 27651.86174069117, 39219.60780392159, 39787.602123979545, 39820.80089599534, 39824.21230513836, 39869.60130398659, 247503.0, 248311.0, 249637.0, 250180.0, 250374.0, 29048.854755726086, 41531.0, 41974.0, 42026.159476810906, 42593.36109958415, 37278.8136059318, 37925.24149517049, 38166.427503586914, 38944.2211155781, 38953.22093558056, 32167.19582010375, 32753.508697370034, 32795.34409311753, 33293.667063329056, 33363.666363337026, 32596.83701581477, 33095.17262068371, 33339.33321333608, 33453.49819752657, 33804.3239135211, 32866.50700239451, 32961.0, 33380.33239335151, 33495.49756753699, 33500.0, 28555.714442856137, 29816.70183298226, 30221.697783022766, 30247.40939064954, 30379.69620303857, 23687.763122368557, 23820.761792381854, 24083.63874541848, 24190.395240118432, 24329.513409731353], "unit": "ms", "name": "ext.html", "value": 16934.037332185777}, {"lowerIsBetter": false, "replicates": [281.5284398632291, 282.3829931599454, 284.46804475630574, 284.69253206536945, 288.60605273801264, 12700.745985080293, 13152.605421837336, 15334.769978450318, 15857.841421585781, 15902.125383103925, 9125.133112354333, 9174.724758257245, 11740.471678774455, 12033.338166400845, 12597.307148106851, 4389.1002344519375, 4484.798184081724, 4521.344405061264, 4524.936639889624, 4532.0, 3371.3088816792497, 3849.441830934513, 4504.774761261924, 4540.9091818163615, 4541.705613900039, 5107.38711354638, 5142.691438513682, 5147.1249887519025, 5157.432682404932, 5161.845144645647, 5025.547700706954, 5114.053900028507, 5117.872053198663, 5124.256982737501, 5166.225066240057, 4950.331705219785, 4955.331030310898, 4971.055499455092, 4987.650864439491, 4994.175960966436, 10816.296940698909, 11400.885991140149, 16755.413560525445, 16876.915615421844, 17399.391021314193, 1687.4600127959059, 1699.328765137776, 1754.7280171573427, 1764.7970483394317, 1767.540439485743, 8193.180681931819, 8314.70898518555, 8357.080721120672, 8399.202075802788, 8474.957625211897, 1753.2723919573361, 1753.8947663140252, 1759.6359236594892, 1775.5649865782837, 1778.0309731196528, 53554.19668704973, 56536.43463565353, 56824.43175568233, 56992.43007569954, 57456.71271643657, 9517.428954262767, 9681.177099946442, 9838.557264923096, 9849.704508864745, 9880.555375008142, 12196.512139514498, 12219.51121955112, 12257.69355766113, 12272.754544909052, 12279.263244205376, 6521.967390163114, 6566.179227596551, 6800.547467960682, 6805.829854253584, 6893.414059804973, 6509.707063182168, 6519.641419721961, 6526.967365163144, 6551.246606640298, 6615.272320044791, 3842.5974519300253, 3906.43356713275, 4013.678905687538, 4050.7772072535704, 4132.938005929914, 1654.4374912529797, 1684.3936182974119, 1710.4783041172313, 1779.6173822627939, 1784.3754685860106, 807.3258828877836, 837.623069618674, 867.5618812499773, 920.2499962530517, 924.4176169013613, 15692.450764223197, 15788.842111578737, 15791.447299344467, 16377.754333685005, 16424.917875410785, 780.149636895775, 817.554432834095, 820.1183727492969, 825.9008918929767, 840.7393707950555, 9018.86471702925, 9238.722838314727, 9297.302702297355, 9466.100720431548, 9557.665481708245, 328113.0, 333613.0, 469664.0, 476200.0, 481944.0, 65504.344956550776, 65829.34170658232, 76880.23119768842, 79403.60298198472, 79481.60259198667, 385.77046657238895, 396.7084193118056, 396.8591150141716, 397.2809215320222, 397.30669980882965, 9254.4910029949, 9348.298877584073, 9398.530073496435, 9599.232061434928, 9606.759831004281, 33327.50008749822, 33630.159246019044, 34387.65612343844, 35649.643503564635, 35905.28189436145, 46323.0, 47713.52286477091, 47948.28077578909, 48498.75750621224, 48895.5110448891, 8296.25333719944, 8616.0522342541, 8916.10838916129, 9209.125133112344, 9222.907770922473, 15296.31166597528, 15557.611059723598, 15981.200939952723, 16352.0, 16393.0, 12932.676683082998, 13177.0, 13521.661958451117, 13538.323083845571, 13937.512187073404, 11090.279131856403, 11212.383318917538, 12810.103292769416, 13641.249731264876, 14071.718565628425, 13529.458821647024, 13610.59168224955, 13953.23257220822, 13960.860391396362, 13963.092398994033, 8201.58992050407, 8353.122922093093, 8437.367197460339, 8464.57677116154, 8610.095939926217, 8151.1441298662785, 8162.102168761313, 8214.014318281845, 12444.440000199831, 13177.538786142439], "unit": "ms", "name": "jquery.html", "value": 7583.008963484949}, {"lowerIsBetter": false, "replicates": [1484.970300593989, 1643.3098098798503, 1689.5100420877945, 1701.6766814305288, 1714.751361052647, 6919.515633905628, 6935.583864968093, 7120.572765634059, 7120.928790712098, 7126.429885609152, 7104.467164962635, 7116.288371162881, 7189.496735228536, 7205.459590530718, 7219.747308844191, 2055.989720051405, 2101.086027578001, 2102.0330647901983, 2102.6530622447276, 2109.2512158183854, 2086.0821238654944, 2088.1438610169835, 2107.283523601975, 2152.1929276521305, 2154.7306586676664, 2035.4911272181955, 2055.332017094443, 2081.3339731285996, 2093.874367537945, 2105.8315334773183, 2026.868253563521, 2112.1849158114883, 2117.100232401231, 2118.8940552972367, 2133.4772980619846, 2068.844836637243, 2101.3800928726064, 2106.4839114417064, 2109.156337465011, 2111.4510227341, 6807.5575087619145, 6959.269276725972, 6988.126484189476, 7008.649567521604, 7026.859462810767, 4065.0447144920918, 4118.4440100586635, 4136.069384388518, 4145.7719825409595, 4146.66826653867, 2708.8103832731717, 2735.39821239327, 2764.115483045426, 2781.721827817202, 2794.9580756288674, 795.0657976877204, 800.1798156889236, 819.3281509162489, 833.3874602167463, 833.8415701016787, 9035.638574457014, 9113.81772364549, 9115.22520585751, 9136.862947055799, 9187.77030574241, 3648.7993160375904, 3670.871519496805, 3694.0, 3709.0541911812315, 3748.11919198988, 7423.183449820515, 7432.070991126109, 7433.219511951275, 7478.513896596813, 7488.588127653032, 3983.8008099595486, 3993.1614360983936, 4018.095928416083, 4035.435039094529, 4056.1684854604737, 3633.5276414066, 3663.505426767352, 3676.2647470506004, 3689.6679298862696, 3706.703463722896, 3045.8629361678777, 3053.4198502284494, 3062.127293721279, 3075.2773098321877, 3088.119885832572, 889.4396530185942, 898.2993265253114, 899.3165194452264, 904.7104926423613, 908.5094049213483, 863.1325517854516, 867.2411639815161, 872.0146234754686, 911.1116661255355, 940.2478017585904, 6491.350864913471, 6555.3772391622715, 6573.112629795012, 6581.3418658133805, 6589.538732288694, 1003.0, 1013.366645846346, 1029.891861354562, 1051.4269723000982, 1059.7032830807232, 5074.23886417033, 5127.1540195867265, 5138.717370544656, 5153.072446959508, 5153.948460515422, 8052.677892884219, 8066.11272759996, 8233.217844304781, 8245.505269683837, 8358.832823343499, 8020.5588692621295, 8029.156938521488, 8045.637946292431, 8064.556449395222, 8103.027636683636, 6631.1379520662, 6652.201735791639, 6708.899366509506, 6717.16035495563, 6797.320267973163, 6303.842403939938, 6492.188476440445, 6544.640044797582, 6554.213494380705, 6564.277929427663, 7244.348008679244, 7515.549067055994, 7521.323080922743, 7592.924070759222, 7638.961805190938, 7542.622868856645, 7597.050368703912, 7668.846623067619, 7866.881996769938, 7886.250806173404, 6105.5420843437805, 6166.784162554289, 6172.845678858064, 6177.104319873503, 6199.132121502903, 6531.738730450728, 6532.314107018885, 6577.0, 6625.834354140992, 6657.101291325609, 6202.503799696104, 6216.222972128484, 6291.779787707408, 6298.464630506458, 6434.935650643621, 5884.117382392504, 6103.05402662588, 6132.41742034506, 6175.876482470236, 6276.121343012073, 6340.175777148941, 6347.238331400077, 6349.904751428825, 6357.841053973502, 6373.0, 5726.455986681259, 5764.3371012332445, 5770.6249093808765, 5828.213191219131, 5838.211841401357, 5977.252843394575, 5979.581429300081, 5983.401659833982, 5992.760289588367, 5996.280446346466], "unit": "ms", "name": "mootools.html", "value": 3979.8226709942755}, {"lowerIsBetter": false, "replicates": [253.2162955652256, 254.67656076782498, 260.91389841352355, 262.5746291008565, 263.3311389071758, 5487.368952570456, 5510.6142570020065, 5548.223248745169, 5548.334199896013, 5748.252727145476, 5543.667379957195, 5600.887982240363, 5610.158476228557, 5613.158026296048, 5623.887522249553, 3956.1494278730065, 4010.498687664042, 4045.858394956177, 4125.834966601333, 4148.087420767426, 4104.240715467633, 4119.052617897885, 4122.793860306988, 4126.1541384016355, 4144.088300573869, 4062.837486500536, 4069.104796944682, 4071.1043570414463, 4092.0997380576227, 4097.8770636880945, 4116.485439320085, 4117.07365842686, 4121.031557583965, 4122.443470131524, 4124.8556300529635, 3377.6960073593496, 3430.125318043908, 3516.191276006533, 3523.5243242162237, 3536.6816986471085, 5259.079661059338, 5275.129603615399, 5298.894022119574, 5301.681899086028, 5317.521423071903, 4692.648051396159, 4706.599939005188, 4712.034033023257, 4713.151632706112, 4719.622430205575, 5790.04464263396, 5798.507126894219, 5814.563907706939, 5825.271841019872, 5828.300603927513, 3661.1945372018113, 3813.3707938190164, 3827.311084004878, 3829.100161462054, 3834.6740527055235, 6145.201123853871, 6149.29283132441, 6208.751649933997, 6215.533834962396, 6218.906716399258, 3914.178022615226, 3917.4319723639915, 3929.410588411704, 3935.74417662851, 3939.113699417608, 3984.641382275551, 3987.7009224308295, 3989.4614227079555, 3990.2618015667194, 3994.9201015979515, 4542.409486766765, 4691.554302341272, 4694.037722266927, 4709.7174169549935, 4712.31671407644, 5752.6836024019085, 5884.382139875252, 5902.557308201902, 5904.616199947076, 5913.733881975236, 1379.048456564967, 1381.9239941803298, 1386.5355106039387, 1388.590365842079, 1388.9097208681605, 897.1387468030764, 902.702108304258, 906.1618003346878, 917.2249449215402, 920.2959735802117, 5066.189409694505, 5067.391912970394, 5077.39071311445, 5082.440931497532, 5088.669236499616, 6076.453119219292, 6107.48086412651, 6123.265208174958, 6128.1114238435175, 6130.325664176937, 5055.16589762685, 5071.670341427869, 5073.086844367976, 5084.56781173597, 5085.974570127126, 3188.9681103188673, 3256.1859535116223, 3277.770556061053, 3283.3761585298716, 3283.4910588858766, 5652.85867853307, 5656.321241451053, 5657.745401456944, 5663.660180389107, 5682.062459694104, 6155.753769849156, 6177.96911015442, 6204.069389591507, 6208.50331973441, 6208.565400422018, 5526.198701188225, 5651.660900345993, 5662.830115096472, 5666.348369937427, 5675.3757086720425, 5998.520118390606, 6016.578839481194, 6016.969915150396, 6027.367126451835, 6037.78867739627, 5871.0, 5871.73577189036, 5888.764449421975, 5902.5277977762535, 5905.8228253150755, 5646.237757902631, 5661.631993920382, 5666.518345940642, 5675.177099320493, 5689.203511508475, 3814.694824413985, 3867.43922131295, 3898.8050597469446, 3902.043999220209, 3914.4911161548816, 5993.460588547052, 6000.969995149996, 6025.18659980897, 6049.243844519435, 6198.380161983766, 5907.202527658711, 5912.970435147797, 5931.584789064724, 5935.139404786368, 5952.315483719254, 5868.647881127146, 5884.941150588439, 5924.081767326072, 5933.910991335047, 5939.227900372924, 5606.859828504157, 5769.048107062287, 5789.623674461147, 5798.768049277982, 5803.65178089316, 5940.702964851826, 5949.553783466171, 5957.344692083954, 5974.641521508724, 5980.641161530322, 5766.509846663081, 5788.652680839163, 5827.708614569339, 5832.037713777179, 5835.183074369506], "unit": "ms", "name": "prototype.html", "value": 4267.5591493972715}, {"lowerIsBetter": false, "replicates": [727.1201845766623, 743.7991742229598, 788.601756113163, 796.4623878881757, 805.2430715127783, 11659.183857130005, 11838.940805295972, 11868.643940681794, 14516.346764395601, 14727.410903563872, 13397.732045359087, 13451.730965380686, 13510.72978540431, 13538.661533461669, 13542.45830166792, 782.7573452229813, 797.5374282915924, 797.8085259537698, 799.4403917257914, 800.4836880212259, 779.1701837542998, 802.2258520527689, 807.1766797866202, 807.4186585658316, 808.337163525909, 833.7873842170238, 836.6862426590029, 836.9204925532065, 839.8698201778703, 844.0673056272822, 830.6967956695823, 831.268483734313, 831.629924683516, 839.290799274612, 840.0381563110235, 621.6332363905318, 621.7761605821901, 622.7384498510636, 623.1742940603673, 623.5479277523805, 11830.112741544333, 11881.40592970348, 11907.642770716893, 11957.88042119585, 11986.340751258676, 10533.36799792015, 10808.891911080946, 10979.28634638746, 11254.662360129209, 11448.198626096177, 9187.494687792168, 9460.763480912963, 9576.23390128795, 9650.324477286593, 9657.213415518152, 3091.7217450429343, 3148.8740450381956, 3156.305612765188, 3157.068664743906, 3208.406444807718, 38476.0, 38545.807270963465, 38772.418413723535, 39070.21859562793, 39199.0, 8872.689455869013, 9079.773005674911, 9091.31815113869, 9198.264138868875, 9378.718638440858, 15180.696386072217, 15195.772063419057, 15209.391624334903, 15261.771073433907, 15274.0, 6182.227221597301, 6215.782447614402, 6234.781782637677, 6368.872622547523, 6539.444147247537, 3666.046827824785, 3743.288775132716, 3747.5877653458097, 3753.6621704046765, 3774.5281839770028, 2640.8943642254094, 2661.294756889426, 2668.066176838091, 2670.105514652574, 2670.4258584404056, 464.12512414099666, 467.16377683946035, 467.60054404479246, 473.6305681568382, 473.9976300118477, 453.76631035016993, 473.5477618873967, 474.3690891114809, 476.3236204589491, 479.7673128532659, 7400.5189662671755, 7506.28690274423, 8198.754037378889, 8301.335893128535, 8637.0, 421.4058177969049, 445.46099219944233, 486.4575997762469, 499.90751710932864, 559.8600349912522, 3334.433146365124, 3364.9495257571157, 3448.137965508623, 3499.3876071687355, 3584.6953008994005, 45096.0, 45367.773161133984, 45762.54237457583, 47817.76091119592, 49137.262941055196, 39120.0, 39538.40692389617, 39660.40509392361, 41238.79380603078, 44538.77730611391, 39933.60066399299, 40099.19057689515, 40374.39438408426, 40464.0, 41198.38202426966, 7688.384929205762, 7740.535567865721, 8054.23484768946, 8095.797605059921, 8221.136780637948, 30922.845385772926, 31491.527627085154, 31690.0, 31997.520037199927, 32168.19579510531, 35684.821575891954, 35837.46243806397, 36996.44505332476, 38319.0, 38382.0, 10288.639897603547, 10474.371537707762, 10477.37135771856, 10520.78958420812, 10630.25588208818, 10895.400752958347, 11070.723231919266, 11118.444077796239, 11554.133439992202, 11555.191136620691, 9617.807643847224, 9831.410115393099, 10025.699229023141, 10529.684109476728, 11027.117830573696, 10302.742431439274, 10622.787544248917, 10904.0, 11021.44892755375, 11087.22389432732, 9743.512824358895, 9765.9023409765, 10438.582456701646, 10693.09108725767, 10711.517981690688, 8860.556972151495, 8885.333599980157, 9095.545222738969, 9097.135772101905, 9203.86194207074, 8116.350691944512, 8390.244877961013, 8523.0, 8883.822323553622, 8967.08172606077], "unit": "ms", "name": "yui.html", "value": 5637.704994325071}], "name": "dromaeo_css", "value": 6213.524597925772}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 117.0, 113.0, 114.0, 127.0, 113.0, 113.0, 113.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [162.0, 130.0, 151.0, 175.0, 131.0, 151.0, 153.0, 135.0, 166.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 164.0, 164.0, 164.0, 169.0, 162.0, 167.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 75.0, 159.0, 72.0, 79.0, 72.0, 74.0, 154.0], "unit": "ms", "name": "audio-fft", "value": 90.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 137.0, 94.0, 95.0, 94.0, 140.0, 94.0, 96.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 111.0, 109.0, 111.0, 109.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 149.0, 148.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 97.0, 97.0, 97.0, 95.0, 96.0, 96.0, 98.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 74.0, 73.0, 76.0, 74.0, 73.0, 80.0, 71.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 74.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 73.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 84.0, 86.0, 84.0, 85.0, 85.0, 95.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [128.0, 127.0, 130.0, 126.0, 131.0, 126.0, 127.0, 120.0, 123.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [137.0, 149.0, 153.0, 149.0, 152.0, 136.0, 147.0, 139.0, 150.0, 157.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 71.0, 70.0, 72.0, 73.0, 72.0, 71.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1554.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.66666666666666], "unit": "score", "name": "Richards", "value": 211.81200000000004}, {"lowerIsBetter": false, "replicates": [191.16803670426305], "unit": "score", "name": "DeltaBlue", "value": 345.8632580000001}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1076.4262648008612], "unit": "score", "name": "RayTrace", "value": 687.4497810000001}, {"lowerIsBetter": false, "replicates": [722.0216606498195], "unit": "score", "name": "Earley", "value": 923.0512549999999}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [26102.5641025641], "unit": "score", "name": "RegExp", "value": 34.90021119842827}, {"lowerIsBetter": false, "replicates": [599.1611743559017], "unit": "score", "name": "Splay", "value": 136.00847899999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21206.54785428402}]} 03:15:13 INFO - RETURN: dromaeo_css: 6213.52 03:15:13 INFO - RETURN: kraken: 1554.30 03:15:13 INFO - RETURN: v8_7: 21206.55 03:15:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21206.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1554.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6213.52"}}} 03:15:13 INFO - Return code: 0 03:15:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:15:13 INFO - # TBPL SUCCESS # 03:15:13 INFO - Running post-action listener: _resource_record_post_action 03:15:13 INFO - Running post-run listener: _resource_record_post_run 03:15:14 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 507191296; Read time: 176; Write time: 464224 03:15:14 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231346176; Read time: 0; Write time: 337088 03:15:14 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 275013632; Read time: 176; Write time: 126184 03:15:14 INFO - Running post-run listener: _upload_blobber_files 03:15:14 INFO - Blob upload gear active. 03:15:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:15:14 INFO - Copying logs to upload dir... 03:15:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.099486 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-09 03:15:13.720283) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 03:15:13.727006) ========= 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=928fd09416829678a2f67a56000001ac-1449657811.931297-661670290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009868 build_url: 'https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 03:15:13.784529) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:15:13.787819) ========= 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=928fd09416829678a2f67a56000001ac-1449657811.931297-661670290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:15:13.840300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 03:15:13.840631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 03:15:13.841083) ========= ========= Total master_lag: 0.33 =========