builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1448559460.14 results: success (0) buildid: 20151126075612 builduid: 3d51a1fbb8204edc80382d0578ecd39b revision: b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.137440) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.137896) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.138213) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005616 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.154961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.155255) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.163534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.163798) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003966 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.211100) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.211398) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.211742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.212024) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 09:37:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 61.5M=0s 2015-11-26 09:37:40 (61.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182277 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.406289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.406605) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020039 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:40.455858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 09:37:40.456197) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce --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 b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce --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=2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 09:37:40,472 truncating revision to first 12 chars 2015-11-26 09:37:40,472 Setting DEBUG logging. 2015-11-26 09:37:40,472 attempt 1/10 2015-11-26 09:37:40,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7d8d9b1e833?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 09:37:41,684 unpacking tar archive at: fx-team-b7d8d9b1e833/testing/mozharness/ program finished with exit code 0 elapsedTime=1.558466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 09:37:42.027389) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:42.027713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:42.038152) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:42.038657) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 09:37:42.039182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-26 09:37:42.039496) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:37:42 INFO - MultiFileLogger online at 20151126 09:37:42 in /builds/slave/test 09:37:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:37:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:37:42 INFO - {'append_to_log': False, 09:37:42 INFO - 'base_work_dir': '/builds/slave/test', 09:37:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:37:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:37:42 INFO - 'branch': 'Fx-Team-Non-PGO', 09:37:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:37:42 INFO - 'config_files': ('talos/linux_config.py',), 09:37:42 INFO - 'default_actions': ('clobber', 09:37:42 INFO - 'read-buildbot-config', 09:37:42 INFO - 'download-and-extract', 09:37:42 INFO - 'populate-webroot', 09:37:42 INFO - 'create-virtualenv', 09:37:42 INFO - 'install', 09:37:42 INFO - 'run-tests'), 09:37:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:37:42 INFO - 'download_minidump_stackwalk': True, 09:37:42 INFO - 'download_symbols': 'ondemand', 09:37:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:37:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:37:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:37:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:37:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:37:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:37:42 INFO - 'installer_path': 'installer.exe', 09:37:42 INFO - 'log_level': 'info', 09:37:42 INFO - 'log_name': 'talos', 09:37:42 INFO - 'log_to_console': True, 09:37:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:37:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:37:42 INFO - 'opt_config_files': (), 09:37:42 INFO - 'pip_index': False, 09:37:42 INFO - 'sps_profile': False, 09:37:42 INFO - 'sps_profile_interval': 0, 09:37:42 INFO - 'suite': 'dromaeojs', 09:37:42 INFO - 'system_bits': '64', 09:37:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:37:42 INFO - 'title': 'talos-linux64-ix-032', 09:37:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:37:42 INFO - 'use_talos_json': True, 09:37:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:37:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:37:42 INFO - 'work_dir': 'build'} 09:37:42 INFO - ##### 09:37:42 INFO - ##### Running clobber step. 09:37:42 INFO - ##### 09:37:42 INFO - Running pre-action listener: _resource_record_pre_action 09:37:42 INFO - Running main action method: clobber 09:37:42 INFO - rmtree: /builds/slave/test/build 09:37:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:37:42 INFO - Running post-action listener: _resource_record_post_action 09:37:42 INFO - ##### 09:37:42 INFO - ##### Running read-buildbot-config step. 09:37:42 INFO - ##### 09:37:42 INFO - Running pre-action listener: _resource_record_pre_action 09:37:42 INFO - Running main action method: read_buildbot_config 09:37:42 INFO - Using buildbot properties: 09:37:42 INFO - { 09:37:42 INFO - "properties": { 09:37:42 INFO - "buildnumber": 934, 09:37:42 INFO - "product": "firefox", 09:37:42 INFO - "script_repo_revision": "production", 09:37:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:37:42 INFO - "repository": "", 09:37:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:37:42 INFO - "buildid": "20151126075612", 09:37:42 INFO - "slavename": "talos-linux64-ix-032", 09:37:42 INFO - "pgo_build": "False", 09:37:42 INFO - "basedir": "/builds/slave/test", 09:37:42 INFO - "project": "", 09:37:42 INFO - "platform": "ubuntu64_hw", 09:37:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:37:42 INFO - "slavebuilddir": "test", 09:37:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:37:42 INFO - "branch": "fx-team", 09:37:42 INFO - "repo_path": "integration/fx-team", 09:37:42 INFO - "stage_platform": "linux64", 09:37:42 INFO - "builduid": "3d51a1fbb8204edc80382d0578ecd39b", 09:37:42 INFO - "revision": "b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce" 09:37:42 INFO - }, 09:37:42 INFO - "sourcestamp": { 09:37:42 INFO - "repository": "", 09:37:42 INFO - "hasPatch": false, 09:37:42 INFO - "project": "", 09:37:42 INFO - "branch": "fx-team-linux64-talos", 09:37:42 INFO - "changes": [ 09:37:42 INFO - { 09:37:42 INFO - "category": null, 09:37:42 INFO - "files": [ 09:37:42 INFO - { 09:37:42 INFO - "url": null, 09:37:42 INFO - "name": "https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:37:42 INFO - } 09:37:42 INFO - ], 09:37:42 INFO - "repository": "", 09:37:42 INFO - "rev": "b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce", 09:37:42 INFO - "who": "cbook@mozilla.com", 09:37:42 INFO - "when": 1448558934, 09:37:42 INFO - "number": 6711821, 09:37:42 INFO - "comments": "Merge mozilla-central to fx-team", 09:37:42 INFO - "project": "", 09:37:42 INFO - "at": "Thu 26 Nov 2015 09:28:54", 09:37:42 INFO - "branch": "fx-team-linux64-talos", 09:37:42 INFO - "revlink": "", 09:37:42 INFO - "properties": [ 09:37:42 INFO - [ 09:37:42 INFO - "buildid", 09:37:42 INFO - "20151126075612", 09:37:42 INFO - "Change" 09:37:42 INFO - ], 09:37:42 INFO - [ 09:37:42 INFO - "builduid", 09:37:42 INFO - "3d51a1fbb8204edc80382d0578ecd39b", 09:37:42 INFO - "Change" 09:37:42 INFO - ], 09:37:42 INFO - [ 09:37:42 INFO - "pgo_build", 09:37:42 INFO - "False", 09:37:42 INFO - "Change" 09:37:42 INFO - ] 09:37:42 INFO - ], 09:37:42 INFO - "revision": "b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce" 09:37:42 INFO - } 09:37:42 INFO - ], 09:37:42 INFO - "revision": "b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce" 09:37:42 INFO - } 09:37:42 INFO - } 09:37:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:37:42 INFO - Running post-action listener: _resource_record_post_action 09:37:42 INFO - ##### 09:37:42 INFO - ##### Running download-and-extract step. 09:37:42 INFO - ##### 09:37:42 INFO - Running pre-action listener: _resource_record_pre_action 09:37:42 INFO - Running main action method: download_and_extract 09:37:42 INFO - mkdir: /builds/slave/test/build/tests 09:37:42 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')]} 09:37:42 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json 09:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json 09:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:37:43 INFO - Downloaded 1302 bytes. 09:37:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:37:43 INFO - Using the following test package requirements: 09:37:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:37:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:37:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:43 INFO - u'jsshell-linux-x86_64.zip'], 09:37:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:37:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:37:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:37:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:37:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:37:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:37:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:37:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:43 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:37:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:37:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:37:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:37:44 INFO - Downloaded 21515226 bytes. 09:37:44 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 09:37:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:37:44 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 09:37:45 INFO - Return code: 0 09:37:45 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 09:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:45 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:37:46 INFO - Downloaded 21515226 bytes. 09:37:46 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 09:37:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:37:46 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 09:37:47 INFO - Return code: 0 09:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:47 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:37:48 INFO - Downloaded 11131728 bytes. 09:37:48 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 09:37:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:37:48 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 09:37:49 INFO - Return code: 0 09:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:49 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:37:50 INFO - Downloaded 56868570 bytes. 09:37:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:37:50 INFO - mkdir: /builds/slave/test/properties 09:37:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:50 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:50 INFO - Contents: 09:37:50 INFO - build_url:https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:37:50 INFO - Running post-action listener: _resource_record_post_action 09:37:50 INFO - Running post-action listener: set_extra_try_arguments 09:37:50 INFO - ##### 09:37:50 INFO - ##### Running populate-webroot step. 09:37:50 INFO - ##### 09:37:50 INFO - Running pre-action listener: _resource_record_pre_action 09:37:50 INFO - Running main action method: populate_webroot 09:37:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:37:50 INFO - '../fennec_ids.txt'], 09:37:50 INFO - 'tests': ['tcheck2']}, 09:37:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:50 INFO - '--tppagecycles', 09:37:50 INFO - '7'], 09:37:50 INFO - 'tests': ['tsvgm']}}, 09:37:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:37:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:37:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:37:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:50 INFO - 'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:50 INFO - 'tests': ['damp', 'tps']}, 09:37:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:50 INFO - 'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['damp', 'tps']}, 09:37:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:37:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:50 INFO - 'other': {'tests': ['a11yr', 09:37:50 INFO - 'ts_paint', 09:37:50 INFO - 'tpaint', 09:37:50 INFO - 'sessionrestore', 09:37:50 INFO - 'sessionrestore_no_auto_restore']}, 09:37:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['a11yr', 09:37:50 INFO - 'ts_paint', 09:37:50 INFO - 'tpaint', 09:37:50 INFO - 'sessionrestore', 09:37:50 INFO - 'sessionrestore_no_auto_restore']}, 09:37:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['a11yr', 09:37:50 INFO - 'ts_paint', 09:37:50 INFO - 'tpaint', 09:37:50 INFO - 'sessionrestore', 09:37:50 INFO - 'sessionrestore_no_auto_restore']}, 09:37:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['a11yr', 09:37:50 INFO - 'ts_paint', 09:37:50 INFO - 'tpaint', 09:37:50 INFO - 'sessionrestore', 09:37:50 INFO - 'sessionrestore_no_auto_restore']}, 09:37:50 INFO - 'other_l64': {'tests': ['a11yr', 09:37:50 INFO - 'ts_paint', 09:37:50 INFO - 'tpaint', 09:37:50 INFO - 'sessionrestore', 09:37:50 INFO - 'sessionrestore_no_auto_restore']}, 09:37:50 INFO - 'other_nol64': {'tests': ['a11yr', 09:37:50 INFO - 'ts_paint', 09:37:50 INFO - 'tpaint', 09:37:50 INFO - 'sessionrestore', 09:37:50 INFO - 'sessionrestore_no_auto_restore']}, 09:37:50 INFO - 'svgr': {'tests': ['tsvgx', 09:37:50 INFO - 'tsvgr_opacity', 09:37:50 INFO - 'tart', 09:37:50 INFO - 'tscrollx', 09:37:50 INFO - 'cart']}, 09:37:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['tsvgx', 09:37:50 INFO - 'tsvgr_opacity', 09:37:50 INFO - 'tart', 09:37:50 INFO - 'tscrollx', 09:37:50 INFO - 'cart']}, 09:37:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:50 INFO - 'tests': ['tp5o']}, 09:37:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:50 INFO - 'talos_options': ['--e10s'], 09:37:50 INFO - 'tests': ['tp5o']}, 09:37:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:50 INFO - 'talos_options': ['--xperf_path', 09:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:50 INFO - 'tests': ['tp5n']}, 09:37:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:50 INFO - 'talos_options': ['--e10s', 09:37:50 INFO - '--xperf_path', 09:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:50 INFO - 'tests': ['tp5n']}}, 09:37:50 INFO - 'talos.zip': {'path': '', 09:37:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:50 INFO - Running post-action listener: _resource_record_post_action 09:37:50 INFO - ##### 09:37:50 INFO - ##### Running create-virtualenv step. 09:37:50 INFO - ##### 09:37:50 INFO - Running pre-action listener: _resource_record_pre_action 09:37:50 INFO - Running main action method: create_virtualenv 09:37:50 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:50 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 09:37:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:50 INFO - Using real prefix '/usr' 09:37:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:50 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:53 INFO - Installing pip.................done. 09:37:53 INFO - Return code: 0 09:37:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:53 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')]} 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 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')]} 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 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 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:37:53 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 09:37:53 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 09:37:53 INFO - Using env: {'DISPLAY': ':0', 09:37:53 INFO - 'HOME': '/home/cltbld', 09:37:53 INFO - 'LANG': 'en_US.UTF-8', 09:37:53 INFO - 'LANGUAGE': 'en_US:en', 09:37:53 INFO - 'LOGNAME': 'cltbld', 09:37:53 INFO - 'MAIL': '/var/mail/cltbld', 09:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:53 INFO - 'MOZ_NO_REMOTE': '1', 09:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:53 INFO - 'NO_EM_RESTART': '1', 09:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:53 INFO - 'PWD': '/builds/slave/test', 09:37:53 INFO - 'SHELL': '/bin/bash', 09:37:53 INFO - 'SHLVL': '1', 09:37:53 INFO - 'TERM': 'linux', 09:37:53 INFO - 'TMOUT': '86400', 09:37:53 INFO - 'USER': 'cltbld', 09:37:53 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:53 INFO - '_': '/tools/buildbot/bin/python'} 09:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:53 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 09:37:53 INFO - Cleaning up... 09:37:53 INFO - Return code: 0 09:37:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:37:53 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')]} 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 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')]} 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 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 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:37:53 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 09:37:53 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 09:37:53 INFO - Using env: {'DISPLAY': ':0', 09:37:53 INFO - 'HOME': '/home/cltbld', 09:37:53 INFO - 'LANG': 'en_US.UTF-8', 09:37:53 INFO - 'LANGUAGE': 'en_US:en', 09:37:53 INFO - 'LOGNAME': 'cltbld', 09:37:53 INFO - 'MAIL': '/var/mail/cltbld', 09:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:53 INFO - 'MOZ_NO_REMOTE': '1', 09:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:53 INFO - 'NO_EM_RESTART': '1', 09:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:53 INFO - 'PWD': '/builds/slave/test', 09:37:53 INFO - 'SHELL': '/bin/bash', 09:37:53 INFO - 'SHLVL': '1', 09:37:53 INFO - 'TERM': 'linux', 09:37:53 INFO - 'TMOUT': '86400', 09:37:53 INFO - 'USER': 'cltbld', 09:37:53 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:53 INFO - '_': '/tools/buildbot/bin/python'} 09:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:53 INFO - Downloading/unpacking psutil>=0.7.1 09:37:53 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 09:37:53 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 09:37:53 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 09:37:53 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 09:37:53 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 09:37:53 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 09:37:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:37:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:55 INFO - Installing collected packages: psutil 09:37:55 INFO - Running setup.py install for psutil 09:37:55 INFO - building 'psutil._psutil_linux' extension 09:37:55 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 09:37:55 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 09:37:55 INFO - building 'psutil._psutil_posix' extension 09:37:55 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 09:37:56 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 09:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:56 INFO - Successfully installed psutil 09:37:56 INFO - Cleaning up... 09:37:56 INFO - Return code: 0 09:37:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:37:56 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')]} 09:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:56 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')]} 09:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:56 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 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:37:56 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 09:37:56 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 09:37:56 INFO - Using env: {'DISPLAY': ':0', 09:37:56 INFO - 'HOME': '/home/cltbld', 09:37:56 INFO - 'LANG': 'en_US.UTF-8', 09:37:56 INFO - 'LANGUAGE': 'en_US:en', 09:37:56 INFO - 'LOGNAME': 'cltbld', 09:37:56 INFO - 'MAIL': '/var/mail/cltbld', 09:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:56 INFO - 'MOZ_NO_REMOTE': '1', 09:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:56 INFO - 'NO_EM_RESTART': '1', 09:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:56 INFO - 'PWD': '/builds/slave/test', 09:37:56 INFO - 'SHELL': '/bin/bash', 09:37:56 INFO - 'SHLVL': '1', 09:37:56 INFO - 'TERM': 'linux', 09:37:56 INFO - 'TMOUT': '86400', 09:37:56 INFO - 'USER': 'cltbld', 09:37:56 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:56 INFO - '_': '/tools/buildbot/bin/python'} 09:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:37:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:37:58 INFO - Installing collected packages: mozsystemmonitor 09:37:58 INFO - Running setup.py install for mozsystemmonitor 09:37:58 INFO - Successfully installed mozsystemmonitor 09:37:58 INFO - Cleaning up... 09:37:59 INFO - Return code: 0 09:37:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:37:59 INFO - Using env: {'DISPLAY': ':0', 09:37:59 INFO - 'HOME': '/home/cltbld', 09:37:59 INFO - 'LANG': 'en_US.UTF-8', 09:37:59 INFO - 'LANGUAGE': 'en_US:en', 09:37:59 INFO - 'LOGNAME': 'cltbld', 09:37:59 INFO - 'MAIL': '/var/mail/cltbld', 09:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:59 INFO - 'MOZ_NO_REMOTE': '1', 09:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:59 INFO - 'NO_EM_RESTART': '1', 09:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:59 INFO - 'PWD': '/builds/slave/test', 09:37:59 INFO - 'SHELL': '/bin/bash', 09:37:59 INFO - 'SHLVL': '1', 09:37:59 INFO - 'TERM': 'linux', 09:37:59 INFO - 'TMOUT': '86400', 09:37:59 INFO - 'USER': 'cltbld', 09:37:59 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:59 INFO - '_': '/tools/buildbot/bin/python'} 09:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:38:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:38:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:03 INFO - Downloading docopt-0.6.1.tar.gz 09:38:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:38:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:38:03 INFO - Running setup.py install for blobuploader 09:38:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:38:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:38:03 INFO - Running setup.py install for requests 09:38:03 INFO - Running setup.py install for docopt 09:38:03 INFO - Successfully installed blobuploader requests docopt 09:38:03 INFO - Cleaning up... 09:38:03 INFO - Return code: 0 09:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:38:03 INFO - Using env: {'DISPLAY': ':0', 09:38:03 INFO - 'HOME': '/home/cltbld', 09:38:03 INFO - 'LANG': 'en_US.UTF-8', 09:38:03 INFO - 'LANGUAGE': 'en_US:en', 09:38:03 INFO - 'LOGNAME': 'cltbld', 09:38:03 INFO - 'MAIL': '/var/mail/cltbld', 09:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:03 INFO - 'MOZ_NO_REMOTE': '1', 09:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:03 INFO - 'NO_EM_RESTART': '1', 09:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:03 INFO - 'PWD': '/builds/slave/test', 09:38:03 INFO - 'SHELL': '/bin/bash', 09:38:03 INFO - 'SHLVL': '1', 09:38:03 INFO - 'TERM': 'linux', 09:38:03 INFO - 'TMOUT': '86400', 09:38:03 INFO - 'USER': 'cltbld', 09:38:03 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:03 INFO - '_': '/tools/buildbot/bin/python'} 09:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:04 INFO - Running setup.py (path:/tmp/pip-4rNldm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:04 INFO - Running setup.py (path:/tmp/pip-lGIEo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:04 INFO - Running setup.py (path:/tmp/pip-r6lgpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:04 INFO - Running setup.py (path:/tmp/pip-Jb19QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:04 INFO - Running setup.py (path:/tmp/pip-jVeUKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:04 INFO - Running setup.py (path:/tmp/pip-0aLOtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:04 INFO - Running setup.py (path:/tmp/pip-iLgj2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:04 INFO - Running setup.py (path:/tmp/pip-xAPyFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:04 INFO - Running setup.py (path:/tmp/pip-slwcKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:04 INFO - Running setup.py (path:/tmp/pip-mzYXMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:04 INFO - Running setup.py (path:/tmp/pip-5NDwqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:04 INFO - Running setup.py (path:/tmp/pip-gb7_7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:05 INFO - Running setup.py (path:/tmp/pip-qyYygL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:05 INFO - Running setup.py (path:/tmp/pip-YkfEmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:05 INFO - Running setup.py (path:/tmp/pip-PmvCeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:05 INFO - Running setup.py (path:/tmp/pip-PawUMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:05 INFO - Running setup.py (path:/tmp/pip-hLh6gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:38:05 INFO - Running setup.py install for manifestparser 09:38:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Running setup.py install for mozcrash 09:38:05 INFO - Running setup.py install for mozdebug 09:38:05 INFO - Running setup.py install for mozdevice 09:38:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Running setup.py install for mozfile 09:38:05 INFO - Running setup.py install for mozhttpd 09:38:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Running setup.py install for mozinfo 09:38:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for mozInstall 09:38:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for mozleak 09:38:06 INFO - Running setup.py install for mozlog 09:38:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for moznetwork 09:38:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for mozprocess 09:38:06 INFO - Running setup.py install for mozprofile 09:38:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for mozrunner 09:38:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for mozscreenshot 09:38:06 INFO - Running setup.py install for moztest 09:38:07 INFO - Running setup.py install for mozversion 09:38:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:38:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:38:07 INFO - Cleaning up... 09:38:07 INFO - Return code: 0 09:38:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:38:07 INFO - Using env: {'DISPLAY': ':0', 09:38:07 INFO - 'HOME': '/home/cltbld', 09:38:07 INFO - 'LANG': 'en_US.UTF-8', 09:38:07 INFO - 'LANGUAGE': 'en_US:en', 09:38:07 INFO - 'LOGNAME': 'cltbld', 09:38:07 INFO - 'MAIL': '/var/mail/cltbld', 09:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:07 INFO - 'MOZ_NO_REMOTE': '1', 09:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:07 INFO - 'NO_EM_RESTART': '1', 09:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:07 INFO - 'PWD': '/builds/slave/test', 09:38:07 INFO - 'SHELL': '/bin/bash', 09:38:07 INFO - 'SHLVL': '1', 09:38:07 INFO - 'TERM': 'linux', 09:38:07 INFO - 'TMOUT': '86400', 09:38:07 INFO - 'USER': 'cltbld', 09:38:07 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:07 INFO - '_': '/tools/buildbot/bin/python'} 09:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:07 INFO - Running setup.py (path:/tmp/pip-TMdD2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:07 INFO - Running setup.py (path:/tmp/pip-BajVgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:07 INFO - Running setup.py (path:/tmp/pip-a4n_df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:07 INFO - Running setup.py (path:/tmp/pip-9k5RKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:07 INFO - Running setup.py (path:/tmp/pip-UI2JqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:07 INFO - Running setup.py (path:/tmp/pip-Hge4Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:07 INFO - Running setup.py (path:/tmp/pip-5xYTI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:07 INFO - Running setup.py (path:/tmp/pip-g7uFkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:07 INFO - Running setup.py (path:/tmp/pip-_cpfJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:08 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)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:08 INFO - Running setup.py (path:/tmp/pip-dSN7IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:08 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)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:08 INFO - Running setup.py (path:/tmp/pip-hnxTRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:08 INFO - Running setup.py (path:/tmp/pip-WkTJOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:08 INFO - Running setup.py (path:/tmp/pip-s81bj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:08 INFO - Running setup.py (path:/tmp/pip-zBrm1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:08 INFO - Running setup.py (path:/tmp/pip-bMnVrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:08 INFO - Running setup.py (path:/tmp/pip-GGwvvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:08 INFO - Running setup.py (path:/tmp/pip-TbfvRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:38:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:10 INFO - Downloading blessings-1.5.1.tar.gz 09:38:10 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:38:10 INFO - Installing collected packages: blessings 09:38:10 INFO - Running setup.py install for blessings 09:38:10 INFO - Successfully installed blessings 09:38:10 INFO - Cleaning up... 09:38:10 INFO - Return code: 0 09:38:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:38:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:10 INFO - Reading from file tmpfile_stdout 09:38:10 INFO - Current package versions: 09:38:10 INFO - argparse == 1.2.1 09:38:10 INFO - blessings == 1.5.1 09:38:10 INFO - blobuploader == 1.2.4 09:38:10 INFO - docopt == 0.6.1 09:38:10 INFO - manifestparser == 1.1 09:38:10 INFO - mozInstall == 1.12 09:38:10 INFO - mozcrash == 0.16 09:38:10 INFO - mozdebug == 0.1 09:38:10 INFO - mozdevice == 0.47 09:38:10 INFO - mozfile == 1.2 09:38:10 INFO - mozhttpd == 0.7 09:38:10 INFO - mozinfo == 0.9 09:38:10 INFO - mozleak == 0.1 09:38:10 INFO - mozlog == 3.1 09:38:10 INFO - moznetwork == 0.27 09:38:10 INFO - mozprocess == 0.22 09:38:10 INFO - mozprofile == 0.27 09:38:10 INFO - mozrunner == 6.11 09:38:10 INFO - mozscreenshot == 0.1 09:38:10 INFO - mozsystemmonitor == 0.0 09:38:10 INFO - moztest == 0.7 09:38:10 INFO - mozversion == 1.4 09:38:10 INFO - psutil == 3.1.1 09:38:10 INFO - requests == 1.2.3 09:38:10 INFO - wsgiref == 0.1.2 09:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:38:10 INFO - Using env: {'DISPLAY': ':0', 09:38:10 INFO - 'HOME': '/home/cltbld', 09:38:10 INFO - 'LANG': 'en_US.UTF-8', 09:38:10 INFO - 'LANGUAGE': 'en_US:en', 09:38:10 INFO - 'LOGNAME': 'cltbld', 09:38:10 INFO - 'MAIL': '/var/mail/cltbld', 09:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:10 INFO - 'MOZ_NO_REMOTE': '1', 09:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:10 INFO - 'NO_EM_RESTART': '1', 09:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:10 INFO - 'PWD': '/builds/slave/test', 09:38:10 INFO - 'SHELL': '/bin/bash', 09:38:10 INFO - 'SHLVL': '1', 09:38:10 INFO - 'TERM': 'linux', 09:38:10 INFO - 'TMOUT': '86400', 09:38:10 INFO - 'USER': 'cltbld', 09:38:10 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:10 INFO - '_': '/tools/buildbot/bin/python'} 09:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:38:10 INFO - Cleaning up... 09:38:10 INFO - Return code: 0 09:38:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:38:10 INFO - Using env: {'DISPLAY': ':0', 09:38:10 INFO - 'HOME': '/home/cltbld', 09:38:10 INFO - 'LANG': 'en_US.UTF-8', 09:38:10 INFO - 'LANGUAGE': 'en_US:en', 09:38:10 INFO - 'LOGNAME': 'cltbld', 09:38:10 INFO - 'MAIL': '/var/mail/cltbld', 09:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:10 INFO - 'MOZ_NO_REMOTE': '1', 09:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:10 INFO - 'NO_EM_RESTART': '1', 09:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:10 INFO - 'PWD': '/builds/slave/test', 09:38:10 INFO - 'SHELL': '/bin/bash', 09:38:10 INFO - 'SHLVL': '1', 09:38:10 INFO - 'TERM': 'linux', 09:38:10 INFO - 'TMOUT': '86400', 09:38:10 INFO - 'USER': 'cltbld', 09:38:10 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:10 INFO - '_': '/tools/buildbot/bin/python'} 09:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:11 INFO - Downloading/unpacking jsonschema 09:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:38:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 09:38:12 INFO - Downloading/unpacking functools32 (from jsonschema) 09:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:38:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:38:13 INFO - warning: no files found matching '*.txt' 09:38:13 INFO - no previously-included directories found matching 'build' 09:38:13 INFO - no previously-included directories found matching 'dist' 09:38:13 INFO - no previously-included directories found matching '.git*' 09:38:13 INFO - Installing collected packages: jsonschema, functools32 09:38:13 INFO - Running setup.py install for functools32 09:38:13 INFO - warning: no files found matching '*.txt' 09:38:13 INFO - no previously-included directories found matching 'build' 09:38:13 INFO - no previously-included directories found matching 'dist' 09:38:13 INFO - no previously-included directories found matching '.git*' 09:38:13 INFO - Successfully installed jsonschema functools32 09:38:13 INFO - Cleaning up... 09:38:13 INFO - Return code: 0 09:38:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6806ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', '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 09:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:38:13 INFO - Using env: {'DISPLAY': ':0', 09:38:13 INFO - 'HOME': '/home/cltbld', 09:38:13 INFO - 'LANG': 'en_US.UTF-8', 09:38:13 INFO - 'LANGUAGE': 'en_US:en', 09:38:13 INFO - 'LOGNAME': 'cltbld', 09:38:13 INFO - 'MAIL': '/var/mail/cltbld', 09:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:13 INFO - 'MOZ_NO_REMOTE': '1', 09:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:13 INFO - 'NO_EM_RESTART': '1', 09:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:13 INFO - 'PWD': '/builds/slave/test', 09:38:13 INFO - 'SHELL': '/bin/bash', 09:38:13 INFO - 'SHLVL': '1', 09:38:13 INFO - 'TERM': 'linux', 09:38:13 INFO - 'TMOUT': '86400', 09:38:13 INFO - 'USER': 'cltbld', 09:38:13 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:13 INFO - '_': '/tools/buildbot/bin/python'} 09:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:13 INFO - Downloading/unpacking flake8 09:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:38:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 09:38:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:38:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 09:38:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 09:38:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:38:15 INFO - no previously-included directories found matching 'docs/_build' 09:38:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:38:15 INFO - Running setup.py install for pep8 09:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:38:15 INFO - no previously-included directories found matching 'docs/_build' 09:38:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:38:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:38:16 INFO - Cleaning up... 09:38:16 INFO - Return code: 0 09:38:16 INFO - Running post-action listener: _resource_record_post_action 09:38:16 INFO - Running post-action listener: _start_resource_monitoring 09:38:16 INFO - Starting resource monitoring. 09:38:16 INFO - ##### 09:38:16 INFO - ##### Running install step. 09:38:16 INFO - ##### 09:38:16 INFO - Running pre-action listener: _resource_record_pre_action 09:38:16 INFO - Running main action method: install 09:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:16 INFO - Reading from file tmpfile_stdout 09:38:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:38:16 INFO - Reading from file tmpfile_stdout 09:38:16 INFO - Output received: 09:38:16 INFO - Usage: mozinstall [options] installer 09:38:16 INFO - Options: 09:38:16 INFO - -h, --help show this help message and exit 09:38:16 INFO - -d DEST, --destination=DEST 09:38:16 INFO - Directory to install application into. [default: 09:38:16 INFO - "/builds/slave/test"] 09:38:16 INFO - --app=APP Application being installed. [default: firefox] 09:38:16 INFO - mkdir: /builds/slave/test/build/application 09:38:16 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'] 09:38:16 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 09:38:30 INFO - Reading from file tmpfile_stdout 09:38:30 INFO - Output received: 09:38:30 INFO - /builds/slave/test/build/application/firefox/firefox 09:38:30 INFO - Running post-action listener: _resource_record_post_action 09:38:30 INFO - ##### 09:38:30 INFO - ##### Running run-tests step. 09:38:30 INFO - ##### 09:38:30 INFO - Running pre-action listener: _resource_record_pre_action 09:38:30 INFO - Running main action method: run_tests 09:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:38:30 INFO - Python 2.7.3 09:38:30 INFO - Return code: 0 09:38:30 INFO - grabbing minidump binary from tooltool 09:38: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')]} 09:38:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de80b0>, '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 0x1de8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:38:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:38:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:38:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:38:30 INFO - Return code: 0 09:38:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:38:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:38:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:38:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:38:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:38:31 INFO - Return code: 0 09:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] in /builds/slave/test/build 09:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost 09:38:31 INFO - Using env: {'DISPLAY': ':0', 09:38:31 INFO - 'HOME': '/home/cltbld', 09:38:31 INFO - 'LANG': 'en_US.UTF-8', 09:38:31 INFO - 'LANGUAGE': 'en_US:en', 09:38:31 INFO - 'LOGNAME': 'cltbld', 09:38:31 INFO - 'MAIL': '/var/mail/cltbld', 09:38:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:38:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:31 INFO - 'MOZ_NO_REMOTE': '1', 09:38:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:31 INFO - 'NO_EM_RESTART': '1', 09:38:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:31 INFO - 'PWD': '/builds/slave/test', 09:38:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:38:31 INFO - 'SHELL': '/bin/bash', 09:38:31 INFO - 'SHLVL': '1', 09:38:31 INFO - 'TERM': 'linux', 09:38:31 INFO - 'TMOUT': '86400', 09:38:31 INFO - 'USER': 'cltbld', 09:38:31 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219', 09:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:31 INFO - '_': '/tools/buildbot/bin/python'} 09:38:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] with output_timeout 3600 09:38:31 INFO - mozversion INFO | application_buildid: 20151126075612 09:38:31 INFO - mozversion INFO | application_changeset: b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce 09:38:31 INFO - mozversion INFO | application_display_name: Nightly 09:38:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:38:31 INFO - mozversion INFO | application_name: Firefox 09:38:31 INFO - mozversion INFO | application_remotingname: firefox 09:38:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:38:31 INFO - mozversion INFO | application_vendor: Mozilla 09:38:31 INFO - mozversion INFO | application_version: 45.0a1 09:38:31 INFO - mozversion INFO | platform_buildid: 20151126075612 09:38:31 INFO - mozversion INFO | platform_changeset: b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce 09:38:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:38:31 INFO - mozversion INFO | platform_version: 45.0a1 09:38:31 INFO - 2015-11-26 09:38:31,944 DEBUG : using testdate: 1448559511 09:38:31 INFO - 2015-11-26 09:38:31,944 DEBUG : actual date: 1448559511 09:38:31 INFO - 2015-11-26 09:38:31,951 INFO : starting webserver on 'localhost:33318' 09:38:31 INFO - 2015-11-26 09:38:31,952 INFO : Starting test suite talos-linux64-ix-032 09:38:31 INFO - 2015-11-26 09:38:31,952 INFO : Starting test dromaeo_css 09:38:31 INFO - 2015-11-26 09:38:31,952 DEBUG : operating with platform_type : linux_ 09:38:31 INFO - 2015-11-26 09:38:31,952 INFO : Initialising browser for dromaeo_css test... 09:38:31 INFO - 2015-11-26 09:38:31,964 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8_Un0H/profile http://localhost:33318/getInfo.html 09:38:36 INFO - 2015-11-26 09:38:36,726 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:38:36 INFO - 2015-11-26 09:38:36,726 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:38:36 INFO - 2015-11-26 09:38:36,726 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:38:36 INFO - 2015-11-26 09:38:36,727 DEBUG : BROWSER_OUTPUT: __metrics 09:38:36 INFO - 2015-11-26 09:38:36,869 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:39 INFO - 2015-11-26 09:38:39,333 INFO : Browser initialized. 09:38:39 INFO - 2015-11-26 09:38:39,334 INFO : Running cycle 1/1 for dromaeo_css test... 09:38:39 INFO - 2015-11-26 09:38:39,334 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8_Un0H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:38:51 INFO - 2015-11-26 09:38:51,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 139440128 09:38:51 INFO - 2015-11-26 09:38:51,237 DEBUG : BROWSER_OUTPUT: 09:39:42 INFO - 2015-11-26 09:39:42,706 DEBUG : BROWSER_OUTPUT: 1448559582704 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] 09:41:54 INFO - 2015-11-26 09:41:54,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33318/tests/dromaeo/cssquery-ext.html) 09:41:56 INFO - 2015-11-26 09:41:56,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 305594368 09:41:56 INFO - 2015-11-26 09:41:56,472 DEBUG : BROWSER_OUTPUT: 09:44:59 INFO - 2015-11-26 09:44:59,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/dromaeo/cssquery-ext.html (next: http://localhost:33318/tests/dromaeo/cssquery-jquery.html) 09:44:59 INFO - 2015-11-26 09:44:59,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 223924224 09:44:59 INFO - 2015-11-26 09:44:59,673 DEBUG : BROWSER_OUTPUT: 09:48:01 INFO - 2015-11-26 09:48:01,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33318/tests/dromaeo/cssquery-mootools.html) 09:48:02 INFO - 2015-11-26 09:48:02,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 218619904 09:48:02 INFO - 2015-11-26 09:48:02,463 DEBUG : BROWSER_OUTPUT: 09:51:04 INFO - 2015-11-26 09:51:04,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33318/tests/dromaeo/cssquery-prototype.html) 09:51:04 INFO - 2015-11-26 09:51:04,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 208220160 09:51:04 INFO - 2015-11-26 09:51:04,920 DEBUG : BROWSER_OUTPUT: 09:54:07 INFO - 2015-11-26 09:54:07,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33318/tests/dromaeo/cssquery-yui.html) 09:54:08 INFO - 2015-11-26 09:54:08,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 208556032 09:54:08 INFO - 2015-11-26 09:54:08,278 DEBUG : BROWSER_OUTPUT: 09:57:10 INFO - 2015-11-26 09:57:10,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/dromaeo/cssquery-yui.html (next: http://localhost:33318/tests/dromaeo/cssquery-dojo.html) 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 234663936 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2675.4114094899123;2767.0453693475743;2777.527820270554;2783.178962206149;2805.1304095730325;4605.562471565205;4743.146233677937;4799.13615549201;4852.781624826886;4853.247746599279;4694.201985662437;4728.66899317048;4809;4811.13399588074;4820.276958456233;4423.579759922803;4461.018575913294;4486.910261794762;4497.617702495292;4517.25465298227;4326.480822301328;4496.482904465979;4503.234450143484;4538.659600529957;4554.795034223452;4331.783410829477;4398.494173170095;4429.778511074465;4448.6218671413135;4456.398386217851;4438.112377524508;4472.955270447286;4480.686351955364;4480.910381792379;4515.819367225307;4266.679999000087;4439.067795762894;4454.153710794971;4470.865874023784;4503.752293623849;4653.488116307203;4682.391289132425;4730.905381892343;4760.5001474844985;4804.039192161582;5193.298904647862;5204.3234379530795;5208.177138001707;5210.687358758487;5260.526552610283;4996.850094497135;5234.842954711365;5239.895202095937;5247.947520524784;5290.418054014055;4759.23852183649;4790.688605240648;4797.328374027639;4830.758462076882;4834.20235661112;5341.572674186055;5355.089634762022;5361.383440904268;5362.061639213122;5407.756650950717;4874.731889746027;5140.717260550631;5145.768440420115;5148.124818780816;5194.818181363634;5122.769475373617;5166.948330516722;5182.144946083929;5199.090159222196;5250.133727934848;5047.722375269322;5052.520010598987;5063.746812659352;5068.16375298079;5094.949050509522;4915.827946021944;5027.4721154279005;5039.823606173766;5048.873778155576;5052.317937078521;4224.345226489838;4225.471816022997;4251.149770045941;4310.590493903074;4329.09089091288;3766.7174961877968;3785.6403641653997;3788.3749181384765;3819.598942111094;3820.446035324918;4466.129104824593;4481.484629267611;4486.170058539181;4486.730796152241;4527.320901864681;5072.340595722532;5175.378954525481;5176.844694659167;5182.455842136596;5184;4416.977915110404;4479.059397526556;4484.865454036384;4502.16709908668;4520.18636645407;4623.42207224097;4626.676132670681;4627.07458508293;4648.83729069481;4665.183592871234;4714.764261786829;4800.711957282435;4929.9014019720125;4932.358793356841;4935.901281974412;5080.034793389244;5114.2840002400435;5172.948270517247;5197.818076367309;5200.791968321225;4918.286848407032;4949.9257511138085;4952.331435256195;4952.678075925053;5001.899962000813;5105.668131571436;5166.4316925138955;5168.173092305213;5169.715665638426;5170.8965820684125;4973.403191617029;5079.796808127633;5084.720340381315;5085.92371114441;5087.211482220262;4951.207806750903;5002.074616196015;5027.974860125676;5042.14283571801;5074.746262686777;5034.723090230073;5067.949320506747;5071.467495912876;5073.188289873602;5117.795288188431;4685.6017238535105;4756.928646070242;4955.231939049453;4968.527989840959;4983.9003219934675;4986.850394488171;4999.0501804657;5012.072766538202;5031.3207716959205;5032.823851165192;4882.7558622068045;4884.267359896044;4942.6293028023765;4945;4948.455669876239 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.949244567989;569.154805114405;572.3846864620534;578.7829563913532;579.7391173971711;26872.328191795215;27692.446151076965;36019.099522511984;36462.270754584955;36573.63426365735;38815.80592097043;39345.606543934555;39389.803050984774;39437;39451.80274098633;6929.514933954625;7924.44528882977;8098.51408915464;8103.311218546431;8105.716299929503;7068.646567671622;10003.199744020461;10205.642802501914;10211.795764084714;10211.846822297633;10042;10145.289829711923;10155.644552440666;10166.440845753481;10169.186465082812;7095.396891264249;7225.1329840419485;10107.393556386603;10226.590936362536;10285.640002599948;9989.800203995952;10127.493625318779;10131.088202061776;10137.036981486746;10146.543405546769;35902.46146307808;36364.454533182026;36380.45429318563;36399.454008189896;36416.271674566364;2970.4504666636526;2997.160794977388;3027.666956634768;3487.250241198129;3629.3467175908327;27355.589666155025;27585.172444826687;27998.5800212997;28168.577471337947;28490.57264141019;3280.5243239730344;3329.4839299908554;3329.766916315859;3332.3668502984356;3351.4302568563403;211710;213126;213824;214721;214727;53294.46705532895;53661.731691341294;53722;53760;53780.731096344265;57516.42483575111;57792;57811;57835.421645783004;58025.70987145122;13579.728405431835;14211.076280041763;14221.146731195955;14227.573172804832;14228.14631122136;10752.139828813833;10876.401797901191;10879.456027198608;10884.61903833362;10892.237543371888;18346.63306733858;18406.907965460086;18488.487187434344;18577.721334179998;18588.628227435376;7294.3799777018485;7436.9256307436235;7457.664405101784;7490.101187857492;7545.434092443089;857.8027053777666;861.6940985950023;904.9230815380766;981.499435287994;1012.8581998520066;24734.166204238372;25440.618390724154;25803.74196258051;25808.741912580634;25839.095631652803;831.6920545486203;917.6971599372191;932.4778124250306;1042.9478526073665;1062.150279776176;12625.494980200689;12912.418941147484;12927.612171634866;12944.223346599234;13057.738845223043;201263;204837;204983;205610;206219;40809.387859182134;40968.59031409648;40981;41028.38457423141;41075.589244107774;1199.1306302930307;1228.9324087175112;1236.3200239868036;1238.4055653286473;1242.9875701243052;22670.319890403316;23020.4244893879;23425.180118695764;23508;23665.881670591538;39627.405588915615;40075.79962100171;40154.59845401509;40285.39571906482;40333;253471;255352;255918;256103;256110;24146.63780043336;24702;24738.381540461633;26356.077537286103;27897.16308510748;28461.146165615064;28692.569611456263;29584.704152958195;33417.66582334146;34225.657743423246;28621;29287.12138635844;30065.398692026476;30350.84824575863;30455.543166852956;30958.53562196524;31790.20524486814;31902;32007;33514.83242583772;26231.60652590251;26292.21123366302;26915.86542067277;27315.86342068277;33173.66826331706;24830.25509234726;27221.1833644991;27528.311792205353;27540.89836406521;27891;21652.675209871548;21885.234016809973;21927.451813704785;23368.415789605395;23555 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: |2;jquery.html;303.8511129546523;310.64586371536444;310.77313561100397;314.53762968436416;318.1362600539535;12485.438155283011;12847.164934279288;15810.920945395272;15913.999999999985;16224;9951.104400603945;10234;10239;14405.207713575775;14868.107913525197;4396.5603439656015;4568.177728008957;4569.154706379314;4572.40558727365;4578.49636539982;3314.834258287076;3408.539847120644;5088.18589025756;5113.002964421939;5294.629375943686;5222;5246.213068039806;5259.868503287429;5281.023010743005;5281.049411106;5121.487851214867;5214.322138122057;5222.112240919034;5223.112070947948;5240.737963101848;5021.322121513622;5023.8492845214705;5024.422191447957;5026.698398096126;5044.621653376012;11917.821232681517;17401.82598174015;17792.288308467647;18047.27810887563;19474.22103115888;1752.6407086547226;1868.1219826681438;1903.486058764126;1935.6419062473346;2014.858959872795;8703.303735701129;8772.561371931379;8964.731058068268;9206.355555111146;10630.681079567625;1547.4197176058979;1553.8912276140675;1575.9290831912592;1650.6946214950271;1768.1159420289855;54293;55973;58325.12512312319;58501;59205.40794592042;9055.411398259092;9091.636334546543;9104.590293436811;9170.81658366829;9256.07439256069;11215.383153926448;11283.830742538868;11287.209895307415;11292.491837867316;11294.887051129384;6875.621840798804;6883.7590684325805;7064.611446370499;7096.92903070973;7098.473828126977;7053.612051337226;7084;7129.18014428337;7150.356467917913;7173.964130179315;3696.334659761269;3752.4371344298575;3762.830672619739;3778.3576791945434;3783.5270591176104;1576.8265490796002;1587.095355647293;1613.6369316903838;1658.5356100291697;1670.9164541772864;847.9448835825651;859.3211363023141;874.6588830356167;919.4069824962861;925.3337596930334;14493.275336233146;15109.773353399707;15316.927815052839;15787.368505259661;16190.271437785328;719.4999475364572;825.014108140766;837.2548431895618;848.5926755157435;888.4491615198618;8339.291160251447;8412.411131220755;8482.752795870374;8738.25724813398;8743.737687869374;507273;510117;510909;523627;525000;70550.64724676344;73039;74363;74462;76176;955.2501286490071;959.3572306554486;968.801395713877;974.1768205866032;985.0297457004845;9434.85847712271;12845.229286242855;13318.40067196998;13327.200367977952;13450;32211.838940805144;32369;33622.83188584042;34702.30595388129;38772;45999;47324.7633761829;47590.524094758606;48058.75970620124;49130.263046053624;14111;14161.787573186617;14269.71460570762;14387.352569134624;14582.927085364505;17043.914780426017;17480.388186413413;17497.83799365846;17635.29458821633;17784.02983817828;14592.708145837236;14761.704765904837;14925.552233433014;15077;15545;14094.36575354091;14673.339699713752;14701.264936753334;14775.852241477447;15284.77072843886;11545.595904143314;11887.76224475523;14683.55949321522;14696.77954830657;14946.701065978403;10730.570777168827;11387.829182562102;13321.400536975665;13422.798658020332;13866.168029917833;9356.95321523388;9890.752731181778;14165;14271.714565708835;14424.495142669955 09:57:11 INFO - 2015-11-26 09:57:11,125 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1397.2873834344482;1589.3404237241543;1654.8262432444592;1660.5184496496017;1675.103819456591;5852.79515216967;6524.249711283204;6643.036759669845;6661.733530658767;6663.233728121261;6623.56946798459;6818.863622727543;6818.931810681892;6818.965905170479;6819.931800681991;1980.6038792241536;2011.0749055434444;2017.2334512885084;2018.3440381875876;2018.8788672679614;1994.6309932662505;2000.2399088346408;2014.21445636202;2059.938201853939;2067.9483012924647;1992.442116207457;2015.2039944222024;2036.3381900882198;2036.9388918332475;2041.040710865898;1940.1269428757046;1983.553700417409;1983.9206431742714;1984.8114429129282;1985.8411327093943;1984.8213660770455;1986.2055177928798;2010.145688082559;2012.5471768852037;2012.7685316188679;5701.059325211335;5835.328937172237;6730.966345168292;6825.078614387044;6834.829129271759;3550.1834578046937;3603.0812142903656;3819.1216020315483;3946.4080387941754;3959.4852669153115;2628.2246737212377;2649.0595838477448;2681.034827462112;2684.221575743032;2690.6771187457434;850.0819115355401;852.2202185000717;864.2783275964578;873.2882700598991;875.6891303587262;8965.686200982935;9001.909980900173;9048.366614337;9054;9070.092990700878;3718.4980027695915;3724.7951362675312;3769.6230376962085;3772.2078363543415;3826.5025546678753;7896.32881205104;7905;7905.249001344863;7905.486143400661;7912.525248485109;4134.028503301722;4156.418101465797;4159.334506479009;4160.54234034256;4165.375193720905;3746.8126593670754;3749.2688925659236;3766.5291838520184;3772.43413487979;3774.358359078963;3125.3749250150063;3126.343467871772;3142.7328677062706;3166.509191075387;3167.3665266946705;1007.9546420411099;1010.1968934696934;1013.4679293371039;1013.6046941692746;1021.4126877045728;1124.7581769919507;1132.909367250618;1145.570411095839;1150.9597164099216;1153.5789436855655;6148.78479253224;6170.321264660884;6183.165272688219;6215.533834962396;6224.190855188796;437.5864807756639;438.2702799838297;439.916415880988;439.9890002749893;442.0650324563525;4355.673324500675;4955.876103097379;5017.648764586517;5034.496550344937;5041.924371134436;7383.593902335423;8013.078495972921;8035.799105022421;8058.919410805935;8073.475224110414;7995.720149794729;8025.9197408025175;8031;8046;8057.556834374166;6229.314775374796;6368.044793280952;6395.904061439082;6406.743730250831;6447.9355206447335;6237.5321850860455;6248.593841400295;6248.9062664059165;6255.874882502416;6260.40526150015;7107.253738357605;7278.871774874903;7338.926610733824;7340.26597340283;7349.081364829396;7034.788956331318;7122.7507037253445;7153.570785752871;7228.530145540733;7426.777196684108;5980.730867111078;5987;6006.9699651503215;6076.240469941257;6079;6439.710213040518;6481.254655714653;6497.18785151856;6503.414692677682;6513.185851768529;6178.66017369049;6180.876382472416;6215.036669316263;6264.436200741955;6311.2426508819235;6042.244719410074;6101.328853826164;6112.572119951561;6177.783777567944;6245.937540624535;6126.846828829315;6169.444749972345;6203.069539569101;6211.409916057967;6218.284897236876;5693.28833895763;5720.885582288414;5731.083026715705;5731.283589551306;5735.598508104559;5837.474627283565;5861.296644402699;5907.17299578068;5907.202527658883;5909.23179986599 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.7748817178515;290.1744536792825;295.4106557417951;296.829323139195;296.9732724054837;5193.740312984345;5261.026710058637;5264.842054738364;5315.521603055724;5406.270153529283;5011.273365362021;5107.668001579895;5179.792808287673;5257.1851363038695;5289.206619007151;4110.691698122653;4120.484939382577;4121.484814398193;4128.422020917074;4137.338025915854;3875.0893540018074;4121.969507623095;4123.628873401393;4124.422580838685;4130.401091841682;3910.9804450977704;3933.645971862532;3947.3092208863477;3951.9209615807667;3974.503187101612;3961.227560625679;3963.1479231965122;3973.2252210818756;3977.5624681285035;4019.5176578810438;3462.601800792916;3490.808005559719;3492.650734926487;3501.7373696972827;3502.439609662442;5068.594512438996;5081.034603425337;5082.1360368737405;5085.338905942241;5093.2105523643895;4485.080558485535;4591.104734576759;4592.678512504126;4593.793279302439;4606.493285738566;5523.751431185607;5529.060059789846;5537.473939975695;5538.086215774392;5542.722863856791;3816.8282427290837;3821.5032045833864;3825.005498570392;3826.0626146594263;3826.789526576037;5816.912746308766;5818.4763371296785;5820.7962721304975;5823.38854420284;5825.970870145665;3897.512810898638;3920.9019774505864;3960.742551734186;4035.1526179502634;4044.3326851069246;4099.446574712376;4140.565240649688;4144.046869220097;4144.212599606065;4151.315033019579;4698.271767875985;4701.247800351927;4702.95297047032;4706.623470122382;4708.246680531099;5524.944750552523;5564.387917329091;5569.081101618269;5570.888582228333;5576.776928922879;1424.9928750356182;1442.5528086293282;1475.0485936570851;1475.3213521779887;1475.6605980624518;962.7929995051097;1009.9293049486465;1021;1021.7649940513724;1031.2677998621064;4846.5638092571835;4877.5366340197625;4905.754712264373;4915.311856340115;4920.138975679241;5709.143628455765;5734.05388110957;5739.885202295931;5741.024025915604;5746.051901436216;4770.141374552614;4894.119058569491;4904.2643603459055;4907.411110666671;4916.582090522345;3048.131282584497;3099.4575949208797;3103.7672174586546;3114.5172498262805;3118.454270502653;5462.180672899018;5510.779568817283;5520.723963801794;5522.447755224445;5525.392206857243;5994.970025149846;5996.280446346466;6000.519958403317;6002.579819412599;6008.6394816310285;5348.946510534923;5503.752331145108;5531.25328080712;5543.501084902378;5550;5851.853703657443;5858.531317494505;5862.208601838697;5862.648241105377;5865.618734782225;5708.971455142698;5718;5720.513756330592;5724.656520608777;5727.367700205422;5320.627556071038;5532.695701736282;5536.058869992192;5536.7785288588;5545.944540554543;3928.4107383892647;3962.385830196324;3967;3968;3969.6824254060184;5827.504662103769;5829.504492118048;5839.065749480063;5841.591088623755;5842.2405087338375;5593.356763972195;5620.156976453564;5620.156976453564;5627.127795191752;5629.662220266797;5440.347158341025;5612.270404847343;5616.1014237721765;5624.437556244343;5629.521490673339;5505.642133261325;5507.449255074461;5511.834644960658;5513.448655134454;5514.255575497256;5659.207710920557;5665.32872802516;5711.200431939615;5729.570282228766;5730.398308177748;5382.461753824587;5507.256520369699;5508.944910550843;5511.53151982086;5515.09001014828 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.6163937211708;762.218725806049;767.2251026463274;768.4927947554613;792.3779832831221;11616.825747613782;11889.108316876236;13269.336533173351;13476.326183690826;13503.324833758323;12531.812022819666;12560;12574.994000479963;12587.685307867308;12589;597.0834768630153;605.3069235725092;766.9961650191741;783.5298820707559;785.8192615698392;762.92752188542;770.0412985832646;776.409928454376;776.6970881356276;776.8601651702692;805.1706742055692;813.3330668851544;813.3980854167903;813.9552324622143;814.5031530766228;621.5586933277378;628.9559730818798;756.08136114621;801.4990630855657;809.7449303469418;595.1548800703013;596.0493013643232;596.4125336543501;596.686739461786;596.7911231069135;12273.570425035081;12576.056795740265;12578.81131783024;12582.937085314516;12593.811092833615;10880.945595271973;10901.618443354444;11087.55649774008;11411.617707819965;11464;9311.953440232823;9399.812003759955;9448.149666529976;9762.755931101708;9772.609095636166;3071.585335979659;3137.607799025122;3171.6352619448826;3190.3778763141195;3194.8402579871145;43665.34501982473;44101.33847992283;44103.77948110271;44143.89640258987;44236.77881610571;9076.954615226881;9366.157045865768;9391.248700103975;9438.622455101719;9452.905470945203;15943;16121.758173627404;16125.113118778345;16176.595585110232;16204.189790510427;6402.8719425611225;6424.550281480251;6444.8388790280615;6496.22045354551;6618.404343609098;3487.75585709003;3498.6676265754713;3500.789952602852;3520.2255503789124;3526.7002304804378;2610.2299821552688;2611.4646497467975;2630;2631.302704783234;2637.353848307139;474.7341488766302;477.0578108236275;483.3474809007882;489.06344350568975;489.37360178970977;446.698478526993;451.9593236608721;458.15927772537765;469.9342092107108;469.9835505757282;7525.4355923305975;7678.654460549289;7878.724244651525;8012.074083699062;8029.437939344307;454.2799662534853;487.98292059777737;578.7251055748486;598.509222437597;604.247711599062;3630.3465874543012;3791.8862434127022;3798.9620103798607;3864.091938394475;3865.420186971977;52990;53799;54023;54099.72950135224;54129.45870541244;44822.77588612101;45188;45239.77380113078;45411;46319;41622.79188604037;41887.162256754695;42059.579404205564;42256.366154507705;42323.57676423196;7329.340359367682;7377.741779037708;7404.851902962018;7428.182899881117;7526.435517336112;32329.191770205933;32405.51391729173;32421.35157296888;32778.83610581932;32830.507542387364;40500.79749601351;42667;42973.140537188454;43266.56733432751;43449;9411.43531388119;10026.097651211427;10036.548355323883;10096.949515252376;10136.290459667753;11415.771684566429;11544.249623774427;11720.238184517979;11779.705507362041;12105.33420661872;10660.733481663021;10800.675979720621;10946.45267736594;11222.270552414067;11244.156688248251;10647.627333043307;10764.246502745045;10890.346579205274;11167.776644467227;11243.718907027389;10819.945900270763;11031.117510598971;11038;11265.211435199457;11289.71775705614;8820.470771753715;8998.867282426048;9006.36955413141;9067.727968160965;9095.636174552943;8710.21608055278;8997.865032024656;9305.302102342215;9486.667966621135;9508.77924346625 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1284 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: __startTimestamp1448560631118__endTimestamp 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,126 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4763.00 Median:4915.83 stddev:494.02 (10.0%) stddev-sans-first:467.60 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: Values: 2675.4 2767.0 2777.5 2783.2 2805.1 4605.6 4743.1 4799.1 4852.8 4853.2 4694.2 4728.7 4809.0 4811.1 4820.3 4423.6 4461.0 4486.9 4497.6 4517.3 4326.5 4496.5 4503.2 4538.7 4554.8 4331.8 4398.5 4429.8 4448.6 4456.4 4438.1 4473.0 4480.7 4480.9 4515.8 4266.7 4439.1 4454.2 4470.9 4503.8 4653.5 4682.4 4730.9 4760.5 4804.0 5193.3 5204.3 5208.2 5210.7 5260.5 4996.9 5234.8 5239.9 5247.9 5290.4 4759.2 4790.7 4797.3 4830.8 4834.2 5341.6 5355.1 5361.4 5362.1 5407.8 4874.7 5140.7 5145.8 5148.1 5194.8 5122.8 5166.9 5182.1 5199.1 5250.1 5047.7 5052.5 5063.7 5068.2 5094.9 4915.8 5027.5 5039.8 5048.9 5052.3 4224.3 4225.5 4251.1 4310.6 4329.1 3766.7 3785.6 3788.4 3819.6 3820.4 4466.1 4481.5 4486.2 4486.7 4527.3 5072.3 5175.4 5176.8 5182.5 5184.0 4417.0 4479.1 4484.9 4502.2 4520.2 4623.4 4626.7 4627.1 4648.8 4665.2 4714.8 4800.7 4929.9 4932.4 4935.9 5080.0 5114.3 5172.9 5197.8 5200.8 4918.3 4949.9 4952.3 4952.7 5001.9 5105.7 5166.4 5168.2 5169.7 5170.9 4973.4 5079.8 5084.7 5085.9 5087.2 4951.2 5002.1 5028.0 5042.1 5074.7 5034.7 5067.9 5071.5 5073.2 5117.8 4685.6 4756.9 4955.2 4968.5 4983.9 4986.9 4999.1 5012.1 5031.3 5032.8 4882.8 4884.3 4942.6 4945.0 4948.5 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37983.73 Median:27894.08 stddev:58641.03 (210.2%) stddev-sans-first:58738.23 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: Values: 563.9 569.2 572.4 578.8 579.7 26872.3 27692.4 36019.1 36462.3 36573.6 38815.8 39345.6 39389.8 39437.0 39451.8 6929.5 7924.4 8098.5 8103.3 8105.7 7068.6 10003.2 10205.6 10211.8 10211.8 10042.0 10145.3 10155.6 10166.4 10169.2 7095.4 7225.1 10107.4 10226.6 10285.6 9989.8 10127.5 10131.1 10137.0 10146.5 35902.5 36364.5 36380.5 36399.5 36416.3 2970.5 2997.2 3027.7 3487.3 3629.3 27355.6 27585.2 27998.6 28168.6 28490.6 3280.5 3329.5 3329.8 3332.4 3351.4 211710.0 213126.0 213824.0 214721.0 214727.0 53294.5 53661.7 53722.0 53760.0 53780.7 57516.4 57792.0 57811.0 57835.4 58025.7 13579.7 14211.1 14221.1 14227.6 14228.1 10752.1 10876.4 10879.5 10884.6 10892.2 18346.6 18406.9 18488.5 18577.7 18588.6 7294.4 7436.9 7457.7 7490.1 7545.4 857.8 861.7 904.9 981.5 1012.9 24734.2 25440.6 25803.7 25808.7 25839.1 831.7 917.7 932.5 1042.9 1062.2 12625.5 12912.4 12927.6 12944.2 13057.7 201263.0 204837.0 204983.0 205610.0 206219.0 40809.4 40968.6 40981.0 41028.4 41075.6 1199.1 1228.9 1236.3 1238.4 1243.0 22670.3 23020.4 23425.2 23508.0 23665.9 39627.4 40075.8 40154.6 40285.4 40333.0 253471.0 255352.0 255918.0 256103.0 256110.0 24146.6 24702.0 24738.4 26356.1 27897.2 28461.1 28692.6 29584.7 33417.7 34225.7 28621.0 29287.1 30065.4 30350.8 30455.5 30958.5 31790.2 31902.0 32007.0 33514.8 26231.6 26292.2 26915.9 27315.9 33173.7 24830.3 27221.2 27528.3 27540.9 27891.0 21652.7 21885.2 21927.5 23368.4 23555.0 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27454.87 Median:3770.59 stddev:84205.01 (2233.2%) stddev-sans-first:84416.55 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: Values: 303.9 310.6 310.8 314.5 318.1 12485.4 12847.2 15810.9 15914.0 16224.0 9951.1 10234.0 10239.0 14405.2 14868.1 4396.6 4568.2 4569.2 4572.4 4578.5 3314.8 3408.5 5088.2 5113.0 5294.6 5222.0 5246.2 5259.9 5281.0 5281.0 5121.5 5214.3 5222.1 5223.1 5240.7 5021.3 5023.8 5024.4 5026.7 5044.6 11917.8 17401.8 17792.3 18047.3 19474.2 1752.6 1868.1 1903.5 1935.6 2014.9 8703.3 8772.6 8964.7 9206.4 10630.7 1547.4 1553.9 1575.9 1650.7 1768.1 54293.0 55973.0 58325.1 58501.0 59205.4 9055.4 9091.6 9104.6 9170.8 9256.1 11215.4 11283.8 11287.2 11292.5 11294.9 6875.6 6883.8 7064.6 7096.9 7098.5 7053.6 7084.0 7129.2 7150.4 7174.0 3696.3 3752.4 3762.8 3778.4 3783.5 1576.8 1587.1 1613.6 1658.5 1670.9 847.9 859.3 874.7 919.4 925.3 14493.3 15109.8 15316.9 15787.4 16190.3 719.5 825.0 837.3 848.6 888.4 8339.3 8412.4 8482.8 8738.3 8743.7 507273.0 510117.0 510909.0 523627.0 525000.0 70550.6 73039.0 74363.0 74462.0 76176.0 955.3 959.4 968.8 974.2 985.0 9434.9 12845.2 13318.4 13327.2 13450.0 32211.8 32369.0 33622.8 34702.3 38772.0 45999.0 47324.8 47590.5 48058.8 49130.3 14111.0 14161.8 14269.7 14387.4 14582.9 17043.9 17480.4 17497.8 17635.3 17784.0 14592.7 14761.7 14925.6 15077.0 15545.0 14094.4 14673.3 14701.3 14775.9 15284.8 11545.6 11887.8 14683.6 14696.8 14946.7 10730.6 11387.8 13321.4 13422.8 13866.2 9357.0 9890.8 14165.0 14271.7 14424.5 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,128 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4714.09 Median:5907.19 stddev:2422.64 (41.0%) stddev-sans-first:2416.61 09:57:11 INFO - 2015-11-26 09:57:11,129 DEBUG : BROWSER_OUTPUT: Values: 1397.3 1589.3 1654.8 1660.5 1675.1 5852.8 6524.2 6643.0 6661.7 6663.2 6623.6 6818.9 6818.9 6819.0 6819.9 1980.6 2011.1 2017.2 2018.3 2018.9 1994.6 2000.2 2014.2 2059.9 2067.9 1992.4 2015.2 2036.3 2036.9 2041.0 1940.1 1983.6 1983.9 1984.8 1985.8 1984.8 1986.2 2010.1 2012.5 2012.8 5701.1 5835.3 6731.0 6825.1 6834.8 3550.2 3603.1 3819.1 3946.4 3959.5 2628.2 2649.1 2681.0 2684.2 2690.7 850.1 852.2 864.3 873.3 875.7 8965.7 9001.9 9048.4 9054.0 9070.1 3718.5 3724.8 3769.6 3772.2 3826.5 7896.3 7905.0 7905.2 7905.5 7912.5 4134.0 4156.4 4159.3 4160.5 4165.4 3746.8 3749.3 3766.5 3772.4 3774.4 3125.4 3126.3 3142.7 3166.5 3167.4 1008.0 1010.2 1013.5 1013.6 1021.4 1124.8 1132.9 1145.6 1151.0 1153.6 6148.8 6170.3 6183.2 6215.5 6224.2 437.6 438.3 439.9 440.0 442.1 4355.7 4955.9 5017.6 5034.5 5041.9 7383.6 8013.1 8035.8 8058.9 8073.5 7995.7 8025.9 8031.0 8046.0 8057.6 6229.3 6368.0 6395.9 6406.7 6447.9 6237.5 6248.6 6248.9 6255.9 6260.4 7107.3 7278.9 7338.9 7340.3 7349.1 7034.8 7122.8 7153.6 7228.5 7426.8 5980.7 5987.0 6007.0 6076.2 6079.0 6439.7 6481.3 6497.2 6503.4 6513.2 6178.7 6180.9 6215.0 6264.4 6311.2 6042.2 6101.3 6112.6 6177.8 6245.9 6126.8 6169.4 6203.1 6211.4 6218.3 5693.3 5720.9 5731.1 5731.3 5735.6 5837.5 5861.3 5907.2 5907.2 5909.2 09:57:11 INFO - 2015-11-26 09:57:11,130 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,130 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4622.52 Median:5143.73 stddev:1369.56 (26.6%) stddev-sans-first:1334.18 09:57:11 INFO - 2015-11-26 09:57:11,130 DEBUG : BROWSER_OUTPUT: Values: 286.8 290.2 295.4 296.8 297.0 5193.7 5261.0 5264.8 5315.5 5406.3 5011.3 5107.7 5179.8 5257.2 5289.2 4110.7 4120.5 4121.5 4128.4 4137.3 3875.1 4122.0 4123.6 4124.4 4130.4 3911.0 3933.6 3947.3 3951.9 3974.5 3961.2 3963.1 3973.2 3977.6 4019.5 3462.6 3490.8 3492.7 3501.7 3502.4 5068.6 5081.0 5082.1 5085.3 5093.2 4485.1 4591.1 4592.7 4593.8 4606.5 5523.8 5529.1 5537.5 5538.1 5542.7 3816.8 3821.5 3825.0 3826.1 3826.8 5816.9 5818.5 5820.8 5823.4 5826.0 3897.5 3920.9 3960.7 4035.2 4044.3 4099.4 4140.6 4144.0 4144.2 4151.3 4698.3 4701.2 4703.0 4706.6 4708.2 5524.9 5564.4 5569.1 5570.9 5576.8 1425.0 1442.6 1475.0 1475.3 1475.7 962.8 1009.9 1021.0 1021.8 1031.3 4846.6 4877.5 4905.8 4915.3 4920.1 5709.1 5734.1 5739.9 5741.0 5746.1 4770.1 4894.1 4904.3 4907.4 4916.6 3048.1 3099.5 3103.8 3114.5 3118.5 5462.2 5510.8 5520.7 5522.4 5525.4 5995.0 5996.3 6000.5 6002.6 6008.6 5348.9 5503.8 5531.3 5543.5 5550.0 5851.9 5858.5 5862.2 5862.6 5865.6 5709.0 5718.0 5720.5 5724.7 5727.4 5320.6 5532.7 5536.1 5536.8 5545.9 3928.4 3962.4 3967.0 3968.0 3969.7 5827.5 5829.5 5839.1 5841.6 5842.2 5593.4 5620.2 5620.2 5627.1 5629.7 5440.3 5612.3 5616.1 5624.4 5629.5 5505.6 5507.4 5511.8 5513.4 5514.3 5659.2 5665.3 5711.2 5729.6 5730.4 5382.5 5507.3 5508.9 5511.5 5515.1 09:57:11 INFO - 2015-11-26 09:57:11,130 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,130 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12719.90 Median:22637.37 stddev:14688.07 (64.9%) stddev-sans-first:14701.81 09:57:11 INFO - 2015-11-26 09:57:11,132 DEBUG : BROWSER_OUTPUT: Values: 759.6 762.2 767.2 768.5 792.4 11616.8 11889.1 13269.3 13476.3 13503.3 12531.8 12560.0 12575.0 12587.7 12589.0 597.1 605.3 767.0 783.5 785.8 762.9 770.0 776.4 776.7 776.9 805.2 813.3 813.4 814.0 814.5 621.6 629.0 756.1 801.5 809.7 595.2 596.0 596.4 596.7 596.8 12273.6 12576.1 12578.8 12582.9 12593.8 10880.9 10901.6 11087.6 11411.6 11464.0 9312.0 9399.8 9448.1 9762.8 9772.6 3071.6 3137.6 3171.6 3190.4 3194.8 43665.3 44101.3 44103.8 44143.9 44236.8 9077.0 9366.2 9391.2 9438.6 9452.9 15943.0 16121.8 16125.1 16176.6 16204.2 6402.9 6424.6 6444.8 6496.2 6618.4 3487.8 3498.7 3500.8 3520.2 3526.7 2610.2 2611.5 2630.0 2631.3 2637.4 474.7 477.1 483.3 489.1 489.4 446.7 452.0 458.2 469.9 470.0 7525.4 7678.7 7878.7 8012.1 8029.4 454.3 488.0 578.7 598.5 604.2 3630.3 3791.9 3799.0 3864.1 3865.4 52990.0 53799.0 54023.0 54099.7 54129.5 44822.8 45188.0 45239.8 45411.0 46319.0 41622.8 41887.2 42059.6 42256.4 42323.6 7329.3 7377.7 7404.9 7428.2 7526.4 32329.2 32405.5 32421.4 32778.8 32830.5 40500.8 42667.0 42973.1 43266.6 43449.0 9411.4 10026.1 10036.5 10096.9 10136.3 11415.8 11544.2 11720.2 11779.7 12105.3 10660.7 10800.7 10946.5 11222.3 11244.2 10647.6 10764.2 10890.3 11167.8 11243.7 10819.9 11031.1 11038.0 11265.2 11289.7 8820.5 8998.9 9006.4 9067.7 9095.6 8710.2 8997.9 9305.3 9486.7 9508.8 09:57:11 INFO - 2015-11-26 09:57:11,132 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:57:11 INFO - 2015-11-26 09:57:11,132 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2015-11-26 09:57:11,921 INFO : Browser exited with error code: 0 09:57:11 INFO - 2015-11-26 09:57:11,942 INFO : Completed test dromaeo_css (00:18:39) 09:57:11 INFO - 2015-11-26 09:57:11,943 INFO : Starting test kraken 09:57:11 INFO - 2015-11-26 09:57:11,943 DEBUG : operating with platform_type : linux_ 09:57:11 INFO - 2015-11-26 09:57:11,943 INFO : Initialising browser for kraken test... 09:57:11 INFO - 2015-11-26 09:57:11,949 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRuuTxS/profile http://localhost:33318/getInfo.html 09:57:16 INFO - 2015-11-26 09:57:16,673 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:57:16 INFO - 2015-11-26 09:57:16,673 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:57:16 INFO - 2015-11-26 09:57:16,673 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:57:16 INFO - 2015-11-26 09:57:16,673 DEBUG : BROWSER_OUTPUT: __metrics 09:57:16 INFO - 2015-11-26 09:57:16,911 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:18 INFO - 2015-11-26 09:57:18,368 INFO : Browser initialized. 09:57:18 INFO - 2015-11-26 09:57:18,369 INFO : Running cycle 1/1 for kraken test... 09:57:18 INFO - 2015-11-26 09:57:18,369 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRuuTxS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:57:30 INFO - 2015-11-26 09:57:30,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 141901824 09:57:30 INFO - 2015-11-26 09:57:30,235 DEBUG : BROWSER_OUTPUT: 09:57:32 INFO - 2015-11-26 09:57:32,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33318/tests/kraken/driver.html?testName=audio-beat-detection) 09:57:33 INFO - 2015-11-26 09:57:33,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 175222784 09:57:33 INFO - 2015-11-26 09:57:33,457 DEBUG : BROWSER_OUTPUT: 09:57:36 INFO - 2015-11-26 09:57:36,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33318/tests/kraken/driver.html?testName=audio-dft) 09:57:36 INFO - 2015-11-26 09:57:36,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 165625856 09:57:36 INFO - 2015-11-26 09:57:36,744 DEBUG : BROWSER_OUTPUT: 09:57:39 INFO - 2015-11-26 09:57:39,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33318/tests/kraken/driver.html?testName=audio-fft) 09:57:40 INFO - 2015-11-26 09:57:40,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 151732224 09:57:40 INFO - 2015-11-26 09:57:40,336 DEBUG : BROWSER_OUTPUT: 09:57:42 INFO - 2015-11-26 09:57:42,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33318/tests/kraken/driver.html?testName=audio-oscillator) 09:57:42 INFO - 2015-11-26 09:57:42,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 154234880 09:57:42 INFO - 2015-11-26 09:57:42,931 DEBUG : BROWSER_OUTPUT: 09:57:45 INFO - 2015-11-26 09:57:45,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:45 INFO - 2015-11-26 09:57:45,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 155131904 09:57:45 INFO - 2015-11-26 09:57:45,734 DEBUG : BROWSER_OUTPUT: 09:57:48 INFO - 2015-11-26 09:57:48,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33318/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:49 INFO - 2015-11-26 09:57:49,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 154882048 09:57:49 INFO - 2015-11-26 09:57:49,261 DEBUG : BROWSER_OUTPUT: 09:57:52 INFO - 2015-11-26 09:57:52,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33318/tests/kraken/driver.html?testName=imaging-desaturate) 09:57:53 INFO - 2015-11-26 09:57:53,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 155189248 09:57:53 INFO - 2015-11-26 09:57:53,248 DEBUG : BROWSER_OUTPUT: 09:57:56 INFO - 2015-11-26 09:57:56,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33318/tests/kraken/driver.html?testName=json-parse-financial) 09:57:56 INFO - 2015-11-26 09:57:56,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 154107904 09:57:56 INFO - 2015-11-26 09:57:56,652 DEBUG : BROWSER_OUTPUT: 09:57:58 INFO - 2015-11-26 09:57:58,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:57:59 INFO - 2015-11-26 09:57:59,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 163348480 09:57:59 INFO - 2015-11-26 09:57:59,000 DEBUG : BROWSER_OUTPUT: 09:58:00 INFO - 2015-11-26 09:58:00,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33318/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:58:01 INFO - 2015-11-26 09:58:01,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 163676160 09:58:01 INFO - 2015-11-26 09:58:01,512 DEBUG : BROWSER_OUTPUT: 09:58:03 INFO - 2015-11-26 09:58:03,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:58:04 INFO - 2015-11-26 09:58:04,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 172564480 09:58:04 INFO - 2015-11-26 09:58:04,231 DEBUG : BROWSER_OUTPUT: 09:58:06 INFO - 2015-11-26 09:58:06,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:58:07 INFO - 2015-11-26 09:58:07,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 177319936 09:58:07 INFO - 2015-11-26 09:58:07,311 DEBUG : BROWSER_OUTPUT: 09:58:09 INFO - 2015-11-26 09:58:09,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:58:10 INFO - 2015-11-26 09:58:10,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 176320512 09:58:10 INFO - 2015-11-26 09:58:10,515 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33318/tests/kraken/driver.html?testName=ai-astar) 09:58:12 INFO - 2015-11-26 09:58:12,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 235966464 09:58:12 INFO - 2015-11-26 09:58:12,510 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,513 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:58:12 INFO - 2015-11-26 09:58:12,513 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:58:12 INFO - 2015-11-26 09:58:12,513 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:58:12 INFO - 2015-11-26 09:58:12,514 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:58:12 INFO - 2015-11-26 09:58:12,514 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;107;112;112;113;102;111;112;105 09:58:12 INFO - 2015-11-26 09:58:12,514 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;130;150;161;130;156;155;130;166;133 09:58:12 INFO - 2015-11-26 09:58:12,514 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;159;161;160;159;161;163;162;161 09:58:12 INFO - 2015-11-26 09:58:12,514 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;87;103;72;72;72;107;86;73 09:58:12 INFO - 2015-11-26 09:58:12,515 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;126;93;94;94;127;94;93;122 09:58:12 INFO - 2015-11-26 09:58:12,515 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;110;109;110 09:58:12 INFO - 2015-11-26 09:58:12,515 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;148;146;146;146;146;146;146 09:58:12 INFO - 2015-11-26 09:58:12,515 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;96;96;96;95;95 09:58:12 INFO - 2015-11-26 09:58:12,515 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;71;71;71;71;70;79;69;69 09:58:12 INFO - 2015-11-26 09:58:12,516 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;68;69;69;70;70;70;69;69 09:58:12 INFO - 2015-11-26 09:58:12,516 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;85;84;90;83;83;83;86;82 09:58:12 INFO - 2015-11-26 09:58:12,516 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;122;129;123;120;120;132;123;119;121 09:58:12 INFO - 2015-11-26 09:58:12,516 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;144;146;147;149;147;148;147;159;147 09:58:12 INFO - 2015-11-26 09:58:12,516 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;68;67;69;69;68;69;68;69 09:58:12 INFO - 2015-11-26 09:58:12,516 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:58:12 INFO - 2015-11-26 09:58:12,516 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:58:12 INFO - 2015-11-26 09:58:12,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 09:58:12 INFO - 2015-11-26 09:58:12,517 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:58:12 INFO - 2015-11-26 09:58:12,517 DEBUG : BROWSER_OUTPUT: __startTimestamp1448560692512__endTimestamp 09:58:12 INFO - 2015-11-26 09:58:12,517 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,524 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:112.00 stddev:3.71 (3.3%) stddev-sans-first:3.91 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 107.0 112.0 112.0 113.0 102.0 111.0 112.0 105.0 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.00 stddev:14.08 (9.2%) stddev-sans-first:14.82 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: Values: 151.0 130.0 150.0 161.0 130.0 156.0 155.0 130.0 166.0 133.0 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 09:58:12 INFO - 2015-11-26 09:58:12,525 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 159.0 161.0 160.0 159.0 161.0 163.0 162.0 161.0 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:72.00 stddev:13.77 (19.1%) stddev-sans-first:14.07 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 87.0 103.0 72.0 72.0 72.0 107.0 86.0 73.0 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:94.00 stddev:15.11 (16.1%) stddev-sans-first:15.65 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 126.0 93.0 94.0 94.0 127.0 94.0 93.0 122.0 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 148.0 146.0 146.0 146.0 146.0 146.0 146.0 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:58:12 INFO - 2015-11-26 09:58:12,526 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 09:58:12 INFO - 2015-11-26 09:58:12,527 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,527 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:2.84 (4.0%) stddev-sans-first:3.00 09:58:12 INFO - 2015-11-26 09:58:12,527 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 71.0 71.0 71.0 70.0 79.0 69.0 69.0 09:58:12 INFO - 2015-11-26 09:58:12,527 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,527 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:0.79 (1.1%) stddev-sans-first:0.71 09:58:12 INFO - 2015-11-26 09:58:12,527 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 69.0 69.0 70.0 70.0 70.0 69.0 69.0 09:58:12 INFO - 2015-11-26 09:58:12,527 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,527 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.60 (3.1%) stddev-sans-first:2.54 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 85.0 84.0 90.0 83.0 83.0 83.0 86.0 82.0 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:122.50 stddev:4.28 (3.5%) stddev-sans-first:4.41 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: Values: 120.0 122.0 129.0 123.0 120.0 120.0 132.0 123.0 119.0 121.0 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:147.00 stddev:4.04 (2.7%) stddev-sans-first:4.27 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: Values: 147.0 144.0 146.0 147.0 149.0 147.0 148.0 147.0 159.0 147.0 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 09:58:12 INFO - 2015-11-26 09:58:12,528 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 67.0 69.0 69.0 68.0 69.0 68.0 69.0 09:58:12 INFO - 2015-11-26 09:58:12,529 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:58:12 INFO - 2015-11-26 09:58:12,529 DEBUG : BROWSER_OUTPUT: 09:58:13 INFO - 2015-11-26 09:58:13,477 INFO : Browser exited with error code: 0 09:58:13 INFO - 2015-11-26 09:58:13,525 INFO : Completed test kraken (00:01:01) 09:58:13 INFO - 2015-11-26 09:58:13,526 INFO : Starting test v8_7 09:58:13 INFO - 2015-11-26 09:58:13,526 DEBUG : operating with platform_type : linux_ 09:58:13 INFO - 2015-11-26 09:58:13,526 INFO : Initialising browser for v8_7 test... 09:58:13 INFO - 2015-11-26 09:58:13,532 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfU4Xnr/profile http://localhost:33318/getInfo.html 09:58:18 INFO - 2015-11-26 09:58:18,511 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:58:18 INFO - 2015-11-26 09:58:18,511 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:58:18 INFO - 2015-11-26 09:58:18,511 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:58:18 INFO - 2015-11-26 09:58:18,511 DEBUG : BROWSER_OUTPUT: __metrics 09:58:18 INFO - 2015-11-26 09:58:18,607 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:20 INFO - 2015-11-26 09:58:20,152 INFO : Browser initialized. 09:58:20 INFO - 2015-11-26 09:58:20,153 INFO : Running cycle 1/1 for v8_7 test... 09:58:20 INFO - 2015-11-26 09:58:20,153 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfU4Xnr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:58:32 INFO - 2015-11-26 09:58:32,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 139235328 09:58:32 INFO - 2015-11-26 09:58:32,012 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33318/tests/v8_7/run.html (next: http://localhost:33318/tests/v8_7/run.html) 09:58:53 INFO - 2015-11-26 09:58:53,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 440664064 09:58:53 INFO - 2015-11-26 09:58:53,763 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,765 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:58:53 INFO - 2015-11-26 09:58:53,765 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:58:53 INFO - 2015-11-26 09:58:53,765 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:58:53 INFO - 2015-11-26 09:58:53,765 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:58:53 INFO - 2015-11-26 09:58:53,765 DEBUG : BROWSER_OUTPUT: |0;Richards;165.61775422325275 09:58:53 INFO - 2015-11-26 09:58:53,765 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.131498470948 09:58:53 INFO - 2015-11-26 09:58:53,766 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.39251040221916 09:58:53 INFO - 2015-11-26 09:58:53,766 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 09:58:53 INFO - 2015-11-26 09:58:53,766 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1960.7843137254902 09:58:53 INFO - 2015-11-26 09:58:53,766 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 09:58:53 INFO - 2015-11-26 09:58:53,766 DEBUG : BROWSER_OUTPUT: |6;Boyer;12144.578313253012 09:58:53 INFO - 2015-11-26 09:58:53,767 DEBUG : BROWSER_OUTPUT: |7;RegExp;26526.315789473683 09:58:53 INFO - 2015-11-26 09:58:53,767 DEBUG : BROWSER_OUTPUT: |8;Splay;602.4096385542168 09:58:53 INFO - 2015-11-26 09:58:53,767 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 09:58:53 INFO - 2015-11-26 09:58:53,767 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:58:53 INFO - 2015-11-26 09:58:53,767 DEBUG : BROWSER_OUTPUT: __startTimestamp1448560733764__endTimestamp 09:58:53 INFO - 2015-11-26 09:58:53,767 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,767 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.62 Median:165.62 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: Values: 165.6 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.13 Median:191.13 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: Values: 191.1 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.39 Median:277.39 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: Values: 277.4 09:58:53 INFO - 2015-11-26 09:58:53,768 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: Values: 5186.5 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: Values: 1960.8 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: Values: 788.0 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,769 DEBUG : BROWSER_OUTPUT: Values: 12144.6 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: Values: 26526.3 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.41 Median:602.41 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: Values: 602.4 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: Values: 4835.7 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:58:53 INFO - 2015-11-26 09:58:53,770 DEBUG : BROWSER_OUTPUT: 09:58:54 INFO - 2015-11-26 09:58:54,661 INFO : Browser exited with error code: 0 09:58:54 INFO - 2015-11-26 09:58:54,676 INFO : Completed test v8_7 (00:00:41) 09:58:54 INFO - 2015-11-26 09:58:54,718 INFO : Completed test suite (00:20:22) 09:58:54 INFO - 2015-11-26 09:58:54,718 DEBUG : Working with test: dromaeo_css 09:58:54 INFO - 2015-11-26 09:58:54,718 DEBUG : Generating results file: dromaeo_css 09:58:54 INFO - 2015-11-26 09:58:54,720 DEBUG : Working with test: kraken 09:58:54 INFO - 2015-11-26 09:58:54,720 DEBUG : Generating results file: kraken 09:58:54 INFO - 2015-11-26 09:58:54,720 INFO : javascript benchmark 09:58:54 INFO - 2015-11-26 09:58:54,720 DEBUG : Working with test: v8_7 09:58:54 INFO - 2015-11-26 09:58:54,720 DEBUG : Generating results file: v8_7 09:58:54 INFO - 2015-11-26 09:58:54,721 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:58:54 INFO - 2015-11-26 09:58:54,780 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:58:54 INFO - 2015-11-26 09:58:54,780 DEBUG : process_Request line: dromaeo_css 6247.90 graph.html#tests=[[72,132,35]] 09:58:54 INFO - 2015-11-26 09:58:54,780 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:58:54 INFO - 2015-11-26 09:58:54,816 DEBUG : process_Request line: kraken 1516.80 graph.html#tests=[[232,132,35]] 09:58:54 INFO - 2015-11-26 09:58:54,816 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:58:54 INFO - 2015-11-26 09:58:54,849 DEBUG : process_Request line: v8_7 19835.23 graph.html#tests=[[230,132,35]] 09:58:54 INFO - 2015-11-26 09:58:54,850 INFO : javascript benchmark 09:58:54 INFO - 2015-11-26 09:58:54,854 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2675.4114094899123, 2767.0453693475743, 2777.527820270554, 2783.178962206149, 2805.1304095730325, 4605.562471565205, 4743.146233677937, 4799.13615549201, 4852.781624826886, 4853.247746599279, 4694.201985662437, 4728.66899317048, 4809.0, 4811.13399588074, 4820.276958456233, 4423.579759922803, 4461.018575913294, 4486.910261794762, 4497.617702495292, 4517.25465298227, 4326.480822301328, 4496.482904465979, 4503.234450143484, 4538.659600529957, 4554.795034223452, 4331.783410829477, 4398.494173170095, 4429.778511074465, 4448.6218671413135, 4456.398386217851, 4438.112377524508, 4472.955270447286, 4480.686351955364, 4480.910381792379, 4515.819367225307, 4266.679999000087, 4439.067795762894, 4454.153710794971, 4470.865874023784, 4503.752293623849, 4653.488116307203, 4682.391289132425, 4730.905381892343, 4760.5001474844985, 4804.039192161582, 5193.298904647862, 5204.3234379530795, 5208.177138001707, 5210.687358758487, 5260.526552610283, 4996.850094497135, 5234.842954711365, 5239.895202095937, 5247.947520524784, 5290.418054014055, 4759.23852183649, 4790.688605240648, 4797.328374027639, 4830.758462076882, 4834.20235661112, 5341.572674186055, 5355.089634762022, 5361.383440904268, 5362.061639213122, 5407.756650950717, 4874.731889746027, 5140.717260550631, 5145.768440420115, 5148.124818780816, 5194.818181363634, 5122.769475373617, 5166.948330516722, 5182.144946083929, 5199.090159222196, 5250.133727934848, 5047.722375269322, 5052.520010598987, 5063.746812659352, 5068.16375298079, 5094.949050509522, 4915.827946021944, 5027.4721154279005, 5039.823606173766, 5048.873778155576, 5052.317937078521, 4224.345226489838, 4225.471816022997, 4251.149770045941, 4310.590493903074, 4329.09089091288, 3766.7174961877968, 3785.6403641653997, 3788.3749181384765, 3819.598942111094, 3820.446035324918, 4466.129104824593, 4481.484629267611, 4486.170058539181, 4486.730796152241, 4527.320901864681, 5072.340595722532, 5175.378954525481, 5176.844694659167, 5182.455842136596, 5184.0, 4416.977915110404, 4479.059397526556, 4484.865454036384, 4502.16709908668, 4520.18636645407, 4623.42207224097, 4626.676132670681, 4627.07458508293, 4648.83729069481, 4665.183592871234, 4714.764261786829, 4800.711957282435, 4929.9014019720125, 4932.358793356841, 4935.901281974412, 5080.034793389244, 5114.2840002400435, 5172.948270517247, 5197.818076367309, 5200.791968321225, 4918.286848407032, 4949.9257511138085, 4952.331435256195, 4952.678075925053, 5001.899962000813, 5105.668131571436, 5166.4316925138955, 5168.173092305213, 5169.715665638426, 5170.8965820684125, 4973.403191617029, 5079.796808127633, 5084.720340381315, 5085.92371114441, 5087.211482220262, 4951.207806750903, 5002.074616196015, 5027.974860125676, 5042.14283571801, 5074.746262686777, 5034.723090230073, 5067.949320506747, 5071.467495912876, 5073.188289873602, 5117.795288188431, 4685.6017238535105, 4756.928646070242, 4955.231939049453, 4968.527989840959, 4983.9003219934675, 4986.850394488171, 4999.0501804657, 5012.072766538202, 5031.3207716959205, 5032.823851165192, 4882.7558622068045, 4884.267359896044, 4942.6293028023765, 4945.0, 4948.455669876239], "unit": "ms", "name": "dojo.html", "value": 4732.410235459211}, {"lowerIsBetter": false, "replicates": [563.949244567989, 569.154805114405, 572.3846864620534, 578.7829563913532, 579.7391173971711, 26872.328191795215, 27692.446151076965, 36019.099522511984, 36462.270754584955, 36573.63426365735, 38815.80592097043, 39345.606543934555, 39389.803050984774, 39437.0, 39451.80274098633, 6929.514933954625, 7924.44528882977, 8098.51408915464, 8103.311218546431, 8105.716299929503, 7068.646567671622, 10003.199744020461, 10205.642802501914, 10211.795764084714, 10211.846822297633, 10042.0, 10145.289829711923, 10155.644552440666, 10166.440845753481, 10169.186465082812, 7095.396891264249, 7225.1329840419485, 10107.393556386603, 10226.590936362536, 10285.640002599948, 9989.800203995952, 10127.493625318779, 10131.088202061776, 10137.036981486746, 10146.543405546769, 35902.46146307808, 36364.454533182026, 36380.45429318563, 36399.454008189896, 36416.271674566364, 2970.4504666636526, 2997.160794977388, 3027.666956634768, 3487.250241198129, 3629.3467175908327, 27355.589666155025, 27585.172444826687, 27998.5800212997, 28168.577471337947, 28490.57264141019, 3280.5243239730344, 3329.4839299908554, 3329.766916315859, 3332.3668502984356, 3351.4302568563403, 211710.0, 213126.0, 213824.0, 214721.0, 214727.0, 53294.46705532895, 53661.731691341294, 53722.0, 53760.0, 53780.731096344265, 57516.42483575111, 57792.0, 57811.0, 57835.421645783004, 58025.70987145122, 13579.728405431835, 14211.076280041763, 14221.146731195955, 14227.573172804832, 14228.14631122136, 10752.139828813833, 10876.401797901191, 10879.456027198608, 10884.61903833362, 10892.237543371888, 18346.63306733858, 18406.907965460086, 18488.487187434344, 18577.721334179998, 18588.628227435376, 7294.3799777018485, 7436.9256307436235, 7457.664405101784, 7490.101187857492, 7545.434092443089, 857.8027053777666, 861.6940985950023, 904.9230815380766, 981.499435287994, 1012.8581998520066, 24734.166204238372, 25440.618390724154, 25803.74196258051, 25808.741912580634, 25839.095631652803, 831.6920545486203, 917.6971599372191, 932.4778124250306, 1042.9478526073665, 1062.150279776176, 12625.494980200689, 12912.418941147484, 12927.612171634866, 12944.223346599234, 13057.738845223043, 201263.0, 204837.0, 204983.0, 205610.0, 206219.0, 40809.387859182134, 40968.59031409648, 40981.0, 41028.38457423141, 41075.589244107774, 1199.1306302930307, 1228.9324087175112, 1236.3200239868036, 1238.4055653286473, 1242.9875701243052, 22670.319890403316, 23020.4244893879, 23425.180118695764, 23508.0, 23665.881670591538, 39627.405588915615, 40075.79962100171, 40154.59845401509, 40285.39571906482, 40333.0, 253471.0, 255352.0, 255918.0, 256103.0, 256110.0, 24146.63780043336, 24702.0, 24738.381540461633, 26356.077537286103, 27897.16308510748, 28461.146165615064, 28692.569611456263, 29584.704152958195, 33417.66582334146, 34225.657743423246, 28621.0, 29287.12138635844, 30065.398692026476, 30350.84824575863, 30455.543166852956, 30958.53562196524, 31790.20524486814, 31902.0, 32007.0, 33514.83242583772, 26231.60652590251, 26292.21123366302, 26915.86542067277, 27315.86342068277, 33173.66826331706, 24830.25509234726, 27221.1833644991, 27528.311792205353, 27540.89836406521, 27891.0, 21652.675209871548, 21885.234016809973, 21927.451813704785, 23368.415789605395, 23555.0], "unit": "ms", "name": "ext.html", "value": 16518.76741793472}, {"lowerIsBetter": false, "replicates": [303.8511129546523, 310.64586371536444, 310.77313561100397, 314.53762968436416, 318.1362600539535, 12485.438155283011, 12847.164934279288, 15810.920945395272, 15913.999999999985, 16224.0, 9951.104400603945, 10234.0, 10239.0, 14405.207713575775, 14868.107913525197, 4396.5603439656015, 4568.177728008957, 4569.154706379314, 4572.40558727365, 4578.49636539982, 3314.834258287076, 3408.539847120644, 5088.18589025756, 5113.002964421939, 5294.629375943686, 5222.0, 5246.213068039806, 5259.868503287429, 5281.023010743005, 5281.049411106, 5121.487851214867, 5214.322138122057, 5222.112240919034, 5223.112070947948, 5240.737963101848, 5021.322121513622, 5023.8492845214705, 5024.422191447957, 5026.698398096126, 5044.621653376012, 11917.821232681517, 17401.82598174015, 17792.288308467647, 18047.27810887563, 19474.22103115888, 1752.6407086547226, 1868.1219826681438, 1903.486058764126, 1935.6419062473346, 2014.858959872795, 8703.303735701129, 8772.561371931379, 8964.731058068268, 9206.355555111146, 10630.681079567625, 1547.4197176058979, 1553.8912276140675, 1575.9290831912592, 1650.6946214950271, 1768.1159420289855, 54293.0, 55973.0, 58325.12512312319, 58501.0, 59205.40794592042, 9055.411398259092, 9091.636334546543, 9104.590293436811, 9170.81658366829, 9256.07439256069, 11215.383153926448, 11283.830742538868, 11287.209895307415, 11292.491837867316, 11294.887051129384, 6875.621840798804, 6883.7590684325805, 7064.611446370499, 7096.92903070973, 7098.473828126977, 7053.612051337226, 7084.0, 7129.18014428337, 7150.356467917913, 7173.964130179315, 3696.334659761269, 3752.4371344298575, 3762.830672619739, 3778.3576791945434, 3783.5270591176104, 1576.8265490796002, 1587.095355647293, 1613.6369316903838, 1658.5356100291697, 1670.9164541772864, 847.9448835825651, 859.3211363023141, 874.6588830356167, 919.4069824962861, 925.3337596930334, 14493.275336233146, 15109.773353399707, 15316.927815052839, 15787.368505259661, 16190.271437785328, 719.4999475364572, 825.014108140766, 837.2548431895618, 848.5926755157435, 888.4491615198618, 8339.291160251447, 8412.411131220755, 8482.752795870374, 8738.25724813398, 8743.737687869374, 507273.0, 510117.0, 510909.0, 523627.0, 525000.0, 70550.64724676344, 73039.0, 74363.0, 74462.0, 76176.0, 955.2501286490071, 959.3572306554486, 968.801395713877, 974.1768205866032, 985.0297457004845, 9434.85847712271, 12845.229286242855, 13318.40067196998, 13327.200367977952, 13450.0, 32211.838940805144, 32369.0, 33622.83188584042, 34702.30595388129, 38772.0, 45999.0, 47324.7633761829, 47590.524094758606, 48058.75970620124, 49130.263046053624, 14111.0, 14161.787573186617, 14269.71460570762, 14387.352569134624, 14582.927085364505, 17043.914780426017, 17480.388186413413, 17497.83799365846, 17635.29458821633, 17784.02983817828, 14592.708145837236, 14761.704765904837, 14925.552233433014, 15077.0, 15545.0, 14094.36575354091, 14673.339699713752, 14701.264936753334, 14775.852241477447, 15284.77072843886, 11545.595904143314, 11887.76224475523, 14683.55949321522, 14696.77954830657, 14946.701065978403, 10730.570777168827, 11387.829182562102, 13321.400536975665, 13422.798658020332, 13866.168029917833, 9356.95321523388, 9890.752731181778, 14165.0, 14271.714565708835, 14424.495142669955], "unit": "ms", "name": "jquery.html", "value": 8275.298164464019}, {"lowerIsBetter": false, "replicates": [1397.2873834344482, 1589.3404237241543, 1654.8262432444592, 1660.5184496496017, 1675.103819456591, 5852.79515216967, 6524.249711283204, 6643.036759669845, 6661.733530658767, 6663.233728121261, 6623.56946798459, 6818.863622727543, 6818.931810681892, 6818.965905170479, 6819.931800681991, 1980.6038792241536, 2011.0749055434444, 2017.2334512885084, 2018.3440381875876, 2018.8788672679614, 1994.6309932662505, 2000.2399088346408, 2014.21445636202, 2059.938201853939, 2067.9483012924647, 1992.442116207457, 2015.2039944222024, 2036.3381900882198, 2036.9388918332475, 2041.040710865898, 1940.1269428757046, 1983.553700417409, 1983.9206431742714, 1984.8114429129282, 1985.8411327093943, 1984.8213660770455, 1986.2055177928798, 2010.145688082559, 2012.5471768852037, 2012.7685316188679, 5701.059325211335, 5835.328937172237, 6730.966345168292, 6825.078614387044, 6834.829129271759, 3550.1834578046937, 3603.0812142903656, 3819.1216020315483, 3946.4080387941754, 3959.4852669153115, 2628.2246737212377, 2649.0595838477448, 2681.034827462112, 2684.221575743032, 2690.6771187457434, 850.0819115355401, 852.2202185000717, 864.2783275964578, 873.2882700598991, 875.6891303587262, 8965.686200982935, 9001.909980900173, 9048.366614337, 9054.0, 9070.092990700878, 3718.4980027695915, 3724.7951362675312, 3769.6230376962085, 3772.2078363543415, 3826.5025546678753, 7896.32881205104, 7905.0, 7905.249001344863, 7905.486143400661, 7912.525248485109, 4134.028503301722, 4156.418101465797, 4159.334506479009, 4160.54234034256, 4165.375193720905, 3746.8126593670754, 3749.2688925659236, 3766.5291838520184, 3772.43413487979, 3774.358359078963, 3125.3749250150063, 3126.343467871772, 3142.7328677062706, 3166.509191075387, 3167.3665266946705, 1007.9546420411099, 1010.1968934696934, 1013.4679293371039, 1013.6046941692746, 1021.4126877045728, 1124.7581769919507, 1132.909367250618, 1145.570411095839, 1150.9597164099216, 1153.5789436855655, 6148.78479253224, 6170.321264660884, 6183.165272688219, 6215.533834962396, 6224.190855188796, 437.5864807756639, 438.2702799838297, 439.916415880988, 439.9890002749893, 442.0650324563525, 4355.673324500675, 4955.876103097379, 5017.648764586517, 5034.496550344937, 5041.924371134436, 7383.593902335423, 8013.078495972921, 8035.799105022421, 8058.919410805935, 8073.475224110414, 7995.720149794729, 8025.9197408025175, 8031.0, 8046.0, 8057.556834374166, 6229.314775374796, 6368.044793280952, 6395.904061439082, 6406.743730250831, 6447.9355206447335, 6237.5321850860455, 6248.593841400295, 6248.9062664059165, 6255.874882502416, 6260.40526150015, 7107.253738357605, 7278.871774874903, 7338.926610733824, 7340.26597340283, 7349.081364829396, 7034.788956331318, 7122.7507037253445, 7153.570785752871, 7228.530145540733, 7426.777196684108, 5980.730867111078, 5987.0, 6006.9699651503215, 6076.240469941257, 6079.0, 6439.710213040518, 6481.254655714653, 6497.18785151856, 6503.414692677682, 6513.185851768529, 6178.66017369049, 6180.876382472416, 6215.036669316263, 6264.436200741955, 6311.2426508819235, 6042.244719410074, 6101.328853826164, 6112.572119951561, 6177.783777567944, 6245.937540624535, 6126.846828829315, 6169.444749972345, 6203.069539569101, 6211.409916057967, 6218.284897236876, 5693.28833895763, 5720.885582288414, 5731.083026715705, 5731.283589551306, 5735.598508104559, 5837.474627283565, 5861.296644402699, 5907.17299578068, 5907.202527658883, 5909.23179986599], "unit": "ms", "name": "mootools.html", "value": 3837.713045796136}, {"lowerIsBetter": false, "replicates": [286.7748817178515, 290.1744536792825, 295.4106557417951, 296.829323139195, 296.9732724054837, 5193.740312984345, 5261.026710058637, 5264.842054738364, 5315.521603055724, 5406.270153529283, 5011.273365362021, 5107.668001579895, 5179.792808287673, 5257.1851363038695, 5289.206619007151, 4110.691698122653, 4120.484939382577, 4121.484814398193, 4128.422020917074, 4137.338025915854, 3875.0893540018074, 4121.969507623095, 4123.628873401393, 4124.422580838685, 4130.401091841682, 3910.9804450977704, 3933.645971862532, 3947.3092208863477, 3951.9209615807667, 3974.503187101612, 3961.227560625679, 3963.1479231965122, 3973.2252210818756, 3977.5624681285035, 4019.5176578810438, 3462.601800792916, 3490.808005559719, 3492.650734926487, 3501.7373696972827, 3502.439609662442, 5068.594512438996, 5081.034603425337, 5082.1360368737405, 5085.338905942241, 5093.2105523643895, 4485.080558485535, 4591.104734576759, 4592.678512504126, 4593.793279302439, 4606.493285738566, 5523.751431185607, 5529.060059789846, 5537.473939975695, 5538.086215774392, 5542.722863856791, 3816.8282427290837, 3821.5032045833864, 3825.005498570392, 3826.0626146594263, 3826.789526576037, 5816.912746308766, 5818.4763371296785, 5820.7962721304975, 5823.38854420284, 5825.970870145665, 3897.512810898638, 3920.9019774505864, 3960.742551734186, 4035.1526179502634, 4044.3326851069246, 4099.446574712376, 4140.565240649688, 4144.046869220097, 4144.212599606065, 4151.315033019579, 4698.271767875985, 4701.247800351927, 4702.95297047032, 4706.623470122382, 4708.246680531099, 5524.944750552523, 5564.387917329091, 5569.081101618269, 5570.888582228333, 5576.776928922879, 1424.9928750356182, 1442.5528086293282, 1475.0485936570851, 1475.3213521779887, 1475.6605980624518, 962.7929995051097, 1009.9293049486465, 1021.0, 1021.7649940513724, 1031.2677998621064, 4846.5638092571835, 4877.5366340197625, 4905.754712264373, 4915.311856340115, 4920.138975679241, 5709.143628455765, 5734.05388110957, 5739.885202295931, 5741.024025915604, 5746.051901436216, 4770.141374552614, 4894.119058569491, 4904.2643603459055, 4907.411110666671, 4916.582090522345, 3048.131282584497, 3099.4575949208797, 3103.7672174586546, 3114.5172498262805, 3118.454270502653, 5462.180672899018, 5510.779568817283, 5520.723963801794, 5522.447755224445, 5525.392206857243, 5994.970025149846, 5996.280446346466, 6000.519958403317, 6002.579819412599, 6008.6394816310285, 5348.946510534923, 5503.752331145108, 5531.25328080712, 5543.501084902378, 5550.0, 5851.853703657443, 5858.531317494505, 5862.208601838697, 5862.648241105377, 5865.618734782225, 5708.971455142698, 5718.0, 5720.513756330592, 5724.656520608777, 5727.367700205422, 5320.627556071038, 5532.695701736282, 5536.058869992192, 5536.7785288588, 5545.944540554543, 3928.4107383892647, 3962.385830196324, 3967.0, 3968.0, 3969.6824254060184, 5827.504662103769, 5829.504492118048, 5839.065749480063, 5841.591088623755, 5842.2405087338375, 5593.356763972195, 5620.156976453564, 5620.156976453564, 5627.127795191752, 5629.662220266797, 5440.347158341025, 5612.270404847343, 5616.1014237721765, 5624.437556244343, 5629.521490673339, 5505.642133261325, 5507.449255074461, 5511.834644960658, 5513.448655134454, 5514.255575497256, 5659.207710920557, 5665.32872802516, 5711.200431939615, 5729.570282228766, 5730.398308177748, 5382.461753824587, 5507.256520369699, 5508.944910550843, 5511.53151982086, 5515.09001014828], "unit": "ms", "name": "prototype.html", "value": 4183.500052654027}, {"lowerIsBetter": false, "replicates": [759.6163937211708, 762.218725806049, 767.2251026463274, 768.4927947554613, 792.3779832831221, 11616.825747613782, 11889.108316876236, 13269.336533173351, 13476.326183690826, 13503.324833758323, 12531.812022819666, 12560.0, 12574.994000479963, 12587.685307867308, 12589.0, 597.0834768630153, 605.3069235725092, 766.9961650191741, 783.5298820707559, 785.8192615698392, 762.92752188542, 770.0412985832646, 776.409928454376, 776.6970881356276, 776.8601651702692, 805.1706742055692, 813.3330668851544, 813.3980854167903, 813.9552324622143, 814.5031530766228, 621.5586933277378, 628.9559730818798, 756.08136114621, 801.4990630855657, 809.7449303469418, 595.1548800703013, 596.0493013643232, 596.4125336543501, 596.686739461786, 596.7911231069135, 12273.570425035081, 12576.056795740265, 12578.81131783024, 12582.937085314516, 12593.811092833615, 10880.945595271973, 10901.618443354444, 11087.55649774008, 11411.617707819965, 11464.0, 9311.953440232823, 9399.812003759955, 9448.149666529976, 9762.755931101708, 9772.609095636166, 3071.585335979659, 3137.607799025122, 3171.6352619448826, 3190.3778763141195, 3194.8402579871145, 43665.34501982473, 44101.33847992283, 44103.77948110271, 44143.89640258987, 44236.77881610571, 9076.954615226881, 9366.157045865768, 9391.248700103975, 9438.622455101719, 9452.905470945203, 15943.0, 16121.758173627404, 16125.113118778345, 16176.595585110232, 16204.189790510427, 6402.8719425611225, 6424.550281480251, 6444.8388790280615, 6496.22045354551, 6618.404343609098, 3487.75585709003, 3498.6676265754713, 3500.789952602852, 3520.2255503789124, 3526.7002304804378, 2610.2299821552688, 2611.4646497467975, 2630.0, 2631.302704783234, 2637.353848307139, 474.7341488766302, 477.0578108236275, 483.3474809007882, 489.06344350568975, 489.37360178970977, 446.698478526993, 451.9593236608721, 458.15927772537765, 469.9342092107108, 469.9835505757282, 7525.4355923305975, 7678.654460549289, 7878.724244651525, 8012.074083699062, 8029.437939344307, 454.2799662534853, 487.98292059777737, 578.7251055748486, 598.509222437597, 604.247711599062, 3630.3465874543012, 3791.8862434127022, 3798.9620103798607, 3864.091938394475, 3865.420186971977, 52990.0, 53799.0, 54023.0, 54099.72950135224, 54129.45870541244, 44822.77588612101, 45188.0, 45239.77380113078, 45411.0, 46319.0, 41622.79188604037, 41887.162256754695, 42059.579404205564, 42256.366154507705, 42323.57676423196, 7329.340359367682, 7377.741779037708, 7404.851902962018, 7428.182899881117, 7526.435517336112, 32329.191770205933, 32405.51391729173, 32421.35157296888, 32778.83610581932, 32830.507542387364, 40500.79749601351, 42667.0, 42973.140537188454, 43266.56733432751, 43449.0, 9411.43531388119, 10026.097651211427, 10036.548355323883, 10096.949515252376, 10136.290459667753, 11415.771684566429, 11544.249623774427, 11720.238184517979, 11779.705507362041, 12105.33420661872, 10660.733481663021, 10800.675979720621, 10946.45267736594, 11222.270552414067, 11244.156688248251, 10647.627333043307, 10764.246502745045, 10890.346579205274, 11167.776644467227, 11243.718907027389, 10819.945900270763, 11031.117510598971, 11038.0, 11265.211435199457, 11289.71775705614, 8820.470771753715, 8998.867282426048, 9006.36955413141, 9067.727968160965, 9095.636174552943, 8710.21608055278, 8997.865032024656, 9305.302102342215, 9486.667966621135, 9508.77924346625], "unit": "ms", "name": "yui.html", "value": 5726.674739842417}], "name": "dromaeo_css", "value": 6247.900785463014}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 112.0, 112.0, 113.0, 102.0, 111.0, 112.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 150.0, 161.0, 130.0, 156.0, 155.0, 130.0, 166.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 159.0, 161.0, 160.0, 159.0, 161.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 87.0, 103.0, 72.0, 72.0, 72.0, 107.0, 86.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 126.0, 93.0, 94.0, 94.0, 127.0, 94.0, 93.0, 122.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 71.0, 71.0, 71.0, 70.0, 79.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 85.0, 84.0, 90.0, 83.0, 83.0, 83.0, 86.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [120.0, 122.0, 129.0, 123.0, 120.0, 120.0, 132.0, 123.0, 119.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [147.0, 144.0, 146.0, 147.0, 149.0, 147.0, 148.0, 147.0, 159.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 67.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1516.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.61775422325275], "unit": "score", "name": "Richards", "value": 213.15347599999996}, {"lowerIsBetter": false, "replicates": [191.131498470948], "unit": "score", "name": "DeltaBlue", "value": 345.9293760000001}, {"lowerIsBetter": false, "replicates": [277.39251040221916], "unit": "score", "name": "Encrypt", "value": 959.5825049999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [602.4096385542168], "unit": "score", "name": "Splay", "value": 135.27506}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19835.231493277097}]} 09:58:54 INFO - RETURN: dromaeo_css: 6247.90 09:58:54 INFO - RETURN: kraken: 1516.80 09:58:54 INFO - RETURN: v8_7: 19835.23 09:58:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19835.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1516.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6247.90"}}} 09:58:54 INFO - Return code: 0 09:58:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:58:54 INFO - # TBPL SUCCESS # 09:58:54 INFO - Running post-action listener: _resource_record_post_action 09:58:54 INFO - Running post-run listener: _resource_record_post_run 09:58:56 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 630784; Write bytes: 269647872; Read time: 348; Write time: 376188 09:58:56 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 2301952; Read time: 0; Write time: 140 09:58:56 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 630784; Write bytes: 267345920; Read time: 348; Write time: 376048 09:58:56 INFO - Running post-run listener: _upload_blobber_files 09:58:56 INFO - Blob upload gear active. 09:58:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:58:56 INFO - Copying logs to upload dir... 09:58:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.080908 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-26 09:58:56.137930) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:58:56.141849) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009851 build_url: 'https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:58:56.193453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:58:56.193770) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1448559459.343949-728029219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:58:56.243118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 09:58:56.243436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 09:58:56.243731) ========= ========= Total master_lag: 0.21 =========