builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1449498925.16 results: success (0) buildid: 20151207051729 builduid: 5bc339d3f05b4e65abe830512698c4f8 revision: 59bc3c7a83de7ffb611203912a7da6ad84535a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.160003) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.160449) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.160747) ========= 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=5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006415 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.203019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.203371) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.217604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.218040) ========= 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=5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.268975) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.269267) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.269640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.269913) ========= 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=5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-07 06:35:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.0M=0s 2015-12-07 06:35:26 (78.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.470168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.470465) ========= 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=5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018471 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.520085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.520425) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 59bc3c7a83de7ffb611203912a7da6ad84535a5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 59bc3c7a83de7ffb611203912a7da6ad84535a5a --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=5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-07 06:35:26,430 truncating revision to first 12 chars 2015-12-07 06:35:26,430 Setting DEBUG logging. 2015-12-07 06:35:26,430 attempt 1/10 2015-12-07 06:35:26,430 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/59bc3c7a83de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-07 06:35:26,668 unpacking tar archive at: mozilla-central-59bc3c7a83de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.508106 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:26.041709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:26.042015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:26.049512) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:26.049787) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:26.050164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-07 06:35:26.050471) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:35:27 INFO - MultiFileLogger online at 20151207 06:35:27 in /builds/slave/test 06:35:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:35:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:35:27 INFO - {'append_to_log': False, 06:35:27 INFO - 'base_work_dir': '/builds/slave/test', 06:35:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:35:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:35:27 INFO - 'branch': 'Firefox-Non-PGO', 06:35:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:35:27 INFO - 'config_files': ('talos/linux_config.py',), 06:35:27 INFO - 'default_actions': ('clobber', 06:35:27 INFO - 'read-buildbot-config', 06:35:27 INFO - 'download-and-extract', 06:35:27 INFO - 'populate-webroot', 06:35:27 INFO - 'create-virtualenv', 06:35:27 INFO - 'install', 06:35:27 INFO - 'run-tests'), 06:35:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:35:27 INFO - 'download_minidump_stackwalk': True, 06:35:27 INFO - 'download_symbols': 'ondemand', 06:35:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:35:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:35:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:35:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:35:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:35:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:35:27 INFO - 'installer_path': 'installer.exe', 06:35:27 INFO - 'log_level': 'info', 06:35:27 INFO - 'log_name': 'talos', 06:35:27 INFO - 'log_to_console': True, 06:35:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:35:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:35:27 INFO - 'opt_config_files': (), 06:35:27 INFO - 'pip_index': False, 06:35:27 INFO - 'sps_profile': False, 06:35:27 INFO - 'sps_profile_interval': 0, 06:35:27 INFO - 'suite': 'dromaeojs-e10s', 06:35:27 INFO - 'system_bits': '64', 06:35:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:27 INFO - 'title': 'talos-linux64-ix-061', 06:35:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:35:27 INFO - 'use_talos_json': True, 06:35:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:35:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:35:27 INFO - 'work_dir': 'build'} 06:35:27 INFO - ##### 06:35:27 INFO - ##### Running clobber step. 06:35:27 INFO - ##### 06:35:27 INFO - Running pre-action listener: _resource_record_pre_action 06:35:27 INFO - Running main action method: clobber 06:35:27 INFO - rmtree: /builds/slave/test/build 06:35:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:35:27 INFO - Running post-action listener: _resource_record_post_action 06:35:27 INFO - ##### 06:35:27 INFO - ##### Running read-buildbot-config step. 06:35:27 INFO - ##### 06:35:27 INFO - Running pre-action listener: _resource_record_pre_action 06:35:27 INFO - Running main action method: read_buildbot_config 06:35:27 INFO - Using buildbot properties: 06:35:27 INFO - { 06:35:27 INFO - "properties": { 06:35:27 INFO - "buildnumber": 136, 06:35:27 INFO - "product": "firefox", 06:35:27 INFO - "script_repo_revision": "production", 06:35:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:35:27 INFO - "repository": "", 06:35:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:35:27 INFO - "buildid": "20151207051729", 06:35:27 INFO - "slavename": "talos-linux64-ix-061", 06:35:27 INFO - "pgo_build": "False", 06:35:27 INFO - "basedir": "/builds/slave/test", 06:35:27 INFO - "project": "", 06:35:27 INFO - "platform": "ubuntu64_hw", 06:35:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:35:27 INFO - "slavebuilddir": "test", 06:35:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:35:27 INFO - "branch": "mozilla-central", 06:35:27 INFO - "repo_path": "mozilla-central", 06:35:27 INFO - "stage_platform": "linux64", 06:35:27 INFO - "builduid": "5bc339d3f05b4e65abe830512698c4f8", 06:35:27 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 06:35:27 INFO - }, 06:35:27 INFO - "sourcestamp": { 06:35:27 INFO - "repository": "", 06:35:27 INFO - "hasPatch": false, 06:35:27 INFO - "project": "", 06:35:27 INFO - "branch": "mozilla-central-linux64-talos", 06:35:27 INFO - "changes": [ 06:35:27 INFO - { 06:35:27 INFO - "category": null, 06:35:27 INFO - "files": [ 06:35:27 INFO - { 06:35:27 INFO - "url": null, 06:35:27 INFO - "name": "https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:35:27 INFO - } 06:35:27 INFO - ], 06:35:27 INFO - "repository": "", 06:35:27 INFO - "rev": "59bc3c7a83de7ffb611203912a7da6ad84535a5a", 06:35:27 INFO - "who": "cbook@mozilla.com", 06:35:27 INFO - "when": 1449498835, 06:35:27 INFO - "number": 6963273, 06:35:27 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 06:35:27 INFO - "project": "", 06:35:27 INFO - "at": "Mon 07 Dec 2015 06:33:55", 06:35:27 INFO - "branch": "mozilla-central-linux64-talos", 06:35:27 INFO - "revlink": "", 06:35:27 INFO - "properties": [ 06:35:27 INFO - [ 06:35:27 INFO - "buildid", 06:35:27 INFO - "20151207051729", 06:35:27 INFO - "Change" 06:35:27 INFO - ], 06:35:27 INFO - [ 06:35:27 INFO - "builduid", 06:35:27 INFO - "5bc339d3f05b4e65abe830512698c4f8", 06:35:27 INFO - "Change" 06:35:27 INFO - ], 06:35:27 INFO - [ 06:35:27 INFO - "pgo_build", 06:35:27 INFO - "False", 06:35:27 INFO - "Change" 06:35:27 INFO - ] 06:35:27 INFO - ], 06:35:27 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 06:35:27 INFO - } 06:35:27 INFO - ], 06:35:27 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 06:35:27 INFO - } 06:35:27 INFO - } 06:35:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:35:27 INFO - Running post-action listener: _resource_record_post_action 06:35:27 INFO - ##### 06:35:27 INFO - ##### Running download-and-extract step. 06:35:27 INFO - ##### 06:35:27 INFO - Running pre-action listener: _resource_record_pre_action 06:35:27 INFO - Running main action method: download_and_extract 06:35:27 INFO - mkdir: /builds/slave/test/build/tests 06:35: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')]} 06:35:27 INFO - https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:35:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/test_packages.json 06:35:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/test_packages.json 06:35:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:35:33 INFO - Downloaded 1302 bytes. 06:35:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:35:33 INFO - Using the following test package requirements: 06:35:33 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:35:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:35:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:33 INFO - u'jsshell-linux-x86_64.zip'], 06:35:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:35:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:35:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:35:33 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:35:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:35:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:35:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:35:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:35: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')]} 06:35:33 INFO - https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:35:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:35:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:35:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/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 06:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/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 06:35:34 INFO - Downloaded 21859907 bytes. 06:35:34 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 06:35:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:35:34 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 06:35:35 INFO - Return code: 0 06:35:35 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 06:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:35 INFO - https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:35:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:35:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:35:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/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 06:35:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/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 06:35:38 INFO - Downloaded 21859907 bytes. 06:35:38 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 06:35:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:35:38 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 06:35:39 INFO - Return code: 0 06:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:39 INFO - https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:35:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:35:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:35:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/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 06:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/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 06:35:40 INFO - Downloaded 11132074 bytes. 06:35:40 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 06:35:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:35:40 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 06:35:41 INFO - Return code: 0 06:35:41 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')]} 06:35:41 INFO - https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/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 06:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EakUL9dtSBWy2BZG-Pna-w/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 06:35:42 INFO - Downloaded 57726599 bytes. 06:35:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:35:42 INFO - mkdir: /builds/slave/test/properties 06:35:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:42 INFO - Contents: 06:35:42 INFO - build_url:https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:35:42 INFO - Running post-action listener: _resource_record_post_action 06:35:42 INFO - Running post-action listener: set_extra_try_arguments 06:35:42 INFO - ##### 06:35:42 INFO - ##### Running populate-webroot step. 06:35:42 INFO - ##### 06:35:42 INFO - Running pre-action listener: _resource_record_pre_action 06:35:42 INFO - Running main action method: populate_webroot 06:35:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:42 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:35:42 INFO - '../fennec_ids.txt'], 06:35:42 INFO - 'tests': ['tcheck2']}, 06:35:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:42 INFO - '--tppagecycles', 06:35:42 INFO - '7'], 06:35:42 INFO - 'tests': ['tsvgm']}}, 06:35:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:35:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:35:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:35:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:42 INFO - 'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:42 INFO - 'tests': ['damp', 'tps']}, 06:35:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:42 INFO - 'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['damp', 'tps']}, 06:35:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:35:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:42 INFO - 'other': {'tests': ['a11yr', 06:35:42 INFO - 'ts_paint', 06:35:42 INFO - 'tpaint', 06:35:42 INFO - 'sessionrestore', 06:35:42 INFO - 'sessionrestore_no_auto_restore']}, 06:35:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['a11yr', 06:35:42 INFO - 'ts_paint', 06:35:42 INFO - 'tpaint', 06:35:42 INFO - 'sessionrestore', 06:35:42 INFO - 'sessionrestore_no_auto_restore']}, 06:35:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['a11yr', 06:35:42 INFO - 'ts_paint', 06:35:42 INFO - 'tpaint', 06:35:42 INFO - 'sessionrestore', 06:35:42 INFO - 'sessionrestore_no_auto_restore']}, 06:35:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['a11yr', 06:35:42 INFO - 'ts_paint', 06:35:42 INFO - 'tpaint', 06:35:42 INFO - 'sessionrestore', 06:35:42 INFO - 'sessionrestore_no_auto_restore']}, 06:35:42 INFO - 'other_l64': {'tests': ['a11yr', 06:35:42 INFO - 'ts_paint', 06:35:42 INFO - 'tpaint', 06:35:42 INFO - 'sessionrestore', 06:35:42 INFO - 'sessionrestore_no_auto_restore']}, 06:35:42 INFO - 'other_nol64': {'tests': ['a11yr', 06:35:42 INFO - 'ts_paint', 06:35:42 INFO - 'tpaint', 06:35:42 INFO - 'sessionrestore', 06:35:42 INFO - 'sessionrestore_no_auto_restore']}, 06:35:42 INFO - 'svgr': {'tests': ['tsvgx', 06:35:42 INFO - 'tsvgr_opacity', 06:35:42 INFO - 'tart', 06:35:42 INFO - 'tscrollx', 06:35:42 INFO - 'cart']}, 06:35:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['tsvgx', 06:35:42 INFO - 'tsvgr_opacity', 06:35:42 INFO - 'tart', 06:35:42 INFO - 'tscrollx', 06:35:42 INFO - 'cart']}, 06:35:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:42 INFO - 'tests': ['tp5o']}, 06:35:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:42 INFO - 'talos_options': ['--e10s'], 06:35:42 INFO - 'tests': ['tp5o']}, 06:35:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:42 INFO - 'talos_options': ['--xperf_path', 06:35:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:42 INFO - 'tests': ['tp5n']}, 06:35:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:42 INFO - 'talos_options': ['--e10s', 06:35:42 INFO - '--xperf_path', 06:35:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:42 INFO - 'tests': ['tp5n']}}, 06:35:42 INFO - 'talos.zip': {'path': '', 06:35:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:42 INFO - Running post-action listener: _resource_record_post_action 06:35:42 INFO - ##### 06:35:42 INFO - ##### Running create-virtualenv step. 06:35:42 INFO - ##### 06:35:42 INFO - Running pre-action listener: _resource_record_pre_action 06:35:42 INFO - Running main action method: create_virtualenv 06:35:42 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:42 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 06:35:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:42 INFO - Using real prefix '/usr' 06:35:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:45 INFO - Installing pip.................done. 06:35:45 INFO - Return code: 0 06:35:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:45 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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:35:45 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 06:35:45 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 06:35:45 INFO - Using env: {'DISPLAY': ':0', 06:35:45 INFO - 'HOME': '/home/cltbld', 06:35:45 INFO - 'LANG': 'en_US.UTF-8', 06:35:45 INFO - 'LANGUAGE': 'en_US:en', 06:35:45 INFO - 'LOGNAME': 'cltbld', 06:35:45 INFO - 'MAIL': '/var/mail/cltbld', 06:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:45 INFO - 'MOZ_NO_REMOTE': '1', 06:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:45 INFO - 'NO_EM_RESTART': '1', 06:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:45 INFO - 'PWD': '/builds/slave/test', 06:35:45 INFO - 'SHELL': '/bin/bash', 06:35:45 INFO - 'SHLVL': '1', 06:35:45 INFO - 'TERM': 'linux', 06:35:45 INFO - 'TMOUT': '86400', 06:35:45 INFO - 'USER': 'cltbld', 06:35:45 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:45 INFO - '_': '/tools/buildbot/bin/python'} 06:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:45 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 06:35:45 INFO - Cleaning up... 06:35:45 INFO - Return code: 0 06:35:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:45 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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:35:45 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 06:35:45 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 06:35:45 INFO - Using env: {'DISPLAY': ':0', 06:35:45 INFO - 'HOME': '/home/cltbld', 06:35:45 INFO - 'LANG': 'en_US.UTF-8', 06:35:45 INFO - 'LANGUAGE': 'en_US:en', 06:35:45 INFO - 'LOGNAME': 'cltbld', 06:35:45 INFO - 'MAIL': '/var/mail/cltbld', 06:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:45 INFO - 'MOZ_NO_REMOTE': '1', 06:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:45 INFO - 'NO_EM_RESTART': '1', 06:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:45 INFO - 'PWD': '/builds/slave/test', 06:35:45 INFO - 'SHELL': '/bin/bash', 06:35:45 INFO - 'SHLVL': '1', 06:35:45 INFO - 'TERM': 'linux', 06:35:45 INFO - 'TMOUT': '86400', 06:35:45 INFO - 'USER': 'cltbld', 06:35:45 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:45 INFO - '_': '/tools/buildbot/bin/python'} 06:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:45 INFO - Downloading/unpacking psutil>=0.7.1 06:35:45 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 06:35:45 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 06:35:45 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 06:35:45 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 06:35:45 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 06:35:45 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 06:35:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:35:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:35:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:47 INFO - Installing collected packages: psutil 06:35:47 INFO - Running setup.py install for psutil 06:35:47 INFO - building 'psutil._psutil_linux' extension 06:35:47 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 06:35:47 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 06:35:47 INFO - building 'psutil._psutil_posix' extension 06:35:47 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 06:35:47 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 06:35:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:47 INFO - Successfully installed psutil 06:35:47 INFO - Cleaning up... 06:35:47 INFO - Return code: 0 06:35:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:47 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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:35:47 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 06:35:47 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 06:35:47 INFO - Using env: {'DISPLAY': ':0', 06:35:47 INFO - 'HOME': '/home/cltbld', 06:35:47 INFO - 'LANG': 'en_US.UTF-8', 06:35:47 INFO - 'LANGUAGE': 'en_US:en', 06:35:47 INFO - 'LOGNAME': 'cltbld', 06:35:47 INFO - 'MAIL': '/var/mail/cltbld', 06:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:47 INFO - 'MOZ_NO_REMOTE': '1', 06:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:47 INFO - 'NO_EM_RESTART': '1', 06:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:47 INFO - 'PWD': '/builds/slave/test', 06:35:47 INFO - 'SHELL': '/bin/bash', 06:35:47 INFO - 'SHLVL': '1', 06:35:47 INFO - 'TERM': 'linux', 06:35:47 INFO - 'TMOUT': '86400', 06:35:47 INFO - 'USER': 'cltbld', 06:35:47 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:47 INFO - '_': '/tools/buildbot/bin/python'} 06:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:35:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:35:49 INFO - Installing collected packages: mozsystemmonitor 06:35:49 INFO - Running setup.py install for mozsystemmonitor 06:35:49 INFO - Successfully installed mozsystemmonitor 06:35:49 INFO - Cleaning up... 06:35:49 INFO - Return code: 0 06:35:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:49 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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:35:49 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 06:35:49 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 06:35:49 INFO - Using env: {'DISPLAY': ':0', 06:35:49 INFO - 'HOME': '/home/cltbld', 06:35:49 INFO - 'LANG': 'en_US.UTF-8', 06:35:49 INFO - 'LANGUAGE': 'en_US:en', 06:35:49 INFO - 'LOGNAME': 'cltbld', 06:35:49 INFO - 'MAIL': '/var/mail/cltbld', 06:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:49 INFO - 'MOZ_NO_REMOTE': '1', 06:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:49 INFO - 'NO_EM_RESTART': '1', 06:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:49 INFO - 'PWD': '/builds/slave/test', 06:35:49 INFO - 'SHELL': '/bin/bash', 06:35:49 INFO - 'SHLVL': '1', 06:35:49 INFO - 'TERM': 'linux', 06:35:49 INFO - 'TMOUT': '86400', 06:35:49 INFO - 'USER': 'cltbld', 06:35:49 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:49 INFO - '_': '/tools/buildbot/bin/python'} 06:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:51 INFO - Downloading blobuploader-1.2.4.tar.gz 06:35:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:35:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:35:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:35:52 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 06:35:52 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 06:35:52 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 06:35:52 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 06:35:52 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 06:35:52 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 06:35:52 INFO - Downloading docopt-0.6.1.tar.gz 06:35:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:35:52 INFO - Installing collected packages: blobuploader, requests, docopt 06:35:52 INFO - Running setup.py install for blobuploader 06:35:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:35:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:35:52 INFO - Running setup.py install for requests 06:35:52 INFO - Running setup.py install for docopt 06:35:53 INFO - Successfully installed blobuploader requests docopt 06:35:53 INFO - Cleaning up... 06:35:53 INFO - Return code: 0 06:35:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:53 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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:35:53 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 06:35:53 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 06:35:53 INFO - Using env: {'DISPLAY': ':0', 06:35:53 INFO - 'HOME': '/home/cltbld', 06:35:53 INFO - 'LANG': 'en_US.UTF-8', 06:35:53 INFO - 'LANGUAGE': 'en_US:en', 06:35:53 INFO - 'LOGNAME': 'cltbld', 06:35:53 INFO - 'MAIL': '/var/mail/cltbld', 06:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:53 INFO - 'MOZ_NO_REMOTE': '1', 06:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:53 INFO - 'NO_EM_RESTART': '1', 06:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:53 INFO - 'PWD': '/builds/slave/test', 06:35:53 INFO - 'SHELL': '/bin/bash', 06:35:53 INFO - 'SHLVL': '1', 06:35:53 INFO - 'TERM': 'linux', 06:35:53 INFO - 'TMOUT': '86400', 06:35:53 INFO - 'USER': 'cltbld', 06:35:53 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:53 INFO - '_': '/tools/buildbot/bin/python'} 06:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:53 INFO - Running setup.py (path:/tmp/pip-2N3kzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:53 INFO - Running setup.py (path:/tmp/pip-hkES4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:53 INFO - Running setup.py (path:/tmp/pip-RoH70T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:53 INFO - Running setup.py (path:/tmp/pip-3tXzDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:53 INFO - Running setup.py (path:/tmp/pip-5CaJyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:53 INFO - Running setup.py (path:/tmp/pip-QyaJms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:53 INFO - Running setup.py (path:/tmp/pip-RrYS2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:53 INFO - Running setup.py (path:/tmp/pip-5lVV9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:53 INFO - Running setup.py (path:/tmp/pip-oadao9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:53 INFO - Running setup.py (path:/tmp/pip-xL13jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:54 INFO - Running setup.py (path:/tmp/pip-3xmwcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:54 INFO - Running setup.py (path:/tmp/pip-Wkv37q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:54 INFO - Running setup.py (path:/tmp/pip-ybNkmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:54 INFO - Running setup.py (path:/tmp/pip-dLYkRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:54 INFO - Running setup.py (path:/tmp/pip-vAyH_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:54 INFO - Running setup.py (path:/tmp/pip-JUUUPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:54 INFO - Running setup.py (path:/tmp/pip-n7rVLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:35:54 INFO - Running setup.py install for manifestparser 06:35:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Running setup.py install for mozcrash 06:35:54 INFO - Running setup.py install for mozdebug 06:35:54 INFO - Running setup.py install for mozdevice 06:35:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Running setup.py install for mozfile 06:35:55 INFO - Running setup.py install for mozhttpd 06:35:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Running setup.py install for mozinfo 06:35:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Running setup.py install for mozInstall 06:35:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Running setup.py install for mozleak 06:35:55 INFO - Running setup.py install for mozlog 06:35:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Running setup.py install for moznetwork 06:35:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Running setup.py install for mozprocess 06:35:55 INFO - Running setup.py install for mozprofile 06:35:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Running setup.py install for mozrunner 06:35:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:35:56 INFO - Running setup.py install for mozscreenshot 06:35:56 INFO - Running setup.py install for moztest 06:35:56 INFO - Running setup.py install for mozversion 06:35:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:35:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:35:56 INFO - Cleaning up... 06:35:56 INFO - Return code: 0 06:35:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:35:56 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 06:35:56 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 06:35:56 INFO - Using env: {'DISPLAY': ':0', 06:35:56 INFO - 'HOME': '/home/cltbld', 06:35:56 INFO - 'LANG': 'en_US.UTF-8', 06:35:56 INFO - 'LANGUAGE': 'en_US:en', 06:35:56 INFO - 'LOGNAME': 'cltbld', 06:35:56 INFO - 'MAIL': '/var/mail/cltbld', 06:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:56 INFO - 'MOZ_NO_REMOTE': '1', 06:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:56 INFO - 'NO_EM_RESTART': '1', 06:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:56 INFO - 'PWD': '/builds/slave/test', 06:35:56 INFO - 'SHELL': '/bin/bash', 06:35:56 INFO - 'SHLVL': '1', 06:35:56 INFO - 'TERM': 'linux', 06:35:56 INFO - 'TMOUT': '86400', 06:35:56 INFO - 'USER': 'cltbld', 06:35:56 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:56 INFO - '_': '/tools/buildbot/bin/python'} 06:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:56 INFO - Running setup.py (path:/tmp/pip-YdptT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:56 INFO - Running setup.py (path:/tmp/pip-rjvShP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:56 INFO - Running setup.py (path:/tmp/pip-ex27Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:56 INFO - Running setup.py (path:/tmp/pip-Z8cGWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:56 INFO - Running setup.py (path:/tmp/pip-qrWPgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:56 INFO - Running setup.py (path:/tmp/pip-3cCDqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:56 INFO - Running setup.py (path:/tmp/pip-a6e4a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:57 INFO - Running setup.py (path:/tmp/pip-MsQ40v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:57 INFO - Running setup.py (path:/tmp/pip-rtNI5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:57 INFO - Running setup.py (path:/tmp/pip-DOytHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:57 INFO - Running setup.py (path:/tmp/pip-_fYpbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:57 INFO - Running setup.py (path:/tmp/pip-J3pJtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:57 INFO - Running setup.py (path:/tmp/pip-av4BM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:57 INFO - Running setup.py (path:/tmp/pip-8IpxFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:57 INFO - Running setup.py (path:/tmp/pip-1ubCpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:57 INFO - Running setup.py (path:/tmp/pip-t71ivV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:57 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:57 INFO - Running setup.py (path:/tmp/pip-04UJf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:57 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)) 06:35:57 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)) 06:35:57 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)) 06:35:57 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)) 06:35:57 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)) 06:35:57 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)) 06:35:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:59 INFO - Downloading blessings-1.5.1.tar.gz 06:35:59 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 06:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:35:59 INFO - Installing collected packages: blessings 06:35:59 INFO - Running setup.py install for blessings 06:35:59 INFO - Successfully installed blessings 06:35:59 INFO - Cleaning up... 06:35:59 INFO - Return code: 0 06:35:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:35:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:59 INFO - Reading from file tmpfile_stdout 06:35:59 INFO - Current package versions: 06:35:59 INFO - argparse == 1.2.1 06:35:59 INFO - blessings == 1.5.1 06:35:59 INFO - blobuploader == 1.2.4 06:35:59 INFO - docopt == 0.6.1 06:35:59 INFO - manifestparser == 1.1 06:35:59 INFO - mozInstall == 1.12 06:35:59 INFO - mozcrash == 0.16 06:35:59 INFO - mozdebug == 0.1 06:35:59 INFO - mozdevice == 0.47 06:35:59 INFO - mozfile == 1.2 06:35:59 INFO - mozhttpd == 0.7 06:35:59 INFO - mozinfo == 0.9 06:35:59 INFO - mozleak == 0.1 06:35:59 INFO - mozlog == 3.1 06:35:59 INFO - moznetwork == 0.27 06:35:59 INFO - mozprocess == 0.22 06:35:59 INFO - mozprofile == 0.27 06:35:59 INFO - mozrunner == 6.11 06:35:59 INFO - mozscreenshot == 0.1 06:35:59 INFO - mozsystemmonitor == 0.0 06:35:59 INFO - moztest == 0.7 06:35:59 INFO - mozversion == 1.4 06:35:59 INFO - psutil == 3.1.1 06:35:59 INFO - requests == 1.2.3 06:35:59 INFO - wsgiref == 0.1.2 06:35:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:35:59 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 06:35:59 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 06:35:59 INFO - Using env: {'DISPLAY': ':0', 06:35:59 INFO - 'HOME': '/home/cltbld', 06:35:59 INFO - 'LANG': 'en_US.UTF-8', 06:35:59 INFO - 'LANGUAGE': 'en_US:en', 06:35:59 INFO - 'LOGNAME': 'cltbld', 06:35:59 INFO - 'MAIL': '/var/mail/cltbld', 06:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:59 INFO - 'MOZ_NO_REMOTE': '1', 06:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:59 INFO - 'NO_EM_RESTART': '1', 06:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:59 INFO - 'PWD': '/builds/slave/test', 06:35:59 INFO - 'SHELL': '/bin/bash', 06:35:59 INFO - 'SHLVL': '1', 06:35:59 INFO - 'TERM': 'linux', 06:35:59 INFO - 'TMOUT': '86400', 06:35:59 INFO - 'USER': 'cltbld', 06:35:59 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:59 INFO - '_': '/tools/buildbot/bin/python'} 06:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 INFO - Cleaning up... 06:36:00 INFO - Return code: 0 06:36:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:00 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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:36:00 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 06:36:00 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 06:36:00 INFO - Using env: {'DISPLAY': ':0', 06:36:00 INFO - 'HOME': '/home/cltbld', 06:36:00 INFO - 'LANG': 'en_US.UTF-8', 06:36:00 INFO - 'LANGUAGE': 'en_US:en', 06:36:00 INFO - 'LOGNAME': 'cltbld', 06:36:00 INFO - 'MAIL': '/var/mail/cltbld', 06:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:00 INFO - 'MOZ_NO_REMOTE': '1', 06:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:00 INFO - 'NO_EM_RESTART': '1', 06:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:00 INFO - 'PWD': '/builds/slave/test', 06:36:00 INFO - 'SHELL': '/bin/bash', 06:36:00 INFO - 'SHLVL': '1', 06:36:00 INFO - 'TERM': 'linux', 06:36:00 INFO - 'TMOUT': '86400', 06:36:00 INFO - 'USER': 'cltbld', 06:36:00 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:00 INFO - '_': '/tools/buildbot/bin/python'} 06:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:00 INFO - Downloading/unpacking jsonschema 06:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:02 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 06:36:02 INFO - Downloading/unpacking functools32 (from jsonschema) 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:02 INFO - warning: no files found matching '*.txt' 06:36:02 INFO - no previously-included directories found matching 'build' 06:36:02 INFO - no previously-included directories found matching 'dist' 06:36:02 INFO - no previously-included directories found matching '.git*' 06:36:02 INFO - Installing collected packages: jsonschema, functools32 06:36:02 INFO - Running setup.py install for functools32 06:36:02 INFO - warning: no files found matching '*.txt' 06:36:02 INFO - no previously-included directories found matching 'build' 06:36:02 INFO - no previously-included directories found matching 'dist' 06:36:02 INFO - no previously-included directories found matching '.git*' 06:36:02 INFO - Successfully installed jsonschema functools32 06:36:02 INFO - Cleaning up... 06:36:02 INFO - Return code: 0 06:36:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:36:02 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')]} 06:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:02 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')]} 06:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:02 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 0x7f63542a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, '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': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', '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 06:36:02 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 06:36:02 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 06:36:02 INFO - Using env: {'DISPLAY': ':0', 06:36:02 INFO - 'HOME': '/home/cltbld', 06:36:02 INFO - 'LANG': 'en_US.UTF-8', 06:36:02 INFO - 'LANGUAGE': 'en_US:en', 06:36:02 INFO - 'LOGNAME': 'cltbld', 06:36:02 INFO - 'MAIL': '/var/mail/cltbld', 06:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:02 INFO - 'MOZ_NO_REMOTE': '1', 06:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:02 INFO - 'NO_EM_RESTART': '1', 06:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:02 INFO - 'PWD': '/builds/slave/test', 06:36:02 INFO - 'SHELL': '/bin/bash', 06:36:02 INFO - 'SHLVL': '1', 06:36:02 INFO - 'TERM': 'linux', 06:36:02 INFO - 'TMOUT': '86400', 06:36:02 INFO - 'USER': 'cltbld', 06:36:02 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:02 INFO - '_': '/tools/buildbot/bin/python'} 06:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:02 INFO - Downloading/unpacking flake8 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:36:04 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 06:36:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:36:04 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 06:36:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:36:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:04 INFO - no previously-included directories found matching 'docs/_build' 06:36:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:36:05 INFO - Running setup.py install for pep8 06:36:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:05 INFO - no previously-included directories found matching 'docs/_build' 06:36:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:36:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:36:05 INFO - Cleaning up... 06:36:05 INFO - Return code: 0 06:36:05 INFO - Running post-action listener: _resource_record_post_action 06:36:05 INFO - Running post-action listener: _start_resource_monitoring 06:36:05 INFO - Starting resource monitoring. 06:36:05 INFO - ##### 06:36:05 INFO - ##### Running install step. 06:36:05 INFO - ##### 06:36:05 INFO - Running pre-action listener: _resource_record_pre_action 06:36:05 INFO - Running main action method: install 06:36:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:05 INFO - Reading from file tmpfile_stdout 06:36:05 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:05 INFO - Reading from file tmpfile_stdout 06:36:05 INFO - Output received: 06:36:05 INFO - Usage: mozinstall [options] installer 06:36:05 INFO - Options: 06:36:05 INFO - -h, --help show this help message and exit 06:36:05 INFO - -d DEST, --destination=DEST 06:36:05 INFO - Directory to install application into. [default: 06:36:05 INFO - "/builds/slave/test"] 06:36:05 INFO - --app=APP Application being installed. [default: firefox] 06:36:05 INFO - mkdir: /builds/slave/test/build/application 06:36:05 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'] 06:36:05 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 06:36:20 INFO - Reading from file tmpfile_stdout 06:36:20 INFO - Output received: 06:36:20 INFO - /builds/slave/test/build/application/firefox/firefox 06:36:20 INFO - Running post-action listener: _resource_record_post_action 06:36:20 INFO - ##### 06:36:20 INFO - ##### Running run-tests step. 06:36:20 INFO - ##### 06:36:20 INFO - Running pre-action listener: _resource_record_pre_action 06:36:20 INFO - Running main action method: run_tests 06:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:20 INFO - Python 2.7.3 06:36:20 INFO - Return code: 0 06:36:20 INFO - grabbing minidump binary from tooltool 06:36: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')]} 06:36:20 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 0x24f50b0>, '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 0x24f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f6440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:20 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 06:36:20 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 06:36:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:20 INFO - Return code: 0 06:36:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:36:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:36:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:36:21 INFO - Return code: 0 06:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test/build 06:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 06:36:21 INFO - Using env: {'DISPLAY': ':0', 06:36:21 INFO - 'HOME': '/home/cltbld', 06:36:21 INFO - 'LANG': 'en_US.UTF-8', 06:36:21 INFO - 'LANGUAGE': 'en_US:en', 06:36:21 INFO - 'LOGNAME': 'cltbld', 06:36:21 INFO - 'MAIL': '/var/mail/cltbld', 06:36:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:21 INFO - 'MOZ_NO_REMOTE': '1', 06:36:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:21 INFO - 'NO_EM_RESTART': '1', 06:36:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:21 INFO - 'PWD': '/builds/slave/test', 06:36:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:21 INFO - 'SHELL': '/bin/bash', 06:36:21 INFO - 'SHLVL': '1', 06:36:21 INFO - 'TERM': 'linux', 06:36:21 INFO - 'TMOUT': '86400', 06:36:21 INFO - 'USER': 'cltbld', 06:36:21 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318', 06:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:21 INFO - '_': '/tools/buildbot/bin/python'} 06:36:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 06:36:21 INFO - mozversion INFO | application_buildid: 20151207051729 06:36:21 INFO - mozversion INFO | application_changeset: 59bc3c7a83de7ffb611203912a7da6ad84535a5a 06:36:21 INFO - mozversion INFO | application_display_name: Nightly 06:36:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:21 INFO - mozversion INFO | application_name: Firefox 06:36:21 INFO - mozversion INFO | application_remotingname: firefox 06:36:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:36:21 INFO - mozversion INFO | application_vendor: Mozilla 06:36:21 INFO - mozversion INFO | application_version: 45.0a1 06:36:21 INFO - mozversion INFO | platform_buildid: 20151207051729 06:36:21 INFO - mozversion INFO | platform_changeset: 59bc3c7a83de7ffb611203912a7da6ad84535a5a 06:36:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:36:21 INFO - mozversion INFO | platform_version: 45.0a1 06:36:21 INFO - 2015-12-07 06:36:21,298 DEBUG : using testdate: 1449498981 06:36:21 INFO - 2015-12-07 06:36:21,298 DEBUG : actual date: 1449498981 06:36:21 INFO - 2015-12-07 06:36:21,307 INFO : starting webserver on 'localhost:39447' 06:36:21 INFO - 2015-12-07 06:36:21,308 INFO : Starting test suite talos-linux64-ix-061.e 06:36:21 INFO - 2015-12-07 06:36:21,308 INFO : Starting test dromaeo_css 06:36:21 INFO - 2015-12-07 06:36:21,308 DEBUG : operating with platform_type : linux_ 06:36:21 INFO - 2015-12-07 06:36:21,309 INFO : Initialising browser for dromaeo_css test... 06:36:21 INFO - 2015-12-07 06:36:21,324 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5ssvm/profile http://localhost:39447/getInfo.html 06:36:26 INFO - 2015-12-07 06:36:26,106 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:36:26 INFO - 2015-12-07 06:36:26,106 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:36:26 INFO - 2015-12-07 06:36:26,106 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:36:26 INFO - 2015-12-07 06:36:26,107 DEBUG : BROWSER_OUTPUT: __metrics 06:36:26 INFO - 2015-12-07 06:36:26,223 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] 06:36:27 INFO - 2015-12-07 06:36:27,130 INFO : Browser initialized. 06:36:27 INFO - 2015-12-07 06:36:27,131 INFO : Running cycle 1/1 for dromaeo_css test... 06:36:27 INFO - 2015-12-07 06:36:27,131 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5ssvm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:36:39 INFO - 2015-12-07 06:36:39,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 142823424 06:36:39 INFO - 2015-12-07 06:36:39,163 DEBUG : BROWSER_OUTPUT: 06:37:28 INFO - 2015-12-07 06:37:28,774 DEBUG : BROWSER_OUTPUT: 1449499048773 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] 06:39:40 INFO - 2015-12-07 06:39:40,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39447/tests/dromaeo/cssquery-ext.html) 06:39:42 INFO - 2015-12-07 06:39:42,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 146161664 06:39:42 INFO - 2015-12-07 06:39:42,065 DEBUG : BROWSER_OUTPUT: 06:42:44 INFO - 2015-12-07 06:42:44,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/dromaeo/cssquery-ext.html (next: http://localhost:39447/tests/dromaeo/cssquery-jquery.html) 06:42:44 INFO - 2015-12-07 06:42:44,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 145031168 06:42:44 INFO - 2015-12-07 06:42:44,808 DEBUG : BROWSER_OUTPUT: 06:45:46 INFO - 2015-12-07 06:45:46,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39447/tests/dromaeo/cssquery-mootools.html) 06:45:47 INFO - 2015-12-07 06:45:47,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 145174528 06:45:47 INFO - 2015-12-07 06:45:47,156 DEBUG : BROWSER_OUTPUT: 06:48:48 INFO - 2015-12-07 06:48:48,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39447/tests/dromaeo/cssquery-prototype.html) 06:48:49 INFO - 2015-12-07 06:48:49,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 144130048 06:48:49 INFO - 2015-12-07 06:48:49,527 DEBUG : BROWSER_OUTPUT: 06:51:52 INFO - 2015-12-07 06:51:52,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39447/tests/dromaeo/cssquery-yui.html) 06:51:52 INFO - 2015-12-07 06:51:52,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 145063936 06:51:52 INFO - 2015-12-07 06:51:52,783 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/dromaeo/cssquery-yui.html (next: http://localhost:39447/tests/dromaeo/cssquery-dojo.html) 06:54:55 INFO - 2015-12-07 06:54:55,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 146894848 06:54:55 INFO - 2015-12-07 06:54:55,331 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,331 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:54:55 INFO - 2015-12-07 06:54:55,331 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:54:55 INFO - 2015-12-07 06:54:55,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:54:55 INFO - 2015-12-07 06:54:55,332 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:54:55 INFO - 2015-12-07 06:54:55,333 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2696.838189708618;2718.456308738253;2753.9724602753977;2787.6794168670604;2792.274008757722;4619;4775.617950563951;4781.163296423125;4882.316475693406;4889.9266511002315;4711.9528804711945;4734.455537613176;4735.739534325619;4736.455307639622;4938.604911607072;4374.409454723604;4468.664850136237;4472.753998530079;4497.617702495292;4528.139653465847;4428.291473364262;4453.421055262811;4508.887277818048;4539.7049191802425;4574.794134263966;4194.224068547298;4523.298888672244;4537.70504917181;4540.841070562515;4570.497245303047;4360.498542667602;4384.408104905829;4458.866234012985;4463.843765468226;4476.932846007313;4455.754933478657;4470.8882277942985;4486.865394038184;4499.707519011254;4532.818687252506;4511.729296242236;4597.241455159928;4746.501617330199;4748.667593268473;4762.761861906925;5068.923966140511;5181.300524429229;5196.8960620787375;5220.8694782630355;5223.73881305937;5207.661502002357;5231.947680523184;5247.763850626731;5249.658772179834;5251.133562962106;4595.839145629887;4712.410948631421;4795.880102997418;4817.927731084036;4822.879428014257;5202.947970520322;5257.342832145981;5280.551153152025;5286.762095705702;5332.040232758063;5088.542031217208;5103.464136265713;5104.770285337168;5111.591072714174;5140.563052140536;4933.260010998379;5032.496750325012;5188.688678679291;5189.481051894781;5211.739413029333;4965.677230979974;5057.443681195065;5057.570106540985;5075.0357432087785;5108.846734597968;5074.314967479417;5087.974560127176;5104.617153713486;5109.233614957786;5163.7676304566385;3788.45067465216;3854.1520865409566;3881.6700580450415;3929.0373858404873;3978.224246272007;3545.2554963457965;3550.5029295898594;3565.5899571549085;3580.051286409104;3586.1751797086818;4451.755153466591;4452;4475.395821564112;4476.910461790746;4516.728996260234;4939.333190019373;5045.596352291808;5047.293378926953;5053.671511351824;5244.868878278074;4332.155229730172;4344.695871289043;4372.081862808782;4391.451068616423;4425.114977004612;4545.499995000548;4562.475315338778;4570.9314360284625;4579.335996280521;4597.3333866589155;4773.618110551078;4860.684055536379;4862.90274194507;4862.95137048632;4865.294532292868;5160.509751573594;5256.448072952285;5261.579073674174;5275;5335.226392173191;4933.975330123327;4947.727874966911;4951.009798040478;4955.925661115159;5004.824831130893;4864.464908859952;4968.577670898014;4981.975090124526;5176.559992400537;5183.144781111075;5193.039287731782;5249.842504724865;5253.947460525345;5260.421353651019;5269.499397557226;5070.3155074064525;5075.492450754895;5078.669886457368;5079.619028572798;5108.770105345194;4877.95122048775;4928.975355123202;4999.700017998932;5043.394792624908;5072.721000345016;4890.902181956412;4936.531029552187;4940.851774446773;4954.3311652926395;5015.7492125392855;5058.392992840735;5070.138076526926;5085.694858308513;5102.872428189176;5128.922926185543;4618.30725391194;4785;4810.63920205979;4890.364252647133;4936.975315123402 06:54:55 INFO - 2015-12-07 06:54:55,334 DEBUG : BROWSER_OUTPUT: |1;ext.html;532.6670830730791;538.4292649791221;540.9323834520685;541.5126386252371;542.6554138122291;25507.74492255079;26734.197974060786;34237.31525369491;34944.12639684009;35030.29939401217;37964.620353796454;38403;38538.229235415274;38581;38649.42025869614;7790.8441831163345;7983.720569780059;8030.678772849079;8045.718399856006;8073;7724.806879828021;7803.726869559567;7867.645955931968;7871.8032049198655;7896.052473703164;7917.208279172094;7921.881171782428;7952.3638108951145;7999.800004999864;8005.279524842763;7835.333996610295;7853.0576330840095;7899.565523896184;7910.446268761218;7927.246911543394;7711.0746710395115;7757.650905709256;7771.067471903351;7789.9221007789765;7809.960950195269;36054.098647533756;36162;36427.271454571026;36471.63528364735;36629.084272893124;2668.3462551674966;2680.2176552592505;2761.4615150045747;2802.719728027201;3383.881564145268;27047.323816904536;27887.302817429525;28275.717242827515;28428.431431371257;28703.282417939718;3312.8343582821003;3436.6563343665434;3454.654534546525;3462.567179102612;3535.52270443492;213631;216201;216310;217072;217097.99999999843;51406.74296628493;52473;55305;55390.99999999919;56470.717646411504;49734;49913.75043124761;50072;50325;50344.22418318641;13464.394102265422;13517.526886558922;13609.727805443836;13611.911047116406;13639.727205455836;9850.310478266452;9873.259505537113;9885.505724713736;9899.30704850668;9906.851397229048;18594.163262653212;18666.253349866125;18712.53218669517;18774.812251877578;18809.529761756065;7557;7745.380369570421;7770;7829.099653539915;7854.2145785421;864.4769914201943;872.9563521823883;891.2513488669549;894.3170488534397;977.5894124467741;26058.47024370859;26434.6034809478;26461;26677.86661066682;26808.59787103195;915.1763412928418;944.7968686732386;987.4272921705393;1111.1666250312267;1119.3787447966456;14797.482088126864;15554.75561955041;15568.152383988541;15993.583036897362;16250.106244156685;310552;315514;319817;319830;320694;46708.29937550939;47110.5288947113;47328.290075648896;47435.28847067297;47594.52405475901;1240.1628900492133;1244.3094082784141;1255.3660401497368;1259.2822091407809;1259.5276771210797;26909.596356054284;27134.592981104903;27459.725402745717;27580.448391032467;27727.861360693067;38271;38407.61592384041;38569.42145867758;38594.2281154381;38894;224104;226688;226788;227099;229218;28407;41387.586124139576;42145.15709685851;42615.37769289645;42799.7860010698;37499.625003749614;37653.62346376501;37746.43380349242;38339.80830095831;38824.41763373495;31836.363272734878;32146;32807.67192328046;32982.670173297956;33091.172720682174;32416.585229652155;32634.673653263162;32932.50601241031;33047.53858229108;33315.500267495525;32690.34619307553;32956.67043329536;33069.17327066747;33124.834375827966;33155;28279.747828999927;29224.561631575118;29798.404031919676;30138.917354421254;30470.390592188476;24625.261242162764;24857.62713559262;24946.501069978134;25556.616650749882;25583.488330233664 06:54:55 INFO - 2015-12-07 06:54:55,338 DEBUG : BROWSER_OUTPUT: |2;jquery.html;278.4097712848761;283.83395713507593;283.9361143742658;286.2814336016598;289.55986899912136;12786.744265114692;13106.541271055516;14855.480058197965;15457.381704731812;15469.149196794186;9649.517524123801;10188.490575471234;10414.531346089425;10490.947545262263;10491.42297173655;4514.887127821798;4641.0949864776385;4655.906881862377;4661.300804879262;4662.487126416091;4604.493505714368;6097.908531372011;6379.170707807978;6386.265579458375;6394.392532709385;6216.347283535231;6354.809355719336;6493.123428337185;6583.275839657634;6594.934050659504;6617.4706023518;6711.563748356366;6815.454763618924;6821.045053692487;6851.04085428038;6512.544121911468;6515.70679319427;6519.771807986698;6529.706163222619;6540.051692504608;19288.710669339973;20082.397528074034;20170.29403970854;20783.58432831335;21538.676919846213;1888.8488920886296;1930.5849242412949;1937.7965313642005;1983.2860170338668;2016.919323227069;13638.318084095756;13743.381547830371;13965.511207107702;14117.78823317651;14162.575122746333;1846.843018343429;1876.1463534091956;1937.5931054478576;1940.0105945967516;1975.7826639069835;49716;49809.25286120675;50749;57682.7115864418;61903.38096619021;14649.414023439156;15388;15675.372985080698;15690.74474042074;15695;22973.195938142086;23154;23274.8836255821;23325.88337058338;23388.298351049496;8013.439059265912;8025.31784798287;8054.919450805417;8077.313428358655;8103;6684.632345220963;6685.465162786965;6689.531732778756;6698.531102822853;6708.127943367331;4069.9389509156795;4185.309423945015;4202.936955945664;7643.312101910855;7697.461177717618;1692.61916068886;1697.3889399816057;1716.7768190135203;1753.4213709475841;1757.349780581193;808.8584497712877;824.027647376102;898.4339865884451;979.4759803505091;984.5717113055844;14901.776473352907;15394.23028848553;15982.520524384287;16156.27296771648;16896.915515422592;803.7910143362768;834.3408707121428;844.7170197983621;870.9303255739526;916.7799728065349;9010.729678109667;9110.954445227731;9240.21458176049;9341.299402544837;9455.810883782286;452990;460567;464898;469241;470459;70147.64926175337;72530.63734681293;73498.6325068382;73869;74643.62678186574;1033.8655974723238;1044.7649278912183;1045.743792770776;1047.120418848156;1071.4000159910474;14568.781468277772;14636.707265854411;14753;14765.261736912897;14906.254687265377;31965.84017079993;35042.474362884066;35153.296934060665;35497.82251088728;36182.819085904404;36387.45418818773;37109.257814844095;38262;38964.41553376645;39691.603083969945;8279.461834980708;8528.658853645784;8770.12298770118;8782.648694052166;8815.382923195315;9954.104130628279;10065.496725163859;14315.642108947359;15680;15929.601759956095;12815.807762883378;13048.478060877458;13318.667033324244;13367.264800436069;13538.796918046433;12430.192037517532;12599.811002834782;12982.260758889597;13130.146540474838;13441.529546465827;13259.933700331436;13554.86445135536;13657.658558536115;13911.860881391462;14158.292085395895;8880.1563851434;8892.911070889208;8908.955455222682;9066.50134242623;9082.318826088202;9428.057194280516;13148;13464.798028029392;13869.930650347087;13877.722445551235 06:54:55 INFO - 2015-12-07 06:54:55,339 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1474.2849717886816;1645.9999999999998;1677.9748303775445;1702.7701260329852;1719.8280171982803;5974.8805023899495;6122.87754244916;6784.151981002375;6986.8253293667685;6999;6431.26040505342;6476.093346931433;6539.378759017885;6550.967245163767;6552.508561857856;2028.188724510193;2058.3516192399347;2058.6397380458434;2059.5366042640435;2065.483629092727;2041.1427200575795;2070.1512379924234;2074.315475892959;2078.251829341436;2091.4039498742864;1994.7905469925668;1996.5308152584132;2031.207828946712;2031.989840050805;2035.5318276796345;2050.2004218354855;2072.160774886166;2075.055849588434;2075.4811297175706;2079.438551591077;2029.2593203480772;2047.9897600511902;2056.598963202176;2057.0331943986303;2066.2354928676336;7073.186583542907;7124.715011399538;7154.570725756419;7174.210836807947;7189.424846012306;4110.034141976633;4151.958480415187;4159.355299928516;4177.143685544456;4194.580541945811;2658.162678756205;2707.756301932816;2734.5624700048097;2735.4392349568293;2750.642416485864;826.3802148388709;827.462149602757;836.8075342671159;851.6848765956573;858.1332853817627;9496.287778416647;9660.903390966141;9696.51517424126;9708.077732615391;9725.6596019139;3792.544894612664;3813.504244448204;3855.055511399725;3864.42033694948;3870.806459677005;8276.213759692819;8293.543855088028;8322;8335.041470230879;8345.791355216046;4233.724807887477;4252.596003379674;4257.254980378421;4259.7231179973205;4280.143971205771;3200.439923013463;3299.5050742388353;3733.9253214936093;3855.9036024099623;3857.7106716996336;3412.146963259185;3432.553768010143;3437.5015622734563;3460.965390346115;3464.3244567309134;1030.258214085857;1038.1850247555633;1042.6142327338932;1065.8488832061355;1083.991887544591;1024.7233247023262;1041.4116024446164;1042.0777611813598;1044.1490185498794;1072.903438690506;6410.583312084699;6474.5791523550815;6506.089147519351;6519.608823470607;6519.8696026079215;386.7331541236538;388.3882884456992;402.736207783902;403.9779358223699;404.3590908410203;5163.870903227375;5209.739513024334;5216.843494695166;5219.086659834514;5258.842234732964;8217.917820821835;8555.529445880411;8627.396082274181;8633.568321583896;8684.782880427914;8542.273906718;8543;8570.700025499078;8628.094050124646;8668.306535477146;6481.254655714559;6602.570832895751;6694.531382803254;6745;6886.827829304308;6630.469562434897;6662.133922590227;6673.733050677918;6678.198616166092;6680.098186744727;7544.924550754422;7627.847443051219;7724.459287849797;7774.222577742181;7786.416018798726;7765.961170194113;7980.521168729895;8007.919920800718;8037.517748935083;8116.59417029158;5205.297284866495;5258.290130832442;6071.544634152545;6241.625502469867;6303.905441418291;6486.513511486752;6528.706208220547;6569.737210511526;6576.44100251484;6615.073889655356;5843.824685259449;5926.940730592812;6132.110843927695;6336.429721325103;6361.045843123384;5793.913091303718;6114.755409783559;6123.693815309306;6212.968935155295;6256.186695729708;6252.687365631609;6312.021636646327;6312.021636646327;6317.368263173646;6322.747090116528;5459.836204913859;5460.372057213472;5462.617616766788;5465.59008074388;5474.069408200536;5702.344230413555;5716.456936591017;5747.3103227612955;5846;5886.440788125121 06:54:55 INFO - 2015-12-07 06:54:55,339 DEBUG : BROWSER_OUTPUT: |4;prototype.html;254.03593363186704;258.97280785517535;261.3114443441531;261.4940090924062;264.6281973826774;5491.176323551469;5544.1960915667205;5558.944410555899;5570.805021824237;5687.516561092312;5489.862753431156;5586.301712285965;5594.832155035345;5625.746841392137;5639.943600563993;3939.1333906540585;4002.599740026003;4095.1604920991276;4189.895252618679;4197.559256278093;4174.853880114197;4180.665546756252;4181.101063271396;4182.22628813669;4183.895402614929;4088.693347998897;4134.793260336971;4135.875923722293;4139.855105071323;4146.253674338618;4134.937975930348;4136.31750761124;4139.917201655965;4141.254574176647;4150.27370210215;3395.915102122442;3437.106352348407;3519.03226612681;3532.3288575170636;3545.574531056264;5437.32033495813;5445.700486473243;5446.264754258164;5456.645318054314;5458.263134476834;4666;4673.369095172142;4683.484816670163;4684.156851766681;4692.788824502905;5855.975204339224;5865.032269675498;5876.647401155944;5879.059350503899;5885.44088311614;3641.799701016443;3724.42271447926;3726.496922915399;3756.981215093934;3758.868439604628;6126.264848218198;6196.256449226122;6199.287081985584;6204.100405441231;6213.254409470847;3945.5265368156006;3949.585293544194;3952.6442620164325;3954.367301231789;3958.4062390641056;3987.8803635890968;3995.081131339808;3995.760254384746;4011.859584914514;4011.91976160481;4612.446506419251;4747.548982846693;4751.976240118777;4758.238681810963;4791.760411979387;5891.234139561915;5915.822525324247;5937.346891841894;5938.6436813791315;5945.940540594625;1423.6369725719876;1428.6428392901776;1430.8283006039342;1443.5452832357985;1443.877270432025;948.5020364308793;950.8922105746727;957.6121670723368;981.4945303168873;986.0238364019569;5085.847424577269;5105.668131571436;5113.335266415343;5122.103631864484;5124.308218390544;6114.847128821815;6123.877522449526;6134.141220229171;6144.631322120687;6152.046432802923;5099.311592934906;5125.56432703217;5129.076766182123;5136.666116702402;5144.074066668036;3247.3180632067056;3311.0563489405404;3336.115929278743;3343.983280083584;3365.343757967222;5713.485786279255;5838.036723940587;5838.532917366685;5852.356240813507;5867.530597552186;6332.746690132435;6347.904781428282;6406.5515413920575;6409.294977552466;6415.422611964946;5821.301443826683;5827.79602713903;5828.6794226317115;5831.1253312001845;5834.708264586839;6010.939890601213;6158.04550294705;6197.132401463708;6221.377862213923;6225.937740622717;6070.1501789750355;6073.514118870568;6076.665783381956;6095;6097.329293777592;5791.928493228597;5800.651960882361;5829.883402331845;5838.32859221178;5853.151293062568;3930.6265904739003;3990.102226998902;4003.3194356958807;4006.4390985261502;4017.1965606878157;5971.671558064349;6176.320604733386;6182.938170618416;6188;6192.907106393498;5922.378150294157;5933.050711886078;5939.376365481735;5943.316518600416;5945.732442040032;5926.377730338252;5927.2590926134235;5939.10913362999;5940.46535811779;5954.791582294599;5648.604597678123;5807.274090738658;5812.564057695774;5822.301323841166;5822.679752613647;5946.43508866657;5964.463198312173;5967.224260846062;5971.58198926071;5979.1928089707335;5829.650220986754;5834.212381328466;5835.066389377679;5837.211976383134;5853.063509838576 06:54:55 INFO - 2015-12-07 06:54:55,340 DEBUG : BROWSER_OUTPUT: |5;yui.html;689.7241103558576;734.3794493652869;757.7120694136228;778.8052986753312;808.531051989846;11133.443327833606;11536.307821530714;11566.363849988236;11610.12924030697;11622.941885290584;11216.439178041086;11224.607138750145;11239.66281011571;11273.267237629549;11325.150613703963;604.794369914229;613.8710870717132;769.2346115614971;778.6690656471005;792.4373694676786;779.5517577392993;783.6316931042429;790.4071946040469;791.3866753266236;791.7545560876118;814.767791179514;823.9876401853977;824.9298809601191;825.4923222218323;826.0335407573124;822.9753107406757;824.171707434028;824.8886400335938;824.9670013199465;826.8718348655938;605.8364241654729;611.8500967263049;615.4522474997256;616.3928530397554;616.7995401494533;11275.718107047307;11319.547218111265;11340.376279304635;11414.486348114355;11464.770704585944;10317.948410257975;10504.212184086224;10757.246992710514;10774.622888198875;10810.29733067348;9090.363674542785;9321.067893210624;9330.393524420891;9418.670346537838;9495.57269922855;3224.193951512122;3236.6925142111463;3248.399046176441;3252.7560432967384;3267.591551056118;37834.81082594569;38124.618753812385;38221;38426.423603646246;38674.41988370177;8739.344549158839;8836.911630883738;8847.69033083839;9017.458952462874;9100.044495328028;14041.227732474812;14052.71894562103;15224.619384515476;15416;15484.767728484081;6008.128821320884;6089.908651370233;6108.236470441195;6191.133241346215;6277.027060805583;3446.483027545838;3448.9482657760154;3503.264314493985;3509.12271932017;3522.7005704515404;2562.3722188064044;2584.754448327406;2588.637590737261;2603.271084096456;2605.439830436427;457.76882674249293;462.7269910752672;463.5063657205066;475.847728726811;486.3750081145711;579.4639958038797;619.2568917299259;620.1906512001791;624.6158612453308;637.4358692557121;7913.643886025143;8283.95858020706;8371.623276952552;8476.576171191417;8491;567.8693900402931;596.0850095104081;598.4344794169468;612.9448349648553;630.6846576711645;3521.6053083903194;3651.561812582454;3674.467202255658;3768.924621507609;3788.8484460621266;47090.293645595346;48603;48710.75644621754;48888;49404;42945.57054429478;43883.341749873776;44346;44605.10789784186;45197.096058078656;40458.19083618311;40764.38853417201;40970.18059638791;41098.38352424716;41330.793346033075;7120.715171393086;7234.348908598251;7378.040854688856;7549.320561149523;8172.223638754309;29089.854550727112;29169;29211.41577168487;30103.849480752455;30153;37001.44497832588;37463;38136;38870.80564597159;39376.40935386029;9666.806663866542;9894.703158905244;10100.191984641358;10135.54390052464;10314.587416503557;10943.507542160463;11094.167937404565;11097.223194376316;11197.888021119685;11948.701282468008;10531.45584820671;10577.62978295756;10939.453027348442;10961.123110151328;11100.777984440427;10589.364638121737;10596.841047384141;10688.144948403953;10743.462826858782;10783.137349012217;9443.338966272295;9941.155001824925;9945.30382873192;10124.544395502367;10353.74115647115;8802.691905783267;8825;8983.236424903957;9049.683261085831;9344.205742511962;8339.374546909128;8636.222739953435;8826.145619909154;8837.381383303107;8870.911290887008 06:54:55 INFO - 2015-12-07 06:54:55,340 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:54:55 INFO - 2015-12-07 06:54:55,341 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:54:55 INFO - 2015-12-07 06:54:55,341 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,319 06:54:55 INFO - 2015-12-07 06:54:55,341 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:54:55 INFO - 2015-12-07 06:54:55,341 DEBUG : BROWSER_OUTPUT: __startTimestamp1449500095329__endTimestamp 06:54:55 INFO - 2015-12-07 06:54:55,341 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,342 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:54:55 INFO - 2015-12-07 06:54:55,342 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:54:55 INFO - 2015-12-07 06:54:55,342 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,342 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4738.02 Median:4882.32 stddev:528.66 (10.8%) stddev-sans-first:505.45 06:54:55 INFO - 2015-12-07 06:54:55,342 DEBUG : BROWSER_OUTPUT: Values: 2696.8 2718.5 2754.0 2787.7 2792.3 4619.0 4775.6 4781.2 4882.3 4889.9 4712.0 4734.5 4735.7 4736.5 4938.6 4374.4 4468.7 4472.8 4497.6 4528.1 4428.3 4453.4 4508.9 4539.7 4574.8 4194.2 4523.3 4537.7 4540.8 4570.5 4360.5 4384.4 4458.9 4463.8 4476.9 4455.8 4470.9 4486.9 4499.7 4532.8 4511.7 4597.2 4746.5 4748.7 4762.8 5068.9 5181.3 5196.9 5220.9 5223.7 5207.7 5231.9 5247.8 5249.7 5251.1 4595.8 4712.4 4795.9 4817.9 4822.9 5202.9 5257.3 5280.6 5286.8 5332.0 5088.5 5103.5 5104.8 5111.6 5140.6 4933.3 5032.5 5188.7 5189.5 5211.7 4965.7 5057.4 5057.6 5075.0 5108.8 5074.3 5088.0 5104.6 5109.2 5163.8 3788.5 3854.2 3881.7 3929.0 3978.2 3545.3 3550.5 3565.6 3580.1 3586.2 4451.8 4452.0 4475.4 4476.9 4516.7 4939.3 5045.6 5047.3 5053.7 5244.9 4332.2 4344.7 4372.1 4391.5 4425.1 4545.5 4562.5 4570.9 4579.3 4597.3 4773.6 4860.7 4862.9 4863.0 4865.3 5160.5 5256.4 5261.6 5275.0 5335.2 4934.0 4947.7 4951.0 4955.9 5004.8 4864.5 4968.6 4982.0 5176.6 5183.1 5193.0 5249.8 5253.9 5260.4 5269.5 5070.3 5075.5 5078.7 5079.6 5108.8 4878.0 4929.0 4999.7 5043.4 5072.7 4890.9 4936.5 4940.9 4954.3 5015.7 5058.4 5070.1 5085.7 5102.9 5128.9 4618.3 4785.0 4810.6 4890.4 4937.0 06:54:55 INFO - 2015-12-07 06:54:55,343 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,343 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41216.21 Median:34987.21 stddev:67245.52 (192.2%) stddev-sans-first:67364.78 06:54:55 INFO - 2015-12-07 06:54:55,344 DEBUG : BROWSER_OUTPUT: Values: 532.7 538.4 540.9 541.5 542.7 25507.7 26734.2 34237.3 34944.1 35030.3 37964.6 38403.0 38538.2 38581.0 38649.4 7790.8 7983.7 8030.7 8045.7 8073.0 7724.8 7803.7 7867.6 7871.8 7896.1 7917.2 7921.9 7952.4 7999.8 8005.3 7835.3 7853.1 7899.6 7910.4 7927.2 7711.1 7757.7 7771.1 7789.9 7810.0 36054.1 36162.0 36427.3 36471.6 36629.1 2668.3 2680.2 2761.5 2802.7 3383.9 27047.3 27887.3 28275.7 28428.4 28703.3 3312.8 3436.7 3454.7 3462.6 3535.5 213631.0 216201.0 216310.0 217072.0 217098.0 51406.7 52473.0 55305.0 55391.0 56470.7 49734.0 49913.8 50072.0 50325.0 50344.2 13464.4 13517.5 13609.7 13611.9 13639.7 9850.3 9873.3 9885.5 9899.3 9906.9 18594.2 18666.3 18712.5 18774.8 18809.5 7557.0 7745.4 7770.0 7829.1 7854.2 864.5 873.0 891.3 894.3 977.6 26058.5 26434.6 26461.0 26677.9 26808.6 915.2 944.8 987.4 1111.2 1119.4 14797.5 15554.8 15568.2 15993.6 16250.1 310552.0 315514.0 319817.0 319830.0 320694.0 46708.3 47110.5 47328.3 47435.3 47594.5 1240.2 1244.3 1255.4 1259.3 1259.5 26909.6 27134.6 27459.7 27580.4 27727.9 38271.0 38407.6 38569.4 38594.2 38894.0 224104.0 226688.0 226788.0 227099.0 229218.0 28407.0 41387.6 42145.2 42615.4 42799.8 37499.6 37653.6 37746.4 38339.8 38824.4 31836.4 32146.0 32807.7 32982.7 33091.2 32416.6 32634.7 32932.5 33047.5 33315.5 32690.3 32956.7 33069.2 33124.8 33155.0 28279.7 29224.6 29798.4 30138.9 30470.4 24625.3 24857.6 24946.5 25556.6 25583.5 06:54:55 INFO - 2015-12-07 06:54:55,344 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,344 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26206.95 Median:35840.32 stddev:75638.89 (211.0%) stddev-sans-first:75826.02 06:54:55 INFO - 2015-12-07 06:54:55,344 DEBUG : BROWSER_OUTPUT: Values: 278.4 283.8 283.9 286.3 289.6 12786.7 13106.5 14855.5 15457.4 15469.1 9649.5 10188.5 10414.5 10490.9 10491.4 4514.9 4641.1 4655.9 4661.3 4662.5 4604.5 6097.9 6379.2 6386.3 6394.4 6216.3 6354.8 6493.1 6583.3 6594.9 6617.5 6711.6 6815.5 6821.0 6851.0 6512.5 6515.7 6519.8 6529.7 6540.1 19288.7 20082.4 20170.3 20783.6 21538.7 1888.8 1930.6 1937.8 1983.3 2016.9 13638.3 13743.4 13965.5 14117.8 14162.6 1846.8 1876.1 1937.6 1940.0 1975.8 49716.0 49809.3 50749.0 57682.7 61903.4 14649.4 15388.0 15675.4 15690.7 15695.0 22973.2 23154.0 23274.9 23325.9 23388.3 8013.4 8025.3 8054.9 8077.3 8103.0 6684.6 6685.5 6689.5 6698.5 6708.1 4069.9 4185.3 4202.9 7643.3 7697.5 1692.6 1697.4 1716.8 1753.4 1757.3 808.9 824.0 898.4 979.5 984.6 14901.8 15394.2 15982.5 16156.3 16896.9 803.8 834.3 844.7 870.9 916.8 9010.7 9111.0 9240.2 9341.3 9455.8 452990.0 460567.0 464898.0 469241.0 470459.0 70147.6 72530.6 73498.6 73869.0 74643.6 1033.9 1044.8 1045.7 1047.1 1071.4 14568.8 14636.7 14753.0 14765.3 14906.3 31965.8 35042.5 35153.3 35497.8 36182.8 36387.5 37109.3 38262.0 38964.4 39691.6 8279.5 8528.7 8770.1 8782.6 8815.4 9954.1 10065.5 14315.6 15680.0 15929.6 12815.8 13048.5 13318.7 13367.3 13538.8 12430.2 12599.8 12982.3 13130.1 13441.5 13259.9 13554.9 13657.7 13911.9 14158.3 8880.2 8892.9 8909.0 9066.5 9082.3 9428.1 13148.0 13464.8 13869.9 13877.7 06:54:55 INFO - 2015-12-07 06:54:55,344 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,344 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4873.31 Median:5818.87 stddev:2569.09 (44.2%) stddev-sans-first:2563.60 06:54:55 INFO - 2015-12-07 06:54:55,345 DEBUG : BROWSER_OUTPUT: Values: 1474.3 1646.0 1678.0 1702.8 1719.8 5974.9 6122.9 6784.2 6986.8 6999.0 6431.3 6476.1 6539.4 6551.0 6552.5 2028.2 2058.4 2058.6 2059.5 2065.5 2041.1 2070.2 2074.3 2078.3 2091.4 1994.8 1996.5 2031.2 2032.0 2035.5 2050.2 2072.2 2075.1 2075.5 2079.4 2029.3 2048.0 2056.6 2057.0 2066.2 7073.2 7124.7 7154.6 7174.2 7189.4 4110.0 4152.0 4159.4 4177.1 4194.6 2658.2 2707.8 2734.6 2735.4 2750.6 826.4 827.5 836.8 851.7 858.1 9496.3 9660.9 9696.5 9708.1 9725.7 3792.5 3813.5 3855.1 3864.4 3870.8 8276.2 8293.5 8322.0 8335.0 8345.8 4233.7 4252.6 4257.3 4259.7 4280.1 3200.4 3299.5 3733.9 3855.9 3857.7 3412.1 3432.6 3437.5 3461.0 3464.3 1030.3 1038.2 1042.6 1065.8 1084.0 1024.7 1041.4 1042.1 1044.1 1072.9 6410.6 6474.6 6506.1 6519.6 6519.9 386.7 388.4 402.7 404.0 404.4 5163.9 5209.7 5216.8 5219.1 5258.8 8217.9 8555.5 8627.4 8633.6 8684.8 8542.3 8543.0 8570.7 8628.1 8668.3 6481.3 6602.6 6694.5 6745.0 6886.8 6630.5 6662.1 6673.7 6678.2 6680.1 7544.9 7627.8 7724.5 7774.2 7786.4 7766.0 7980.5 8007.9 8037.5 8116.6 5205.3 5258.3 6071.5 6241.6 6303.9 6486.5 6528.7 6569.7 6576.4 6615.1 5843.8 5926.9 6132.1 6336.4 6361.0 5793.9 6114.8 6123.7 6213.0 6256.2 6252.7 6312.0 6312.0 6317.4 6322.7 5459.8 5460.4 5462.6 5465.6 5474.1 5702.3 5716.5 5747.3 5846.0 5886.4 06:54:55 INFO - 2015-12-07 06:54:55,345 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,345 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4826.25 Median:5590.57 stddev:1499.31 (26.8%) stddev-sans-first:1463.71 06:54:55 INFO - 2015-12-07 06:54:55,345 DEBUG : BROWSER_OUTPUT: Values: 254.0 259.0 261.3 261.5 264.6 5491.2 5544.2 5558.9 5570.8 5687.5 5489.9 5586.3 5594.8 5625.7 5639.9 3939.1 4002.6 4095.2 4189.9 4197.6 4174.9 4180.7 4181.1 4182.2 4183.9 4088.7 4134.8 4135.9 4139.9 4146.3 4134.9 4136.3 4139.9 4141.3 4150.3 3395.9 3437.1 3519.0 3532.3 3545.6 5437.3 5445.7 5446.3 5456.6 5458.3 4666.0 4673.4 4683.5 4684.2 4692.8 5856.0 5865.0 5876.6 5879.1 5885.4 3641.8 3724.4 3726.5 3757.0 3758.9 6126.3 6196.3 6199.3 6204.1 6213.3 3945.5 3949.6 3952.6 3954.4 3958.4 3987.9 3995.1 3995.8 4011.9 4011.9 4612.4 4747.5 4752.0 4758.2 4791.8 5891.2 5915.8 5937.3 5938.6 5945.9 1423.6 1428.6 1430.8 1443.5 1443.9 948.5 950.9 957.6 981.5 986.0 5085.8 5105.7 5113.3 5122.1 5124.3 6114.8 6123.9 6134.1 6144.6 6152.0 5099.3 5125.6 5129.1 5136.7 5144.1 3247.3 3311.1 3336.1 3344.0 3365.3 5713.5 5838.0 5838.5 5852.4 5867.5 6332.7 6347.9 6406.6 6409.3 6415.4 5821.3 5827.8 5828.7 5831.1 5834.7 6010.9 6158.0 6197.1 6221.4 6225.9 6070.2 6073.5 6076.7 6095.0 6097.3 5791.9 5800.7 5829.9 5838.3 5853.2 3930.6 3990.1 4003.3 4006.4 4017.2 5971.7 6176.3 6182.9 6188.0 6192.9 5922.4 5933.1 5939.4 5943.3 5945.7 5926.4 5927.3 5939.1 5940.5 5954.8 5648.6 5807.3 5812.6 5822.3 5822.7 5946.4 5964.5 5967.2 5971.6 5979.2 5829.7 5834.2 5835.1 5837.2 5853.1 06:54:55 INFO - 2015-12-07 06:54:55,345 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-12-07 06:54:55,345 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11917.79 Median:460.25 stddev:13453.73 (2923.1%) stddev-sans-first:13465.05 06:54:55 INFO - 2015-12-07 06:54:55,346 DEBUG : BROWSER_OUTPUT: Values: 689.7 734.4 757.7 778.8 808.5 11133.4 11536.3 11566.4 11610.1 11622.9 11216.4 11224.6 11239.7 11273.3 11325.2 604.8 613.9 769.2 778.7 792.4 779.6 783.6 790.4 791.4 791.8 814.8 824.0 824.9 825.5 826.0 823.0 824.2 824.9 825.0 826.9 605.8 611.9 615.5 616.4 616.8 11275.7 11319.5 11340.4 11414.5 11464.8 10317.9 10504.2 10757.2 10774.6 10810.3 9090.4 9321.1 9330.4 9418.7 9495.6 3224.2 3236.7 3248.4 3252.8 3267.6 37834.8 38124.6 38221.0 38426.4 38674.4 8739.3 8836.9 8847.7 9017.5 9100.0 14041.2 14052.7 15224.6 15416.0 15484.8 6008.1 6089.9 6108.2 6191.1 6277.0 3446.5 3448.9 3503.3 3509.1 3522.7 2562.4 2584.8 2588.6 2603.3 2605.4 457.8 462.7 463.5 475.8 486.4 579.5 619.3 620.2 624.6 637.4 7913.6 8284.0 8371.6 8476.6 8491.0 567.9 596.1 598.4 612.9 630.7 3521.6 3651.6 3674.5 3768.9 3788.8 47090.3 48603.0 48710.8 48888.0 49404.0 42945.6 43883.3 44346.0 44605.1 45197.1 40458.2 40764.4 40970.2 41098.4 41330.8 7120.7 7234.3 7378.0 7549.3 8172.2 29089.9 29169.0 29211.4 30103.8 30153.0 37001.4 37463.0 38136.0 38870.8 39376.4 9666.8 9894.7 10100.2 10135.5 10314.6 10943.5 11094.2 11097.2 11197.9 11948.7 10531.5 10577.6 10939.5 10961.1 11100.8 10589.4 10596.8 10688.1 10743.5 10783.1 9443.3 9941.2 9945.3 10124.5 10353.7 8802.7 8825.0 8983.2 9049.7 9344.2 8339.4 8636.2 8826.1 8837.4 8870.9 06:54:55 INFO - 2015-12-07 06:54:55,347 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:54:55 INFO - 2015-12-07 06:54:55,347 DEBUG : BROWSER_OUTPUT: 06:54:56 INFO - 2015-12-07 06:54:56,055 INFO : Browser exited with error code: 0 06:54:56 INFO - 2015-12-07 06:54:56,076 INFO : Completed test dromaeo_css (00:18:34) 06:54:56 INFO - 2015-12-07 06:54:56,076 INFO : Starting test kraken 06:54:56 INFO - 2015-12-07 06:54:56,076 DEBUG : operating with platform_type : linux_ 06:54:56 INFO - 2015-12-07 06:54:56,076 INFO : Initialising browser for kraken test... 06:54:56 INFO - 2015-12-07 06:54:56,082 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0c6zPy/profile http://localhost:39447/getInfo.html 06:55:00 INFO - 2015-12-07 06:55:00,616 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:55:00 INFO - 2015-12-07 06:55:00,617 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:55:00 INFO - 2015-12-07 06:55:00,617 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:55:00 INFO - 2015-12-07 06:55:00,617 DEBUG : BROWSER_OUTPUT: __metrics 06:55:00 INFO - 2015-12-07 06:55:00,733 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] 06:55:01 INFO - 2015-12-07 06:55:01,622 INFO : Browser initialized. 06:55:01 INFO - 2015-12-07 06:55:01,623 INFO : Running cycle 1/1 for kraken test... 06:55:01 INFO - 2015-12-07 06:55:01,623 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0c6zPy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:55:13 INFO - 2015-12-07 06:55:13,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 143642624 06:55:13 INFO - 2015-12-07 06:55:13,703 DEBUG : BROWSER_OUTPUT: 06:55:16 INFO - 2015-12-07 06:55:16,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39447/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:16 INFO - 2015-12-07 06:55:16,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 143233024 06:55:16 INFO - 2015-12-07 06:55:16,912 DEBUG : BROWSER_OUTPUT: 06:55:19 INFO - 2015-12-07 06:55:19,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39447/tests/kraken/driver.html?testName=audio-dft) 06:55:20 INFO - 2015-12-07 06:55:20,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 143007744 06:55:20 INFO - 2015-12-07 06:55:20,251 DEBUG : BROWSER_OUTPUT: 06:55:23 INFO - 2015-12-07 06:55:23,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39447/tests/kraken/driver.html?testName=audio-fft) 06:55:23 INFO - 2015-12-07 06:55:23,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 138530816 06:55:23 INFO - 2015-12-07 06:55:23,768 DEBUG : BROWSER_OUTPUT: 06:55:25 INFO - 2015-12-07 06:55:25,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39447/tests/kraken/driver.html?testName=audio-oscillator) 06:55:26 INFO - 2015-12-07 06:55:26,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 139845632 06:55:26 INFO - 2015-12-07 06:55:26,414 DEBUG : BROWSER_OUTPUT: 06:55:28 INFO - 2015-12-07 06:55:28,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:55:29 INFO - 2015-12-07 06:55:29,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 140296192 06:55:29 INFO - 2015-12-07 06:55:29,254 DEBUG : BROWSER_OUTPUT: 06:55:32 INFO - 2015-12-07 06:55:32,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39447/tests/kraken/driver.html?testName=imaging-darkroom) 06:55:32 INFO - 2015-12-07 06:55:32,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 139751424 06:55:32 INFO - 2015-12-07 06:55:32,875 DEBUG : BROWSER_OUTPUT: 06:55:36 INFO - 2015-12-07 06:55:36,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39447/tests/kraken/driver.html?testName=imaging-desaturate) 06:55:36 INFO - 2015-12-07 06:55:36,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 137994240 06:55:36 INFO - 2015-12-07 06:55:36,961 DEBUG : BROWSER_OUTPUT: 06:55:39 INFO - 2015-12-07 06:55:39,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39447/tests/kraken/driver.html?testName=json-parse-financial) 06:55:40 INFO - 2015-12-07 06:55:40,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 138166272 06:55:40 INFO - 2015-12-07 06:55:40,505 DEBUG : BROWSER_OUTPUT: 06:55:42 INFO - 2015-12-07 06:55:42,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:42 INFO - 2015-12-07 06:55:42,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 140148736 06:55:42 INFO - 2015-12-07 06:55:42,857 DEBUG : BROWSER_OUTPUT: 06:55:44 INFO - 2015-12-07 06:55:44,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39447/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:55:45 INFO - 2015-12-07 06:55:45,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 141344768 06:55:45 INFO - 2015-12-07 06:55:45,368 DEBUG : BROWSER_OUTPUT: 06:55:47 INFO - 2015-12-07 06:55:47,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:55:48 INFO - 2015-12-07 06:55:48,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 140906496 06:55:48 INFO - 2015-12-07 06:55:48,126 DEBUG : BROWSER_OUTPUT: 06:55:50 INFO - 2015-12-07 06:55:50,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:55:51 INFO - 2015-12-07 06:55:51,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 141438976 06:55:51 INFO - 2015-12-07 06:55:51,288 DEBUG : BROWSER_OUTPUT: 06:55:53 INFO - 2015-12-07 06:55:53,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:55:54 INFO - 2015-12-07 06:55:54,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 141250560 06:55:54 INFO - 2015-12-07 06:55:54,529 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39447/tests/kraken/driver.html?testName=ai-astar) 06:55:56 INFO - 2015-12-07 06:55:56,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 141234176 06:55:56 INFO - 2015-12-07 06:55:56,565 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,568 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:55:56 INFO - 2015-12-07 06:55:56,568 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:55:56 INFO - 2015-12-07 06:55:56,568 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:55:56 INFO - 2015-12-07 06:55:56,568 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:55:56 INFO - 2015-12-07 06:55:56,568 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;110;114;115;115;126;114;113;114;113 06:55:56 INFO - 2015-12-07 06:55:56,568 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;132;163;167;133;152;163;133;167;131 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;164;166;163;168;164;166;165 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;71;72;74;133;79;74;73;74 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;132;94;96;95;129;95;95;131 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;109;110;110;110;109;111 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;151;148;148;147;149;148;148;149;149 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;98;97;96;96;95;96;96;96 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;79;74;75;73;73;73;73;73;73;72 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;69;69;69;69;69;69;70;69 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;92;86;95;86;86;85;85;86;95 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;129;124;134;132;128;131;126;124;126 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;151;146;152;152;138;154;151;148;140 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;74;70;73;71;69;72;69;70;74 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,815 06:55:56 INFO - 2015-12-07 06:55:56,569 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:55:56 INFO - 2015-12-07 06:55:56,570 DEBUG : BROWSER_OUTPUT: __startTimestamp1449500156566__endTimestamp 06:55:56 INFO - 2015-12-07 06:55:56,570 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,577 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:55:56 INFO - 2015-12-07 06:55:56,577 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:55:56 INFO - 2015-12-07 06:55:56,577 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,577 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.18 (3.7%) stddev-sans-first:4.43 06:55:56 INFO - 2015-12-07 06:55:56,577 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 114.0 115.0 115.0 126.0 114.0 113.0 114.0 113.0 06:55:56 INFO - 2015-12-07 06:55:56,577 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,577 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:158.00 stddev:15.59 (9.9%) stddev-sans-first:16.48 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: Values: 153.0 132.0 163.0 167.0 133.0 152.0 163.0 133.0 167.0 131.0 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:1.78 (1.1%) stddev-sans-first:1.88 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 164.0 166.0 163.0 168.0 164.0 166.0 165.0 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:73.50 stddev:18.96 (25.8%) stddev-sans-first:19.92 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 72.0 74.0 133.0 79.0 74.0 73.0 74.0 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:95.00 stddev:17.26 (18.2%) stddev-sans-first:17.94 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 132.0 94.0 96.0 95.0 129.0 95.0 95.0 131.0 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 111.0 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.17 (0.8%) stddev-sans-first:1.13 06:55:56 INFO - 2015-12-07 06:55:56,578 DEBUG : BROWSER_OUTPUT: Values: 147.0 151.0 148.0 148.0 147.0 149.0 148.0 148.0 149.0 149.0 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 98.0 97.0 96.0 96.0 95.0 96.0 96.0 96.0 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.80 Median:73.00 stddev:1.99 (2.7%) stddev-sans-first:0.83 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: Values: 79.0 74.0 75.0 73.0 73.0 73.0 73.0 73.0 73.0 72.0 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 69.0 69.0 69.0 69.0 69.0 70.0 69.0 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:86.00 stddev:4.10 (4.8%) stddev-sans-first:4.28 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: Values: 86.0 92.0 86.0 95.0 86.0 86.0 85.0 85.0 86.0 95.0 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:128.50 stddev:3.43 (2.7%) stddev-sans-first:3.56 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: Values: 126.0 129.0 124.0 134.0 132.0 128.0 131.0 126.0 124.0 126.0 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,579 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:151.00 stddev:5.64 (3.7%) stddev-sans-first:5.63 06:55:56 INFO - 2015-12-07 06:55:56,580 DEBUG : BROWSER_OUTPUT: Values: 142.0 151.0 146.0 152.0 152.0 138.0 154.0 151.0 148.0 140.0 06:55:56 INFO - 2015-12-07 06:55:56,580 DEBUG : BROWSER_OUTPUT: 06:55:56 INFO - 2015-12-07 06:55:56,580 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:1.93 (2.7%) stddev-sans-first:2.00 06:55:56 INFO - 2015-12-07 06:55:56,580 DEBUG : BROWSER_OUTPUT: Values: 70.0 74.0 70.0 73.0 71.0 69.0 72.0 69.0 70.0 74.0 06:55:56 INFO - 2015-12-07 06:55:56,580 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:55:56 INFO - 2015-12-07 06:55:56,580 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-12-07 06:55:57,503 INFO : Browser exited with error code: 0 06:55:57 INFO - 2015-12-07 06:55:57,551 INFO : Completed test kraken (00:01:01) 06:55:57 INFO - 2015-12-07 06:55:57,551 INFO : Starting test v8_7 06:55:57 INFO - 2015-12-07 06:55:57,551 DEBUG : operating with platform_type : linux_ 06:55:57 INFO - 2015-12-07 06:55:57,551 INFO : Initialising browser for v8_7 test... 06:55:57 INFO - 2015-12-07 06:55:57,557 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptq0x48/profile http://localhost:39447/getInfo.html 06:56:02 INFO - 2015-12-07 06:56:02,381 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:56:02 INFO - 2015-12-07 06:56:02,381 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:56:02 INFO - 2015-12-07 06:56:02,381 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:56:02 INFO - 2015-12-07 06:56:02,382 DEBUG : BROWSER_OUTPUT: __metrics 06:56:02 INFO - 2015-12-07 06:56:02,506 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] 06:56:03 INFO - 2015-12-07 06:56:03,354 INFO : Browser initialized. 06:56:03 INFO - 2015-12-07 06:56:03,355 INFO : Running cycle 1/1 for v8_7 test... 06:56:03 INFO - 2015-12-07 06:56:03,355 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptq0x48/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:56:15 INFO - 2015-12-07 06:56:15,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 143413248 06:56:15 INFO - 2015-12-07 06:56:15,391 DEBUG : BROWSER_OUTPUT: 06:56:36 INFO - 2015-12-07 06:56:36,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39447/tests/v8_7/run.html (next: http://localhost:39447/tests/v8_7/run.html) 06:56:37 INFO - 2015-12-07 06:56:37,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 138756096 06:56:37 INFO - 2015-12-07 06:56:37,118 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,118 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:56:37 INFO - 2015-12-07 06:56:37,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:56:37 INFO - 2015-12-07 06:56:37,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:56:37 INFO - 2015-12-07 06:56:37,118 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:56:37 INFO - 2015-12-07 06:56:37,118 DEBUG : BROWSER_OUTPUT: |0;Richards;173.16017316017317 06:56:37 INFO - 2015-12-07 06:56:37,119 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.94901661256444 06:56:37 INFO - 2015-12-07 06:56:37,119 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.39251040221916 06:56:37 INFO - 2015-12-07 06:56:37,119 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 06:56:37 INFO - 2015-12-07 06:56:37,119 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1051.5247108307046 06:56:37 INFO - 2015-12-07 06:56:37,119 DEBUG : BROWSER_OUTPUT: |5;Earley;709.7232079488999 06:56:37 INFO - 2015-12-07 06:56:37,119 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 06:56:37 INFO - 2015-12-07 06:56:37,119 DEBUG : BROWSER_OUTPUT: |7;RegExp;26315.78947368421 06:56:37 INFO - 2015-12-07 06:56:37,119 DEBUG : BROWSER_OUTPUT: |8;Splay;593.9716312056737 06:56:37 INFO - 2015-12-07 06:56:37,120 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 06:56:37 INFO - 2015-12-07 06:56:37,120 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:56:37 INFO - 2015-12-07 06:56:37,120 DEBUG : BROWSER_OUTPUT: __startTimestamp1449500197111__endTimestamp 06:56:37 INFO - 2015-12-07 06:56:37,120 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,120 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:56:37 INFO - 2015-12-07 06:56:37,120 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:56:37 INFO - 2015-12-07 06:56:37,120 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,121 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.16 Median:173.16 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,121 DEBUG : BROWSER_OUTPUT: Values: 173.2 06:56:37 INFO - 2015-12-07 06:56:37,121 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,121 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,121 DEBUG : BROWSER_OUTPUT: Values: 190.9 06:56:37 INFO - 2015-12-07 06:56:37,121 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,121 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.39 Median:277.39 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,121 DEBUG : BROWSER_OUTPUT: Values: 277.4 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: Values: 5170.1 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1051.52 Median:1051.52 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: Values: 1051.5 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:709.72 Median:709.72 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: Values: 709.7 06:56:37 INFO - 2015-12-07 06:56:37,122 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: Values: 12512.5 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26315.79 Median:26315.79 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: Values: 26315.8 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:593.97 Median:593.97 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: Values: 594.0 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:56:37 INFO - 2015-12-07 06:56:37,123 DEBUG : BROWSER_OUTPUT: 06:56:37 INFO - 2015-12-07 06:56:37,999 INFO : Browser exited with error code: 0 06:56:38 INFO - 2015-12-07 06:56:38,013 INFO : Completed test v8_7 (00:00:40) 06:56:38 INFO - 2015-12-07 06:56:38,134 INFO : Completed test suite (00:20:16) 06:56:38 INFO - 2015-12-07 06:56:38,134 DEBUG : Working with test: dromaeo_css 06:56:38 INFO - 2015-12-07 06:56:38,134 DEBUG : Generating results file: dromaeo_css 06:56:38 INFO - 2015-12-07 06:56:38,135 DEBUG : Working with test: kraken 06:56:38 INFO - 2015-12-07 06:56:38,135 DEBUG : Generating results file: kraken 06:56:38 INFO - 2015-12-07 06:56:38,135 INFO : javascript benchmark 06:56:38 INFO - 2015-12-07 06:56:38,136 DEBUG : Working with test: v8_7 06:56:38 INFO - 2015-12-07 06:56:38,136 DEBUG : Generating results file: v8_7 06:56:38 INFO - 2015-12-07 06:56:38,136 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:38 INFO - 2015-12-07 06:56:38,288 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 06:56:38 INFO - 2015-12-07 06:56:38,288 DEBUG : process_Request line: dromaeo_css 6359.99 graph.html#tests=[[72,94,43]] 06:56:38 INFO - 2015-12-07 06:56:38,288 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:38 INFO - 2015-12-07 06:56:38,393 DEBUG : process_Request line: kraken 1546.40 graph.html#tests=[[232,94,43]] 06:56:38 INFO - 2015-12-07 06:56:38,393 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:38 INFO - 2015-12-07 06:56:38,432 DEBUG : process_Request line: v8_7 21234.99 graph.html#tests=[[230,94,43]] 06:56:38 INFO - 2015-12-07 06:56:38,433 INFO : javascript benchmark 06:56:38 INFO - 2015-12-07 06:56:38,437 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2696.838189708618, 2718.456308738253, 2753.9724602753977, 2787.6794168670604, 2792.274008757722, 4619.0, 4775.617950563951, 4781.163296423125, 4882.316475693406, 4889.9266511002315, 4711.9528804711945, 4734.455537613176, 4735.739534325619, 4736.455307639622, 4938.604911607072, 4374.409454723604, 4468.664850136237, 4472.753998530079, 4497.617702495292, 4528.139653465847, 4428.291473364262, 4453.421055262811, 4508.887277818048, 4539.7049191802425, 4574.794134263966, 4194.224068547298, 4523.298888672244, 4537.70504917181, 4540.841070562515, 4570.497245303047, 4360.498542667602, 4384.408104905829, 4458.866234012985, 4463.843765468226, 4476.932846007313, 4455.754933478657, 4470.8882277942985, 4486.865394038184, 4499.707519011254, 4532.818687252506, 4511.729296242236, 4597.241455159928, 4746.501617330199, 4748.667593268473, 4762.761861906925, 5068.923966140511, 5181.300524429229, 5196.8960620787375, 5220.8694782630355, 5223.73881305937, 5207.661502002357, 5231.947680523184, 5247.763850626731, 5249.658772179834, 5251.133562962106, 4595.839145629887, 4712.410948631421, 4795.880102997418, 4817.927731084036, 4822.879428014257, 5202.947970520322, 5257.342832145981, 5280.551153152025, 5286.762095705702, 5332.040232758063, 5088.542031217208, 5103.464136265713, 5104.770285337168, 5111.591072714174, 5140.563052140536, 4933.260010998379, 5032.496750325012, 5188.688678679291, 5189.481051894781, 5211.739413029333, 4965.677230979974, 5057.443681195065, 5057.570106540985, 5075.0357432087785, 5108.846734597968, 5074.314967479417, 5087.974560127176, 5104.617153713486, 5109.233614957786, 5163.7676304566385, 3788.45067465216, 3854.1520865409566, 3881.6700580450415, 3929.0373858404873, 3978.224246272007, 3545.2554963457965, 3550.5029295898594, 3565.5899571549085, 3580.051286409104, 3586.1751797086818, 4451.755153466591, 4452.0, 4475.395821564112, 4476.910461790746, 4516.728996260234, 4939.333190019373, 5045.596352291808, 5047.293378926953, 5053.671511351824, 5244.868878278074, 4332.155229730172, 4344.695871289043, 4372.081862808782, 4391.451068616423, 4425.114977004612, 4545.499995000548, 4562.475315338778, 4570.9314360284625, 4579.335996280521, 4597.3333866589155, 4773.618110551078, 4860.684055536379, 4862.90274194507, 4862.95137048632, 4865.294532292868, 5160.509751573594, 5256.448072952285, 5261.579073674174, 5275.0, 5335.226392173191, 4933.975330123327, 4947.727874966911, 4951.009798040478, 4955.925661115159, 5004.824831130893, 4864.464908859952, 4968.577670898014, 4981.975090124526, 5176.559992400537, 5183.144781111075, 5193.039287731782, 5249.842504724865, 5253.947460525345, 5260.421353651019, 5269.499397557226, 5070.3155074064525, 5075.492450754895, 5078.669886457368, 5079.619028572798, 5108.770105345194, 4877.95122048775, 4928.975355123202, 4999.700017998932, 5043.394792624908, 5072.721000345016, 4890.902181956412, 4936.531029552187, 4940.851774446773, 4954.3311652926395, 5015.7492125392855, 5058.392992840735, 5070.138076526926, 5085.694858308513, 5102.872428189176, 5128.922926185543, 4618.30725391194, 4785.0, 4810.63920205979, 4890.364252647133, 4936.975315123402], "unit": "ms", "name": "dojo.html", "value": 4703.192470411338}, {"lowerIsBetter": false, "replicates": [532.6670830730791, 538.4292649791221, 540.9323834520685, 541.5126386252371, 542.6554138122291, 25507.74492255079, 26734.197974060786, 34237.31525369491, 34944.12639684009, 35030.29939401217, 37964.620353796454, 38403.0, 38538.229235415274, 38581.0, 38649.42025869614, 7790.8441831163345, 7983.720569780059, 8030.678772849079, 8045.718399856006, 8073.0, 7724.806879828021, 7803.726869559567, 7867.645955931968, 7871.8032049198655, 7896.052473703164, 7917.208279172094, 7921.881171782428, 7952.3638108951145, 7999.800004999864, 8005.279524842763, 7835.333996610295, 7853.0576330840095, 7899.565523896184, 7910.446268761218, 7927.246911543394, 7711.0746710395115, 7757.650905709256, 7771.067471903351, 7789.9221007789765, 7809.960950195269, 36054.098647533756, 36162.0, 36427.271454571026, 36471.63528364735, 36629.084272893124, 2668.3462551674966, 2680.2176552592505, 2761.4615150045747, 2802.719728027201, 3383.881564145268, 27047.323816904536, 27887.302817429525, 28275.717242827515, 28428.431431371257, 28703.282417939718, 3312.8343582821003, 3436.6563343665434, 3454.654534546525, 3462.567179102612, 3535.52270443492, 213631.0, 216201.0, 216310.0, 217072.0, 217097.99999999843, 51406.74296628493, 52473.0, 55305.0, 55390.99999999919, 56470.717646411504, 49734.0, 49913.75043124761, 50072.0, 50325.0, 50344.22418318641, 13464.394102265422, 13517.526886558922, 13609.727805443836, 13611.911047116406, 13639.727205455836, 9850.310478266452, 9873.259505537113, 9885.505724713736, 9899.30704850668, 9906.851397229048, 18594.163262653212, 18666.253349866125, 18712.53218669517, 18774.812251877578, 18809.529761756065, 7557.0, 7745.380369570421, 7770.0, 7829.099653539915, 7854.2145785421, 864.4769914201943, 872.9563521823883, 891.2513488669549, 894.3170488534397, 977.5894124467741, 26058.47024370859, 26434.6034809478, 26461.0, 26677.86661066682, 26808.59787103195, 915.1763412928418, 944.7968686732386, 987.4272921705393, 1111.1666250312267, 1119.3787447966456, 14797.482088126864, 15554.75561955041, 15568.152383988541, 15993.583036897362, 16250.106244156685, 310552.0, 315514.0, 319817.0, 319830.0, 320694.0, 46708.29937550939, 47110.5288947113, 47328.290075648896, 47435.28847067297, 47594.52405475901, 1240.1628900492133, 1244.3094082784141, 1255.3660401497368, 1259.2822091407809, 1259.5276771210797, 26909.596356054284, 27134.592981104903, 27459.725402745717, 27580.448391032467, 27727.861360693067, 38271.0, 38407.61592384041, 38569.42145867758, 38594.2281154381, 38894.0, 224104.0, 226688.0, 226788.0, 227099.0, 229218.0, 28407.0, 41387.586124139576, 42145.15709685851, 42615.37769289645, 42799.7860010698, 37499.625003749614, 37653.62346376501, 37746.43380349242, 38339.80830095831, 38824.41763373495, 31836.363272734878, 32146.0, 32807.67192328046, 32982.670173297956, 33091.172720682174, 32416.585229652155, 32634.673653263162, 32932.50601241031, 33047.53858229108, 33315.500267495525, 32690.34619307553, 32956.67043329536, 33069.17327066747, 33124.834375827966, 33155.0, 28279.747828999927, 29224.561631575118, 29798.404031919676, 30138.917354421254, 30470.390592188476, 24625.261242162764, 24857.62713559262, 24946.501069978134, 25556.616650749882, 25583.488330233664], "unit": "ms", "name": "ext.html", "value": 16876.61310882288}, {"lowerIsBetter": false, "replicates": [278.4097712848761, 283.83395713507593, 283.9361143742658, 286.2814336016598, 289.55986899912136, 12786.744265114692, 13106.541271055516, 14855.480058197965, 15457.381704731812, 15469.149196794186, 9649.517524123801, 10188.490575471234, 10414.531346089425, 10490.947545262263, 10491.42297173655, 4514.887127821798, 4641.0949864776385, 4655.906881862377, 4661.300804879262, 4662.487126416091, 4604.493505714368, 6097.908531372011, 6379.170707807978, 6386.265579458375, 6394.392532709385, 6216.347283535231, 6354.809355719336, 6493.123428337185, 6583.275839657634, 6594.934050659504, 6617.4706023518, 6711.563748356366, 6815.454763618924, 6821.045053692487, 6851.04085428038, 6512.544121911468, 6515.70679319427, 6519.771807986698, 6529.706163222619, 6540.051692504608, 19288.710669339973, 20082.397528074034, 20170.29403970854, 20783.58432831335, 21538.676919846213, 1888.8488920886296, 1930.5849242412949, 1937.7965313642005, 1983.2860170338668, 2016.919323227069, 13638.318084095756, 13743.381547830371, 13965.511207107702, 14117.78823317651, 14162.575122746333, 1846.843018343429, 1876.1463534091956, 1937.5931054478576, 1940.0105945967516, 1975.7826639069835, 49716.0, 49809.25286120675, 50749.0, 57682.7115864418, 61903.38096619021, 14649.414023439156, 15388.0, 15675.372985080698, 15690.74474042074, 15695.0, 22973.195938142086, 23154.0, 23274.8836255821, 23325.88337058338, 23388.298351049496, 8013.439059265912, 8025.31784798287, 8054.919450805417, 8077.313428358655, 8103.0, 6684.632345220963, 6685.465162786965, 6689.531732778756, 6698.531102822853, 6708.127943367331, 4069.9389509156795, 4185.309423945015, 4202.936955945664, 7643.312101910855, 7697.461177717618, 1692.61916068886, 1697.3889399816057, 1716.7768190135203, 1753.4213709475841, 1757.349780581193, 808.8584497712877, 824.027647376102, 898.4339865884451, 979.4759803505091, 984.5717113055844, 14901.776473352907, 15394.23028848553, 15982.520524384287, 16156.27296771648, 16896.915515422592, 803.7910143362768, 834.3408707121428, 844.7170197983621, 870.9303255739526, 916.7799728065349, 9010.729678109667, 9110.954445227731, 9240.21458176049, 9341.299402544837, 9455.810883782286, 452990.0, 460567.0, 464898.0, 469241.0, 470459.0, 70147.64926175337, 72530.63734681293, 73498.6325068382, 73869.0, 74643.62678186574, 1033.8655974723238, 1044.7649278912183, 1045.743792770776, 1047.120418848156, 1071.4000159910474, 14568.781468277772, 14636.707265854411, 14753.0, 14765.261736912897, 14906.254687265377, 31965.84017079993, 35042.474362884066, 35153.296934060665, 35497.82251088728, 36182.819085904404, 36387.45418818773, 37109.257814844095, 38262.0, 38964.41553376645, 39691.603083969945, 8279.461834980708, 8528.658853645784, 8770.12298770118, 8782.648694052166, 8815.382923195315, 9954.104130628279, 10065.496725163859, 14315.642108947359, 15680.0, 15929.601759956095, 12815.807762883378, 13048.478060877458, 13318.667033324244, 13367.264800436069, 13538.796918046433, 12430.192037517532, 12599.811002834782, 12982.260758889597, 13130.146540474838, 13441.529546465827, 13259.933700331436, 13554.86445135536, 13657.658558536115, 13911.860881391462, 14158.292085395895, 8880.1563851434, 8892.911070889208, 8908.955455222682, 9066.50134242623, 9082.318826088202, 9428.057194280516, 13148.0, 13464.798028029392, 13869.930650347087, 13877.722445551235], "unit": "ms", "name": "jquery.html", "value": 8753.892970834702}, {"lowerIsBetter": false, "replicates": [1474.2849717886816, 1645.9999999999998, 1677.9748303775445, 1702.7701260329852, 1719.8280171982803, 5974.8805023899495, 6122.87754244916, 6784.151981002375, 6986.8253293667685, 6999.0, 6431.26040505342, 6476.093346931433, 6539.378759017885, 6550.967245163767, 6552.508561857856, 2028.188724510193, 2058.3516192399347, 2058.6397380458434, 2059.5366042640435, 2065.483629092727, 2041.1427200575795, 2070.1512379924234, 2074.315475892959, 2078.251829341436, 2091.4039498742864, 1994.7905469925668, 1996.5308152584132, 2031.207828946712, 2031.989840050805, 2035.5318276796345, 2050.2004218354855, 2072.160774886166, 2075.055849588434, 2075.4811297175706, 2079.438551591077, 2029.2593203480772, 2047.9897600511902, 2056.598963202176, 2057.0331943986303, 2066.2354928676336, 7073.186583542907, 7124.715011399538, 7154.570725756419, 7174.210836807947, 7189.424846012306, 4110.034141976633, 4151.958480415187, 4159.355299928516, 4177.143685544456, 4194.580541945811, 2658.162678756205, 2707.756301932816, 2734.5624700048097, 2735.4392349568293, 2750.642416485864, 826.3802148388709, 827.462149602757, 836.8075342671159, 851.6848765956573, 858.1332853817627, 9496.287778416647, 9660.903390966141, 9696.51517424126, 9708.077732615391, 9725.6596019139, 3792.544894612664, 3813.504244448204, 3855.055511399725, 3864.42033694948, 3870.806459677005, 8276.213759692819, 8293.543855088028, 8322.0, 8335.041470230879, 8345.791355216046, 4233.724807887477, 4252.596003379674, 4257.254980378421, 4259.7231179973205, 4280.143971205771, 3200.439923013463, 3299.5050742388353, 3733.9253214936093, 3855.9036024099623, 3857.7106716996336, 3412.146963259185, 3432.553768010143, 3437.5015622734563, 3460.965390346115, 3464.3244567309134, 1030.258214085857, 1038.1850247555633, 1042.6142327338932, 1065.8488832061355, 1083.991887544591, 1024.7233247023262, 1041.4116024446164, 1042.0777611813598, 1044.1490185498794, 1072.903438690506, 6410.583312084699, 6474.5791523550815, 6506.089147519351, 6519.608823470607, 6519.8696026079215, 386.7331541236538, 388.3882884456992, 402.736207783902, 403.9779358223699, 404.3590908410203, 5163.870903227375, 5209.739513024334, 5216.843494695166, 5219.086659834514, 5258.842234732964, 8217.917820821835, 8555.529445880411, 8627.396082274181, 8633.568321583896, 8684.782880427914, 8542.273906718, 8543.0, 8570.700025499078, 8628.094050124646, 8668.306535477146, 6481.254655714559, 6602.570832895751, 6694.531382803254, 6745.0, 6886.827829304308, 6630.469562434897, 6662.133922590227, 6673.733050677918, 6678.198616166092, 6680.098186744727, 7544.924550754422, 7627.847443051219, 7724.459287849797, 7774.222577742181, 7786.416018798726, 7765.961170194113, 7980.521168729895, 8007.919920800718, 8037.517748935083, 8116.59417029158, 5205.297284866495, 5258.290130832442, 6071.544634152545, 6241.625502469867, 6303.905441418291, 6486.513511486752, 6528.706208220547, 6569.737210511526, 6576.44100251484, 6615.073889655356, 5843.824685259449, 5926.940730592812, 6132.110843927695, 6336.429721325103, 6361.045843123384, 5793.913091303718, 6114.755409783559, 6123.693815309306, 6212.968935155295, 6256.186695729708, 6252.687365631609, 6312.021636646327, 6312.021636646327, 6317.368263173646, 6322.747090116528, 5459.836204913859, 5460.372057213472, 5462.617616766788, 5465.59008074388, 5474.069408200536, 5702.344230413555, 5716.456936591017, 5747.3103227612955, 5846.0, 5886.440788125121], "unit": "ms", "name": "mootools.html", "value": 3924.526400117274}, {"lowerIsBetter": false, "replicates": [254.03593363186704, 258.97280785517535, 261.3114443441531, 261.4940090924062, 264.6281973826774, 5491.176323551469, 5544.1960915667205, 5558.944410555899, 5570.805021824237, 5687.516561092312, 5489.862753431156, 5586.301712285965, 5594.832155035345, 5625.746841392137, 5639.943600563993, 3939.1333906540585, 4002.599740026003, 4095.1604920991276, 4189.895252618679, 4197.559256278093, 4174.853880114197, 4180.665546756252, 4181.101063271396, 4182.22628813669, 4183.895402614929, 4088.693347998897, 4134.793260336971, 4135.875923722293, 4139.855105071323, 4146.253674338618, 4134.937975930348, 4136.31750761124, 4139.917201655965, 4141.254574176647, 4150.27370210215, 3395.915102122442, 3437.106352348407, 3519.03226612681, 3532.3288575170636, 3545.574531056264, 5437.32033495813, 5445.700486473243, 5446.264754258164, 5456.645318054314, 5458.263134476834, 4666.0, 4673.369095172142, 4683.484816670163, 4684.156851766681, 4692.788824502905, 5855.975204339224, 5865.032269675498, 5876.647401155944, 5879.059350503899, 5885.44088311614, 3641.799701016443, 3724.42271447926, 3726.496922915399, 3756.981215093934, 3758.868439604628, 6126.264848218198, 6196.256449226122, 6199.287081985584, 6204.100405441231, 6213.254409470847, 3945.5265368156006, 3949.585293544194, 3952.6442620164325, 3954.367301231789, 3958.4062390641056, 3987.8803635890968, 3995.081131339808, 3995.760254384746, 4011.859584914514, 4011.91976160481, 4612.446506419251, 4747.548982846693, 4751.976240118777, 4758.238681810963, 4791.760411979387, 5891.234139561915, 5915.822525324247, 5937.346891841894, 5938.6436813791315, 5945.940540594625, 1423.6369725719876, 1428.6428392901776, 1430.8283006039342, 1443.5452832357985, 1443.877270432025, 948.5020364308793, 950.8922105746727, 957.6121670723368, 981.4945303168873, 986.0238364019569, 5085.847424577269, 5105.668131571436, 5113.335266415343, 5122.103631864484, 5124.308218390544, 6114.847128821815, 6123.877522449526, 6134.141220229171, 6144.631322120687, 6152.046432802923, 5099.311592934906, 5125.56432703217, 5129.076766182123, 5136.666116702402, 5144.074066668036, 3247.3180632067056, 3311.0563489405404, 3336.115929278743, 3343.983280083584, 3365.343757967222, 5713.485786279255, 5838.036723940587, 5838.532917366685, 5852.356240813507, 5867.530597552186, 6332.746690132435, 6347.904781428282, 6406.5515413920575, 6409.294977552466, 6415.422611964946, 5821.301443826683, 5827.79602713903, 5828.6794226317115, 5831.1253312001845, 5834.708264586839, 6010.939890601213, 6158.04550294705, 6197.132401463708, 6221.377862213923, 6225.937740622717, 6070.1501789750355, 6073.514118870568, 6076.665783381956, 6095.0, 6097.329293777592, 5791.928493228597, 5800.651960882361, 5829.883402331845, 5838.32859221178, 5853.151293062568, 3930.6265904739003, 3990.102226998902, 4003.3194356958807, 4006.4390985261502, 4017.1965606878157, 5971.671558064349, 6176.320604733386, 6182.938170618416, 6188.0, 6192.907106393498, 5922.378150294157, 5933.050711886078, 5939.376365481735, 5943.316518600416, 5945.732442040032, 5926.377730338252, 5927.2590926134235, 5939.10913362999, 5940.46535811779, 5954.791582294599, 5648.604597678123, 5807.274090738658, 5812.564057695774, 5822.301323841166, 5822.679752613647, 5946.43508866657, 5964.463198312173, 5967.224260846062, 5971.58198926071, 5979.1928089707335, 5829.650220986754, 5834.212381328466, 5835.066389377679, 5837.211976383134, 5853.063509838576], "unit": "ms", "name": "prototype.html", "value": 4322.202431810283}, {"lowerIsBetter": false, "replicates": [689.7241103558576, 734.3794493652869, 757.7120694136228, 778.8052986753312, 808.531051989846, 11133.443327833606, 11536.307821530714, 11566.363849988236, 11610.12924030697, 11622.941885290584, 11216.439178041086, 11224.607138750145, 11239.66281011571, 11273.267237629549, 11325.150613703963, 604.794369914229, 613.8710870717132, 769.2346115614971, 778.6690656471005, 792.4373694676786, 779.5517577392993, 783.6316931042429, 790.4071946040469, 791.3866753266236, 791.7545560876118, 814.767791179514, 823.9876401853977, 824.9298809601191, 825.4923222218323, 826.0335407573124, 822.9753107406757, 824.171707434028, 824.8886400335938, 824.9670013199465, 826.8718348655938, 605.8364241654729, 611.8500967263049, 615.4522474997256, 616.3928530397554, 616.7995401494533, 11275.718107047307, 11319.547218111265, 11340.376279304635, 11414.486348114355, 11464.770704585944, 10317.948410257975, 10504.212184086224, 10757.246992710514, 10774.622888198875, 10810.29733067348, 9090.363674542785, 9321.067893210624, 9330.393524420891, 9418.670346537838, 9495.57269922855, 3224.193951512122, 3236.6925142111463, 3248.399046176441, 3252.7560432967384, 3267.591551056118, 37834.81082594569, 38124.618753812385, 38221.0, 38426.423603646246, 38674.41988370177, 8739.344549158839, 8836.911630883738, 8847.69033083839, 9017.458952462874, 9100.044495328028, 14041.227732474812, 14052.71894562103, 15224.619384515476, 15416.0, 15484.767728484081, 6008.128821320884, 6089.908651370233, 6108.236470441195, 6191.133241346215, 6277.027060805583, 3446.483027545838, 3448.9482657760154, 3503.264314493985, 3509.12271932017, 3522.7005704515404, 2562.3722188064044, 2584.754448327406, 2588.637590737261, 2603.271084096456, 2605.439830436427, 457.76882674249293, 462.7269910752672, 463.5063657205066, 475.847728726811, 486.3750081145711, 579.4639958038797, 619.2568917299259, 620.1906512001791, 624.6158612453308, 637.4358692557121, 7913.643886025143, 8283.95858020706, 8371.623276952552, 8476.576171191417, 8491.0, 567.8693900402931, 596.0850095104081, 598.4344794169468, 612.9448349648553, 630.6846576711645, 3521.6053083903194, 3651.561812582454, 3674.467202255658, 3768.924621507609, 3788.8484460621266, 47090.293645595346, 48603.0, 48710.75644621754, 48888.0, 49404.0, 42945.57054429478, 43883.341749873776, 44346.0, 44605.10789784186, 45197.096058078656, 40458.19083618311, 40764.38853417201, 40970.18059638791, 41098.38352424716, 41330.793346033075, 7120.715171393086, 7234.348908598251, 7378.040854688856, 7549.320561149523, 8172.223638754309, 29089.854550727112, 29169.0, 29211.41577168487, 30103.849480752455, 30153.0, 37001.44497832588, 37463.0, 38136.0, 38870.80564597159, 39376.40935386029, 9666.806663866542, 9894.703158905244, 10100.191984641358, 10135.54390052464, 10314.587416503557, 10943.507542160463, 11094.167937404565, 11097.223194376316, 11197.888021119685, 11948.701282468008, 10531.45584820671, 10577.62978295756, 10939.453027348442, 10961.123110151328, 11100.777984440427, 10589.364638121737, 10596.841047384141, 10688.144948403953, 10743.462826858782, 10783.137349012217, 9443.338966272295, 9941.155001824925, 9945.30382873192, 10124.544395502367, 10353.74115647115, 8802.691905783267, 8825.0, 8983.236424903957, 9049.683261085831, 9344.205742511962, 8339.374546909128, 8636.222739953435, 8826.145619909154, 8837.381383303107, 8870.911290887008], "unit": "ms", "name": "yui.html", "value": 5614.599974568617}], "name": "dromaeo_css", "value": 6359.985877652429}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 114.0, 115.0, 115.0, 126.0, 114.0, 113.0, 114.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 163.0, 167.0, 133.0, 152.0, 163.0, 133.0, 167.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 164.0, 166.0, 163.0, 168.0, 164.0, 166.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 72.0, 74.0, 133.0, 79.0, 74.0, 73.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 132.0, 94.0, 96.0, 95.0, 129.0, 95.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 151.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 149.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [79.0, 74.0, 75.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 73.8}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 86.0, 95.0, 86.0, 86.0, 85.0, 85.0, 86.0, 95.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [126.0, 129.0, 124.0, 134.0, 132.0, 128.0, 131.0, 126.0, 124.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.0}, {"lowerIsBetter": true, "replicates": [142.0, 151.0, 146.0, 152.0, 152.0, 138.0, 154.0, 151.0, 148.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 70.0, 73.0, 71.0, 69.0, 72.0, 69.0, 70.0, 74.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1546.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [173.16017316017317], "unit": "score", "name": "Richards", "value": 203.86904999999993}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [277.39251040221916], "unit": "score", "name": "Encrypt", "value": 959.5825049999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1051.5247108307046], "unit": "score", "name": "RayTrace", "value": 703.7295389999999}, {"lowerIsBetter": false, "replicates": [709.7232079488999], "unit": "score", "name": "Earley", "value": 939.0463669999997}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [26315.78947368421], "unit": "score", "name": "RegExp", "value": 34.61742999999998}, {"lowerIsBetter": false, "replicates": [593.9716312056737], "unit": "score", "name": "Splay", "value": 137.1967880597015}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21234.985310701493}]} 06:56:38 INFO - RETURN: dromaeo_css: 6359.99 06:56:38 INFO - RETURN: kraken: 1546.40 06:56:38 INFO - RETURN: v8_7: 21234.99 06:56:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21234.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1546.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6359.99"}}} 06:56:38 INFO - Return code: 0 06:56:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:56:38 INFO - # TBPL SUCCESS # 06:56:38 INFO - Running post-action listener: _resource_record_post_action 06:56:38 INFO - Running post-run listener: _resource_record_post_run 06:56:39 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 73728; Write bytes: 518111232; Read time: 20; Write time: 316628 06:56:39 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231051264; Read time: 0; Write time: 188892 06:56:39 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 73728; Write bytes: 275505152; Read time: 20; Write time: 119280 06:56:39 INFO - Running post-run listener: _upload_blobber_files 06:56:39 INFO - Blob upload gear active. 06:56:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:56:39 INFO - Copying logs to upload dir... 06:56:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.747430 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-07 06:56:38.818656) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 06:56:38.822869) ========= 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=5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009866 build_url: 'https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 06:56:38.874956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:56:38.875281) ========= 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=5804b9f07a53938c557deee7000001c5-1449498163.646750-1148332318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:56:38.926195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 06:56:38.926610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 06:56:38.926991) ========= ========= Total master_lag: 0.25 =========