builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1449146412.3 results: success (0) buildid: 20151203030926 builduid: f91e78c5d05842f09b4cd5f521e97225 revision: 68a90b9e9293b100b177e781fb3bf83773af9f92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.297507) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.298554) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.299281) ========= 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=820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006109 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.327357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.327981) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.342627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.342968) ========= 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=820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.392584) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.392899) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.393338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.393658) ========= 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=820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 04:40:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2015-12-03 04:40:12 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117305 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.524270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.524668) ========= 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=820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021825 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.577902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:12.578776) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 68a90b9e9293b100b177e781fb3bf83773af9f92 --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 68a90b9e9293b100b177e781fb3bf83773af9f92 --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=820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 04:40:12,718 truncating revision to first 12 chars 2015-12-03 04:40:12,718 Setting DEBUG logging. 2015-12-03 04:40:12,718 attempt 1/10 2015-12-03 04:40:12,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/68a90b9e9293?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 04:40:12,973 unpacking tar archive at: fx-team-68a90b9e9293/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:13.147205) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:13.147581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:13.158669) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:13.158977) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 04:40:13.159420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-03 04:40:13.159736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:40:13 INFO - MultiFileLogger online at 20151203 04:40:13 in /builds/slave/test 04:40:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:40:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:13 INFO - {'append_to_log': False, 04:40:13 INFO - 'base_work_dir': '/builds/slave/test', 04:40:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:40:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:13 INFO - 'branch': 'Fx-Team-Non-PGO', 04:40:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:13 INFO - 'config_files': ('talos/linux_config.py',), 04:40:13 INFO - 'default_actions': ('clobber', 04:40:13 INFO - 'read-buildbot-config', 04:40:13 INFO - 'download-and-extract', 04:40:13 INFO - 'populate-webroot', 04:40:13 INFO - 'create-virtualenv', 04:40:13 INFO - 'install', 04:40:13 INFO - 'run-tests'), 04:40:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:13 INFO - 'download_minidump_stackwalk': True, 04:40:13 INFO - 'download_symbols': 'ondemand', 04:40:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:13 INFO - 'installer_path': 'installer.exe', 04:40:13 INFO - 'log_level': 'info', 04:40:13 INFO - 'log_name': 'talos', 04:40:13 INFO - 'log_to_console': True, 04:40:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:40:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:40:13 INFO - 'opt_config_files': (), 04:40:13 INFO - 'pip_index': False, 04:40:13 INFO - 'sps_profile': False, 04:40:13 INFO - 'sps_profile_interval': 0, 04:40:13 INFO - 'suite': 'dromaeojs-e10s', 04:40:13 INFO - 'system_bits': '64', 04:40:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:13 INFO - 'title': 'talos-linux64-ix-055', 04:40:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:13 INFO - 'use_talos_json': True, 04:40:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:13 INFO - 'work_dir': 'build'} 04:40:13 INFO - ##### 04:40:13 INFO - ##### Running clobber step. 04:40:13 INFO - ##### 04:40:13 INFO - Running pre-action listener: _resource_record_pre_action 04:40:13 INFO - Running main action method: clobber 04:40:13 INFO - rmtree: /builds/slave/test/build 04:40:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:13 INFO - Running post-action listener: _resource_record_post_action 04:40:13 INFO - ##### 04:40:13 INFO - ##### Running read-buildbot-config step. 04:40:13 INFO - ##### 04:40:13 INFO - Running pre-action listener: _resource_record_pre_action 04:40:13 INFO - Running main action method: read_buildbot_config 04:40:13 INFO - Using buildbot properties: 04:40:13 INFO - { 04:40:13 INFO - "properties": { 04:40:13 INFO - "buildnumber": 511, 04:40:13 INFO - "product": "firefox", 04:40:13 INFO - "script_repo_revision": "production", 04:40:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:40:13 INFO - "repository": "", 04:40:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:40:13 INFO - "buildid": "20151203030926", 04:40:13 INFO - "slavename": "talos-linux64-ix-055", 04:40:13 INFO - "pgo_build": "False", 04:40:13 INFO - "basedir": "/builds/slave/test", 04:40:13 INFO - "project": "", 04:40:13 INFO - "platform": "ubuntu64_hw", 04:40:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:40:13 INFO - "slavebuilddir": "test", 04:40:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:40:13 INFO - "branch": "fx-team", 04:40:13 INFO - "repo_path": "integration/fx-team", 04:40:13 INFO - "stage_platform": "linux64", 04:40:13 INFO - "builduid": "f91e78c5d05842f09b4cd5f521e97225", 04:40:13 INFO - "revision": "68a90b9e9293b100b177e781fb3bf83773af9f92" 04:40:13 INFO - }, 04:40:13 INFO - "sourcestamp": { 04:40:13 INFO - "repository": "", 04:40:13 INFO - "hasPatch": false, 04:40:13 INFO - "project": "", 04:40:13 INFO - "branch": "fx-team-linux64-talos", 04:40:13 INFO - "changes": [ 04:40:13 INFO - { 04:40:13 INFO - "category": null, 04:40:13 INFO - "files": [ 04:40:13 INFO - { 04:40:13 INFO - "url": null, 04:40:13 INFO - "name": "https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:40:13 INFO - } 04:40:13 INFO - ], 04:40:13 INFO - "repository": "", 04:40:13 INFO - "rev": "68a90b9e9293b100b177e781fb3bf83773af9f92", 04:40:13 INFO - "who": "cbook@mozilla.com", 04:40:13 INFO - "when": 1449146022, 04:40:13 INFO - "number": 6738851, 04:40:13 INFO - "comments": "Merge mozilla-central to fx-team", 04:40:13 INFO - "project": "", 04:40:13 INFO - "at": "Thu 03 Dec 2015 04:33:42", 04:40:13 INFO - "branch": "fx-team-linux64-talos", 04:40:13 INFO - "revlink": "", 04:40:13 INFO - "properties": [ 04:40:13 INFO - [ 04:40:13 INFO - "buildid", 04:40:13 INFO - "20151203030926", 04:40:13 INFO - "Change" 04:40:13 INFO - ], 04:40:13 INFO - [ 04:40:13 INFO - "builduid", 04:40:13 INFO - "f91e78c5d05842f09b4cd5f521e97225", 04:40:13 INFO - "Change" 04:40:13 INFO - ], 04:40:13 INFO - [ 04:40:13 INFO - "pgo_build", 04:40:13 INFO - "False", 04:40:13 INFO - "Change" 04:40:13 INFO - ] 04:40:13 INFO - ], 04:40:13 INFO - "revision": "68a90b9e9293b100b177e781fb3bf83773af9f92" 04:40:13 INFO - } 04:40:13 INFO - ], 04:40:13 INFO - "revision": "68a90b9e9293b100b177e781fb3bf83773af9f92" 04:40:13 INFO - } 04:40:13 INFO - } 04:40:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:40:13 INFO - Running post-action listener: _resource_record_post_action 04:40:13 INFO - ##### 04:40:13 INFO - ##### Running download-and-extract step. 04:40:13 INFO - ##### 04:40:13 INFO - Running pre-action listener: _resource_record_pre_action 04:40:13 INFO - Running main action method: download_and_extract 04:40:13 INFO - mkdir: /builds/slave/test/build/tests 04:40: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')]} 04:40:13 INFO - https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:40:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/test_packages.json 04:40:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/test_packages.json 04:40:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:40:14 INFO - Downloaded 1302 bytes. 04:40:14 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:40:14 INFO - Using the following test package requirements: 04:40:14 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:14 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:40:14 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:14 INFO - u'jsshell-linux-x86_64.zip'], 04:40:14 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:40:14 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:14 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:40:14 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:40:14 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:40:14 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:14 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:40:14 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:14 INFO - https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:40:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:40:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/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 04:40:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/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 04:40:16 INFO - Downloaded 21788755 bytes. 04:40:16 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 04:40:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:40:16 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 04:40:17 INFO - Return code: 0 04:40:17 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 04:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:17 INFO - https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:40:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:40:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/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 04:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/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 04:40:18 INFO - Downloaded 21788755 bytes. 04:40:18 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 04:40:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:40:18 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 04:40:19 INFO - Return code: 0 04:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:19 INFO - https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:40:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/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 04:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/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 04:40:20 INFO - Downloaded 11132001 bytes. 04:40:20 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 04:40:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:20 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 04:40:20 INFO - Return code: 0 04:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:20 INFO - https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:40:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:40:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:40:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/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 04:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mnCPUuZqSpqrW8cSN0zsag/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 04:40:22 INFO - Downloaded 57674940 bytes. 04:40:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:40:22 INFO - mkdir: /builds/slave/test/properties 04:40:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:40:22 INFO - Writing to file /builds/slave/test/properties/build_url 04:40:22 INFO - Contents: 04:40:22 INFO - build_url:https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:40:22 INFO - Running post-action listener: _resource_record_post_action 04:40:22 INFO - Running post-action listener: set_extra_try_arguments 04:40:22 INFO - ##### 04:40:22 INFO - ##### Running populate-webroot step. 04:40:22 INFO - ##### 04:40:22 INFO - Running pre-action listener: _resource_record_pre_action 04:40:22 INFO - Running main action method: populate_webroot 04:40:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:40:22 INFO - '../fennec_ids.txt'], 04:40:22 INFO - 'tests': ['tcheck2']}, 04:40:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:22 INFO - '--tppagecycles', 04:40:22 INFO - '7'], 04:40:22 INFO - 'tests': ['tsvgm']}}, 04:40:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:40:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:22 INFO - 'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:22 INFO - 'tests': ['damp', 'tps']}, 04:40:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:22 INFO - 'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['damp', 'tps']}, 04:40:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:40:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:22 INFO - 'other': {'tests': ['a11yr', 04:40:22 INFO - 'ts_paint', 04:40:22 INFO - 'tpaint', 04:40:22 INFO - 'sessionrestore', 04:40:22 INFO - 'sessionrestore_no_auto_restore']}, 04:40:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['a11yr', 04:40:22 INFO - 'ts_paint', 04:40:22 INFO - 'tpaint', 04:40:22 INFO - 'sessionrestore', 04:40:22 INFO - 'sessionrestore_no_auto_restore']}, 04:40:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['a11yr', 04:40:22 INFO - 'ts_paint', 04:40:22 INFO - 'tpaint', 04:40:22 INFO - 'sessionrestore', 04:40:22 INFO - 'sessionrestore_no_auto_restore']}, 04:40:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['a11yr', 04:40:22 INFO - 'ts_paint', 04:40:22 INFO - 'tpaint', 04:40:22 INFO - 'sessionrestore', 04:40:22 INFO - 'sessionrestore_no_auto_restore']}, 04:40:22 INFO - 'other_l64': {'tests': ['a11yr', 04:40:22 INFO - 'ts_paint', 04:40:22 INFO - 'tpaint', 04:40:22 INFO - 'sessionrestore', 04:40:22 INFO - 'sessionrestore_no_auto_restore']}, 04:40:22 INFO - 'other_nol64': {'tests': ['a11yr', 04:40:22 INFO - 'ts_paint', 04:40:22 INFO - 'tpaint', 04:40:22 INFO - 'sessionrestore', 04:40:22 INFO - 'sessionrestore_no_auto_restore']}, 04:40:22 INFO - 'svgr': {'tests': ['tsvgx', 04:40:22 INFO - 'tsvgr_opacity', 04:40:22 INFO - 'tart', 04:40:22 INFO - 'tscrollx', 04:40:22 INFO - 'cart']}, 04:40:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['tsvgx', 04:40:22 INFO - 'tsvgr_opacity', 04:40:22 INFO - 'tart', 04:40:22 INFO - 'tscrollx', 04:40:22 INFO - 'cart']}, 04:40:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:22 INFO - 'tests': ['tp5o']}, 04:40:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:22 INFO - 'talos_options': ['--e10s'], 04:40:22 INFO - 'tests': ['tp5o']}, 04:40:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:22 INFO - 'talos_options': ['--xperf_path', 04:40:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:22 INFO - 'tests': ['tp5n']}, 04:40:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:22 INFO - 'talos_options': ['--e10s', 04:40:22 INFO - '--xperf_path', 04:40:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:22 INFO - 'tests': ['tp5n']}}, 04:40:22 INFO - 'talos.zip': {'path': '', 04:40:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:22 INFO - Running post-action listener: _resource_record_post_action 04:40:22 INFO - ##### 04:40:22 INFO - ##### Running create-virtualenv step. 04:40:22 INFO - ##### 04:40:22 INFO - Running pre-action listener: _resource_record_pre_action 04:40:22 INFO - Running main action method: create_virtualenv 04:40:22 INFO - Creating virtualenv /builds/slave/test/build/venv 04:40:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:40:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:40:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:22 INFO - Using real prefix '/usr' 04:40:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:40:23 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:24 INFO - Installing pip.................done. 04:40:24 INFO - Return code: 0 04:40:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:40:24 INFO - Using env: {'DISPLAY': ':0', 04:40:24 INFO - 'HOME': '/home/cltbld', 04:40:24 INFO - 'LANG': 'en_US.UTF-8', 04:40:24 INFO - 'LANGUAGE': 'en_US:en', 04:40:24 INFO - 'LOGNAME': 'cltbld', 04:40:24 INFO - 'MAIL': '/var/mail/cltbld', 04:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:25 INFO - 'MOZ_NO_REMOTE': '1', 04:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:25 INFO - 'NO_EM_RESTART': '1', 04:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:25 INFO - 'PWD': '/builds/slave/test', 04:40:25 INFO - 'SHELL': '/bin/bash', 04:40:25 INFO - 'SHLVL': '1', 04:40:25 INFO - 'TERM': 'linux', 04:40:25 INFO - 'TMOUT': '86400', 04:40:25 INFO - 'USER': 'cltbld', 04:40:25 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:25 INFO - '_': '/tools/buildbot/bin/python'} 04:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:40:25 INFO - Cleaning up... 04:40:25 INFO - Return code: 0 04:40:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:40:25 INFO - Using env: {'DISPLAY': ':0', 04:40:25 INFO - 'HOME': '/home/cltbld', 04:40:25 INFO - 'LANG': 'en_US.UTF-8', 04:40:25 INFO - 'LANGUAGE': 'en_US:en', 04:40:25 INFO - 'LOGNAME': 'cltbld', 04:40:25 INFO - 'MAIL': '/var/mail/cltbld', 04:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:25 INFO - 'MOZ_NO_REMOTE': '1', 04:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:25 INFO - 'NO_EM_RESTART': '1', 04:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:25 INFO - 'PWD': '/builds/slave/test', 04:40:25 INFO - 'SHELL': '/bin/bash', 04:40:25 INFO - 'SHLVL': '1', 04:40:25 INFO - 'TERM': 'linux', 04:40:25 INFO - 'TMOUT': '86400', 04:40:25 INFO - 'USER': 'cltbld', 04:40:25 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:25 INFO - '_': '/tools/buildbot/bin/python'} 04:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:25 INFO - Downloading/unpacking psutil>=0.7.1 04:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:27 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:40:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:27 INFO - Installing collected packages: psutil 04:40:27 INFO - Running setup.py install for psutil 04:40:27 INFO - building 'psutil._psutil_linux' extension 04:40:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:40:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:40:27 INFO - building 'psutil._psutil_posix' extension 04:40:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:40:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:40:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:27 INFO - Successfully installed psutil 04:40:27 INFO - Cleaning up... 04:40:27 INFO - Return code: 0 04:40:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:40:27 INFO - Using env: {'DISPLAY': ':0', 04:40:27 INFO - 'HOME': '/home/cltbld', 04:40:27 INFO - 'LANG': 'en_US.UTF-8', 04:40:27 INFO - 'LANGUAGE': 'en_US:en', 04:40:27 INFO - 'LOGNAME': 'cltbld', 04:40:27 INFO - 'MAIL': '/var/mail/cltbld', 04:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:27 INFO - 'MOZ_NO_REMOTE': '1', 04:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:27 INFO - 'NO_EM_RESTART': '1', 04:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:27 INFO - 'PWD': '/builds/slave/test', 04:40:27 INFO - 'SHELL': '/bin/bash', 04:40:27 INFO - 'SHLVL': '1', 04:40:27 INFO - 'TERM': 'linux', 04:40:27 INFO - 'TMOUT': '86400', 04:40:27 INFO - 'USER': 'cltbld', 04:40:27 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:27 INFO - '_': '/tools/buildbot/bin/python'} 04:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:40:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:40:29 INFO - Installing collected packages: mozsystemmonitor 04:40:29 INFO - Running setup.py install for mozsystemmonitor 04:40:29 INFO - Successfully installed mozsystemmonitor 04:40:29 INFO - Cleaning up... 04:40:29 INFO - Return code: 0 04:40:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:29 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 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:40:29 INFO - Using env: {'DISPLAY': ':0', 04:40:29 INFO - 'HOME': '/home/cltbld', 04:40:29 INFO - 'LANG': 'en_US.UTF-8', 04:40:29 INFO - 'LANGUAGE': 'en_US:en', 04:40:29 INFO - 'LOGNAME': 'cltbld', 04:40:29 INFO - 'MAIL': '/var/mail/cltbld', 04:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:29 INFO - 'MOZ_NO_REMOTE': '1', 04:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:29 INFO - 'NO_EM_RESTART': '1', 04:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:29 INFO - 'PWD': '/builds/slave/test', 04:40:29 INFO - 'SHELL': '/bin/bash', 04:40:29 INFO - 'SHLVL': '1', 04:40:29 INFO - 'TERM': 'linux', 04:40:29 INFO - 'TMOUT': '86400', 04:40:29 INFO - 'USER': 'cltbld', 04:40:29 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:29 INFO - '_': '/tools/buildbot/bin/python'} 04:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:30 INFO - Downloading/unpacking blobuploader==1.2.4 04:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:31 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:40:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:32 INFO - Downloading docopt-0.6.1.tar.gz 04:40:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:32 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:32 INFO - Running setup.py install for blobuploader 04:40:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:40:32 INFO - Running setup.py install for requests 04:40:33 INFO - Running setup.py install for docopt 04:40:33 INFO - Successfully installed blobuploader requests docopt 04:40:33 INFO - Cleaning up... 04:40:33 INFO - Return code: 0 04:40:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:33 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 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:40:33 INFO - Using env: {'DISPLAY': ':0', 04:40:33 INFO - 'HOME': '/home/cltbld', 04:40:33 INFO - 'LANG': 'en_US.UTF-8', 04:40:33 INFO - 'LANGUAGE': 'en_US:en', 04:40:33 INFO - 'LOGNAME': 'cltbld', 04:40:33 INFO - 'MAIL': '/var/mail/cltbld', 04:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:33 INFO - 'MOZ_NO_REMOTE': '1', 04:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:33 INFO - 'NO_EM_RESTART': '1', 04:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:33 INFO - 'PWD': '/builds/slave/test', 04:40:33 INFO - 'SHELL': '/bin/bash', 04:40:33 INFO - 'SHLVL': '1', 04:40:33 INFO - 'TERM': 'linux', 04:40:33 INFO - 'TMOUT': '86400', 04:40:33 INFO - 'USER': 'cltbld', 04:40:33 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:33 INFO - '_': '/tools/buildbot/bin/python'} 04:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:33 INFO - Running setup.py (path:/tmp/pip-Y0Rz_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:33 INFO - Running setup.py (path:/tmp/pip-rsboHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:33 INFO - Running setup.py (path:/tmp/pip-9zVtHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:33 INFO - Running setup.py (path:/tmp/pip-AZCUcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:33 INFO - Running setup.py (path:/tmp/pip-BLkMNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:33 INFO - Running setup.py (path:/tmp/pip-oeAhlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:33 INFO - Running setup.py (path:/tmp/pip-OyTU96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:33 INFO - Running setup.py (path:/tmp/pip-32aOKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:34 INFO - Running setup.py (path:/tmp/pip-dZd5Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:34 INFO - Running setup.py (path:/tmp/pip-X5siHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:34 INFO - Running setup.py (path:/tmp/pip-FXoEV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:34 INFO - Running setup.py (path:/tmp/pip-5RqZYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:34 INFO - Running setup.py (path:/tmp/pip-1TDKIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:34 INFO - Running setup.py (path:/tmp/pip-UC2ZG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:34 INFO - Running setup.py (path:/tmp/pip-h52xUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:34 INFO - Running setup.py (path:/tmp/pip-_tODbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:34 INFO - Running setup.py (path:/tmp/pip-8DKsrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:34 INFO - Running setup.py install for manifestparser 04:40:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:40:34 INFO - Running setup.py install for mozcrash 04:40:34 INFO - Running setup.py install for mozdebug 04:40:34 INFO - Running setup.py install for mozdevice 04:40:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Running setup.py install for mozfile 04:40:35 INFO - Running setup.py install for mozhttpd 04:40:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Running setup.py install for mozinfo 04:40:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Running setup.py install for mozInstall 04:40:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Running setup.py install for mozleak 04:40:35 INFO - Running setup.py install for mozlog 04:40:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Running setup.py install for moznetwork 04:40:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Running setup.py install for mozprocess 04:40:35 INFO - Running setup.py install for mozprofile 04:40:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:40:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:40:36 INFO - Running setup.py install for mozrunner 04:40:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:40:36 INFO - Running setup.py install for mozscreenshot 04:40:36 INFO - Running setup.py install for moztest 04:40:36 INFO - Running setup.py install for mozversion 04:40:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:40:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:36 INFO - Cleaning up... 04:40:36 INFO - Return code: 0 04:40:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:36 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 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:40:36 INFO - Using env: {'DISPLAY': ':0', 04:40:36 INFO - 'HOME': '/home/cltbld', 04:40:36 INFO - 'LANG': 'en_US.UTF-8', 04:40:36 INFO - 'LANGUAGE': 'en_US:en', 04:40:36 INFO - 'LOGNAME': 'cltbld', 04:40:36 INFO - 'MAIL': '/var/mail/cltbld', 04:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:36 INFO - 'MOZ_NO_REMOTE': '1', 04:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:36 INFO - 'NO_EM_RESTART': '1', 04:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:36 INFO - 'PWD': '/builds/slave/test', 04:40:36 INFO - 'SHELL': '/bin/bash', 04:40:36 INFO - 'SHLVL': '1', 04:40:36 INFO - 'TERM': 'linux', 04:40:36 INFO - 'TMOUT': '86400', 04:40:36 INFO - 'USER': 'cltbld', 04:40:36 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:36 INFO - '_': '/tools/buildbot/bin/python'} 04:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:36 INFO - Running setup.py (path:/tmp/pip-hBisiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:36 INFO - Running setup.py (path:/tmp/pip-etOl_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:36 INFO - Running setup.py (path:/tmp/pip-v6nZOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:36 INFO - Running setup.py (path:/tmp/pip-OE2gpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:36 INFO - Running setup.py (path:/tmp/pip-17ZvvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:37 INFO - Running setup.py (path:/tmp/pip-WC3Io0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:37 INFO - Running setup.py (path:/tmp/pip-z1fad6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:37 INFO - Running setup.py (path:/tmp/pip-EPDiJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:37 INFO - Running setup.py (path:/tmp/pip-bUpx63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:37 INFO - Running setup.py (path:/tmp/pip-6pY31I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:37 INFO - Running setup.py (path:/tmp/pip-eATNKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:37 INFO - Running setup.py (path:/tmp/pip-CtU3QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:37 INFO - Running setup.py (path:/tmp/pip-JdPliI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:37 INFO - Running setup.py (path:/tmp/pip-ZfQgX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:37 INFO - Running setup.py (path:/tmp/pip-iM_PIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:37 INFO - Running setup.py (path:/tmp/pip-gIHIT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:37 INFO - Running setup.py (path:/tmp/pip-wt4AaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:39 INFO - Downloading blessings-1.5.1.tar.gz 04:40:39 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:40:39 INFO - Installing collected packages: blessings 04:40:39 INFO - Running setup.py install for blessings 04:40:39 INFO - Successfully installed blessings 04:40:39 INFO - Cleaning up... 04:40:39 INFO - Return code: 0 04:40:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:40 INFO - Reading from file tmpfile_stdout 04:40:40 INFO - Current package versions: 04:40:40 INFO - argparse == 1.2.1 04:40:40 INFO - blessings == 1.5.1 04:40:40 INFO - blobuploader == 1.2.4 04:40:40 INFO - docopt == 0.6.1 04:40:40 INFO - manifestparser == 1.1 04:40:40 INFO - mozInstall == 1.12 04:40:40 INFO - mozcrash == 0.16 04:40:40 INFO - mozdebug == 0.1 04:40:40 INFO - mozdevice == 0.47 04:40:40 INFO - mozfile == 1.2 04:40:40 INFO - mozhttpd == 0.7 04:40:40 INFO - mozinfo == 0.9 04:40:40 INFO - mozleak == 0.1 04:40:40 INFO - mozlog == 3.1 04:40:40 INFO - moznetwork == 0.27 04:40:40 INFO - mozprocess == 0.22 04:40:40 INFO - mozprofile == 0.27 04:40:40 INFO - mozrunner == 6.11 04:40:40 INFO - mozscreenshot == 0.1 04:40:40 INFO - mozsystemmonitor == 0.0 04:40:40 INFO - moztest == 0.7 04:40:40 INFO - mozversion == 1.4 04:40:40 INFO - psutil == 3.1.1 04:40:40 INFO - requests == 1.2.3 04:40:40 INFO - wsgiref == 0.1.2 04:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:40 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 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:40:40 INFO - Using env: {'DISPLAY': ':0', 04:40:40 INFO - 'HOME': '/home/cltbld', 04:40:40 INFO - 'LANG': 'en_US.UTF-8', 04:40:40 INFO - 'LANGUAGE': 'en_US:en', 04:40:40 INFO - 'LOGNAME': 'cltbld', 04:40:40 INFO - 'MAIL': '/var/mail/cltbld', 04:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:40 INFO - 'MOZ_NO_REMOTE': '1', 04:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:40 INFO - 'NO_EM_RESTART': '1', 04:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:40 INFO - 'PWD': '/builds/slave/test', 04:40:40 INFO - 'SHELL': '/bin/bash', 04:40:40 INFO - 'SHLVL': '1', 04:40:40 INFO - 'TERM': 'linux', 04:40:40 INFO - 'TMOUT': '86400', 04:40:40 INFO - 'USER': 'cltbld', 04:40:40 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:40 INFO - '_': '/tools/buildbot/bin/python'} 04:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:40:40 INFO - Cleaning up... 04:40:40 INFO - Return code: 0 04:40:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:40 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 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:40:40 INFO - Using env: {'DISPLAY': ':0', 04:40:40 INFO - 'HOME': '/home/cltbld', 04:40:40 INFO - 'LANG': 'en_US.UTF-8', 04:40:40 INFO - 'LANGUAGE': 'en_US:en', 04:40:40 INFO - 'LOGNAME': 'cltbld', 04:40:40 INFO - 'MAIL': '/var/mail/cltbld', 04:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:40 INFO - 'MOZ_NO_REMOTE': '1', 04:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:40 INFO - 'NO_EM_RESTART': '1', 04:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:40 INFO - 'PWD': '/builds/slave/test', 04:40:40 INFO - 'SHELL': '/bin/bash', 04:40:40 INFO - 'SHLVL': '1', 04:40:40 INFO - 'TERM': 'linux', 04:40:40 INFO - 'TMOUT': '86400', 04:40:40 INFO - 'USER': 'cltbld', 04:40:40 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:40 INFO - '_': '/tools/buildbot/bin/python'} 04:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:40 INFO - Downloading/unpacking jsonschema 04:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:40:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:40:42 INFO - Downloading/unpacking functools32 (from jsonschema) 04:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:40:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:40:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:40:42 INFO - warning: no files found matching '*.txt' 04:40:42 INFO - no previously-included directories found matching 'build' 04:40:42 INFO - no previously-included directories found matching 'dist' 04:40:42 INFO - no previously-included directories found matching '.git*' 04:40:42 INFO - Installing collected packages: jsonschema, functools32 04:40:42 INFO - Running setup.py install for functools32 04:40:42 INFO - warning: no files found matching '*.txt' 04:40:42 INFO - no previously-included directories found matching 'build' 04:40:42 INFO - no previously-included directories found matching 'dist' 04:40:42 INFO - no previously-included directories found matching '.git*' 04:40:42 INFO - Successfully installed jsonschema functools32 04:40:42 INFO - Cleaning up... 04:40:42 INFO - Return code: 0 04:40:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:42 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 0x7f6c526bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, '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': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:40:42 INFO - Using env: {'DISPLAY': ':0', 04:40:42 INFO - 'HOME': '/home/cltbld', 04:40:42 INFO - 'LANG': 'en_US.UTF-8', 04:40:42 INFO - 'LANGUAGE': 'en_US:en', 04:40:42 INFO - 'LOGNAME': 'cltbld', 04:40:42 INFO - 'MAIL': '/var/mail/cltbld', 04:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:42 INFO - 'MOZ_NO_REMOTE': '1', 04:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:42 INFO - 'NO_EM_RESTART': '1', 04:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:42 INFO - 'PWD': '/builds/slave/test', 04:40:42 INFO - 'SHELL': '/bin/bash', 04:40:42 INFO - 'SHLVL': '1', 04:40:42 INFO - 'TERM': 'linux', 04:40:42 INFO - 'TMOUT': '86400', 04:40:42 INFO - 'USER': 'cltbld', 04:40:42 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:42 INFO - '_': '/tools/buildbot/bin/python'} 04:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:42 INFO - Downloading/unpacking flake8 04:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:40:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:40:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:40:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:40:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:40:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:40:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:40:45 INFO - no previously-included directories found matching 'docs/_build' 04:40:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:40:45 INFO - Running setup.py install for pep8 04:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:40:45 INFO - no previously-included directories found matching 'docs/_build' 04:40:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:40:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:40:45 INFO - Cleaning up... 04:40:45 INFO - Return code: 0 04:40:45 INFO - Running post-action listener: _resource_record_post_action 04:40:45 INFO - Running post-action listener: _start_resource_monitoring 04:40:45 INFO - Starting resource monitoring. 04:40:45 INFO - ##### 04:40:45 INFO - ##### Running install step. 04:40:45 INFO - ##### 04:40:45 INFO - Running pre-action listener: _resource_record_pre_action 04:40:45 INFO - Running main action method: install 04:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:45 INFO - Reading from file tmpfile_stdout 04:40:45 INFO - Detecting whether we're running mozinstall >=1.0... 04:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:40:45 INFO - Reading from file tmpfile_stdout 04:40:45 INFO - Output received: 04:40:45 INFO - Usage: mozinstall [options] installer 04:40:45 INFO - Options: 04:40:45 INFO - -h, --help show this help message and exit 04:40:45 INFO - -d DEST, --destination=DEST 04:40:45 INFO - Directory to install application into. [default: 04:40:45 INFO - "/builds/slave/test"] 04:40:45 INFO - --app=APP Application being installed. [default: firefox] 04:40:45 INFO - mkdir: /builds/slave/test/build/application 04:40:45 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'] 04:40:45 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 04:41:00 INFO - Reading from file tmpfile_stdout 04:41:00 INFO - Output received: 04:41:00 INFO - /builds/slave/test/build/application/firefox/firefox 04:41:00 INFO - Running post-action listener: _resource_record_post_action 04:41:00 INFO - ##### 04:41:00 INFO - ##### Running run-tests step. 04:41:00 INFO - ##### 04:41:00 INFO - Running pre-action listener: _resource_record_pre_action 04:41:00 INFO - Running main action method: run_tests 04:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:41:00 INFO - Python 2.7.3 04:41:00 INFO - Return code: 0 04:41:00 INFO - grabbing minidump binary from tooltool 04:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:00 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 0x1ada0b0>, '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 0x1adafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adb440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:41:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:41:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:41:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:00 INFO - Return code: 0 04:41:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:41:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:41:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:41:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:41:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:41:01 INFO - Return code: 0 04:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test/build 04:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 04:41:01 INFO - Using env: {'DISPLAY': ':0', 04:41:01 INFO - 'HOME': '/home/cltbld', 04:41:01 INFO - 'LANG': 'en_US.UTF-8', 04:41:01 INFO - 'LANGUAGE': 'en_US:en', 04:41:01 INFO - 'LOGNAME': 'cltbld', 04:41:01 INFO - 'MAIL': '/var/mail/cltbld', 04:41:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:41:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:01 INFO - 'MOZ_NO_REMOTE': '1', 04:41:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:01 INFO - 'NO_EM_RESTART': '1', 04:41:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:01 INFO - 'PWD': '/builds/slave/test', 04:41:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:41:01 INFO - 'SHELL': '/bin/bash', 04:41:01 INFO - 'SHLVL': '1', 04:41:01 INFO - 'TERM': 'linux', 04:41:01 INFO - 'TMOUT': '86400', 04:41:01 INFO - 'USER': 'cltbld', 04:41:01 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683', 04:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:01 INFO - '_': '/tools/buildbot/bin/python'} 04:41:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 04:41:01 INFO - mozversion INFO | application_buildid: 20151203030926 04:41:01 INFO - mozversion INFO | application_changeset: 68a90b9e9293b100b177e781fb3bf83773af9f92 04:41:01 INFO - mozversion INFO | application_display_name: Nightly 04:41:01 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:01 INFO - mozversion INFO | application_name: Firefox 04:41:01 INFO - mozversion INFO | application_remotingname: firefox 04:41:01 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:41:01 INFO - mozversion INFO | application_vendor: Mozilla 04:41:01 INFO - mozversion INFO | application_version: 45.0a1 04:41:01 INFO - mozversion INFO | platform_buildid: 20151203030926 04:41:01 INFO - mozversion INFO | platform_changeset: 68a90b9e9293b100b177e781fb3bf83773af9f92 04:41:01 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:41:01 INFO - mozversion INFO | platform_version: 45.0a1 04:41:01 INFO - 2015-12-03 04:41:01,377 DEBUG : using testdate: 1449146461 04:41:01 INFO - 2015-12-03 04:41:01,377 DEBUG : actual date: 1449146461 04:41:01 INFO - 2015-12-03 04:41:01,388 INFO : starting webserver on 'localhost:51656' 04:41:01 INFO - 2015-12-03 04:41:01,389 INFO : Starting test suite talos-linux64-ix-055.e 04:41:01 INFO - 2015-12-03 04:41:01,389 INFO : Starting test dromaeo_css 04:41:01 INFO - 2015-12-03 04:41:01,389 DEBUG : operating with platform_type : linux_ 04:41:01 INFO - 2015-12-03 04:41:01,390 INFO : Initialising browser for dromaeo_css test... 04:41:01 INFO - 2015-12-03 04:41:01,403 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptICNCA/profile http://localhost:51656/getInfo.html 04:41:06 INFO - 2015-12-03 04:41:06,266 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:41:06 INFO - 2015-12-03 04:41:06,267 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:41:06 INFO - 2015-12-03 04:41:06,267 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:41:06 INFO - 2015-12-03 04:41:06,267 DEBUG : BROWSER_OUTPUT: __metrics 04:41:06 INFO - 2015-12-03 04:41:06,484 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:41:06 INFO - 2015-12-03 04:41:06,592 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:41:07 INFO - 2015-12-03 04:41:07,365 INFO : Browser initialized. 04:41:07 INFO - 2015-12-03 04:41:07,366 INFO : Running cycle 1/1 for dromaeo_css test... 04:41:07 INFO - 2015-12-03 04:41:07,366 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptICNCA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:41:19 INFO - 2015-12-03 04:41:19,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 143118336 04:41:19 INFO - 2015-12-03 04:41:19,424 DEBUG : BROWSER_OUTPUT: 04:42:09 INFO - 2015-12-03 04:42:09,057 DEBUG : BROWSER_OUTPUT: 1449146529054 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:44:20 INFO - 2015-12-03 04:44:20,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51656/tests/dromaeo/cssquery-ext.html) 04:44:21 INFO - 2015-12-03 04:44:21,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 147681280 04:44:21 INFO - 2015-12-03 04:44:21,798 DEBUG : BROWSER_OUTPUT: 04:47:23 INFO - 2015-12-03 04:47:23,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-ext.html (next: http://localhost:51656/tests/dromaeo/cssquery-jquery.html) 04:47:24 INFO - 2015-12-03 04:47:24,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 145104896 04:47:24 INFO - 2015-12-03 04:47:24,244 DEBUG : BROWSER_OUTPUT: 04:50:26 INFO - 2015-12-03 04:50:26,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51656/tests/dromaeo/cssquery-mootools.html) 04:50:26 INFO - 2015-12-03 04:50:26,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 145854464 04:50:26 INFO - 2015-12-03 04:50:26,642 DEBUG : BROWSER_OUTPUT: 04:53:28 INFO - 2015-12-03 04:53:28,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51656/tests/dromaeo/cssquery-prototype.html) 04:53:29 INFO - 2015-12-03 04:53:29,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 143532032 04:53:29 INFO - 2015-12-03 04:53:29,002 DEBUG : BROWSER_OUTPUT: 04:56:31 INFO - 2015-12-03 04:56:31,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51656/tests/dromaeo/cssquery-yui.html) 04:56:32 INFO - 2015-12-03 04:56:32,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 144814080 04:56:32 INFO - 2015-12-03 04:56:32,207 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-yui.html (next: http://localhost:51656/tests/dromaeo/cssquery-dojo.html) 04:59:34 INFO - 2015-12-03 04:59:34,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 147935232 04:59:34 INFO - 2015-12-03 04:59:34,770 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,770 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:59:34 INFO - 2015-12-03 04:59:34,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:59:34 INFO - 2015-12-03 04:59:34,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:59:34 INFO - 2015-12-03 04:59:34,772 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:59:34 INFO - 2015-12-03 04:59:34,773 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2648.4305874237043;2680.276325392143;2710.227585138236;2718.1573712149225;2727.9318017049563;4619.7921093550785;4697.248440249557;4769.1415545201935;4776.90446191076;4804.5195480451985;4717.9292310615365;4722.504137065602;4725.574698277154;4738.384010078685;4740.1704701677245;4290.635295999836;4380.759058251795;4414.668899832509;4466.12910482456;4475.261581838992;4456.621187199075;4473.9776301118445;4503.076869241798;4504.504504504502;4544.1593305238475;529.177582615014;4105.548389677133;4417.293233082723;4420.535843736426;4482.7310361378095;4404.273294906337;4435.068635586498;4443.066955939256;4443.933340999887;4494.595486406207;4426.579474949875;4434.312681534335;4441.911161776747;4450.421445212101;4479.507254202035;4519.502854685982;4580.679352445331;4673.112108699336;4696.178168820443;4741.241401375763;5111.4121875984365;5151.150060240056;5156.922646160273;5172.508611681884;5208.427073022002;5195.896082078338;5207.244949482341;5208.791648334062;5209.895802083937;5216.165413533817;4574.519675434065;4656.930146047812;4682.531746825291;4730.124926888537;4776.641751868624;5214.895702085937;5221.425643179247;5225.503577160163;5235.188545775335;5256;4767;4977.452480227172;5012.398512178562;5031.22016087507;5035.219540971156;5002.949970500321;5043.193089105799;5048.217526283432;5088.033273677989;5114.923276150861;5026.271190677331;5044.092063428545;5045.747712614355;5062.873428164252;5064.265681476165;4821.63837712173;4889.584385327287;4992.825251116266;5012.774425150877;5024.447310795809;4088.8160032798596;4173.645240154621;4174.248635245624;4195.601417865298;4200.684948628865;3734.402495600691;3756.5679946806467;3778.1688028633657;3812.180381217996;3828.464015037897;4254.7659878706345;4266.87199384019;4321.2005778931;4448.35498852671;4449.777511124431;5125.769340379692;5133.101707201225;5136.537711605899;5148.510891465305;5149.48505149482;4395.604395604347;4411.9558804411545;4416.447944006999;4429.446319210098;4445.266531022345;4297.72064815786;4375.671824613167;4400.471943366816;4478.955210447919;4518.570735780096;4814.350062741555;4845.248986407112;4845.466998630219;4853.102176097434;4874.073925954058;5104.055749686171;5109.182530795055;5116.641835071509;5120.513551212629;5162.251473536241;4705.647076469347;4716.6698331116495;4782.665213435026;4806.7836947338155;4823;5000.724960127082;5017.67385119966;5019.171836646912;5019.7741101651245;5068.189089745623;4867.269909513601;5126.487351264844;5126.564242039469;5130.384353877558;5177.352830896138;4879.097366986976;4894.681845680019;4924.778384972757;4960.057589058068;4996.875078123076;4948.109340318777;4966.255061740768;4969.701817890938;4972.428170760409;5010.749462526932;4605.907881842411;4769.880752981203;4861.708297502161;4892;4903.28902309156;4854.19905715553;4861.805527778849;4874.147024270809;4901.656884018084;4957.6281778866005;4839.564439200489;4856.028794241237;4860.392450943632;4861.4895435978715;4905.337779399878 04:59:34 INFO - 2015-12-03 04:59:34,775 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.5983012740447;575.8214953364458;580.9593328467008;581.7556626216989;587.66209429578;27067.323316917063;36565.268694626095;37006.4449033264;37022.25955480892;37044.62955370452;39416.80291598545;39837.203255934866;39879.60120398795;39925;39974.20051598974;7756.418268629847;7934.047914250298;7934.127246002964;7937.761867143966;7938.047434307891;7773.494722842997;7879.330256928168;7883.960580197091;7885.408594355417;7905.96047019767;7787.805304867367;7825.569593672346;7848.254415830487;7863.764087077397;7881.8029549261155;7817.257360550739;7848.45060845741;7884.408669349822;7889.723859664913;7904.841903161962;7674.079110506719;7780.183080776494;7802.609869506502;7831.099423566306;7839.451238413313;36997.26005479902;37106.81446592777;37458;37563;37616.24767504662;2744.862756862149;2852.7004664510137;2977.672456029835;3121.7658675599423;3553.7690050146916;27660.170194894185;28274.85862570674;28351.858240708872;30040.399192016255;30394.696053039628;3317.883874064396;3380.7633465657414;3390.2541440882965;3402.1494626343415;3481.56480439945;210839;213194.93402533044;214818;214889;214921;47876;48652.810623522026;51472.74263628658;52085.47914520882;55778.72110639502;55979;56491;56499.435005649415;56521.7173914136;56543.71728141333;13857.4457021718;13964.581062568139;14007.649808754863;14014.509492167928;14061;10170.389776613427;10284.537195826206;10294.3823370598;10310.07209351147;10314.329568578018;18584.81415185858;18765.155567999474;19158.425247242605;19360.32238871661;19362.031898405025;7669.501482403626;7759.534427934342;7773.650185741655;7811;7884.448088633855;836.4939211776909;841.6549214821894;868.0148031983744;919.7562645898843;1035.49260862177;25782.35544111375;26006.86996565005;26097.478050439266;26307.9476820925;26366.604500932503;960.3469640644429;974.546835721393;977.3793641037992;1000.9599616015278;1094.3980810554162;13255.801162982563;13444.126131801402;13476;13632.863671363159;13639.386227619583;255221;256043;256982;257034;257187;44019;44719.32921006188;44935.325970110476;44986.325205121946;45150.54849451463;1195.0738177912187;1197.6826141072622;1216.0271782573905;1219.3293688471306;1345.4281930179634;25066.99732010699;25212;25601.48797024012;25657.615135772605;25690.229293121236;39140.804295978334;39263.803680981415;39279.6072039276;39361.2127757449;39458.40812387759;241365;243213;243224;243592;244680;29046.7095329044;41898.58101418947;42188.15623687448;42518.78740606277;42682.5731742691;38741.418878717406;38870;38881;39145;39984.600153998086;33651;34127.82936085304;34397.484037738956;34713.65286347104;36889.26221475609;33714.83142584271;33809.32381352408;34233.65766342404;34280.65719342874;34469.138271543416;33630;34090.318193636485;34318.14204644904;34371;34418;30023.249418764706;30078.54882176813;30817.69182308148;30978.69021309848;31049.68950310468;24227.515449690556;24390.51218975646;24397.634035489125;24676.259712208663;24677.38306542279 04:59:34 INFO - 2015-12-03 04:59:34,778 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.34468441853966;336.3189541179112;340.61850727185526;344.3027868566154;344.311377245509;13276.203427794328;14984.925075374622;14991.250437478137;15956.521304360858;16628.085455299955;10459.163266938645;10673.78652426951;14757.48348807792;15775;15783.131927743969;4646.6282697384295;4775.3075804008395;6245.937540624604;6488.675566221694;6494.577852439576;6417.229932408118;6431.067495213191;6494.51291153163;6774.93225067748;6816.625085620289;3951.2097580483874;4096.201240758053;6564.146660934072;6791.083203767503;6802.285759995203;6701.061851340816;6727.360900714424;6750.594964302158;6757.695903684346;6759.797206083801;6316.589421687576;6450.709718062699;6470.2559205691;6472.061551075115;6482.805515834532;19388;19479.220831166735;19753.60492790136;19802.900985495125;20962.266320678704;1920.5294702797764;1926.7687877454655;1996.9201231950703;2015.445752418082;2071.326818783886;13082.86917130826;13403.195808251536;13651.317434128354;13846.792298115537;14288;1811.9547011324692;1834.4129878438905;2025.4733769220109;2051.6819892916624;2067.80355866194;50070;51145;52797.47202527964;53545.732271338784;53549;15411.306491207923;15479.22603869802;15544;15604.375824966874;15678.9216053919;22915.885420573122;23144;23155.189568365025;23161;23325.650115248285;8682.392232543787;8760.8685869712;8764.386492945432;8779.780505487413;8842.734717958472;7362.705491780269;7364.631768411558;7368.15266244378;7371.852562948711;7435;7601.543907365576;7730.432094456516;7739.071311442663;7751.302382785577;7895.644695988694;3049.16148059281;3055.847207639609;3174.4603417419094;3194.536792165123;3211.6467188609236;357.91946811967097;363.33328342491825;368.18814513996574;374.6759053418773;380.3458052150297;9658.420494770337;9830.4101753895;9882.308238423386;9953.950230248802;10025.097741203326;385.32760333218715;388.8852788427421;389.98245078971513;390.75968279508464;400.0858039380061;5243.606729495303;5625.296837895263;5661.46216109469;5669.688167150764;5706.229658996065;457252;466551;471039;474190;476507;63603;65723;67865.66067169633;71072.2892771076;73736.63131684308;1052.8631277933819;1053.6154303679255;1060.4644654449608;1078.563181911327;1079.983800242997;14782.556523304318;14812.7778083331;14827.258637067887;15020.699586008437;15442.2278886053;33876.322473550885;34122.65877341294;34625;35018.649813501535;35323;44395;45489.31766023446;45503.54496454993;45536.08927821491;51340;13290.734185316433;13795.655108621962;13927.721445571235;14608.342624581706;14621.92689036548;17486.562835929202;17600;17773.911130444267;17806.732899006267;18447;9019.77450563715;9435.009324020879;9438.85841712361;14194.929025354808;14896.329665164876;8963.731088067369;9081.218299279444;9291.860622090539;9418.95290523543;9511.524423778921;9667.951660241653;9827.361221520578;9908.009199080034;9920.255980801325;9937.055979681918;14083.436662533793;14087.225202613954;14151.929240353733;14208.644783880485;14325.355359009078;14750.967432279638;14935;14990.250487475365;15051.924740376227;15164.241787910782 04:59:34 INFO - 2015-12-03 04:59:34,779 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1490.1208287110603;1646.8188499265082;1679.5297316751307;1688.679150961318;1713.4773893962335;6192.102145188945;6368.140301059356;7236.167840698321;7379.1513975892785;7401.148867880189;6819.49971006379;6904.620245886475;6966.16406031277;6983.580985140882;6987.161540615133;2089.2896415218784;2136.8824714640687;2141.732283464567;2143.132031527234;2148.151480165334;2107.6417009108486;2131.381899249224;2170.7937745914114;2179.08478439056;2187.0158428707146;2030.1777779999125;2046.7850875658064;2054.435030366646;2076.169532187122;2083.5207902182506;2093.6859471079306;2118.8304935605115;2120.2473122041683;2121.5650791587686;2125.3517677108475;2092.2886218685567;2138.176801931252;2141.2291575032978;2150.806427421524;2154.1060459909118;7207.351338379571;7288.271172882669;7299.19708832028;7299.598522081284;7311;4106.404571337169;4171.749695018309;4205.789710514462;4206.936895946563;4213.199492096523;2775.777937764974;2785.5264605017196;2839.2475993861644;2848.060140153744;2855.6430446194227;866.8353012927587;901.3825529512239;931.6226928094133;936.3679516326453;938.4275591888942;9591.856122158173;9617.51912404377;9623.663171789023;9633.759156021015;9645.517724113766;3958.188571342868;4050.696197785178;4059.878203653836;4080.0207950091763;4088.2436749201493;8254.339652827879;8295.95852020736;8332.291755200877;8340.374471914509;8345.207205315486;4120.75275483472;4150.543440221573;4155.480564929384;4184.81168347419;4188.28799104153;3246.918827029343;3349.1292264011045;3756.436534519844;3763.7741735495956;3835;3485.634008429078;3511.4908338290807;3513.701335386521;3529.27649831789;3531.9293614127573;1071.3678929431674;1077.3374374759624;1081.2431298091367;1086.706589220906;1087.374759513283;881.9867701984475;948.5257371314343;1141.1042331769522;1158.1892675127444;1168.363242033094;6757.560758550679;6786.966065169642;6819.045333653194;6842.247352791189;6861.691223894937;982.916452101565;1066.2003497376968;1071.9624813131502;1072.2119242356862;1102.7959827431791;5261.631685782035;5278.20826875964;5281.735913204325;5291.603129765283;5318.202269659505;8637.352198585006;8684.696035638848;8924.821503570021;8943.329250306253;9017.909820901707;8760.824783504422;8779.868301975475;8844.911550884408;8872.290216782641;8936.329775266751;6699.665016749143;6704.161979752531;6787.6266805325195;6868.244493105654;6976.860462790716;6485.383888530582;6494.383033611799;6531.869362612816;6552;6559.180102487189;7708.4218683600075;7851.725189618336;7918.762437126896;7921.801954951173;7941.404394670307;7966.84066318682;8075.87886181696;8114;8151.184881511801;8184.8363032737825;5037.697738135724;5424.53891419218;5444.782208711607;6092.482139018233;6141.692915354304;6937.132858392701;6937.687804048931;6956.165260168812;6976.825579360557;6978.860422791414;6577.276499584946;6648.069270302259;6673.099131617169;6730.158730158731;6793.592384456949;6391.9041214380895;6461.321561236191;6567.343265673395;6576.76981305652;6637.70130344126;6634.203895532374;6677.565958212895;6687.832804179934;6690.6320152390135;6692.096566963398;6074.878502430015;6105.664188469676;6119.265688117454;6119.296280927751;6132.78535251264;6168.753249869955;6172.814815555541;6192.938070619236;6194.876102478015;6199.3490683477585 04:59:34 INFO - 2015-12-03 04:59:34,783 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.1715334107758;294.254065942835;294.78922570362187;295.3738075280406;295.91566403574984;5547.500724934755;5568.220449137119;5594.86012849679;5614.578906582013;5638.605297629168;5506.201600767887;5520.736498035806;5523.972380138093;5533.833984980457;5538.501534861862;4269.935950960738;4271.231178387904;4278.315469524877;4281.272183728774;4288.785560721967;4102.774347410891;4117.155983023488;4118.0322624183445;4122.546519882825;4134.834606615732;4067.491563554556;4068.3897415387632;4072.796360181994;4074.6740260779065;4075.6535694466006;4082.2243773682903;4122.072533679928;4155.688323375759;4157.334826427757;4165.666746660275;3587.157018100744;3587.497750314958;3592.3354179476883;3595.083253770298;3595.5505561804775;5163.819266325698;5182.248573956793;5304.73476326186;5305.734713264322;5346.599005074635;4814.927776083362;4825.927611085836;4828.61371090312;4829.589484893788;4832.444268909086;5835.0372188588835;5841.532677385841;5847.707614619252;5852.092925596539;5863.648181109147;3945.704072194597;3946.112124771932;3946.289667859784;3949.486566746333;3952.229315283521;5884.9705751470965;6087.756489740405;6120.877582448371;6126.846828829271;6147.661878596676;4001.7198796083994;4001.979990100031;4002.799860006988;4004.799760012046;4009.558948515661;4045.19096180765;4046.3121269384274;4046.8785936421955;4054.7567145971334;4056.6957478189256;4734.337192793012;4756.7145971241835;4758.643101767312;4763.309320148559;4765.904681906342;5616.2698849150165;5792;5800.796972105956;5801.94198058014;5808.7095645218415;1430.0918916487897;1443.6679563700409;1447.0811034992855;1447.2185020089244;1447.3052934591456;958.0611001218845;961.4904100826573;962.605331813953;975.7560609847538;978.9363691360039;5059.696418214845;5064.645474816727;5065.518775716301;5069.543741063322;5101.617378696613;6017.2779266488305;6050.092486127028;6060.454559089703;6066;6104.114903338991;5067.721275329818;5071.771770270347;5072.18844984808;5073.923891141636;5080.923786143211;3201.5677883485896;3254.6582608825734;3260.103471545344;3271.85276662546;3288.177955511122;5674;5689.971550142222;5704.543636509069;5705.828825135252;5709.314882214161;6083.9391606084255;6249.937500625027;6254.437100660963;6276.623402595859;6284.591501552384;5664.858378540487;5666.206731057655;5698.572607054488;5702.8289151325525;5703.287089113861;6042.637441753509;6071.241094863142;6076.787312444043;6077.908831367621;6083.452489275986;5783.7397317119985;5940.910886336622;5941.91087133702;5950.583459157818;5963.075723262901;5669.489745922887;5671.688057156896;5672.290963629546;5673.716314184357;5676.148577713376;4069.6337329640473;4118.444010058603;4121.031557583906;4124.690648201336;4130.235906357333;5942.049272116441;6051.878962420815;6065.878682426239;6073.423024812812;6091.543134264859;5823.388544202798;5826.271716035496;5841.153032810304;5841.649501029951;5844.532437405082;5816.767329306949;5845.707714614167;5850.7074646266665;5850.824475265749;5860.560457965585;5686.2323586315315;5714.542836573148;5715.257016587817;5718.542516598579;5727.799527016535;5769.221155144001;5813.82558523245;5838;5886.852828679317;5907.084401917709;5709.314882214161;5742.368339482737;5743.59794814359;5744.626599271034;5761.423857614205 04:59:34 INFO - 2015-12-03 04:59:34,783 DEBUG : BROWSER_OUTPUT: |5;yui.html;645.3739872323845;734.7722206116102;747.0960138232738;766.2643861892583;772.1274959295995;11639.127065470091;11961.880381196186;11993.64019079429;12027.458764355613;12031.278123312608;12831.679208019805;12856.67858303543;12859.421326040327;12866;12866.742665146692;770.9383249340067;774.9845003099935;775.3990657240628;781.0978320040363;792.065362871811;771.6180490657133;772.1390649425906;772.6600295869828;773.8839174123871;774.2373761844578;824.579464473117;830.161536847782;830.2071521696765;830.2320353672828;830.6428235858579;810.4934415990007;817.9713710020151;819.7499762572413;821.4250024982506;821.7863355527546;607.9817605471843;608.2305883057935;609.5580703989572;612.017711572928;612.2408213814838;12467.438965246494;12500.874991250063;12557.05822063349;12566.68583285416;12597.622071337875;10706.518206680641;10748.408837513934;10793.5682572697;10969.725756856064;12044;8588.484690918565;8690.217880390732;8707.912920870773;8900.37697361185;9015.14356136166;3089.922751931197;3149.370125974814;3167.2715275486535;3180.997985634541;3202.2154572129743;43008.784956075644;43264.78367608142;43508.3473747894;43935.56064439347;43979.12041759147;8535.95732021336;8872.24585910205;8991.460512369147;9019.278457723367;9410.95294523523;16394.83605163933;16545.090020049014;16554.58613534671;16561.751573726404;16638;6057.091436284504;6077.24034495688;6114.205153330127;6217.191765070603;6244.12582238487;3545.06055895188;3576.070221742366;3608.226916497608;3613.530241068697;3675.0628589709986;2693.313205132679;2734.2207470871103;2735.42556063225;2738;2742.163640089792;478.15366800762456;480.0662711027019;484.92726091085916;493.361097378888;497.73868718922853;455.67191622032084;474.5349557433734;475.41286511158694;487.4564860180944;540.5135378159688;7427.4800763946005;7672.769816905502;7896.960515197387;8019.839603207904;8107.918920810716;477.3102866358079;514.5163546266498;574.9540036797047;575.1372940589116;605.4853374631527;3357.5970883494138;3432.5709286339206;3446.9482957755654;3564.91087722809;3582.5342705448124;55221.44778552243;55722.16416753671;55852.720736396055;56029;56264;46753;47429.76285118552;47736;48560.27159592609;48714.756426217646;43359.34960975588;44737.55262447334;44930.101397971855;45195;45216.32175517304;7533.472656913963;7622.58075805836;7663.923360766544;7676;7722.41532133554;31225.531617026216;31407.68592314139;31690.04929852108;31692.841535793097;31837.36325273528;37335.25329493449;37735.433968489946;37778.62221377751;42711.7864410676;42723.57276427196;8032.437729358889;8187.426880118334;9049.547522623974;9854.901450985399;10107;11253.381064041556;11462.828057578976;11562.479688413874;11774.234674746114;11879.168458207843;10495;10532.842007370049;10596.89403105959;10701.51843167075;10769.515371808444;10478.58085676595;10820.242583019113;11033.117350611772;11041.779164416506;11057.723556911142;10421.322614030063;10531.262811603114;10551;10597;11230.887691122984;8756.737297881074;9103.453792772454;9169.54152292396;9277;9500.382475139093;8632.611532480927;8785.912140878509;8838.381313308264;8896.243819275434;8906.73279801607 04:59:34 INFO - 2015-12-03 04:59:34,783 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:59:34 INFO - 2015-12-03 04:59:34,783 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:59:34 INFO - 2015-12-03 04:59:34,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,335 04:59:34 INFO - 2015-12-03 04:59:34,783 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:59:34 INFO - 2015-12-03 04:59:34,784 DEBUG : BROWSER_OUTPUT: __startTimestamp1449147574770__endTimestamp 04:59:34 INFO - 2015-12-03 04:59:34,784 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,784 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:59:34 INFO - 2015-12-03 04:59:34,784 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:59:34 INFO - 2015-12-03 04:59:34,784 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,784 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4668.80 Median:4821.64 stddev:587.58 (12.2%) stddev-sans-first:567.60 04:59:34 INFO - 2015-12-03 04:59:34,785 DEBUG : BROWSER_OUTPUT: Values: 2648.4 2680.3 2710.2 2718.2 2727.9 4619.8 4697.2 4769.1 4776.9 4804.5 4717.9 4722.5 4725.6 4738.4 4740.2 4290.6 4380.8 4414.7 4466.1 4475.3 4456.6 4474.0 4503.1 4504.5 4544.2 529.2 4105.5 4417.3 4420.5 4482.7 4404.3 4435.1 4443.1 4443.9 4494.6 4426.6 4434.3 4441.9 4450.4 4479.5 4519.5 4580.7 4673.1 4696.2 4741.2 5111.4 5151.2 5156.9 5172.5 5208.4 5195.9 5207.2 5208.8 5209.9 5216.2 4574.5 4656.9 4682.5 4730.1 4776.6 5214.9 5221.4 5225.5 5235.2 5256.0 4767.0 4977.5 5012.4 5031.2 5035.2 5002.9 5043.2 5048.2 5088.0 5114.9 5026.3 5044.1 5045.7 5062.9 5064.3 4821.6 4889.6 4992.8 5012.8 5024.4 4088.8 4173.6 4174.2 4195.6 4200.7 3734.4 3756.6 3778.2 3812.2 3828.5 4254.8 4266.9 4321.2 4448.4 4449.8 5125.8 5133.1 5136.5 5148.5 5149.5 4395.6 4412.0 4416.4 4429.4 4445.3 4297.7 4375.7 4400.5 4479.0 4518.6 4814.4 4845.2 4845.5 4853.1 4874.1 5104.1 5109.2 5116.6 5120.5 5162.3 4705.6 4716.7 4782.7 4806.8 4823.0 5000.7 5017.7 5019.2 5019.8 5068.2 4867.3 5126.5 5126.6 5130.4 5177.4 4879.1 4894.7 4924.8 4960.1 4996.9 4948.1 4966.3 4969.7 4972.4 5010.7 4605.9 4769.9 4861.7 4892.0 4903.3 4854.2 4861.8 4874.1 4901.7 4957.6 4839.6 4856.0 4860.4 4861.5 4905.3 04:59:34 INFO - 2015-12-03 04:59:34,785 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,785 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40237.39 Median:34591.40 stddev:61980.79 (179.2%) stddev-sans-first:62082.97 04:59:34 INFO - 2015-12-03 04:59:34,785 DEBUG : BROWSER_OUTPUT: Values: 535.6 575.8 581.0 581.8 587.7 27067.3 36565.3 37006.4 37022.3 37044.6 39416.8 39837.2 39879.6 39925.0 39974.2 7756.4 7934.0 7934.1 7937.8 7938.0 7773.5 7879.3 7884.0 7885.4 7906.0 7787.8 7825.6 7848.3 7863.8 7881.8 7817.3 7848.5 7884.4 7889.7 7904.8 7674.1 7780.2 7802.6 7831.1 7839.5 36997.3 37106.8 37458.0 37563.0 37616.2 2744.9 2852.7 2977.7 3121.8 3553.8 27660.2 28274.9 28351.9 30040.4 30394.7 3317.9 3380.8 3390.3 3402.1 3481.6 210839.0 213194.9 214818.0 214889.0 214921.0 47876.0 48652.8 51472.7 52085.5 55778.7 55979.0 56491.0 56499.4 56521.7 56543.7 13857.4 13964.6 14007.6 14014.5 14061.0 10170.4 10284.5 10294.4 10310.1 10314.3 18584.8 18765.2 19158.4 19360.3 19362.0 7669.5 7759.5 7773.7 7811.0 7884.4 836.5 841.7 868.0 919.8 1035.5 25782.4 26006.9 26097.5 26307.9 26366.6 960.3 974.5 977.4 1001.0 1094.4 13255.8 13444.1 13476.0 13632.9 13639.4 255221.0 256043.0 256982.0 257034.0 257187.0 44019.0 44719.3 44935.3 44986.3 45150.5 1195.1 1197.7 1216.0 1219.3 1345.4 25067.0 25212.0 25601.5 25657.6 25690.2 39140.8 39263.8 39279.6 39361.2 39458.4 241365.0 243213.0 243224.0 243592.0 244680.0 29046.7 41898.6 42188.2 42518.8 42682.6 38741.4 38870.0 38881.0 39145.0 39984.6 33651.0 34127.8 34397.5 34713.7 36889.3 33714.8 33809.3 34233.7 34280.7 34469.1 33630.0 34090.3 34318.1 34371.0 34418.0 30023.2 30078.5 30817.7 30978.7 31049.7 24227.5 24390.5 24397.6 24676.3 24677.4 04:59:34 INFO - 2015-12-03 04:59:34,785 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,786 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26607.58 Median:371.43 stddev:76443.75 (20580.8%) stddev-sans-first:76632.74 04:59:34 INFO - 2015-12-03 04:59:34,787 DEBUG : BROWSER_OUTPUT: Values: 334.3 336.3 340.6 344.3 344.3 13276.2 14984.9 14991.3 15956.5 16628.1 10459.2 10673.8 14757.5 15775.0 15783.1 4646.6 4775.3 6245.9 6488.7 6494.6 6417.2 6431.1 6494.5 6774.9 6816.6 3951.2 4096.2 6564.1 6791.1 6802.3 6701.1 6727.4 6750.6 6757.7 6759.8 6316.6 6450.7 6470.3 6472.1 6482.8 19388.0 19479.2 19753.6 19802.9 20962.3 1920.5 1926.8 1996.9 2015.4 2071.3 13082.9 13403.2 13651.3 13846.8 14288.0 1812.0 1834.4 2025.5 2051.7 2067.8 50070.0 51145.0 52797.5 53545.7 53549.0 15411.3 15479.2 15544.0 15604.4 15678.9 22915.9 23144.0 23155.2 23161.0 23325.7 8682.4 8760.9 8764.4 8779.8 8842.7 7362.7 7364.6 7368.2 7371.9 7435.0 7601.5 7730.4 7739.1 7751.3 7895.6 3049.2 3055.8 3174.5 3194.5 3211.6 357.9 363.3 368.2 374.7 380.3 9658.4 9830.4 9882.3 9954.0 10025.1 385.3 388.9 390.0 390.8 400.1 5243.6 5625.3 5661.5 5669.7 5706.2 457252.0 466551.0 471039.0 474190.0 476507.0 63603.0 65723.0 67865.7 71072.3 73736.6 1052.9 1053.6 1060.5 1078.6 1080.0 14782.6 14812.8 14827.3 15020.7 15442.2 33876.3 34122.7 34625.0 35018.6 35323.0 44395.0 45489.3 45503.5 45536.1 51340.0 13290.7 13795.7 13927.7 14608.3 14621.9 17486.6 17600.0 17773.9 17806.7 18447.0 9019.8 9435.0 9438.9 14194.9 14896.3 8963.7 9081.2 9291.9 9419.0 9511.5 9668.0 9827.4 9908.0 9920.3 9937.1 14083.4 14087.2 14151.9 14208.6 14325.4 14751.0 14935.0 14990.3 15051.9 15164.2 04:59:34 INFO - 2015-12-03 04:59:34,787 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,787 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5043.94 Median:6193.91 stddev:2609.22 (42.1%) stddev-sans-first:2602.87 04:59:34 INFO - 2015-12-03 04:59:34,787 DEBUG : BROWSER_OUTPUT: Values: 1490.1 1646.8 1679.5 1688.7 1713.5 6192.1 6368.1 7236.2 7379.2 7401.1 6819.5 6904.6 6966.2 6983.6 6987.2 2089.3 2136.9 2141.7 2143.1 2148.2 2107.6 2131.4 2170.8 2179.1 2187.0 2030.2 2046.8 2054.4 2076.2 2083.5 2093.7 2118.8 2120.2 2121.6 2125.4 2092.3 2138.2 2141.2 2150.8 2154.1 7207.4 7288.3 7299.2 7299.6 7311.0 4106.4 4171.7 4205.8 4206.9 4213.2 2775.8 2785.5 2839.2 2848.1 2855.6 866.8 901.4 931.6 936.4 938.4 9591.9 9617.5 9623.7 9633.8 9645.5 3958.2 4050.7 4059.9 4080.0 4088.2 8254.3 8296.0 8332.3 8340.4 8345.2 4120.8 4150.5 4155.5 4184.8 4188.3 3246.9 3349.1 3756.4 3763.8 3835.0 3485.6 3511.5 3513.7 3529.3 3531.9 1071.4 1077.3 1081.2 1086.7 1087.4 882.0 948.5 1141.1 1158.2 1168.4 6757.6 6787.0 6819.0 6842.2 6861.7 982.9 1066.2 1072.0 1072.2 1102.8 5261.6 5278.2 5281.7 5291.6 5318.2 8637.4 8684.7 8924.8 8943.3 9017.9 8760.8 8779.9 8844.9 8872.3 8936.3 6699.7 6704.2 6787.6 6868.2 6976.9 6485.4 6494.4 6531.9 6552.0 6559.2 7708.4 7851.7 7918.8 7921.8 7941.4 7966.8 8075.9 8114.0 8151.2 8184.8 5037.7 5424.5 5444.8 6092.5 6141.7 6937.1 6937.7 6956.2 6976.8 6978.9 6577.3 6648.1 6673.1 6730.2 6793.6 6391.9 6461.3 6567.3 6576.8 6637.7 6634.2 6677.6 6687.8 6690.6 6692.1 6074.9 6105.7 6119.3 6119.3 6132.8 6168.8 6172.8 6192.9 6194.9 6199.3 04:59:34 INFO - 2015-12-03 04:59:34,787 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,787 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4789.32 Median:5557.86 stddev:1445.30 (26.0%) stddev-sans-first:1409.28 04:59:34 INFO - 2015-12-03 04:59:34,787 DEBUG : BROWSER_OUTPUT: Values: 286.2 294.3 294.8 295.4 295.9 5547.5 5568.2 5594.9 5614.6 5638.6 5506.2 5520.7 5524.0 5533.8 5538.5 4269.9 4271.2 4278.3 4281.3 4288.8 4102.8 4117.2 4118.0 4122.5 4134.8 4067.5 4068.4 4072.8 4074.7 4075.7 4082.2 4122.1 4155.7 4157.3 4165.7 3587.2 3587.5 3592.3 3595.1 3595.6 5163.8 5182.2 5304.7 5305.7 5346.6 4814.9 4825.9 4828.6 4829.6 4832.4 5835.0 5841.5 5847.7 5852.1 5863.6 3945.7 3946.1 3946.3 3949.5 3952.2 5885.0 6087.8 6120.9 6126.8 6147.7 4001.7 4002.0 4002.8 4004.8 4009.6 4045.2 4046.3 4046.9 4054.8 4056.7 4734.3 4756.7 4758.6 4763.3 4765.9 5616.3 5792.0 5800.8 5801.9 5808.7 1430.1 1443.7 1447.1 1447.2 1447.3 958.1 961.5 962.6 975.8 978.9 5059.7 5064.6 5065.5 5069.5 5101.6 6017.3 6050.1 6060.5 6066.0 6104.1 5067.7 5071.8 5072.2 5073.9 5080.9 3201.6 3254.7 3260.1 3271.9 3288.2 5674.0 5690.0 5704.5 5705.8 5709.3 6083.9 6249.9 6254.4 6276.6 6284.6 5664.9 5666.2 5698.6 5702.8 5703.3 6042.6 6071.2 6076.8 6077.9 6083.5 5783.7 5940.9 5941.9 5950.6 5963.1 5669.5 5671.7 5672.3 5673.7 5676.1 4069.6 4118.4 4121.0 4124.7 4130.2 5942.0 6051.9 6065.9 6073.4 6091.5 5823.4 5826.3 5841.2 5841.6 5844.5 5816.8 5845.7 5850.7 5850.8 5860.6 5686.2 5714.5 5715.3 5718.5 5727.8 5769.2 5813.8 5838.0 5886.9 5907.1 5709.3 5742.4 5743.6 5744.6 5761.4 04:59:34 INFO - 2015-12-03 04:59:34,787 DEBUG : BROWSER_OUTPUT: 04:59:34 INFO - 2015-12-03 04:59:34,788 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12699.85 Median:476.36 stddev:14961.56 (3140.8%) stddev-sans-first:14976.15 04:59:34 INFO - 2015-12-03 04:59:34,789 DEBUG : BROWSER_OUTPUT: Values: 645.4 734.8 747.1 766.3 772.1 11639.1 11961.9 11993.6 12027.5 12031.3 12831.7 12856.7 12859.4 12866.0 12866.7 770.9 775.0 775.4 781.1 792.1 771.6 772.1 772.7 773.9 774.2 824.6 830.2 830.2 830.2 830.6 810.5 818.0 819.7 821.4 821.8 608.0 608.2 609.6 612.0 612.2 12467.4 12500.9 12557.1 12566.7 12597.6 10706.5 10748.4 10793.6 10969.7 12044.0 8588.5 8690.2 8707.9 8900.4 9015.1 3089.9 3149.4 3167.3 3181.0 3202.2 43008.8 43264.8 43508.3 43935.6 43979.1 8536.0 8872.2 8991.5 9019.3 9411.0 16394.8 16545.1 16554.6 16561.8 16638.0 6057.1 6077.2 6114.2 6217.2 6244.1 3545.1 3576.1 3608.2 3613.5 3675.1 2693.3 2734.2 2735.4 2738.0 2742.2 478.2 480.1 484.9 493.4 497.7 455.7 474.5 475.4 487.5 540.5 7427.5 7672.8 7897.0 8019.8 8107.9 477.3 514.5 575.0 575.1 605.5 3357.6 3432.6 3446.9 3564.9 3582.5 55221.4 55722.2 55852.7 56029.0 56264.0 46753.0 47429.8 47736.0 48560.3 48714.8 43359.3 44737.6 44930.1 45195.0 45216.3 7533.5 7622.6 7663.9 7676.0 7722.4 31225.5 31407.7 31690.0 31692.8 31837.4 37335.3 37735.4 37778.6 42711.8 42723.6 8032.4 8187.4 9049.5 9854.9 10107.0 11253.4 11462.8 11562.5 11774.2 11879.2 10495.0 10532.8 10596.9 10701.5 10769.5 10478.6 10820.2 11033.1 11041.8 11057.7 10421.3 10531.3 10551.0 10597.0 11230.9 8756.7 9103.5 9169.5 9277.0 9500.4 8632.6 8785.9 8838.4 8896.2 8906.7 04:59:34 INFO - 2015-12-03 04:59:34,789 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:59:34 INFO - 2015-12-03 04:59:34,789 DEBUG : BROWSER_OUTPUT: 04:59:35 INFO - 2015-12-03 04:59:35,513 INFO : Browser exited with error code: 0 04:59:35 INFO - 2015-12-03 04:59:35,532 INFO : Completed test dromaeo_css (00:18:34) 04:59:35 INFO - 2015-12-03 04:59:35,532 INFO : Starting test kraken 04:59:35 INFO - 2015-12-03 04:59:35,532 DEBUG : operating with platform_type : linux_ 04:59:35 INFO - 2015-12-03 04:59:35,532 INFO : Initialising browser for kraken test... 04:59:35 INFO - 2015-12-03 04:59:35,539 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwf9NR5/profile http://localhost:51656/getInfo.html 04:59:40 INFO - 2015-12-03 04:59:40,144 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:59:40 INFO - 2015-12-03 04:59:40,145 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:59:40 INFO - 2015-12-03 04:59:40,145 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:59:40 INFO - 2015-12-03 04:59:40,145 DEBUG : BROWSER_OUTPUT: __metrics 04:59:40 INFO - 2015-12-03 04:59:40,302 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:59:41 INFO - 2015-12-03 04:59:41,173 INFO : Browser initialized. 04:59:41 INFO - 2015-12-03 04:59:41,174 INFO : Running cycle 1/1 for kraken test... 04:59:41 INFO - 2015-12-03 04:59:41,174 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwf9NR5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:59:53 INFO - 2015-12-03 04:59:53,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 143622144 04:59:53 INFO - 2015-12-03 04:59:53,218 DEBUG : BROWSER_OUTPUT: 04:59:55 INFO - 2015-12-03 04:59:55,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51656/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:56 INFO - 2015-12-03 04:59:56,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 145240064 04:59:56 INFO - 2015-12-03 04:59:56,420 DEBUG : BROWSER_OUTPUT: 04:59:59 INFO - 2015-12-03 04:59:59,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51656/tests/kraken/driver.html?testName=audio-dft) 04:59:59 INFO - 2015-12-03 04:59:59,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 144687104 04:59:59 INFO - 2015-12-03 04:59:59,824 DEBUG : BROWSER_OUTPUT: 05:00:02 INFO - 2015-12-03 05:00:02,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51656/tests/kraken/driver.html?testName=audio-fft) 05:00:03 INFO - 2015-12-03 05:00:03,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 138674176 05:00:03 INFO - 2015-12-03 05:00:03,308 DEBUG : BROWSER_OUTPUT: 05:00:05 INFO - 2015-12-03 05:00:05,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51656/tests/kraken/driver.html?testName=audio-oscillator) 05:00:06 INFO - 2015-12-03 05:00:06,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 139694080 05:00:06 INFO - 2015-12-03 05:00:06,009 DEBUG : BROWSER_OUTPUT: 05:00:08 INFO - 2015-12-03 05:00:08,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:08 INFO - 2015-12-03 05:00:08,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 140845056 05:00:08 INFO - 2015-12-03 05:00:08,853 DEBUG : BROWSER_OUTPUT: 05:00:11 INFO - 2015-12-03 05:00:11,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51656/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:12 INFO - 2015-12-03 05:00:12,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 140947456 05:00:12 INFO - 2015-12-03 05:00:12,524 DEBUG : BROWSER_OUTPUT: 05:00:16 INFO - 2015-12-03 05:00:16,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51656/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:16 INFO - 2015-12-03 05:00:16,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 138854400 05:00:16 INFO - 2015-12-03 05:00:16,607 DEBUG : BROWSER_OUTPUT: 05:00:19 INFO - 2015-12-03 05:00:19,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51656/tests/kraken/driver.html?testName=json-parse-financial) 05:00:20 INFO - 2015-12-03 05:00:20,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 139771904 05:00:20 INFO - 2015-12-03 05:00:20,114 DEBUG : BROWSER_OUTPUT: 05:00:21 INFO - 2015-12-03 05:00:21,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:00:22 INFO - 2015-12-03 05:00:22,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 140546048 05:00:22 INFO - 2015-12-03 05:00:22,457 DEBUG : BROWSER_OUTPUT: 05:00:24 INFO - 2015-12-03 05:00:24,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:00:24 INFO - 2015-12-03 05:00:24,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 141066240 05:00:24 INFO - 2015-12-03 05:00:24,962 DEBUG : BROWSER_OUTPUT: 05:00:27 INFO - 2015-12-03 05:00:27,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:27 INFO - 2015-12-03 05:00:27,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 141471744 05:00:27 INFO - 2015-12-03 05:00:27,724 DEBUG : BROWSER_OUTPUT: 05:00:30 INFO - 2015-12-03 05:00:30,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:30 INFO - 2015-12-03 05:00:30,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 141717504 05:00:30 INFO - 2015-12-03 05:00:30,938 DEBUG : BROWSER_OUTPUT: 05:00:33 INFO - 2015-12-03 05:00:33,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:34 INFO - 2015-12-03 05:00:34,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 141467648 05:00:34 INFO - 2015-12-03 05:00:34,120 DEBUG : BROWSER_OUTPUT: 05:00:35 INFO - 2015-12-03 05:00:35,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51656/tests/kraken/driver.html?testName=ai-astar) 05:00:36 INFO - 2015-12-03 05:00:36,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 142479360 05:00:36 INFO - 2015-12-03 05:00:36,161 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,161 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:00:36 INFO - 2015-12-03 05:00:36,161 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:00:36 INFO - 2015-12-03 05:00:36,161 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:00:36 INFO - 2015-12-03 05:00:36,161 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;109;113;113;113;127;115;113;114;112 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;131;156;177;132;165;153;135;167;134 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;163;162;164;167;163;162;164;164 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;72;73;73;147;72;73;72 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;142;94;94;94;134;95;95;132 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;113;111;110;110;110;110;110;110;110;110 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;147;148;146;148;147;147 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;96;96;96;96;95 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;72;72;74;72;72;72;70;74 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;67;69;69;68;68;68 05:00:36 INFO - 2015-12-03 05:00:36,162 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;83;92;86;85;84;86;86;87;96 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;122;121;129;132;137;129;138;130;121 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;146;153;148;149;146;148;147;135;152 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;70;69;69;73;68;71;70;73 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,782 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: __startTimestamp1449147636160__endTimestamp 05:00:36 INFO - 2015-12-03 05:00:36,163 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,166 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:00:36 INFO - 2015-12-03 05:00:36,166 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:00:36 INFO - 2015-12-03 05:00:36,166 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.20 Median:113.00 stddev:4.76 (4.2%) stddev-sans-first:5.02 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: Values: 113.0 109.0 113.0 113.0 113.0 127.0 115.0 113.0 114.0 112.0 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.10 Median:158.50 stddev:16.88 (10.6%) stddev-sans-first:17.51 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: Values: 161.0 131.0 156.0 177.0 132.0 165.0 153.0 135.0 167.0 134.0 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 163.0 162.0 164.0 167.0 163.0 162.0 164.0 164.0 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:72.00 stddev:23.62 (32.8%) stddev-sans-first:24.88 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 72.0 73.0 73.0 147.0 72.0 73.0 72.0 05:00:36 INFO - 2015-12-03 05:00:36,167 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:94.00 stddev:20.24 (21.5%) stddev-sans-first:21.00 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 142.0 94.0 94.0 94.0 134.0 95.0 95.0 132.0 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:0.97 (0.9%) stddev-sans-first:0.33 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: Values: 113.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 147.0 148.0 146.0 148.0 147.0 147.0 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,168 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:72.00 stddev:1.16 (1.6%) stddev-sans-first:1.22 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 72.0 74.0 72.0 72.0 72.0 70.0 74.0 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 67.0 69.0 69.0 68.0 68.0 68.0 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.00 stddev:3.93 (4.6%) stddev-sans-first:4.15 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: Values: 86.0 83.0 92.0 86.0 85.0 84.0 86.0 86.0 87.0 96.0 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,169 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:129.50 stddev:6.07 (4.7%) stddev-sans-first:6.44 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: Values: 128.0 122.0 121.0 129.0 132.0 137.0 129.0 138.0 130.0 121.0 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:148.00 stddev:4.88 (3.3%) stddev-sans-first:5.16 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 153.0 148.0 149.0 146.0 148.0 147.0 135.0 152.0 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:1.65 (2.3%) stddev-sans-first:1.74 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 69.0 69.0 73.0 68.0 71.0 70.0 73.0 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:00:36 INFO - 2015-12-03 05:00:36,170 DEBUG : BROWSER_OUTPUT: 05:00:37 INFO - 2015-12-03 05:00:37,069 INFO : Browser exited with error code: 0 05:00:37 INFO - 2015-12-03 05:00:37,123 INFO : Completed test kraken (00:01:01) 05:00:37 INFO - 2015-12-03 05:00:37,123 INFO : Starting test v8_7 05:00:37 INFO - 2015-12-03 05:00:37,123 DEBUG : operating with platform_type : linux_ 05:00:37 INFO - 2015-12-03 05:00:37,123 INFO : Initialising browser for v8_7 test... 05:00:37 INFO - 2015-12-03 05:00:37,130 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxElULK/profile http://localhost:51656/getInfo.html 05:00:41 INFO - 2015-12-03 05:00:41,753 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:00:41 INFO - 2015-12-03 05:00:41,753 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:00:41 INFO - 2015-12-03 05:00:41,753 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:00:41 INFO - 2015-12-03 05:00:41,753 DEBUG : BROWSER_OUTPUT: __metrics 05:00:41 INFO - 2015-12-03 05:00:41,858 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:00:42 INFO - 2015-12-03 05:00:42,781 INFO : Browser initialized. 05:00:42 INFO - 2015-12-03 05:00:42,782 INFO : Running cycle 1/1 for v8_7 test... 05:00:42 INFO - 2015-12-03 05:00:42,782 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxElULK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:00:54 INFO - 2015-12-03 05:00:54,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 143187968 05:00:54 INFO - 2015-12-03 05:00:54,921 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51656/tests/v8_7/run.html (next: http://localhost:51656/tests/v8_7/run.html) 05:01:16 INFO - 2015-12-03 05:01:16,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 138268672 05:01:16 INFO - 2015-12-03 05:01:16,612 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,612 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:01:16 INFO - 2015-12-03 05:01:16,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:01:16 INFO - 2015-12-03 05:01:16,613 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:01:16 INFO - 2015-12-03 05:01:16,613 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:01:16 INFO - 2015-12-03 05:01:16,613 DEBUG : BROWSER_OUTPUT: |0;Richards;166.8335001668335 05:01:16 INFO - 2015-12-03 05:01:16,613 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.75597206909225 05:01:16 INFO - 2015-12-03 05:01:16,613 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 05:01:16 INFO - 2015-12-03 05:01:16,613 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 05:01:16 INFO - 2015-12-03 05:01:16,613 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1142.6940639269405 05:01:16 INFO - 2015-12-03 05:01:16,614 DEBUG : BROWSER_OUTPUT: |5;Earley;695.8942240779402 05:01:16 INFO - 2015-12-03 05:01:16,614 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 05:01:16 INFO - 2015-12-03 05:01:16,614 DEBUG : BROWSER_OUTPUT: |7;RegExp;25923.076923076922 05:01:16 INFO - 2015-12-03 05:01:16,614 DEBUG : BROWSER_OUTPUT: |8;Splay;1633.986928104575 05:01:16 INFO - 2015-12-03 05:01:16,614 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 05:01:16 INFO - 2015-12-03 05:01:16,614 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:01:16 INFO - 2015-12-03 05:01:16,614 DEBUG : BROWSER_OUTPUT: __startTimestamp1449147676610__endTimestamp 05:01:16 INFO - 2015-12-03 05:01:16,614 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,615 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:01:16 INFO - 2015-12-03 05:01:16,615 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:01:16 INFO - 2015-12-03 05:01:16,615 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,615 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.83 Median:166.83 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,615 DEBUG : BROWSER_OUTPUT: Values: 166.8 05:01:16 INFO - 2015-12-03 05:01:16,615 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,615 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.76 Median:183.76 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,615 DEBUG : BROWSER_OUTPUT: Values: 183.8 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: Values: 277.5 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: Values: 5196.9 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1142.69 Median:1142.69 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,616 DEBUG : BROWSER_OUTPUT: Values: 1142.7 05:01:16 INFO - 2015-12-03 05:01:16,617 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,617 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:695.89 Median:695.89 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,617 DEBUG : BROWSER_OUTPUT: Values: 695.9 05:01:16 INFO - 2015-12-03 05:01:16,617 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,617 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: Values: 12072.3 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: Values: 25923.1 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1633.99 Median:1633.99 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: Values: 1634.0 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 05:01:16 INFO - 2015-12-03 05:01:16,618 DEBUG : BROWSER_OUTPUT: Values: 4854.4 05:01:16 INFO - 2015-12-03 05:01:16,619 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:01:16 INFO - 2015-12-03 05:01:16,619 DEBUG : BROWSER_OUTPUT: 05:01:17 INFO - 2015-12-03 05:01:17,529 INFO : Browser exited with error code: 0 05:01:17 INFO - 2015-12-03 05:01:17,541 INFO : Completed test v8_7 (00:00:40) 05:01:17 INFO - 2015-12-03 05:01:17,612 INFO : Completed test suite (00:20:16) 05:01:17 INFO - 2015-12-03 05:01:17,612 DEBUG : Working with test: dromaeo_css 05:01:17 INFO - 2015-12-03 05:01:17,612 DEBUG : Generating results file: dromaeo_css 05:01:17 INFO - 2015-12-03 05:01:17,613 DEBUG : Working with test: kraken 05:01:17 INFO - 2015-12-03 05:01:17,613 DEBUG : Generating results file: kraken 05:01:17 INFO - 2015-12-03 05:01:17,613 INFO : javascript benchmark 05:01:17 INFO - 2015-12-03 05:01:17,614 DEBUG : Working with test: v8_7 05:01:17 INFO - 2015-12-03 05:01:17,614 DEBUG : Generating results file: v8_7 05:01:17 INFO - 2015-12-03 05:01:17,614 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:17 INFO - 2015-12-03 05:01:17,742 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:01:17 INFO - 2015-12-03 05:01:17,742 DEBUG : process_Request line: dromaeo_css 6423.89 graph.html#tests=[[72,132,43]] 05:01:17 INFO - 2015-12-03 05:01:17,742 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:17 INFO - 2015-12-03 05:01:17,774 DEBUG : process_Request line: kraken 1542.10 graph.html#tests=[[232,132,43]] 05:01:17 INFO - 2015-12-03 05:01:17,774 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:17 INFO - 2015-12-03 05:01:17,822 DEBUG : process_Request line: v8_7 19307.69 graph.html#tests=[[230,132,43]] 05:01:17 INFO - 2015-12-03 05:01:17,823 INFO : javascript benchmark 05:01:17 INFO - 2015-12-03 05:01:17,826 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2648.4305874237043, 2680.276325392143, 2710.227585138236, 2718.1573712149225, 2727.9318017049563, 4619.7921093550785, 4697.248440249557, 4769.1415545201935, 4776.90446191076, 4804.5195480451985, 4717.9292310615365, 4722.504137065602, 4725.574698277154, 4738.384010078685, 4740.1704701677245, 4290.635295999836, 4380.759058251795, 4414.668899832509, 4466.12910482456, 4475.261581838992, 4456.621187199075, 4473.9776301118445, 4503.076869241798, 4504.504504504502, 4544.1593305238475, 529.177582615014, 4105.548389677133, 4417.293233082723, 4420.535843736426, 4482.7310361378095, 4404.273294906337, 4435.068635586498, 4443.066955939256, 4443.933340999887, 4494.595486406207, 4426.579474949875, 4434.312681534335, 4441.911161776747, 4450.421445212101, 4479.507254202035, 4519.502854685982, 4580.679352445331, 4673.112108699336, 4696.178168820443, 4741.241401375763, 5111.4121875984365, 5151.150060240056, 5156.922646160273, 5172.508611681884, 5208.427073022002, 5195.896082078338, 5207.244949482341, 5208.791648334062, 5209.895802083937, 5216.165413533817, 4574.519675434065, 4656.930146047812, 4682.531746825291, 4730.124926888537, 4776.641751868624, 5214.895702085937, 5221.425643179247, 5225.503577160163, 5235.188545775335, 5256.0, 4767.0, 4977.452480227172, 5012.398512178562, 5031.22016087507, 5035.219540971156, 5002.949970500321, 5043.193089105799, 5048.217526283432, 5088.033273677989, 5114.923276150861, 5026.271190677331, 5044.092063428545, 5045.747712614355, 5062.873428164252, 5064.265681476165, 4821.63837712173, 4889.584385327287, 4992.825251116266, 5012.774425150877, 5024.447310795809, 4088.8160032798596, 4173.645240154621, 4174.248635245624, 4195.601417865298, 4200.684948628865, 3734.402495600691, 3756.5679946806467, 3778.1688028633657, 3812.180381217996, 3828.464015037897, 4254.7659878706345, 4266.87199384019, 4321.2005778931, 4448.35498852671, 4449.777511124431, 5125.769340379692, 5133.101707201225, 5136.537711605899, 5148.510891465305, 5149.48505149482, 4395.604395604347, 4411.9558804411545, 4416.447944006999, 4429.446319210098, 4445.266531022345, 4297.72064815786, 4375.671824613167, 4400.471943366816, 4478.955210447919, 4518.570735780096, 4814.350062741555, 4845.248986407112, 4845.466998630219, 4853.102176097434, 4874.073925954058, 5104.055749686171, 5109.182530795055, 5116.641835071509, 5120.513551212629, 5162.251473536241, 4705.647076469347, 4716.6698331116495, 4782.665213435026, 4806.7836947338155, 4823.0, 5000.724960127082, 5017.67385119966, 5019.171836646912, 5019.7741101651245, 5068.189089745623, 4867.269909513601, 5126.487351264844, 5126.564242039469, 5130.384353877558, 5177.352830896138, 4879.097366986976, 4894.681845680019, 4924.778384972757, 4960.057589058068, 4996.875078123076, 4948.109340318777, 4966.255061740768, 4969.701817890938, 4972.428170760409, 5010.749462526932, 4605.907881842411, 4769.880752981203, 4861.708297502161, 4892.0, 4903.28902309156, 4854.19905715553, 4861.805527778849, 4874.147024270809, 4901.656884018084, 4957.6281778866005, 4839.564439200489, 4856.028794241237, 4860.392450943632, 4861.4895435978715, 4905.337779399878], "unit": "ms", "name": "dojo.html", "value": 4634.115704790978}, {"lowerIsBetter": false, "replicates": [535.5983012740447, 575.8214953364458, 580.9593328467008, 581.7556626216989, 587.66209429578, 27067.323316917063, 36565.268694626095, 37006.4449033264, 37022.25955480892, 37044.62955370452, 39416.80291598545, 39837.203255934866, 39879.60120398795, 39925.0, 39974.20051598974, 7756.418268629847, 7934.047914250298, 7934.127246002964, 7937.761867143966, 7938.047434307891, 7773.494722842997, 7879.330256928168, 7883.960580197091, 7885.408594355417, 7905.96047019767, 7787.805304867367, 7825.569593672346, 7848.254415830487, 7863.764087077397, 7881.8029549261155, 7817.257360550739, 7848.45060845741, 7884.408669349822, 7889.723859664913, 7904.841903161962, 7674.079110506719, 7780.183080776494, 7802.609869506502, 7831.099423566306, 7839.451238413313, 36997.26005479902, 37106.81446592777, 37458.0, 37563.0, 37616.24767504662, 2744.862756862149, 2852.7004664510137, 2977.672456029835, 3121.7658675599423, 3553.7690050146916, 27660.170194894185, 28274.85862570674, 28351.858240708872, 30040.399192016255, 30394.696053039628, 3317.883874064396, 3380.7633465657414, 3390.2541440882965, 3402.1494626343415, 3481.56480439945, 210839.0, 213194.93402533044, 214818.0, 214889.0, 214921.0, 47876.0, 48652.810623522026, 51472.74263628658, 52085.47914520882, 55778.72110639502, 55979.0, 56491.0, 56499.435005649415, 56521.7173914136, 56543.71728141333, 13857.4457021718, 13964.581062568139, 14007.649808754863, 14014.509492167928, 14061.0, 10170.389776613427, 10284.537195826206, 10294.3823370598, 10310.07209351147, 10314.329568578018, 18584.81415185858, 18765.155567999474, 19158.425247242605, 19360.32238871661, 19362.031898405025, 7669.501482403626, 7759.534427934342, 7773.650185741655, 7811.0, 7884.448088633855, 836.4939211776909, 841.6549214821894, 868.0148031983744, 919.7562645898843, 1035.49260862177, 25782.35544111375, 26006.86996565005, 26097.478050439266, 26307.9476820925, 26366.604500932503, 960.3469640644429, 974.546835721393, 977.3793641037992, 1000.9599616015278, 1094.3980810554162, 13255.801162982563, 13444.126131801402, 13476.0, 13632.863671363159, 13639.386227619583, 255221.0, 256043.0, 256982.0, 257034.0, 257187.0, 44019.0, 44719.32921006188, 44935.325970110476, 44986.325205121946, 45150.54849451463, 1195.0738177912187, 1197.6826141072622, 1216.0271782573905, 1219.3293688471306, 1345.4281930179634, 25066.99732010699, 25212.0, 25601.48797024012, 25657.615135772605, 25690.229293121236, 39140.804295978334, 39263.803680981415, 39279.6072039276, 39361.2127757449, 39458.40812387759, 241365.0, 243213.0, 243224.0, 243592.0, 244680.0, 29046.7095329044, 41898.58101418947, 42188.15623687448, 42518.78740606277, 42682.5731742691, 38741.418878717406, 38870.0, 38881.0, 39145.0, 39984.600153998086, 33651.0, 34127.82936085304, 34397.484037738956, 34713.65286347104, 36889.26221475609, 33714.83142584271, 33809.32381352408, 34233.65766342404, 34280.65719342874, 34469.138271543416, 33630.0, 34090.318193636485, 34318.14204644904, 34371.0, 34418.0, 30023.249418764706, 30078.54882176813, 30817.69182308148, 30978.69021309848, 31049.68950310468, 24227.515449690556, 24390.51218975646, 24397.634035489125, 24676.259712208663, 24677.38306542279], "unit": "ms", "name": "ext.html", "value": 16957.706894518487}, {"lowerIsBetter": false, "replicates": [334.34468441853966, 336.3189541179112, 340.61850727185526, 344.3027868566154, 344.311377245509, 13276.203427794328, 14984.925075374622, 14991.250437478137, 15956.521304360858, 16628.085455299955, 10459.163266938645, 10673.78652426951, 14757.48348807792, 15775.0, 15783.131927743969, 4646.6282697384295, 4775.3075804008395, 6245.937540624604, 6488.675566221694, 6494.577852439576, 6417.229932408118, 6431.067495213191, 6494.51291153163, 6774.93225067748, 6816.625085620289, 3951.2097580483874, 4096.201240758053, 6564.146660934072, 6791.083203767503, 6802.285759995203, 6701.061851340816, 6727.360900714424, 6750.594964302158, 6757.695903684346, 6759.797206083801, 6316.589421687576, 6450.709718062699, 6470.2559205691, 6472.061551075115, 6482.805515834532, 19388.0, 19479.220831166735, 19753.60492790136, 19802.900985495125, 20962.266320678704, 1920.5294702797764, 1926.7687877454655, 1996.9201231950703, 2015.445752418082, 2071.326818783886, 13082.86917130826, 13403.195808251536, 13651.317434128354, 13846.792298115537, 14288.0, 1811.9547011324692, 1834.4129878438905, 2025.4733769220109, 2051.6819892916624, 2067.80355866194, 50070.0, 51145.0, 52797.47202527964, 53545.732271338784, 53549.0, 15411.306491207923, 15479.22603869802, 15544.0, 15604.375824966874, 15678.9216053919, 22915.885420573122, 23144.0, 23155.189568365025, 23161.0, 23325.650115248285, 8682.392232543787, 8760.8685869712, 8764.386492945432, 8779.780505487413, 8842.734717958472, 7362.705491780269, 7364.631768411558, 7368.15266244378, 7371.852562948711, 7435.0, 7601.543907365576, 7730.432094456516, 7739.071311442663, 7751.302382785577, 7895.644695988694, 3049.16148059281, 3055.847207639609, 3174.4603417419094, 3194.536792165123, 3211.6467188609236, 357.91946811967097, 363.33328342491825, 368.18814513996574, 374.6759053418773, 380.3458052150297, 9658.420494770337, 9830.4101753895, 9882.308238423386, 9953.950230248802, 10025.097741203326, 385.32760333218715, 388.8852788427421, 389.98245078971513, 390.75968279508464, 400.0858039380061, 5243.606729495303, 5625.296837895263, 5661.46216109469, 5669.688167150764, 5706.229658996065, 457252.0, 466551.0, 471039.0, 474190.0, 476507.0, 63603.0, 65723.0, 67865.66067169633, 71072.2892771076, 73736.63131684308, 1052.8631277933819, 1053.6154303679255, 1060.4644654449608, 1078.563181911327, 1079.983800242997, 14782.556523304318, 14812.7778083331, 14827.258637067887, 15020.699586008437, 15442.2278886053, 33876.322473550885, 34122.65877341294, 34625.0, 35018.649813501535, 35323.0, 44395.0, 45489.31766023446, 45503.54496454993, 45536.08927821491, 51340.0, 13290.734185316433, 13795.655108621962, 13927.721445571235, 14608.342624581706, 14621.92689036548, 17486.562835929202, 17600.0, 17773.911130444267, 17806.732899006267, 18447.0, 9019.77450563715, 9435.009324020879, 9438.85841712361, 14194.929025354808, 14896.329665164876, 8963.731088067369, 9081.218299279444, 9291.860622090539, 9418.95290523543, 9511.524423778921, 9667.951660241653, 9827.361221520578, 9908.009199080034, 9920.255980801325, 9937.055979681918, 14083.436662533793, 14087.225202613954, 14151.929240353733, 14208.644783880485, 14325.355359009078, 14750.967432279638, 14935.0, 14990.250487475365, 15051.924740376227, 15164.241787910782], "unit": "ms", "name": "jquery.html", "value": 8722.39881358667}, {"lowerIsBetter": false, "replicates": [1490.1208287110603, 1646.8188499265082, 1679.5297316751307, 1688.679150961318, 1713.4773893962335, 6192.102145188945, 6368.140301059356, 7236.167840698321, 7379.1513975892785, 7401.148867880189, 6819.49971006379, 6904.620245886475, 6966.16406031277, 6983.580985140882, 6987.161540615133, 2089.2896415218784, 2136.8824714640687, 2141.732283464567, 2143.132031527234, 2148.151480165334, 2107.6417009108486, 2131.381899249224, 2170.7937745914114, 2179.08478439056, 2187.0158428707146, 2030.1777779999125, 2046.7850875658064, 2054.435030366646, 2076.169532187122, 2083.5207902182506, 2093.6859471079306, 2118.8304935605115, 2120.2473122041683, 2121.5650791587686, 2125.3517677108475, 2092.2886218685567, 2138.176801931252, 2141.2291575032978, 2150.806427421524, 2154.1060459909118, 7207.351338379571, 7288.271172882669, 7299.19708832028, 7299.598522081284, 7311.0, 4106.404571337169, 4171.749695018309, 4205.789710514462, 4206.936895946563, 4213.199492096523, 2775.777937764974, 2785.5264605017196, 2839.2475993861644, 2848.060140153744, 2855.6430446194227, 866.8353012927587, 901.3825529512239, 931.6226928094133, 936.3679516326453, 938.4275591888942, 9591.856122158173, 9617.51912404377, 9623.663171789023, 9633.759156021015, 9645.517724113766, 3958.188571342868, 4050.696197785178, 4059.878203653836, 4080.0207950091763, 4088.2436749201493, 8254.339652827879, 8295.95852020736, 8332.291755200877, 8340.374471914509, 8345.207205315486, 4120.75275483472, 4150.543440221573, 4155.480564929384, 4184.81168347419, 4188.28799104153, 3246.918827029343, 3349.1292264011045, 3756.436534519844, 3763.7741735495956, 3835.0, 3485.634008429078, 3511.4908338290807, 3513.701335386521, 3529.27649831789, 3531.9293614127573, 1071.3678929431674, 1077.3374374759624, 1081.2431298091367, 1086.706589220906, 1087.374759513283, 881.9867701984475, 948.5257371314343, 1141.1042331769522, 1158.1892675127444, 1168.363242033094, 6757.560758550679, 6786.966065169642, 6819.045333653194, 6842.247352791189, 6861.691223894937, 982.916452101565, 1066.2003497376968, 1071.9624813131502, 1072.2119242356862, 1102.7959827431791, 5261.631685782035, 5278.20826875964, 5281.735913204325, 5291.603129765283, 5318.202269659505, 8637.352198585006, 8684.696035638848, 8924.821503570021, 8943.329250306253, 9017.909820901707, 8760.824783504422, 8779.868301975475, 8844.911550884408, 8872.290216782641, 8936.329775266751, 6699.665016749143, 6704.161979752531, 6787.6266805325195, 6868.244493105654, 6976.860462790716, 6485.383888530582, 6494.383033611799, 6531.869362612816, 6552.0, 6559.180102487189, 7708.4218683600075, 7851.725189618336, 7918.762437126896, 7921.801954951173, 7941.404394670307, 7966.84066318682, 8075.87886181696, 8114.0, 8151.184881511801, 8184.8363032737825, 5037.697738135724, 5424.53891419218, 5444.782208711607, 6092.482139018233, 6141.692915354304, 6937.132858392701, 6937.687804048931, 6956.165260168812, 6976.825579360557, 6978.860422791414, 6577.276499584946, 6648.069270302259, 6673.099131617169, 6730.158730158731, 6793.592384456949, 6391.9041214380895, 6461.321561236191, 6567.343265673395, 6576.76981305652, 6637.70130344126, 6634.203895532374, 6677.565958212895, 6687.832804179934, 6690.6320152390135, 6692.096566963398, 6074.878502430015, 6105.664188469676, 6119.265688117454, 6119.296280927751, 6132.78535251264, 6168.753249869955, 6172.814815555541, 6192.938070619236, 6194.876102478015, 6199.3490683477585], "unit": "ms", "name": "mootools.html", "value": 4156.365690191133}, {"lowerIsBetter": false, "replicates": [286.1715334107758, 294.254065942835, 294.78922570362187, 295.3738075280406, 295.91566403574984, 5547.500724934755, 5568.220449137119, 5594.86012849679, 5614.578906582013, 5638.605297629168, 5506.201600767887, 5520.736498035806, 5523.972380138093, 5533.833984980457, 5538.501534861862, 4269.935950960738, 4271.231178387904, 4278.315469524877, 4281.272183728774, 4288.785560721967, 4102.774347410891, 4117.155983023488, 4118.0322624183445, 4122.546519882825, 4134.834606615732, 4067.491563554556, 4068.3897415387632, 4072.796360181994, 4074.6740260779065, 4075.6535694466006, 4082.2243773682903, 4122.072533679928, 4155.688323375759, 4157.334826427757, 4165.666746660275, 3587.157018100744, 3587.497750314958, 3592.3354179476883, 3595.083253770298, 3595.5505561804775, 5163.819266325698, 5182.248573956793, 5304.73476326186, 5305.734713264322, 5346.599005074635, 4814.927776083362, 4825.927611085836, 4828.61371090312, 4829.589484893788, 4832.444268909086, 5835.0372188588835, 5841.532677385841, 5847.707614619252, 5852.092925596539, 5863.648181109147, 3945.704072194597, 3946.112124771932, 3946.289667859784, 3949.486566746333, 3952.229315283521, 5884.9705751470965, 6087.756489740405, 6120.877582448371, 6126.846828829271, 6147.661878596676, 4001.7198796083994, 4001.979990100031, 4002.799860006988, 4004.799760012046, 4009.558948515661, 4045.19096180765, 4046.3121269384274, 4046.8785936421955, 4054.7567145971334, 4056.6957478189256, 4734.337192793012, 4756.7145971241835, 4758.643101767312, 4763.309320148559, 4765.904681906342, 5616.2698849150165, 5792.0, 5800.796972105956, 5801.94198058014, 5808.7095645218415, 1430.0918916487897, 1443.6679563700409, 1447.0811034992855, 1447.2185020089244, 1447.3052934591456, 958.0611001218845, 961.4904100826573, 962.605331813953, 975.7560609847538, 978.9363691360039, 5059.696418214845, 5064.645474816727, 5065.518775716301, 5069.543741063322, 5101.617378696613, 6017.2779266488305, 6050.092486127028, 6060.454559089703, 6066.0, 6104.114903338991, 5067.721275329818, 5071.771770270347, 5072.18844984808, 5073.923891141636, 5080.923786143211, 3201.5677883485896, 3254.6582608825734, 3260.103471545344, 3271.85276662546, 3288.177955511122, 5674.0, 5689.971550142222, 5704.543636509069, 5705.828825135252, 5709.314882214161, 6083.9391606084255, 6249.937500625027, 6254.437100660963, 6276.623402595859, 6284.591501552384, 5664.858378540487, 5666.206731057655, 5698.572607054488, 5702.8289151325525, 5703.287089113861, 6042.637441753509, 6071.241094863142, 6076.787312444043, 6077.908831367621, 6083.452489275986, 5783.7397317119985, 5940.910886336622, 5941.91087133702, 5950.583459157818, 5963.075723262901, 5669.489745922887, 5671.688057156896, 5672.290963629546, 5673.716314184357, 5676.148577713376, 4069.6337329640473, 4118.444010058603, 4121.031557583906, 4124.690648201336, 4130.235906357333, 5942.049272116441, 6051.878962420815, 6065.878682426239, 6073.423024812812, 6091.543134264859, 5823.388544202798, 5826.271716035496, 5841.153032810304, 5841.649501029951, 5844.532437405082, 5816.767329306949, 5845.707714614167, 5850.7074646266665, 5850.824475265749, 5860.560457965585, 5686.2323586315315, 5714.542836573148, 5715.257016587817, 5718.542516598579, 5727.799527016535, 5769.221155144001, 5813.82558523245, 5838.0, 5886.852828679317, 5907.084401917709, 5709.314882214161, 5742.368339482737, 5743.59794814359, 5744.626599271034, 5761.423857614205], "unit": "ms", "name": "prototype.html", "value": 4315.48399069532}, {"lowerIsBetter": false, "replicates": [645.3739872323845, 734.7722206116102, 747.0960138232738, 766.2643861892583, 772.1274959295995, 11639.127065470091, 11961.880381196186, 11993.64019079429, 12027.458764355613, 12031.278123312608, 12831.679208019805, 12856.67858303543, 12859.421326040327, 12866.0, 12866.742665146692, 770.9383249340067, 774.9845003099935, 775.3990657240628, 781.0978320040363, 792.065362871811, 771.6180490657133, 772.1390649425906, 772.6600295869828, 773.8839174123871, 774.2373761844578, 824.579464473117, 830.161536847782, 830.2071521696765, 830.2320353672828, 830.6428235858579, 810.4934415990007, 817.9713710020151, 819.7499762572413, 821.4250024982506, 821.7863355527546, 607.9817605471843, 608.2305883057935, 609.5580703989572, 612.017711572928, 612.2408213814838, 12467.438965246494, 12500.874991250063, 12557.05822063349, 12566.68583285416, 12597.622071337875, 10706.518206680641, 10748.408837513934, 10793.5682572697, 10969.725756856064, 12044.0, 8588.484690918565, 8690.217880390732, 8707.912920870773, 8900.37697361185, 9015.14356136166, 3089.922751931197, 3149.370125974814, 3167.2715275486535, 3180.997985634541, 3202.2154572129743, 43008.784956075644, 43264.78367608142, 43508.3473747894, 43935.56064439347, 43979.12041759147, 8535.95732021336, 8872.24585910205, 8991.460512369147, 9019.278457723367, 9410.95294523523, 16394.83605163933, 16545.090020049014, 16554.58613534671, 16561.751573726404, 16638.0, 6057.091436284504, 6077.24034495688, 6114.205153330127, 6217.191765070603, 6244.12582238487, 3545.06055895188, 3576.070221742366, 3608.226916497608, 3613.530241068697, 3675.0628589709986, 2693.313205132679, 2734.2207470871103, 2735.42556063225, 2738.0, 2742.163640089792, 478.15366800762456, 480.0662711027019, 484.92726091085916, 493.361097378888, 497.73868718922853, 455.67191622032084, 474.5349557433734, 475.41286511158694, 487.4564860180944, 540.5135378159688, 7427.4800763946005, 7672.769816905502, 7896.960515197387, 8019.839603207904, 8107.918920810716, 477.3102866358079, 514.5163546266498, 574.9540036797047, 575.1372940589116, 605.4853374631527, 3357.5970883494138, 3432.5709286339206, 3446.9482957755654, 3564.91087722809, 3582.5342705448124, 55221.44778552243, 55722.16416753671, 55852.720736396055, 56029.0, 56264.0, 46753.0, 47429.76285118552, 47736.0, 48560.27159592609, 48714.756426217646, 43359.34960975588, 44737.55262447334, 44930.101397971855, 45195.0, 45216.32175517304, 7533.472656913963, 7622.58075805836, 7663.923360766544, 7676.0, 7722.41532133554, 31225.531617026216, 31407.68592314139, 31690.04929852108, 31692.841535793097, 31837.36325273528, 37335.25329493449, 37735.433968489946, 37778.62221377751, 42711.7864410676, 42723.57276427196, 8032.437729358889, 8187.426880118334, 9049.547522623974, 9854.901450985399, 10107.0, 11253.381064041556, 11462.828057578976, 11562.479688413874, 11774.234674746114, 11879.168458207843, 10495.0, 10532.842007370049, 10596.89403105959, 10701.51843167075, 10769.515371808444, 10478.58085676595, 10820.242583019113, 11033.117350611772, 11041.779164416506, 11057.723556911142, 10421.322614030063, 10531.262811603114, 10551.0, 10597.0, 11230.887691122984, 8756.737297881074, 9103.453792772454, 9169.54152292396, 9277.0, 9500.382475139093, 8632.611532480927, 8785.912140878509, 8838.381313308264, 8896.243819275434, 8906.73279801607], "unit": "ms", "name": "yui.html", "value": 5715.179678696146}], "name": "dromaeo_css", "value": 6423.887771630943}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 113.0, 113.0, 113.0, 127.0, 115.0, 113.0, 114.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [161.0, 131.0, 156.0, 177.0, 132.0, 165.0, 153.0, 135.0, 167.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 162.0, 164.0, 167.0, 163.0, 162.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 73.0, 147.0, 72.0, 73.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 142.0, 94.0, 94.0, 94.0, 134.0, 95.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [113.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 72.0, 74.0, 72.0, 72.0, 72.0, 70.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 92.0, 86.0, 85.0, 84.0, 86.0, 86.0, 87.0, 96.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [128.0, 122.0, 121.0, 129.0, 132.0, 137.0, 129.0, 138.0, 130.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 153.0, 148.0, 149.0, 146.0, 148.0, 147.0, 135.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 69.0, 69.0, 73.0, 68.0, 71.0, 70.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1542.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.8335001668335], "unit": "score", "name": "Richards", "value": 211.6001880000001}, {"lowerIsBetter": false, "replicates": [183.75597206909225], "unit": "score", "name": "DeltaBlue", "value": 359.81415599999985}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1142.6940639269405], "unit": "score", "name": "RayTrace", "value": 647.5827812187812}, {"lowerIsBetter": false, "replicates": [695.8942240779402], "unit": "score", "name": "Earley", "value": 957.7073310000004}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [1633.986928104575], "unit": "score", "name": "Splay", "value": 49.872492}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19307.694723618963}]} 05:01:17 INFO - RETURN: dromaeo_css: 6423.89 05:01:17 INFO - RETURN: kraken: 1542.10 05:01:17 INFO - RETURN: v8_7: 19307.69 05:01:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "19307.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1542.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6423.89"}}} 05:01:17 INFO - Return code: 0 05:01:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:01:17 INFO - # TBPL SUCCESS # 05:01:17 INFO - Running post-action listener: _resource_record_post_action 05:01:17 INFO - Running post-run listener: _resource_record_post_run 05:01:19 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506433536; Read time: 12; Write time: 457360 05:01:19 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 230772736; Read time: 0; Write time: 287188 05:01:19 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275226624; Read time: 12; Write time: 170148 05:01:19 INFO - Running post-run listener: _upload_blobber_files 05:01:19 INFO - Blob upload gear active. 05:01:19 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:01:19 INFO - Copying logs to upload dir... 05:01:19 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.834503 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-03 05:01:19.017426) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 05:01:19.020861) ========= 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=820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010075 build_url: 'https://queue.taskcluster.net/v1/task/mnCPUuZqSpqrW8cSN0zsag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 05:01:19.076658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 05:01:19.077323) ========= 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=820bb6602ddf640013a48df2000001a9-1449146411.592751-166232683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 05:01:19.130146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 05:01:19.130795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 05:01:19.131146) ========= ========= Total master_lag: 0.24 =========