builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1449498924.82 results: success (0) buildid: 20151207051729 builduid: 5bc339d3f05b4e65abe830512698c4f8 revision: 59bc3c7a83de7ffb611203912a7da6ad84535a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.820264) ========= 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:24.820719) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.821270) ========= 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=801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006439 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.845748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.846026) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.859159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.859533) ========= 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=801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.907999) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.908285) ========= 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:24.908651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:24.908930) ========= 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=801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2015-12-07 06:35:26 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109910 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.057402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.057690) ========= 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=801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020214 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:25.108219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-07 06:35:25.108567) ========= 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=801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-07 06:35:26,437 truncating revision to first 12 chars 2015-12-07 06:35:26,437 Setting DEBUG logging. 2015-12-07 06:35:26,437 attempt 1/10 2015-12-07 06:35:26,438 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:27,166 unpacking tar archive at: mozilla-central-59bc3c7a83de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.002676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-07 06:35:26.128591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:26.128900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:26.142213) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 06:35:26.142720) ========= 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.143134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-07 06:35:26.143472) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781 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 --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', 06:35:27 INFO - 'system_bits': '64', 06:35:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:27 INFO - 'title': 'talos-linux64-ix-006', 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:28 INFO - Running post-action listener: _resource_record_post_action 06:35:28 INFO - ##### 06:35:28 INFO - ##### Running read-buildbot-config step. 06:35:28 INFO - ##### 06:35:28 INFO - Running pre-action listener: _resource_record_pre_action 06:35:28 INFO - Running main action method: read_buildbot_config 06:35:28 INFO - Using buildbot properties: 06:35:28 INFO - { 06:35:28 INFO - "properties": { 06:35:28 INFO - "buildnumber": 232, 06:35:28 INFO - "product": "firefox", 06:35:28 INFO - "script_repo_revision": "production", 06:35:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:35:28 INFO - "repository": "", 06:35:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:35:28 INFO - "buildid": "20151207051729", 06:35:28 INFO - "slavename": "talos-linux64-ix-006", 06:35:28 INFO - "pgo_build": "False", 06:35:28 INFO - "basedir": "/builds/slave/test", 06:35:28 INFO - "project": "", 06:35:28 INFO - "platform": "ubuntu64_hw", 06:35:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:35:28 INFO - "slavebuilddir": "test", 06:35:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:35:28 INFO - "branch": "mozilla-central", 06:35:28 INFO - "repo_path": "mozilla-central", 06:35:28 INFO - "stage_platform": "linux64", 06:35:28 INFO - "builduid": "5bc339d3f05b4e65abe830512698c4f8", 06:35:28 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 06:35:28 INFO - }, 06:35:28 INFO - "sourcestamp": { 06:35:28 INFO - "repository": "", 06:35:28 INFO - "hasPatch": false, 06:35:28 INFO - "project": "", 06:35:28 INFO - "branch": "mozilla-central-linux64-talos", 06:35:28 INFO - "changes": [ 06:35:28 INFO - { 06:35:28 INFO - "category": null, 06:35:28 INFO - "files": [ 06:35:28 INFO - { 06:35:28 INFO - "url": null, 06:35:28 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:28 INFO - } 06:35:28 INFO - ], 06:35:28 INFO - "repository": "", 06:35:28 INFO - "rev": "59bc3c7a83de7ffb611203912a7da6ad84535a5a", 06:35:28 INFO - "who": "cbook@mozilla.com", 06:35:28 INFO - "when": 1449498835, 06:35:28 INFO - "number": 6963273, 06:35:28 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 06:35:28 INFO - "project": "", 06:35:28 INFO - "at": "Mon 07 Dec 2015 06:33:55", 06:35:28 INFO - "branch": "mozilla-central-linux64-talos", 06:35:28 INFO - "revlink": "", 06:35:28 INFO - "properties": [ 06:35:28 INFO - [ 06:35:28 INFO - "buildid", 06:35:28 INFO - "20151207051729", 06:35:28 INFO - "Change" 06:35:28 INFO - ], 06:35:28 INFO - [ 06:35:28 INFO - "builduid", 06:35:28 INFO - "5bc339d3f05b4e65abe830512698c4f8", 06:35:28 INFO - "Change" 06:35:28 INFO - ], 06:35:28 INFO - [ 06:35:28 INFO - "pgo_build", 06:35:28 INFO - "False", 06:35:28 INFO - "Change" 06:35:28 INFO - ] 06:35:28 INFO - ], 06:35:28 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 06:35:28 INFO - } 06:35:28 INFO - ], 06:35:28 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 06:35:28 INFO - } 06:35:28 INFO - } 06:35:28 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:28 INFO - Running post-action listener: _resource_record_post_action 06:35:28 INFO - ##### 06:35:28 INFO - ##### Running download-and-extract step. 06:35:28 INFO - ##### 06:35:28 INFO - Running pre-action listener: _resource_record_pre_action 06:35:28 INFO - Running main action method: download_and_extract 06:35:28 INFO - mkdir: /builds/slave/test/build/tests 06:35:28 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:28 INFO - https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:35:28 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:28 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:28 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:28 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:32 INFO - Downloaded 1302 bytes. 06:35:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:35:32 INFO - Using the following test package requirements: 06:35:32 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:35:32 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:35:32 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:32 INFO - u'jsshell-linux-x86_64.zip'], 06:35:32 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:35:32 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:35:32 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:35:32 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:35:32 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:35:32 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:35:32 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:35:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:32 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:32 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:32 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:32 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:32 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:35 INFO - Downloaded 21859907 bytes. 06:35:35 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:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:35:35 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:36 INFO - Return code: 0 06:35:36 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:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:36 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:36 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:36 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:36 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:36 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:49 INFO - Downloaded 21859907 bytes. 06:35:49 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:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:35:49 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:50 INFO - Return code: 0 06:35:50 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:50 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:50 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:50 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:50 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:50 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:51 INFO - Downloaded 11132074 bytes. 06:35:51 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:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:35:51 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:51 INFO - Return code: 0 06:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:51 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:51 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:51 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:51 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:51 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:53 INFO - Downloaded 57726599 bytes. 06:35:53 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:53 INFO - mkdir: /builds/slave/test/properties 06:35:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:53 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:53 INFO - Contents: 06:35:53 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:53 INFO - Running post-action listener: _resource_record_post_action 06:35:53 INFO - Running post-action listener: set_extra_try_arguments 06:35:53 INFO - ##### 06:35:53 INFO - ##### Running populate-webroot step. 06:35:53 INFO - ##### 06:35:53 INFO - Running pre-action listener: _resource_record_pre_action 06:35:53 INFO - Running main action method: populate_webroot 06:35:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:35:53 INFO - '../fennec_ids.txt'], 06:35:53 INFO - 'tests': ['tcheck2']}, 06:35:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:53 INFO - '--tppagecycles', 06:35:53 INFO - '7'], 06:35:53 INFO - 'tests': ['tsvgm']}}, 06:35:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:35:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:35:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:35:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:53 INFO - 'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:53 INFO - 'tests': ['damp', 'tps']}, 06:35:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:53 INFO - 'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['damp', 'tps']}, 06:35:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:35:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:53 INFO - 'other': {'tests': ['a11yr', 06:35:53 INFO - 'ts_paint', 06:35:53 INFO - 'tpaint', 06:35:53 INFO - 'sessionrestore', 06:35:53 INFO - 'sessionrestore_no_auto_restore']}, 06:35:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['a11yr', 06:35:53 INFO - 'ts_paint', 06:35:53 INFO - 'tpaint', 06:35:53 INFO - 'sessionrestore', 06:35:53 INFO - 'sessionrestore_no_auto_restore']}, 06:35:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['a11yr', 06:35:53 INFO - 'ts_paint', 06:35:53 INFO - 'tpaint', 06:35:53 INFO - 'sessionrestore', 06:35:53 INFO - 'sessionrestore_no_auto_restore']}, 06:35:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['a11yr', 06:35:53 INFO - 'ts_paint', 06:35:53 INFO - 'tpaint', 06:35:53 INFO - 'sessionrestore', 06:35:53 INFO - 'sessionrestore_no_auto_restore']}, 06:35:53 INFO - 'other_l64': {'tests': ['a11yr', 06:35:53 INFO - 'ts_paint', 06:35:53 INFO - 'tpaint', 06:35:53 INFO - 'sessionrestore', 06:35:53 INFO - 'sessionrestore_no_auto_restore']}, 06:35:53 INFO - 'other_nol64': {'tests': ['a11yr', 06:35:53 INFO - 'ts_paint', 06:35:53 INFO - 'tpaint', 06:35:53 INFO - 'sessionrestore', 06:35:53 INFO - 'sessionrestore_no_auto_restore']}, 06:35:53 INFO - 'svgr': {'tests': ['tsvgx', 06:35:53 INFO - 'tsvgr_opacity', 06:35:53 INFO - 'tart', 06:35:53 INFO - 'tscrollx', 06:35:53 INFO - 'cart']}, 06:35:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['tsvgx', 06:35:53 INFO - 'tsvgr_opacity', 06:35:53 INFO - 'tart', 06:35:53 INFO - 'tscrollx', 06:35:53 INFO - 'cart']}, 06:35:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:53 INFO - 'tests': ['tp5o']}, 06:35:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:53 INFO - 'talos_options': ['--e10s'], 06:35:53 INFO - 'tests': ['tp5o']}, 06:35:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:53 INFO - 'talos_options': ['--xperf_path', 06:35:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:53 INFO - 'tests': ['tp5n']}, 06:35:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:53 INFO - 'talos_options': ['--e10s', 06:35:53 INFO - '--xperf_path', 06:35:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:53 INFO - 'tests': ['tp5n']}}, 06:35:53 INFO - 'talos.zip': {'path': '', 06:35:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:53 INFO - Running post-action listener: _resource_record_post_action 06:35:53 INFO - ##### 06:35:53 INFO - ##### Running create-virtualenv step. 06:35:53 INFO - ##### 06:35:53 INFO - Running pre-action listener: _resource_record_pre_action 06:35:53 INFO - Running main action method: create_virtualenv 06:35:53 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:53 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:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:53 INFO - Using real prefix '/usr' 06:35:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:53 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:55 INFO - Installing pip.................done. 06:35:55 INFO - Return code: 0 06:35:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 06:35:55 INFO - 'HOME': '/home/cltbld', 06:35:55 INFO - 'LANG': 'en_US.UTF-8', 06:35:55 INFO - 'LANGUAGE': 'en_US:en', 06:35:55 INFO - 'LOGNAME': 'cltbld', 06:35:55 INFO - 'MAIL': '/var/mail/cltbld', 06:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:55 INFO - 'MOZ_NO_REMOTE': '1', 06:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:55 INFO - 'NO_EM_RESTART': '1', 06:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:55 INFO - 'PWD': '/builds/slave/test', 06:35:55 INFO - 'SHELL': '/bin/bash', 06:35:55 INFO - 'SHLVL': '1', 06:35:55 INFO - 'TERM': 'linux', 06:35:55 INFO - 'TMOUT': '86400', 06:35:55 INFO - 'USER': 'cltbld', 06:35:55 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:55 INFO - '_': '/tools/buildbot/bin/python'} 06:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:55 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:55 INFO - Cleaning up... 06:35:55 INFO - Return code: 0 06:35:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 06:35:55 INFO - 'HOME': '/home/cltbld', 06:35:55 INFO - 'LANG': 'en_US.UTF-8', 06:35:55 INFO - 'LANGUAGE': 'en_US:en', 06:35:55 INFO - 'LOGNAME': 'cltbld', 06:35:55 INFO - 'MAIL': '/var/mail/cltbld', 06:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:55 INFO - 'MOZ_NO_REMOTE': '1', 06:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:55 INFO - 'NO_EM_RESTART': '1', 06:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:55 INFO - 'PWD': '/builds/slave/test', 06:35:55 INFO - 'SHELL': '/bin/bash', 06:35:55 INFO - 'SHLVL': '1', 06:35:55 INFO - 'TERM': 'linux', 06:35:55 INFO - 'TMOUT': '86400', 06:35:55 INFO - 'USER': 'cltbld', 06:35:55 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:55 INFO - '_': '/tools/buildbot/bin/python'} 06:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:56 INFO - Downloading/unpacking psutil>=0.7.1 06:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:35:57 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:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:35:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:57 INFO - Installing collected packages: psutil 06:35:57 INFO - Running setup.py install for psutil 06:35:58 INFO - building 'psutil._psutil_linux' extension 06:35:58 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:58 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:58 INFO - building 'psutil._psutil_posix' extension 06:35:58 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:58 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:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:58 INFO - Successfully installed psutil 06:35:58 INFO - Cleaning up... 06:35:58 INFO - Return code: 0 06:35:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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:58 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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 06:35:58 INFO - 'HOME': '/home/cltbld', 06:35:58 INFO - 'LANG': 'en_US.UTF-8', 06:35:58 INFO - 'LANGUAGE': 'en_US:en', 06:35:58 INFO - 'LOGNAME': 'cltbld', 06:35:58 INFO - 'MAIL': '/var/mail/cltbld', 06:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:58 INFO - 'MOZ_NO_REMOTE': '1', 06:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:58 INFO - 'NO_EM_RESTART': '1', 06:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:58 INFO - 'PWD': '/builds/slave/test', 06:35:58 INFO - 'SHELL': '/bin/bash', 06:35:58 INFO - 'SHLVL': '1', 06:35:58 INFO - 'TERM': 'linux', 06:35:58 INFO - 'TMOUT': '86400', 06:35:58 INFO - 'USER': 'cltbld', 06:35:58 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:58 INFO - '_': '/tools/buildbot/bin/python'} 06:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:35:58 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:58 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:58 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:58 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:58 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:58 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 - Downloading mozsystemmonitor-0.0.tar.gz 06:36:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:00 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:36:00 INFO - Installing collected packages: mozsystemmonitor 06:36:00 INFO - Running setup.py install for mozsystemmonitor 06:36:00 INFO - Successfully installed mozsystemmonitor 06:36:00 INFO - Cleaning up... 06:36:00 INFO - Return code: 0 06:36:00 INFO - Installing blobuploader==1.2.4 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', '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 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 06:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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 - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:03 INFO - Downloading docopt-0.6.1.tar.gz 06:36:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:03 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:03 INFO - Running setup.py install for blobuploader 06:36:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:03 INFO - Running setup.py install for requests 06:36:03 INFO - Running setup.py install for docopt 06:36:03 INFO - Successfully installed blobuploader requests docopt 06:36:03 INFO - Cleaning up... 06:36:03 INFO - Return code: 0 06:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:36:03 INFO - Using env: {'DISPLAY': ':0', 06:36:03 INFO - 'HOME': '/home/cltbld', 06:36:03 INFO - 'LANG': 'en_US.UTF-8', 06:36:03 INFO - 'LANGUAGE': 'en_US:en', 06:36:03 INFO - 'LOGNAME': 'cltbld', 06:36:03 INFO - 'MAIL': '/var/mail/cltbld', 06:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:03 INFO - 'MOZ_NO_REMOTE': '1', 06:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:03 INFO - 'NO_EM_RESTART': '1', 06:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:03 INFO - 'PWD': '/builds/slave/test', 06:36:03 INFO - 'SHELL': '/bin/bash', 06:36:03 INFO - 'SHLVL': '1', 06:36:03 INFO - 'TERM': 'linux', 06:36:03 INFO - 'TMOUT': '86400', 06:36:03 INFO - 'USER': 'cltbld', 06:36:03 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:03 INFO - '_': '/tools/buildbot/bin/python'} 06:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:04 INFO - Running setup.py (path:/tmp/pip-6ijft_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:04 INFO - Running setup.py (path:/tmp/pip-To1MYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:04 INFO - Running setup.py (path:/tmp/pip-BKAqKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:04 INFO - Running setup.py (path:/tmp/pip-KGUi49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:04 INFO - Running setup.py (path:/tmp/pip-sw5hhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:04 INFO - Running setup.py (path:/tmp/pip-OoLc4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:04 INFO - Running setup.py (path:/tmp/pip-YgQPk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:04 INFO - Running setup.py (path:/tmp/pip-X5hilB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:04 INFO - Running setup.py (path:/tmp/pip-qr_pyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:04 INFO - Running setup.py (path:/tmp/pip-OVL54H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:04 INFO - Running setup.py (path:/tmp/pip-ycyGqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:04 INFO - Running setup.py (path:/tmp/pip-keRlbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:04 INFO - Running setup.py (path:/tmp/pip-jL2Fxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:04 INFO - Running setup.py (path:/tmp/pip-SoKgRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:05 INFO - Running setup.py (path:/tmp/pip-H2YRgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:05 INFO - Running setup.py (path:/tmp/pip-E1UMIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:05 INFO - Running setup.py (path:/tmp/pip-pDiG8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:05 INFO - Running setup.py install for manifestparser 06:36:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:05 INFO - Running setup.py install for mozcrash 06:36:05 INFO - Running setup.py install for mozdebug 06:36:05 INFO - Running setup.py install for mozdevice 06:36:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:36:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:05 INFO - Running setup.py install for mozfile 06:36:05 INFO - Running setup.py install for mozhttpd 06:36:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:05 INFO - Running setup.py install for mozinfo 06:36:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:05 INFO - Running setup.py install for mozInstall 06:36:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Running setup.py install for mozleak 06:36:06 INFO - Running setup.py install for mozlog 06:36:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Running setup.py install for moznetwork 06:36:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Running setup.py install for mozprocess 06:36:06 INFO - Running setup.py install for mozprofile 06:36:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Running setup.py install for mozrunner 06:36:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:06 INFO - Running setup.py install for mozscreenshot 06:36:06 INFO - Running setup.py install for moztest 06:36:06 INFO - Running setup.py install for mozversion 06:36:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:07 INFO - Cleaning up... 06:36:07 INFO - Return code: 0 06:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:36:07 INFO - Using env: {'DISPLAY': ':0', 06:36:07 INFO - 'HOME': '/home/cltbld', 06:36:07 INFO - 'LANG': 'en_US.UTF-8', 06:36:07 INFO - 'LANGUAGE': 'en_US:en', 06:36:07 INFO - 'LOGNAME': 'cltbld', 06:36:07 INFO - 'MAIL': '/var/mail/cltbld', 06:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:07 INFO - 'MOZ_NO_REMOTE': '1', 06:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:07 INFO - 'NO_EM_RESTART': '1', 06:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:07 INFO - 'PWD': '/builds/slave/test', 06:36:07 INFO - 'SHELL': '/bin/bash', 06:36:07 INFO - 'SHLVL': '1', 06:36:07 INFO - 'TERM': 'linux', 06:36:07 INFO - 'TMOUT': '86400', 06:36:07 INFO - 'USER': 'cltbld', 06:36:07 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:07 INFO - '_': '/tools/buildbot/bin/python'} 06:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:07 INFO - Running setup.py (path:/tmp/pip-6ii8lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:07 INFO - Running setup.py (path:/tmp/pip-36Eguv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:07 INFO - Running setup.py (path:/tmp/pip-vNQjXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:07 INFO - Running setup.py (path:/tmp/pip-5hus5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:07 INFO - Running setup.py (path:/tmp/pip-tTLYiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:07 INFO - Running setup.py (path:/tmp/pip-1M6b8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:07 INFO - Running setup.py (path:/tmp/pip-NWXNLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:07 INFO - Running setup.py (path:/tmp/pip-pVKxNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:07 INFO - Running setup.py (path:/tmp/pip-E4n_vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:07 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:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:07 INFO - Running setup.py (path:/tmp/pip-HU9kXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:07 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:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:07 INFO - Running setup.py (path:/tmp/pip-lERrzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:08 INFO - Running setup.py (path:/tmp/pip-GeUyv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:08 INFO - Running setup.py (path:/tmp/pip-3MlKTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:08 INFO - Running setup.py (path:/tmp/pip-U6x5SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:08 INFO - Running setup.py (path:/tmp/pip-otlJGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:08 INFO - Running setup.py (path:/tmp/pip-fNEOIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:08 INFO - Running setup.py (path:/tmp/pip-ym0qiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:10 INFO - Downloading blessings-1.5.1.tar.gz 06:36:10 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:10 INFO - Installing collected packages: blessings 06:36:10 INFO - Running setup.py install for blessings 06:36:10 INFO - Successfully installed blessings 06:36:10 INFO - Cleaning up... 06:36:10 INFO - Return code: 0 06:36:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:10 INFO - Reading from file tmpfile_stdout 06:36:10 INFO - Current package versions: 06:36:10 INFO - argparse == 1.2.1 06:36:10 INFO - blessings == 1.5.1 06:36:10 INFO - blobuploader == 1.2.4 06:36:10 INFO - docopt == 0.6.1 06:36:10 INFO - manifestparser == 1.1 06:36:10 INFO - mozInstall == 1.12 06:36:10 INFO - mozcrash == 0.16 06:36:10 INFO - mozdebug == 0.1 06:36:10 INFO - mozdevice == 0.47 06:36:10 INFO - mozfile == 1.2 06:36:10 INFO - mozhttpd == 0.7 06:36:10 INFO - mozinfo == 0.9 06:36:10 INFO - mozleak == 0.1 06:36:10 INFO - mozlog == 3.1 06:36:10 INFO - moznetwork == 0.27 06:36:10 INFO - mozprocess == 0.22 06:36:10 INFO - mozprofile == 0.27 06:36:10 INFO - mozrunner == 6.11 06:36:10 INFO - mozscreenshot == 0.1 06:36:10 INFO - mozsystemmonitor == 0.0 06:36:10 INFO - moztest == 0.7 06:36:10 INFO - mozversion == 1.4 06:36:10 INFO - psutil == 3.1.1 06:36:10 INFO - requests == 1.2.3 06:36:10 INFO - wsgiref == 0.1.2 06:36:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:36:10 INFO - Using env: {'DISPLAY': ':0', 06:36:10 INFO - 'HOME': '/home/cltbld', 06:36:10 INFO - 'LANG': 'en_US.UTF-8', 06:36:10 INFO - 'LANGUAGE': 'en_US:en', 06:36:10 INFO - 'LOGNAME': 'cltbld', 06:36:10 INFO - 'MAIL': '/var/mail/cltbld', 06:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:10 INFO - 'MOZ_NO_REMOTE': '1', 06:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:10 INFO - 'NO_EM_RESTART': '1', 06:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:10 INFO - 'PWD': '/builds/slave/test', 06:36:10 INFO - 'SHELL': '/bin/bash', 06:36:10 INFO - 'SHLVL': '1', 06:36:10 INFO - 'TERM': 'linux', 06:36:10 INFO - 'TMOUT': '86400', 06:36:10 INFO - 'USER': 'cltbld', 06:36:10 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:10 INFO - '_': '/tools/buildbot/bin/python'} 06:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:36:10 INFO - Cleaning up... 06:36:10 INFO - Return code: 0 06:36:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:36:10 INFO - Using env: {'DISPLAY': ':0', 06:36:10 INFO - 'HOME': '/home/cltbld', 06:36:10 INFO - 'LANG': 'en_US.UTF-8', 06:36:10 INFO - 'LANGUAGE': 'en_US:en', 06:36:10 INFO - 'LOGNAME': 'cltbld', 06:36:10 INFO - 'MAIL': '/var/mail/cltbld', 06:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:10 INFO - 'MOZ_NO_REMOTE': '1', 06:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:10 INFO - 'NO_EM_RESTART': '1', 06:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:10 INFO - 'PWD': '/builds/slave/test', 06:36:10 INFO - 'SHELL': '/bin/bash', 06:36:10 INFO - 'SHLVL': '1', 06:36:10 INFO - 'TERM': 'linux', 06:36:10 INFO - 'TMOUT': '86400', 06:36:10 INFO - 'USER': 'cltbld', 06:36:10 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:10 INFO - '_': '/tools/buildbot/bin/python'} 06:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:11 INFO - Downloading/unpacking jsonschema 06:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 06:36:12 INFO - Downloading/unpacking functools32 (from jsonschema) 06:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:12 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:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:12 INFO - warning: no files found matching '*.txt' 06:36:12 INFO - no previously-included directories found matching 'build' 06:36:12 INFO - no previously-included directories found matching 'dist' 06:36:12 INFO - no previously-included directories found matching '.git*' 06:36:12 INFO - Installing collected packages: jsonschema, functools32 06:36:13 INFO - Running setup.py install for functools32 06:36:13 INFO - warning: no files found matching '*.txt' 06:36:13 INFO - no previously-included directories found matching 'build' 06:36:13 INFO - no previously-included directories found matching 'dist' 06:36:13 INFO - no previously-included directories found matching '.git*' 06:36:13 INFO - Successfully installed jsonschema functools32 06:36:13 INFO - Cleaning up... 06:36:13 INFO - Return code: 0 06:36:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4eeb80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1623240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, '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': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', '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:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:36:13 INFO - Using env: {'DISPLAY': ':0', 06:36:13 INFO - 'HOME': '/home/cltbld', 06:36:13 INFO - 'LANG': 'en_US.UTF-8', 06:36:13 INFO - 'LANGUAGE': 'en_US:en', 06:36:13 INFO - 'LOGNAME': 'cltbld', 06:36:13 INFO - 'MAIL': '/var/mail/cltbld', 06:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:13 INFO - 'MOZ_NO_REMOTE': '1', 06:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:13 INFO - 'NO_EM_RESTART': '1', 06:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:13 INFO - 'PWD': '/builds/slave/test', 06:36:13 INFO - 'SHELL': '/bin/bash', 06:36:13 INFO - 'SHLVL': '1', 06:36:13 INFO - 'TERM': 'linux', 06:36:13 INFO - 'TMOUT': '86400', 06:36:13 INFO - 'USER': 'cltbld', 06:36:13 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:13 INFO - '_': '/tools/buildbot/bin/python'} 06:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:13 INFO - Downloading/unpacking flake8 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:36:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:36:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:36:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:36:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 06:36:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:15 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:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:36:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:15 INFO - no previously-included directories found matching 'docs/_build' 06:36:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:36:15 INFO - Running setup.py install for pep8 06:36:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:15 INFO - no previously-included directories found matching 'docs/_build' 06:36:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:36:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:36:15 INFO - Cleaning up... 06:36:15 INFO - Return code: 0 06:36:15 INFO - Running post-action listener: _resource_record_post_action 06:36:15 INFO - Running post-action listener: _start_resource_monitoring 06:36:16 INFO - Starting resource monitoring. 06:36:16 INFO - ##### 06:36:16 INFO - ##### Running install step. 06:36:16 INFO - ##### 06:36:16 INFO - Running pre-action listener: _resource_record_pre_action 06:36:16 INFO - Running main action method: install 06:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:16 INFO - Reading from file tmpfile_stdout 06:36:16 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:16 INFO - Reading from file tmpfile_stdout 06:36:16 INFO - Output received: 06:36:16 INFO - Usage: mozinstall [options] installer 06:36:16 INFO - Options: 06:36:16 INFO - -h, --help show this help message and exit 06:36:16 INFO - -d DEST, --destination=DEST 06:36:16 INFO - Directory to install application into. [default: 06:36:16 INFO - "/builds/slave/test"] 06:36:16 INFO - --app=APP Application being installed. [default: firefox] 06:36:16 INFO - mkdir: /builds/slave/test/build/application 06:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:36:30 INFO - Reading from file tmpfile_stdout 06:36:30 INFO - Output received: 06:36:30 INFO - /builds/slave/test/build/application/firefox/firefox 06:36:30 INFO - Running post-action listener: _resource_record_post_action 06:36:30 INFO - ##### 06:36:30 INFO - ##### Running run-tests step. 06:36:30 INFO - ##### 06:36:30 INFO - Running pre-action listener: _resource_record_pre_action 06:36:30 INFO - Running main action method: run_tests 06:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:30 INFO - Python 2.7.3 06:36:30 INFO - Return code: 0 06:36:30 INFO - grabbing minidump binary from tooltool 06:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b20b0>, '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 0x16b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:36:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:36:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:30 INFO - Return code: 0 06:36:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:36:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:36:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:36:31 INFO - Return code: 0 06:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] in /builds/slave/test/build 06:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost 06:36:31 INFO - Using env: {'DISPLAY': ':0', 06:36:31 INFO - 'HOME': '/home/cltbld', 06:36:31 INFO - 'LANG': 'en_US.UTF-8', 06:36:31 INFO - 'LANGUAGE': 'en_US:en', 06:36:31 INFO - 'LOGNAME': 'cltbld', 06:36:31 INFO - 'MAIL': '/var/mail/cltbld', 06:36:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:31 INFO - 'MOZ_NO_REMOTE': '1', 06:36:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:31 INFO - 'NO_EM_RESTART': '1', 06:36:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:31 INFO - 'PWD': '/builds/slave/test', 06:36:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:31 INFO - 'SHELL': '/bin/bash', 06:36:31 INFO - 'SHLVL': '1', 06:36:31 INFO - 'TERM': 'linux', 06:36:31 INFO - 'TMOUT': '86400', 06:36:31 INFO - 'USER': 'cltbld', 06:36:31 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781', 06:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:31 INFO - '_': '/tools/buildbot/bin/python'} 06:36:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EakUL9dtSBWy2BZG-Pna-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] with output_timeout 3600 06:36:32 INFO - mozversion INFO | application_buildid: 20151207051729 06:36:32 INFO - mozversion INFO | application_changeset: 59bc3c7a83de7ffb611203912a7da6ad84535a5a 06:36:32 INFO - mozversion INFO | application_display_name: Nightly 06:36:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:32 INFO - mozversion INFO | application_name: Firefox 06:36:32 INFO - mozversion INFO | application_remotingname: firefox 06:36:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:36:32 INFO - mozversion INFO | application_vendor: Mozilla 06:36:32 INFO - mozversion INFO | application_version: 45.0a1 06:36:32 INFO - mozversion INFO | platform_buildid: 20151207051729 06:36:32 INFO - mozversion INFO | platform_changeset: 59bc3c7a83de7ffb611203912a7da6ad84535a5a 06:36:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:36:32 INFO - mozversion INFO | platform_version: 45.0a1 06:36:32 INFO - 2015-12-07 06:36:32,017 DEBUG : using testdate: 1449498992 06:36:32 INFO - 2015-12-07 06:36:32,017 DEBUG : actual date: 1449498992 06:36:32 INFO - 2015-12-07 06:36:32,065 INFO : starting webserver on 'localhost:50620' 06:36:32 INFO - 2015-12-07 06:36:32,066 INFO : Starting test suite talos-linux64-ix-006 06:36:32 INFO - 2015-12-07 06:36:32,066 INFO : Starting test dromaeo_css 06:36:32 INFO - 2015-12-07 06:36:32,066 DEBUG : operating with platform_type : linux_ 06:36:32 INFO - 2015-12-07 06:36:32,067 INFO : Initialising browser for dromaeo_css test... 06:36:32 INFO - 2015-12-07 06:36:32,083 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuOILrv/profile http://localhost:50620/getInfo.html 06:36:36 INFO - 2015-12-07 06:36:36,222 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:36:36 INFO - 2015-12-07 06:36:36,223 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:36:36 INFO - 2015-12-07 06:36:36,223 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:36:36 INFO - 2015-12-07 06:36:36,223 DEBUG : BROWSER_OUTPUT: __metrics 06:36:36 INFO - 2015-12-07 06:36:36,304 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:36 INFO - 2015-12-07 06:36:36,368 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:36:36 ERROR - 2015-12-07 06:36:36,384 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 06:36:37 INFO - 2015-12-07 06:36:37,301 INFO : Browser initialized. 06:36:37 INFO - 2015-12-07 06:36:37,302 INFO : Running cycle 1/1 for dromaeo_css test... 06:36:37 INFO - 2015-12-07 06:36:37,302 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuOILrv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:36:49 INFO - 2015-12-07 06:36:49,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 142622720 06:36:49 INFO - 2015-12-07 06:36:49,371 DEBUG : BROWSER_OUTPUT: 06:37:40 INFO - 2015-12-07 06:37:40,798 DEBUG : BROWSER_OUTPUT: 1449499060792 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:52 INFO - 2015-12-07 06:39:52,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50620/tests/dromaeo/cssquery-ext.html) 06:39:54 INFO - 2015-12-07 06:39:54,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 300187648 06:39:54 INFO - 2015-12-07 06:39:54,002 DEBUG : BROWSER_OUTPUT: 06:42:56 INFO - 2015-12-07 06:42:56,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/dromaeo/cssquery-ext.html (next: http://localhost:50620/tests/dromaeo/cssquery-jquery.html) 06:42:57 INFO - 2015-12-07 06:42:57,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 225300480 06:42:57 INFO - 2015-12-07 06:42:57,194 DEBUG : BROWSER_OUTPUT: 06:45:59 INFO - 2015-12-07 06:45:59,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50620/tests/dromaeo/cssquery-mootools.html) 06:45:59 INFO - 2015-12-07 06:45:59,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 221655040 06:45:59 INFO - 2015-12-07 06:45:59,803 DEBUG : BROWSER_OUTPUT: 06:49:01 INFO - 2015-12-07 06:49:01,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50620/tests/dromaeo/cssquery-prototype.html) 06:49:02 INFO - 2015-12-07 06:49:02,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 207523840 06:49:02 INFO - 2015-12-07 06:49:02,260 DEBUG : BROWSER_OUTPUT: 06:52:04 INFO - 2015-12-07 06:52:04,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50620/tests/dromaeo/cssquery-yui.html) 06:52:05 INFO - 2015-12-07 06:52:05,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 208330752 06:52:05 INFO - 2015-12-07 06:52:05,441 DEBUG : BROWSER_OUTPUT: 06:55:07 INFO - 2015-12-07 06:55:07,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/dromaeo/cssquery-yui.html (next: http://localhost:50620/tests/dromaeo/cssquery-dojo.html) 06:55:08 INFO - 2015-12-07 06:55:08,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 256172032 06:55:08 INFO - 2015-12-07 06:55:08,079 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,079 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:55:08 INFO - 2015-12-07 06:55:08,079 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:55:08 INFO - 2015-12-07 06:55:08,079 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:55:08 INFO - 2015-12-07 06:55:08,079 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:55:08 INFO - 2015-12-07 06:55:08,079 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2638.248099291702;2743.067357098586;2747.7252274772513;2756.338478765097;2767.875445604948;4523.683342166041;4657.720536767788;4690.0854333405;4751.12104260712;4764.285357196422;4630.652701047418;4655.674102812796;4746.7863946122425;4785.928211076836;4790.688605240657;4362.280223763083;4366.2359087159775;4404.493483249419;4407.845725399612;4427.402300689414;4169.770662613555;4423.292273236283;4429.889252768674;4485.102979404132;4489.3939318192115;4289.828406863721;4315.43899293093;4344.413504176927;4382.649388048949;4418.491873434532;4382.0797632497215;4383.079553293812;4386.1008493258805;4386.56134386562;4420;4124.835006599732;4384.649228061748;4391.077873646538;4414.359917811931;4446.799894004777;4514.977425112854;4550.977245113786;4582.014866803654;4640.65195110368;4656.67403281767;5077.695338279715;5127.359080114986;5132.435432102466;5135.897282054375;5158.7678554464765;5137.6403651744395;5145.562627176694;5145.871353216162;5148.485151484859;5195.064888320101;4467.15124126415;4566.40636717228;4570.954290457053;4606.216943119678;4647.604953578983;5213.452587478336;5236.1098613235845;5243.868903277372;5247.422783493813;5258.789648414097;5011.198208286657;5014.598832093424;5017.272495488207;5018.2974383586325;5065;4819.277108433763;4925.359703238628;4928.605711543068;5092.694438333712;5102.234664800236;4968.751562421864;5087.618428617869;5107.693538387709;5134.640575159703;5136.922946155811;5014.799408023711;5036;5037.395512538519;5045.84862454127;5046.621503387188;3748.5501739790852;3865.265599536079;3875.748076375027;3898.8245528951265;3940.172563761585;3414;3450.4306789379975;3477.0611934777467;3479.3911065563425;3512.473129030615;4342.131573685276;4355.060478648133;4357.085012147421;4358.019445624773;4387.692861499728;4860.1008813369635;5080.618953578496;5086.4659210783075;5086.593072554187;5090.338256026767;4221.5567365426805;4268.658507319407;4280.250956082673;4282.100758840616;4316.740995540277;4438.889027774267;4505.5719706627815;4506.233940230169;4507;4524.5927866492175;4589.724616523019;4823.517648235148;4840.588549973221;4844.588210002048;4868.756562171877;4912.164931961646;4939.580135688507;4939.950600493949;5050.671706339076;5052.166392545336;4802.73584952831;4832.323474713473;4834.903301933871;4842.249451335048;4888.560029597354;5014.022265658162;5021.422536408214;5022.422421421437;5040.546350828443;5085.898282034413;4827.8551643450755;4946.975265123651;4948.010397920359;4948.282499037691;5109.693418394908;4801.663883528119;4864.294677271847;4873.074115917964;4874.390701162355;4875.488073752347;4855.902881942271;4858.562729354234;4862.222044472867;4862.294967229803;4868.026394721141;4755.571998520011;4848.272759086165;4856.8300109495995;4886.511348865085;4898.779554919965;4835.178019736723;4886.071646387175;4888.95111048885;4896.6572339935865;4931.630127740362;4616.8614941551805;4721.008588196517;4814.229723244264;4814.662973591955;4817.301491283814 06:55:08 INFO - 2015-12-07 06:55:08,080 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.6685055265735;537.100356902189;539.6950722841594;540.3515781062725;542.755759908041;25001.74998250017;25458.61812072818;34311.656883431155;35373.82313088431;35426.2914741705;39959.40060899089;40558.79720601393;40581.797091014574;40600;40623.59376406235;6897.6206308653;7724.382049436045;7852.528848269122;7897.921020789776;7900.565468899208;6987;10141.695749127539;10395.480225988671;10411.947940260327;10412.68761937143;10001.199904007663;10091.091801737843;10105.343152695088;10108.44403557804;10115.494225288743;7108.751193708247;7289.5261807982315;9918.404895706244;10029.648962286285;10105.696829095139;9812.65655702047;9962.352447090989;9965.40207587547;9975.600975961026;9980.500974951296;36110.81944590287;36628.450573241425;36638.267234655155;36644;36674.26651466983;2708.5530887403556;2740.4245108527034;3157.2264795125343;3326.9833650831833;3527.5590551181103;27478.862605686845;27661.446771064468;27781.16656500288;28057.346386501245;28280.434391312265;3363.025628265738;3451.5858097028267;3454.274602333513;3525.365434221839;3570.1788588624763;214967;216319;216452;216639.91680041657;216995;53534.19698704522;53723.73138134284;53759.19361209585;53827;53895.73052134714;38920.8053959734;39361.21277574432;63350.683246583474;64822;64887.35112648813;13260.801087983687;13429.66425839362;13517.32413379327;13518.729625407437;13535.661608459868;9991.300608957303;10070.244731645156;10074.143697785623;10079.949600251952;10085.344452610703;18403.355882544045;18534.721979170325;18624.348147814762;18639.440816775517;18684.7578290606;6960.234374218832;7144.749933752294;7288.526245794006;7334.339909408179;7421.220771818989;848.6817443458702;893.8033632600817;901.3059943843205;938.2728385501291;960.1166926427563;25685.3578660535;26339.341516462242;27003.729962700123;27705;28220.15339539817;840.369722707969;876.1457578860687;936.639393833379;964.2141654551518;1002.4185972136144;12994.545190918272;13248;13342.53301134475;13377;13389.464421423034;255837;260688;261167;261382;262356;44072.779636101615;44370.33444498335;44410.555894440644;44493.77753111214;44527.777361113636;1202.5911190195375;1206.390772659801;1209.2925638501574;1213.4782043721284;1217.604278609473;22143.889280553492;24856.502869942862;25497.61753573661;25822.096226631977;25851.353716156493;36455.635443646286;36801.81599092094;36809.81595092007;36812;36823.63176368202;199244;200308;200653;200873;200883;22440.551188976457;24955.381469687156;27567.31081722973;28330;29334.266643333234;32025.35949281048;32769.01692949215;33311;33691.663083368854;33779.493307599914;33293.33413331768;35793;36134.638653613125;36456.453153202194;36819.81590092032;31787.841060794548;32131.839340803148;32168.51747223747;32219;32236.19409514781;32099;32566.83716581402;33106.83446582848;33624.1593960153;33652.158696031816;25182.244532664048;27143.59284610693;27151.72848271571;27304.72695273022;27569.331971196254;21329.749229300505;22754.544909101394;22794.54410911806;23077.307680769605;23265.302040938797 06:55:08 INFO - 2015-12-07 06:55:08,080 DEBUG : BROWSER_OUTPUT: |2;jquery.html;278.76645842148486;283.146313863701;284.0413604086209;288.7805267996323;291.4317081690703;12191.51233950641;12392.442340094694;15483.922580387096;15856.048637081769;16050.19749012549;11622.360770157638;13907.165570065778;14608.561743147722;15451.768223476656;15479.458218962338;4760.8095676173;4886.560209581137;4894.877628059309;5031.4465408805;5168.198929165967;3351.715104216132;3428.8457019434186;5155.664881782691;5172.8706782330555;6499.415052645261;6487.41613254807;6613.801585952429;6655.733770649193;6660.9000864987065;6673.666316684171;6597.37324954131;6632.602043877383;6642.3025582313885;6646.9667651661675;6660.100886380325;5965;6148.200733904609;6374.043893415978;6374.85252654522;6378.043293505965;20253;20282.087306071262;20496.282630107875;20659.793402066087;20817.479563010893;1838.7665023850539;1963.6367272054715;1979.5941831924565;1988.681810910262;1995.3016444244543;13309.800352994713;13460.528881489101;13634.454621815115;13694.109882857681;14338.713225735426;1845.5847434327304;1851.5278603955906;1858.869879108463;1864.925402983879;1880.1445342369188;50598;51649.225261621104;51826.48173518292;53059.46940530623;53940.730296348265;15473.613159670873;15504.224788760517;15573.844261557238;15616.92191539035;15713.921430392775;23301.7669823303;23370.883145584165;23458.061677532707;23478.765212348;23511.7648823513;7736.535807851435;7891.250331218525;7949.3243074339325;7961.920380796118;8012.399070069768;6579.407853293131;6595.406413422815;6614.503912206507;6626.370494802986;6665.766698165541;7768.262015108556;7780.8832867507035;7813.960930195312;7854.607269636495;7872.212778722082;1711.3753479979719;1714.431041275013;1729.6627157704127;1758.8417042465983;2153.612349777024;836.8995720513577;889.786451251695;940.8776859008285;972.863799068131;976.3019441099506;16006.759898601531;16160.43438479671;16273.10497922602;16573.91713041427;16604.6679066418;820.3045281009016;840.911704271055;842.1704620948361;860.0066922704286;885.4288983605538;8320.958395208107;8445.746627601182;8597;8601.13988601135;8720.43317184381;454100;459413;460736;473778;494384;57144.428555714745;58060.41939580635;65750;66531;68155;1020.1074060197327;1025.7948410317965;1037.2479952034714;1038.1798379280283;1040.9739756505996;14039.408866994976;14061.156330620195;14720.77918831197;14885;14928.850711492745;31418.842905785325;31653.525197122523;31934.840325799152;32637.673623263465;34929.65070349264;38681.41977870391;39921.60078399179;48622.27066594075;48841.755791220814;49287;8460.534670593177;8512;8806.987196472232;8877.289816814768;8877.33419993516;10206.387616743019;10275.280730348804;10293.794124117327;10336.17310615134;15520;12986.805197921849;13051.543195988095;13259.337033148111;13369.66575835573;13457.259850708306;12644.241345519298;12703.301318427206;12928.806067909178;13139.54011609589;13888.027838051643;13634.659133521345;13649.658758531115;14250.501232456814;14275;14419.711605768036;9021;9140.862887056566;9242.306826987868;9282.071792820663;9312.580933857857;13666.93166534161;13676.384562694504;13842.930785346009;13947.30263486842;14389 06:55:08 INFO - 2015-12-07 06:55:08,080 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1418.0711633879812;1627.8697704183664;1661.3354658136743;1695.7541156532302;1703.8125806161324;5998.490128339091;6675.7663481778145;6846.075779769736;6859.211190713069;6866.24471308157;6911.170659520852;7150.642467876612;7153.642317884098;7154.821129471766;7159.248278930715;1978.277928556081;1995.6308083004617;1999.1803360622148;2000.1799262302459;2001.0495014867895;1994.2421879685771;2005.9598808023832;2019.7778244393105;2072.160774886166;2089.059923034633;2000.3898810862681;2046.6623007203793;2067.018166370977;2069.0999415254337;2075.273654221018;2019.9394018179405;2047.1504325704814;2057.423921302038;2058.0635810706094;2059.268959519379;2036.5010572409853;2051.3333166720877;2053.6098141353095;2059;2072.896355182235;7105.111861017373;7145.857082858313;7177.35403813654;7188.029616001825;7190.856182876366;3919.8824035278985;3992.980035099835;4001.4598029265967;4010.1578668479656;4013.7993100345157;2575.5364034473787;2577;2610.2169349195165;2654.8008899332626;2656.9468610627678;798.5448294472153;812.4231795425255;825.9545724985123;843.696269343036;844.4004756622805;9599.904000960041;9600.423974561549;9601.519924003773;9616.134547890724;9619.230461563058;3754.9061273467837;3769.5288088988877;3807.8286477108595;3827.0623697194364;3836.462895194675;8296.792580185424;8300.70947516834;8313.459625124347;8318.292945099734;8327.20891515305;4143.56492568276;4146.129312844276;4147.3778933160265;4148.585141485888;4156.355764856452;3189.266468712163;3308.652591477908;3708.9443658345144;3789.981050094732;3793.905152371213;3336.2493438976035;3338.0987133473827;3354.496825476198;3373.5108409280515;3379.6620337966497;1022.0597050713361;1032.3083534032216;1033.684726158529;1035.891231420705;1037.2479952034864;911.2482202183226;915.977100572491;918.9264858811413;1000.8598796168542;1044.556063672936;6468.838279043061;6524.119243902107;6530.902036469457;6531.412172904462;6536.509761767887;384.1686768516055;398.42626617670464;402.05717592246134;402.502908907499;409.17551134464077;5108.489151084862;5159.045576568347;5163.3545806774155;5166.819161329336;5176.094183517869;8298.875516867252;8314.501129932223;8431.873521897176;8470.195331443503;8520;8411.158884111663;8458.281046111026;8483.575821208915;8489.108643592457;8491.745247642457;6606.834829129214;6608.4052435281055;6713.798586042427;6725;6725.966370168216;6192.628442293477;6207.6585787782105;6221.129041934042;6223.813285601439;6228.813135605939;7552.358049565849;7560.58416787082;7562.584057876869;7620.771376858703;7676.078870535572;7664.233576642291;7722.575258360844;7775.611219439119;7842.411819113703;7894.447388682737;5161.896762064813;5309.283246761792;6162.075688646739;6198.81403557894;6218.906716399348;6486.54594178403;6629.7348106075215;6708.127943367331;6710.194776626836;6713.227978782503;6274.874502509833;6402.263739669997;6429.292777794532;6499.350064993463;6529.934700652932;6065.423784740443;6068.120122582289;6100.389961003864;6154.138420621027;6169.84575385619;6088.5737998341465;6095.35998720128;6128.540359472968;6133.049377346519;6144.8771024580155;5627.240322556402;5657.264555607745;5660.037793575185;5664.773409063591;5689.118186681071;5806.709664516842;5836.124581312837;5885.028970219866;5887.411258874078;5904.586678932434 06:55:08 INFO - 2015-12-07 06:55:08,081 DEBUG : BROWSER_OUTPUT: |4;prototype.html;249.38526532098385;253.04601651772816;259.0634854999178;259.5367269424078;261.3961748361286;5265.7367131643405;5308.654937429064;5314.707691076994;5315.574754019679;5339.119045357511;5071.087204303224;5123;5194.246834209038;5216.374035115791;5234.816781412651;4021.2158629067417;4025.6980726445486;4035.3139966205817;4035.3139966205817;4036.9798151009204;4025.919481610366;4027.0737730322044;4032.6975476839207;4032.9596704033024;4037.454943582608;3988.12261302513;3994.081361286891;3996.0609256824623;3996.4005399190064;3997.860074897379;3857.0743021674875;3983.203359328117;3992.121733218687;3999.740016898907;4006.038550747814;3423.2639982403903;3424.8116353600544;3427.845746941394;3430.1767575781882;3430.4682774169796;5203.583713302926;5204.115300398941;5204.791808327663;5208.895822083575;5215;4576.473705523841;4579.908401831978;4583.03756211196;4585.358049873021;4586.610138138262;5616.1014237721765;5620.381758006616;5622.8313150605545;5627.352854421712;5629.268195134648;3558.323918455511;3639.217568222845;3645.125169959217;3648.616895226016;3650.470681751158;5686.516646085088;5844.853878653025;5875.471207591295;5958.5828991970575;5963.135345374896;3721.8697345592773;3790.3177428063213;3800.049987503124;3808.333541630204;3822.866199682998;3849.749766265184;3860.9034774130873;3869.96130038696;3870.0905287257474;3871.593482684334;4534.7052441591195;4539.0694907543875;4544.818207271738;4545.886352841206;4546.568076032771;5506.063969125258;5605.383407825136;5625.521830644441;5648.322201335866;5663.405342438985;1328.7873940169527;1331.8867896228928;1341.0813592688844;1342.5234041915176;1344.4218985836185;802.0175285275491;809.3969992355615;841.7937605286744;861.5046348349724;876.2245412809582;4874.341963834908;4877.219644856877;4900.534449227318;4902.264660300983;4905;5807.883842323215;5808.39011903744;5808.796692115756;5809.128630705428;5809.738561764731;4878.56092951636;4882.462929077798;4888.755562221874;4892.0705066037335;4892.119418504703;3076.5846610707717;3100.612423447069;3146.1819926819194;3146.3078122812944;3152.8738850445725;5492.642978206404;5497.917531237034;5498.835034948958;5501.697406642673;5503.091989821634;5973.283206015306;5974.40255974399;5982.73077711504;5991.730372133265;5996.400359963969;5485.122380419114;5485.286912701324;5487.478689524569;5492.231087647732;5492.69790161537;5642.181883626769;5803.912941305968;5812.33158186797;5814.273215848019;5816.970915145566;5692.601517893708;5696.943030569807;5704.229928959538;5704.80033198836;5708.57185711065;5454.072807622793;5464.9180262296895;5476.67139971603;5482.095454250004;5483.808066717806;3718.628137186368;3788.090858194069;3823.369144091194;3838.05967537955;3841.9231615368094;5724.255846739898;5796.855078623068;5799.449052340021;5802.4197580241635;5805.216295800013;5588.385277619377;5591.664500130005;5593.049181639212;5596.720163991703;5601.327840659147;5581.665100094007;5586.888262234814;5587.55299576041;5593.552515798645;5594.720263986703;5339.199120132012;5469.890602187855;5471.2613797138465;5475.260839786737;5480.177973304037;5458.645188062763;5539.086050801734;5586.106223004463;5589.273394458694;5612.214289999485;5461;5462.590305727166;5524.06090964545;5525.806596769094;5539.335279766454 06:55:08 INFO - 2015-12-07 06:55:08,084 DEBUG : BROWSER_OUTPUT: |5;yui.html;779.9571023593703;791.8693415586429;800.6997375984006;801.5311043039818;822.6339279020837;12179.939100304497;12444.377781110954;12450.43973021214;12452.377381130953;12458.813117803229;12991.74016519669;13264.270465124438;13287.534936277232;13292.468301267938;13311.201327920331;622.0451606783588;628.136312570216;783.7374479549344;788.1291173253529;798.7483942558105;796.1878883538787;796.6494742313392;803.4135081390589;803.7709252862935;804.6298702596813;825.9587020648974;829.8464784014947;831.5177197225595;832.1054866019024;832.184459229955;647.5273050673012;653.2487639214893;816.9183081691842;828.2793969246734;833.3832963606948;611.8868009418272;614.1064750787593;614.6772944204329;614.8678034222619;616.9444749972479;11355.659330220107;11467.770644587144;11517.884821151765;11627.244229125079;11672.533098676044;10508.94745526275;10820.458977051116;11017.173711971554;11274.887251127466;11403.486843092081;9289.581968811419;9469.66856160038;9492.050794920522;9513.143817056498;9520.571914212855;3106.1775100801524;3134.420132275536;3161.367726454718;3177.7457803375905;3178.316661917676;38292.80853595742;38587.421188682194;38594.03514912121;38618.61381386178;38632.03419914497;8882.245009174163;8927.776805579913;9033.909660903308;9413.341066125442;9439.056094390506;15665.29506172225;15776.68446631061;15811.604709882346;15824.129672868103;15853.445129420415;6031.728572214261;6263.843403914848;6270.31026587075;6336.746530138743;6390.0734393512685;3464.4803279508274;3586.4105467405416;3589.174489867293;3666.138457462494;3666.1934374437583;2509.372656835791;2562;2569.3833479964674;2570.3831080540535;2571.344307201689;446.8771087950839;451.29147238834713;455.19885002396023;464.70026832692724;467.99532004680196;517.5911030286031;569.4106599669323;589.4223660812428;596.3470000349611;596.9462748352669;7306.415486761046;7336.38599508118;7525.623718814038;7563.773086807405;7625.237476252441;418.8534013095392;513.3198511971652;554.9223108764776;599.9820005399845;606.5147881694627;3394.4399174135992;3457.2048428861503;3541.36255474012;3551;3565.108722819295;47636;47717.761411192725;47823;49015.264771028465;49688;41932;42666.360004599956;42688.57311426908;42716;42951.35572966408;37234.25531489409;37482.43776343357;37961.430578541345;38533.614663853565;38803.029924251554;7086.149662040382;7177.569345839266;7203.2076471589135;7280.453965952681;7383.778486645409;29973.400531988802;30208.395832083675;30238.69761302447;30589.388212236077;30811.53782693306;35961.640383595826;36608.267834642626;37325.4401183977;39638.801805990784;39648.00879978023;8638.912048247037;8897.644094236159;8975.50634715097;9087.591058402255;9110.544472776202;9824.4105353679;9848.261380396356;9861.457619830691;9878.950605246928;9888.950555247178;8870.600822962853;9120.452772833385;9149.451032938045;9226.169644732006;9430.339876208875;8685.478871267744;8800.89988751406;8813.074627164311;8843.292536597186;9534.904650953678;8807.163319484638;8848.601812918305;8989.280857531512;9141.908580914373;9186.08139186076;7631.618419078913;7660.387169026353;7715.3441957432005;7862.646180921758;8044.517328960281;7403.18564957865;7635;7654.846903062019;7762.456628035983;7825.491343062683 06:55:08 INFO - 2015-12-07 06:55:08,084 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:55:08 INFO - 2015-12-07 06:55:08,084 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:55:08 INFO - 2015-12-07 06:55:08,084 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1336 06:55:08 INFO - 2015-12-07 06:55:08,085 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:55:08 INFO - 2015-12-07 06:55:08,085 DEBUG : BROWSER_OUTPUT: __startTimestamp1449500108072__endTimestamp 06:55:08 INFO - 2015-12-07 06:55:08,085 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,085 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:55:08 INFO - 2015-12-07 06:55:08,085 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:55:08 INFO - 2015-12-07 06:55:08,085 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,085 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4640.69 Median:4814.66 stddev:512.79 (10.7%) stddev-sans-first:489.71 06:55:08 INFO - 2015-12-07 06:55:08,085 DEBUG : BROWSER_OUTPUT: Values: 2638.2 2743.1 2747.7 2756.3 2767.9 4523.7 4657.7 4690.1 4751.1 4764.3 4630.7 4655.7 4746.8 4785.9 4790.7 4362.3 4366.2 4404.5 4407.8 4427.4 4169.8 4423.3 4429.9 4485.1 4489.4 4289.8 4315.4 4344.4 4382.6 4418.5 4382.1 4383.1 4386.1 4386.6 4420.0 4124.8 4384.6 4391.1 4414.4 4446.8 4515.0 4551.0 4582.0 4640.7 4656.7 5077.7 5127.4 5132.4 5135.9 5158.8 5137.6 5145.6 5145.9 5148.5 5195.1 4467.2 4566.4 4571.0 4606.2 4647.6 5213.5 5236.1 5243.9 5247.4 5258.8 5011.2 5014.6 5017.3 5018.3 5065.0 4819.3 4925.4 4928.6 5092.7 5102.2 4968.8 5087.6 5107.7 5134.6 5136.9 5014.8 5036.0 5037.4 5045.8 5046.6 3748.6 3865.3 3875.7 3898.8 3940.2 3414.0 3450.4 3477.1 3479.4 3512.5 4342.1 4355.1 4357.1 4358.0 4387.7 4860.1 5080.6 5086.5 5086.6 5090.3 4221.6 4268.7 4280.3 4282.1 4316.7 4438.9 4505.6 4506.2 4507.0 4524.6 4589.7 4823.5 4840.6 4844.6 4868.8 4912.2 4939.6 4940.0 5050.7 5052.2 4802.7 4832.3 4834.9 4842.2 4888.6 5014.0 5021.4 5022.4 5040.5 5085.9 4827.9 4947.0 4948.0 4948.3 5109.7 4801.7 4864.3 4873.1 4874.4 4875.5 4855.9 4858.6 4862.2 4862.3 4868.0 4755.6 4848.3 4856.8 4886.5 4898.8 4835.2 4886.1 4889.0 4896.7 4931.6 4616.9 4721.0 4814.2 4814.7 4817.3 06:55:08 INFO - 2015-12-07 06:55:08,086 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,086 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38411.89 Median:32193.76 stddev:59023.62 (183.3%) stddev-sans-first:59120.67 06:55:08 INFO - 2015-12-07 06:55:08,086 DEBUG : BROWSER_OUTPUT: Values: 534.7 537.1 539.7 540.4 542.8 25001.7 25458.6 34311.7 35373.8 35426.3 39959.4 40558.8 40581.8 40600.0 40623.6 6897.6 7724.4 7852.5 7897.9 7900.6 6987.0 10141.7 10395.5 10411.9 10412.7 10001.2 10091.1 10105.3 10108.4 10115.5 7108.8 7289.5 9918.4 10029.6 10105.7 9812.7 9962.4 9965.4 9975.6 9980.5 36110.8 36628.5 36638.3 36644.0 36674.3 2708.6 2740.4 3157.2 3327.0 3527.6 27478.9 27661.4 27781.2 28057.3 28280.4 3363.0 3451.6 3454.3 3525.4 3570.2 214967.0 216319.0 216452.0 216639.9 216995.0 53534.2 53723.7 53759.2 53827.0 53895.7 38920.8 39361.2 63350.7 64822.0 64887.4 13260.8 13429.7 13517.3 13518.7 13535.7 9991.3 10070.2 10074.1 10079.9 10085.3 18403.4 18534.7 18624.3 18639.4 18684.8 6960.2 7144.7 7288.5 7334.3 7421.2 848.7 893.8 901.3 938.3 960.1 25685.4 26339.3 27003.7 27705.0 28220.2 840.4 876.1 936.6 964.2 1002.4 12994.5 13248.0 13342.5 13377.0 13389.5 255837.0 260688.0 261167.0 261382.0 262356.0 44072.8 44370.3 44410.6 44493.8 44527.8 1202.6 1206.4 1209.3 1213.5 1217.6 22143.9 24856.5 25497.6 25822.1 25851.4 36455.6 36801.8 36809.8 36812.0 36823.6 199244.0 200308.0 200653.0 200873.0 200883.0 22440.6 24955.4 27567.3 28330.0 29334.3 32025.4 32769.0 33311.0 33691.7 33779.5 33293.3 35793.0 36134.6 36456.5 36819.8 31787.8 32131.8 32168.5 32219.0 32236.2 32099.0 32566.8 33106.8 33624.2 33652.2 25182.2 27143.6 27151.7 27304.7 27569.3 21329.7 22754.5 22794.5 23077.3 23265.3 06:55:08 INFO - 2015-12-07 06:55:08,086 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,086 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26286.14 Median:31536.18 stddev:76298.22 (241.9%) stddev-sans-first:76487.27 06:55:08 INFO - 2015-12-07 06:55:08,087 DEBUG : BROWSER_OUTPUT: Values: 278.8 283.1 284.0 288.8 291.4 12191.5 12392.4 15483.9 15856.0 16050.2 11622.4 13907.2 14608.6 15451.8 15479.5 4760.8 4886.6 4894.9 5031.4 5168.2 3351.7 3428.8 5155.7 5172.9 6499.4 6487.4 6613.8 6655.7 6660.9 6673.7 6597.4 6632.6 6642.3 6647.0 6660.1 5965.0 6148.2 6374.0 6374.9 6378.0 20253.0 20282.1 20496.3 20659.8 20817.5 1838.8 1963.6 1979.6 1988.7 1995.3 13309.8 13460.5 13634.5 13694.1 14338.7 1845.6 1851.5 1858.9 1864.9 1880.1 50598.0 51649.2 51826.5 53059.5 53940.7 15473.6 15504.2 15573.8 15616.9 15713.9 23301.8 23370.9 23458.1 23478.8 23511.8 7736.5 7891.3 7949.3 7961.9 8012.4 6579.4 6595.4 6614.5 6626.4 6665.8 7768.3 7780.9 7814.0 7854.6 7872.2 1711.4 1714.4 1729.7 1758.8 2153.6 836.9 889.8 940.9 972.9 976.3 16006.8 16160.4 16273.1 16573.9 16604.7 820.3 840.9 842.2 860.0 885.4 8321.0 8445.7 8597.0 8601.1 8720.4 454100.0 459413.0 460736.0 473778.0 494384.0 57144.4 58060.4 65750.0 66531.0 68155.0 1020.1 1025.8 1037.2 1038.2 1041.0 14039.4 14061.2 14720.8 14885.0 14928.9 31418.8 31653.5 31934.8 32637.7 34929.7 38681.4 39921.6 48622.3 48841.8 49287.0 8460.5 8512.0 8807.0 8877.3 8877.3 10206.4 10275.3 10293.8 10336.2 15520.0 12986.8 13051.5 13259.3 13369.7 13457.3 12644.2 12703.3 12928.8 13139.5 13888.0 13634.7 13649.7 14250.5 14275.0 14419.7 9021.0 9140.9 9242.3 9282.1 9312.6 13666.9 13676.4 13842.9 13947.3 14389.0 06:55:08 INFO - 2015-12-07 06:55:08,087 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,088 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4854.84 Median:6066.77 stddev:2573.83 (42.4%) stddev-sans-first:2568.09 06:55:08 INFO - 2015-12-07 06:55:08,088 DEBUG : BROWSER_OUTPUT: Values: 1418.1 1627.9 1661.3 1695.8 1703.8 5998.5 6675.8 6846.1 6859.2 6866.2 6911.2 7150.6 7153.6 7154.8 7159.2 1978.3 1995.6 1999.2 2000.2 2001.0 1994.2 2006.0 2019.8 2072.2 2089.1 2000.4 2046.7 2067.0 2069.1 2075.3 2019.9 2047.2 2057.4 2058.1 2059.3 2036.5 2051.3 2053.6 2059.0 2072.9 7105.1 7145.9 7177.4 7188.0 7190.9 3919.9 3993.0 4001.5 4010.2 4013.8 2575.5 2577.0 2610.2 2654.8 2656.9 798.5 812.4 826.0 843.7 844.4 9599.9 9600.4 9601.5 9616.1 9619.2 3754.9 3769.5 3807.8 3827.1 3836.5 8296.8 8300.7 8313.5 8318.3 8327.2 4143.6 4146.1 4147.4 4148.6 4156.4 3189.3 3308.7 3708.9 3790.0 3793.9 3336.2 3338.1 3354.5 3373.5 3379.7 1022.1 1032.3 1033.7 1035.9 1037.2 911.2 916.0 918.9 1000.9 1044.6 6468.8 6524.1 6530.9 6531.4 6536.5 384.2 398.4 402.1 402.5 409.2 5108.5 5159.0 5163.4 5166.8 5176.1 8298.9 8314.5 8431.9 8470.2 8520.0 8411.2 8458.3 8483.6 8489.1 8491.7 6606.8 6608.4 6713.8 6725.0 6726.0 6192.6 6207.7 6221.1 6223.8 6228.8 7552.4 7560.6 7562.6 7620.8 7676.1 7664.2 7722.6 7775.6 7842.4 7894.4 5161.9 5309.3 6162.1 6198.8 6218.9 6486.5 6629.7 6708.1 6710.2 6713.2 6274.9 6402.3 6429.3 6499.4 6529.9 6065.4 6068.1 6100.4 6154.1 6169.8 6088.6 6095.4 6128.5 6133.0 6144.9 5627.2 5657.3 5660.0 5664.8 5689.1 5806.7 5836.1 5885.0 5887.4 5904.6 06:55:08 INFO - 2015-12-07 06:55:08,088 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,088 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4582.91 Median:5287.20 stddev:1404.55 (26.6%) stddev-sans-first:1370.31 06:55:08 INFO - 2015-12-07 06:55:08,088 DEBUG : BROWSER_OUTPUT: Values: 249.4 253.0 259.1 259.5 261.4 5265.7 5308.7 5314.7 5315.6 5339.1 5071.1 5123.0 5194.2 5216.4 5234.8 4021.2 4025.7 4035.3 4035.3 4037.0 4025.9 4027.1 4032.7 4033.0 4037.5 3988.1 3994.1 3996.1 3996.4 3997.9 3857.1 3983.2 3992.1 3999.7 4006.0 3423.3 3424.8 3427.8 3430.2 3430.5 5203.6 5204.1 5204.8 5208.9 5215.0 4576.5 4579.9 4583.0 4585.4 4586.6 5616.1 5620.4 5622.8 5627.4 5629.3 3558.3 3639.2 3645.1 3648.6 3650.5 5686.5 5844.9 5875.5 5958.6 5963.1 3721.9 3790.3 3800.0 3808.3 3822.9 3849.7 3860.9 3870.0 3870.1 3871.6 4534.7 4539.1 4544.8 4545.9 4546.6 5506.1 5605.4 5625.5 5648.3 5663.4 1328.8 1331.9 1341.1 1342.5 1344.4 802.0 809.4 841.8 861.5 876.2 4874.3 4877.2 4900.5 4902.3 4905.0 5807.9 5808.4 5808.8 5809.1 5809.7 4878.6 4882.5 4888.8 4892.1 4892.1 3076.6 3100.6 3146.2 3146.3 3152.9 5492.6 5497.9 5498.8 5501.7 5503.1 5973.3 5974.4 5982.7 5991.7 5996.4 5485.1 5485.3 5487.5 5492.2 5492.7 5642.2 5803.9 5812.3 5814.3 5817.0 5692.6 5696.9 5704.2 5704.8 5708.6 5454.1 5464.9 5476.7 5482.1 5483.8 3718.6 3788.1 3823.4 3838.1 3841.9 5724.3 5796.9 5799.4 5802.4 5805.2 5588.4 5591.7 5593.0 5596.7 5601.3 5581.7 5586.9 5587.6 5593.6 5594.7 5339.2 5469.9 5471.3 5475.3 5480.2 5458.6 5539.1 5586.1 5589.3 5612.2 5461.0 5462.6 5524.1 5525.8 5539.3 06:55:08 INFO - 2015-12-07 06:55:08,088 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,088 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11651.24 Median:609.20 stddev:13259.20 (2176.5%) stddev-sans-first:13271.26 06:55:08 INFO - 2015-12-07 06:55:08,090 DEBUG : BROWSER_OUTPUT: Values: 780.0 791.9 800.7 801.5 822.6 12179.9 12444.4 12450.4 12452.4 12458.8 12991.7 13264.3 13287.5 13292.5 13311.2 622.0 628.1 783.7 788.1 798.7 796.2 796.6 803.4 803.8 804.6 826.0 829.8 831.5 832.1 832.2 647.5 653.2 816.9 828.3 833.4 611.9 614.1 614.7 614.9 616.9 11355.7 11467.8 11517.9 11627.2 11672.5 10508.9 10820.5 11017.2 11274.9 11403.5 9289.6 9469.7 9492.1 9513.1 9520.6 3106.2 3134.4 3161.4 3177.7 3178.3 38292.8 38587.4 38594.0 38618.6 38632.0 8882.2 8927.8 9033.9 9413.3 9439.1 15665.3 15776.7 15811.6 15824.1 15853.4 6031.7 6263.8 6270.3 6336.7 6390.1 3464.5 3586.4 3589.2 3666.1 3666.2 2509.4 2562.0 2569.4 2570.4 2571.3 446.9 451.3 455.2 464.7 468.0 517.6 569.4 589.4 596.3 596.9 7306.4 7336.4 7525.6 7563.8 7625.2 418.9 513.3 554.9 600.0 606.5 3394.4 3457.2 3541.4 3551.0 3565.1 47636.0 47717.8 47823.0 49015.3 49688.0 41932.0 42666.4 42688.6 42716.0 42951.4 37234.3 37482.4 37961.4 38533.6 38803.0 7086.1 7177.6 7203.2 7280.5 7383.8 29973.4 30208.4 30238.7 30589.4 30811.5 35961.6 36608.3 37325.4 39638.8 39648.0 8638.9 8897.6 8975.5 9087.6 9110.5 9824.4 9848.3 9861.5 9879.0 9889.0 8870.6 9120.5 9149.5 9226.2 9430.3 8685.5 8800.9 8813.1 8843.3 9534.9 8807.2 8848.6 8989.3 9141.9 9186.1 7631.6 7660.4 7715.3 7862.6 8044.5 7403.2 7635.0 7654.8 7762.5 7825.5 06:55:08 INFO - 2015-12-07 06:55:08,090 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:55:08 INFO - 2015-12-07 06:55:08,090 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-12-07 06:55:08,823 INFO : Browser exited with error code: 0 06:55:08 INFO - 2015-12-07 06:55:08,841 INFO : Completed test dromaeo_css (00:18:36) 06:55:08 INFO - 2015-12-07 06:55:08,842 INFO : Starting test kraken 06:55:08 INFO - 2015-12-07 06:55:08,842 DEBUG : operating with platform_type : linux_ 06:55:08 INFO - 2015-12-07 06:55:08,842 INFO : Initialising browser for kraken test... 06:55:08 INFO - 2015-12-07 06:55:08,848 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08p8bw/profile http://localhost:50620/getInfo.html 06:55:13 INFO - 2015-12-07 06:55:13,131 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:55:13 INFO - 2015-12-07 06:55:13,131 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:55:13 INFO - 2015-12-07 06:55:13,131 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:55:13 INFO - 2015-12-07 06:55:13,131 DEBUG : BROWSER_OUTPUT: __metrics 06:55:13 INFO - 2015-12-07 06:55:13,208 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:13 INFO - 2015-12-07 06:55:13,304 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:13 INFO - 2015-12-07 06:55:13,566 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 06:55:14 INFO - 2015-12-07 06:55:14,268 INFO : Browser initialized. 06:55:14 INFO - 2015-12-07 06:55:14,268 INFO : Running cycle 1/1 for kraken test... 06:55:14 INFO - 2015-12-07 06:55:14,268 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08p8bw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:55:26 INFO - 2015-12-07 06:55:26,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 140324864 06:55:26 INFO - 2015-12-07 06:55:26,265 DEBUG : BROWSER_OUTPUT: 06:55:28 INFO - 2015-12-07 06:55:28,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50620/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:29 INFO - 2015-12-07 06:55:29,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 175788032 06:55:29 INFO - 2015-12-07 06:55:29,488 DEBUG : BROWSER_OUTPUT: 06:55:32 INFO - 2015-12-07 06:55:32,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50620/tests/kraken/driver.html?testName=audio-dft) 06:55:32 INFO - 2015-12-07 06:55:32,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 163422208 06:55:32 INFO - 2015-12-07 06:55:32,786 DEBUG : BROWSER_OUTPUT: 06:55:35 INFO - 2015-12-07 06:55:35,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50620/tests/kraken/driver.html?testName=audio-fft) 06:55:36 INFO - 2015-12-07 06:55:36,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 151683072 06:55:36 INFO - 2015-12-07 06:55:36,359 DEBUG : BROWSER_OUTPUT: 06:55:38 INFO - 2015-12-07 06:55:38,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50620/tests/kraken/driver.html?testName=audio-oscillator) 06:55:38 INFO - 2015-12-07 06:55:38,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 152977408 06:55:38 INFO - 2015-12-07 06:55:38,972 DEBUG : BROWSER_OUTPUT: 06:55:41 INFO - 2015-12-07 06:55:41,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:55:41 INFO - 2015-12-07 06:55:41,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 155664384 06:55:41 INFO - 2015-12-07 06:55:41,784 DEBUG : BROWSER_OUTPUT: 06:55:44 INFO - 2015-12-07 06:55:44,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50620/tests/kraken/driver.html?testName=imaging-darkroom) 06:55:45 INFO - 2015-12-07 06:55:45,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 154517504 06:55:45 INFO - 2015-12-07 06:55:45,369 DEBUG : BROWSER_OUTPUT: 06:55:48 INFO - 2015-12-07 06:55:48,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50620/tests/kraken/driver.html?testName=imaging-desaturate) 06:55:49 INFO - 2015-12-07 06:55:49,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 154853376 06:55:49 INFO - 2015-12-07 06:55:49,384 DEBUG : BROWSER_OUTPUT: 06:55:52 INFO - 2015-12-07 06:55:52,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50620/tests/kraken/driver.html?testName=json-parse-financial) 06:55:52 INFO - 2015-12-07 06:55:52,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 156852224 06:55:52 INFO - 2015-12-07 06:55:52,770 DEBUG : BROWSER_OUTPUT: 06:55:54 INFO - 2015-12-07 06:55:54,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:55 INFO - 2015-12-07 06:55:55,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 164356096 06:55:55 INFO - 2015-12-07 06:55:55,152 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-12-07 06:55:57,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50620/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:55:57 INFO - 2015-12-07 06:55:57,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 163106816 06:55:57 INFO - 2015-12-07 06:55:57,637 DEBUG : BROWSER_OUTPUT: 06:55:59 INFO - 2015-12-07 06:55:59,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:00 INFO - 2015-12-07 06:56:00,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 177319936 06:56:00 INFO - 2015-12-07 06:56:00,398 DEBUG : BROWSER_OUTPUT: 06:56:02 INFO - 2015-12-07 06:56:02,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:03 INFO - 2015-12-07 06:56:03,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 182808576 06:56:03 INFO - 2015-12-07 06:56:03,552 DEBUG : BROWSER_OUTPUT: 06:56:06 INFO - 2015-12-07 06:56:06,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:06 INFO - 2015-12-07 06:56:06,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 181112832 06:56:06 INFO - 2015-12-07 06:56:06,700 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50620/tests/kraken/driver.html?testName=ai-astar) 06:56:08 INFO - 2015-12-07 06:56:08,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 238391296 06:56:08 INFO - 2015-12-07 06:56:08,713 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,714 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:56:08 INFO - 2015-12-07 06:56:08,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:56:08 INFO - 2015-12-07 06:56:08,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:56:08 INFO - 2015-12-07 06:56:08,714 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:56:08 INFO - 2015-12-07 06:56:08,714 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;106;113;113;113;102;112;114;104 06:56:08 INFO - 2015-12-07 06:56:08,714 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;130;153;161;131;157;154;129;166;132 06:56:08 INFO - 2015-12-07 06:56:08,714 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;159;161;165;161;161;162;163;161 06:56:08 INFO - 2015-12-07 06:56:08,714 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;87;96;72;73;74;116;88;72 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;131;94;95;94;130;96;95;126 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;109;110;109;111;110;109;109;109 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;147;146;146;148;147;146;146 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;75;82;72;73;73;73;82;71;71 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;68;69;68;68;69;68 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;87;85;91;84;85;84;85;84;83 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;121;120;120;125;129;134;127;124;125 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;142;149;148;138;135;151;146;149;137 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;69;71;71;70;70;80;69;68 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:56:08 INFO - 2015-12-07 06:56:08,715 DEBUG : BROWSER_OUTPUT: __startTimestamp1449500168708__endTimestamp 06:56:08 INFO - 2015-12-07 06:56:08,716 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:113.00 stddev:4.37 (3.9%) stddev-sans-first:4.64 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 106.0 113.0 113.0 113.0 102.0 112.0 114.0 104.0 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.80 Median:154.50 stddev:14.53 (9.4%) stddev-sans-first:15.10 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: Values: 155.0 130.0 153.0 161.0 131.0 157.0 154.0 129.0 166.0 132.0 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,717 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.58 (1.0%) stddev-sans-first:1.67 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 159.0 161.0 165.0 161.0 161.0 162.0 163.0 161.0 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.10 Median:73.50 stddev:14.83 (20.2%) stddev-sans-first:15.27 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 87.0 96.0 72.0 73.0 74.0 116.0 88.0 72.0 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:94.00 stddev:16.69 (17.8%) stddev-sans-first:17.23 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 131.0 94.0 95.0 94.0 130.0 96.0 95.0 126.0 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.73 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 109.0 110.0 109.0 111.0 110.0 109.0 109.0 109.0 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 147.0 146.0 146.0 148.0 147.0 146.0 146.0 06:56:08 INFO - 2015-12-07 06:56:08,718 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.50 Median:73.00 stddev:4.12 (5.6%) stddev-sans-first:4.33 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 82.0 72.0 73.0 73.0 73.0 82.0 71.0 71.0 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 68.0 69.0 68.0 68.0 69.0 68.0 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.30 (2.7%) stddev-sans-first:2.40 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 85.0 91.0 84.0 85.0 84.0 85.0 84.0 83.0 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.00 stddev:4.37 (3.5%) stddev-sans-first:4.58 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: Values: 127.0 121.0 120.0 120.0 125.0 129.0 134.0 127.0 124.0 125.0 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,719 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:147.00 stddev:5.68 (3.9%) stddev-sans-first:6.01 06:56:08 INFO - 2015-12-07 06:56:08,720 DEBUG : BROWSER_OUTPUT: Values: 145.0 142.0 149.0 148.0 138.0 135.0 151.0 146.0 149.0 137.0 06:56:08 INFO - 2015-12-07 06:56:08,720 DEBUG : BROWSER_OUTPUT: 06:56:08 INFO - 2015-12-07 06:56:08,720 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:3.44 (4.9%) stddev-sans-first:3.60 06:56:08 INFO - 2015-12-07 06:56:08,720 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 71.0 71.0 70.0 70.0 80.0 69.0 68.0 06:56:08 INFO - 2015-12-07 06:56:08,720 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:56:08 INFO - 2015-12-07 06:56:08,720 DEBUG : BROWSER_OUTPUT: 06:56:09 INFO - 2015-12-07 06:56:09,583 INFO : Browser exited with error code: 0 06:56:09 INFO - 2015-12-07 06:56:09,638 INFO : Completed test kraken (00:01:00) 06:56:09 INFO - 2015-12-07 06:56:09,638 INFO : Starting test v8_7 06:56:09 INFO - 2015-12-07 06:56:09,638 DEBUG : operating with platform_type : linux_ 06:56:09 INFO - 2015-12-07 06:56:09,638 INFO : Initialising browser for v8_7 test... 06:56:09 INFO - 2015-12-07 06:56:09,644 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdx6kWu/profile http://localhost:50620/getInfo.html 06:56:13 INFO - 2015-12-07 06:56:13,949 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:56:13 INFO - 2015-12-07 06:56:13,949 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:56:13 INFO - 2015-12-07 06:56:13,950 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:56:13 INFO - 2015-12-07 06:56:13,950 DEBUG : BROWSER_OUTPUT: __metrics 06:56:14 INFO - 2015-12-07 06:56:14,046 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:14 INFO - 2015-12-07 06:56:14,107 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:14 INFO - 2015-12-07 06:56:14,437 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 06:56:15 INFO - 2015-12-07 06:56:15,114 INFO : Browser initialized. 06:56:15 INFO - 2015-12-07 06:56:15,115 INFO : Running cycle 1/1 for v8_7 test... 06:56:15 INFO - 2015-12-07 06:56:15,115 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdx6kWu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:56:27 INFO - 2015-12-07 06:56:27,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 140324864 06:56:27 INFO - 2015-12-07 06:56:27,094 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50620/tests/v8_7/run.html (next: http://localhost:50620/tests/v8_7/run.html) 06:56:48 INFO - 2015-12-07 06:56:48,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 441094144 06:56:48 INFO - 2015-12-07 06:56:48,719 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,721 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:56:48 INFO - 2015-12-07 06:56:48,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:56:48 INFO - 2015-12-07 06:56:48,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:56:48 INFO - 2015-12-07 06:56:48,721 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:56:48 INFO - 2015-12-07 06:56:48,721 DEBUG : BROWSER_OUTPUT: |0;Richards;172.8608470181504 06:56:48 INFO - 2015-12-07 06:56:48,721 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.56318426424198 06:56:48 INFO - 2015-12-07 06:56:48,722 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 06:56:48 INFO - 2015-12-07 06:56:48,722 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 06:56:48 INFO - 2015-12-07 06:56:48,722 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1966.6011787819255 06:56:48 INFO - 2015-12-07 06:56:48,722 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 06:56:48 INFO - 2015-12-07 06:56:48,722 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 06:56:48 INFO - 2015-12-07 06:56:48,722 DEBUG : BROWSER_OUTPUT: |7;RegExp;27486.486486486487 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: |8;Splay;608.272506082725 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: __startTimestamp1449500208720__endTimestamp 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.86 Median:172.86 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,723 DEBUG : BROWSER_OUTPUT: Values: 172.9 06:56:48 INFO - 2015-12-07 06:56:48,724 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,724 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.56 Median:185.56 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,724 DEBUG : BROWSER_OUTPUT: Values: 185.6 06:56:48 INFO - 2015-12-07 06:56:48,724 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,724 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,724 DEBUG : BROWSER_OUTPUT: Values: 278.8 06:56:48 INFO - 2015-12-07 06:56:48,724 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,725 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,725 DEBUG : BROWSER_OUTPUT: Values: 5196.9 06:56:48 INFO - 2015-12-07 06:56:48,725 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,725 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,725 DEBUG : BROWSER_OUTPUT: Values: 1966.6 06:56:48 INFO - 2015-12-07 06:56:48,725 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: Values: 791.1 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: Values: 12072.3 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27486.49 Median:27486.49 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: Values: 27486.5 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.27 Median:608.27 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: Values: 608.3 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: 06:56:48 INFO - 2015-12-07 06:56:48,726 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 06:56:48 INFO - 2015-12-07 06:56:48,727 DEBUG : BROWSER_OUTPUT: Values: 4850.2 06:56:48 INFO - 2015-12-07 06:56:48,727 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:56:48 INFO - 2015-12-07 06:56:48,727 DEBUG : BROWSER_OUTPUT: 06:56:49 INFO - 2015-12-07 06:56:49,639 INFO : Browser exited with error code: 0 06:56:49 INFO - 2015-12-07 06:56:49,651 INFO : Completed test v8_7 (00:00:40) 06:56:49 INFO - 2015-12-07 06:56:49,788 INFO : Completed test suite (00:20:17) 06:56:49 INFO - 2015-12-07 06:56:49,788 DEBUG : Working with test: dromaeo_css 06:56:49 INFO - 2015-12-07 06:56:49,788 DEBUG : Generating results file: dromaeo_css 06:56:49 INFO - 2015-12-07 06:56:49,789 DEBUG : Working with test: kraken 06:56:49 INFO - 2015-12-07 06:56:49,789 DEBUG : Generating results file: kraken 06:56:49 INFO - 2015-12-07 06:56:49,790 INFO : javascript benchmark 06:56:49 INFO - 2015-12-07 06:56:49,790 DEBUG : Working with test: v8_7 06:56:49 INFO - 2015-12-07 06:56:49,790 DEBUG : Generating results file: v8_7 06:56:49 INFO - 2015-12-07 06:56:49,790 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:49 INFO - 2015-12-07 06:56:49,857 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 06:56:49 INFO - 2015-12-07 06:56:49,857 DEBUG : process_Request line: dromaeo_css 6239.73 graph.html#tests=[[72,94,35]] 06:56:49 INFO - 2015-12-07 06:56:49,857 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:49 INFO - 2015-12-07 06:56:49,888 DEBUG : process_Request line: kraken 1524.80 graph.html#tests=[[232,94,35]] 06:56:49 INFO - 2015-12-07 06:56:49,888 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:49 INFO - 2015-12-07 06:56:49,920 DEBUG : process_Request line: v8_7 19699.66 graph.html#tests=[[230,94,35]] 06:56:49 INFO - 2015-12-07 06:56:49,921 INFO : javascript benchmark 06:56:49 INFO - 2015-12-07 06:56:49,925 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2638.248099291702, 2743.067357098586, 2747.7252274772513, 2756.338478765097, 2767.875445604948, 4523.683342166041, 4657.720536767788, 4690.0854333405, 4751.12104260712, 4764.285357196422, 4630.652701047418, 4655.674102812796, 4746.7863946122425, 4785.928211076836, 4790.688605240657, 4362.280223763083, 4366.2359087159775, 4404.493483249419, 4407.845725399612, 4427.402300689414, 4169.770662613555, 4423.292273236283, 4429.889252768674, 4485.102979404132, 4489.3939318192115, 4289.828406863721, 4315.43899293093, 4344.413504176927, 4382.649388048949, 4418.491873434532, 4382.0797632497215, 4383.079553293812, 4386.1008493258805, 4386.56134386562, 4420.0, 4124.835006599732, 4384.649228061748, 4391.077873646538, 4414.359917811931, 4446.799894004777, 4514.977425112854, 4550.977245113786, 4582.014866803654, 4640.65195110368, 4656.67403281767, 5077.695338279715, 5127.359080114986, 5132.435432102466, 5135.897282054375, 5158.7678554464765, 5137.6403651744395, 5145.562627176694, 5145.871353216162, 5148.485151484859, 5195.064888320101, 4467.15124126415, 4566.40636717228, 4570.954290457053, 4606.216943119678, 4647.604953578983, 5213.452587478336, 5236.1098613235845, 5243.868903277372, 5247.422783493813, 5258.789648414097, 5011.198208286657, 5014.598832093424, 5017.272495488207, 5018.2974383586325, 5065.0, 4819.277108433763, 4925.359703238628, 4928.605711543068, 5092.694438333712, 5102.234664800236, 4968.751562421864, 5087.618428617869, 5107.693538387709, 5134.640575159703, 5136.922946155811, 5014.799408023711, 5036.0, 5037.395512538519, 5045.84862454127, 5046.621503387188, 3748.5501739790852, 3865.265599536079, 3875.748076375027, 3898.8245528951265, 3940.172563761585, 3414.0, 3450.4306789379975, 3477.0611934777467, 3479.3911065563425, 3512.473129030615, 4342.131573685276, 4355.060478648133, 4357.085012147421, 4358.019445624773, 4387.692861499728, 4860.1008813369635, 5080.618953578496, 5086.4659210783075, 5086.593072554187, 5090.338256026767, 4221.5567365426805, 4268.658507319407, 4280.250956082673, 4282.100758840616, 4316.740995540277, 4438.889027774267, 4505.5719706627815, 4506.233940230169, 4507.0, 4524.5927866492175, 4589.724616523019, 4823.517648235148, 4840.588549973221, 4844.588210002048, 4868.756562171877, 4912.164931961646, 4939.580135688507, 4939.950600493949, 5050.671706339076, 5052.166392545336, 4802.73584952831, 4832.323474713473, 4834.903301933871, 4842.249451335048, 4888.560029597354, 5014.022265658162, 5021.422536408214, 5022.422421421437, 5040.546350828443, 5085.898282034413, 4827.8551643450755, 4946.975265123651, 4948.010397920359, 4948.282499037691, 5109.693418394908, 4801.663883528119, 4864.294677271847, 4873.074115917964, 4874.390701162355, 4875.488073752347, 4855.902881942271, 4858.562729354234, 4862.222044472867, 4862.294967229803, 4868.026394721141, 4755.571998520011, 4848.272759086165, 4856.8300109495995, 4886.511348865085, 4898.779554919965, 4835.178019736723, 4886.071646387175, 4888.95111048885, 4896.6572339935865, 4931.630127740362, 4616.8614941551805, 4721.008588196517, 4814.229723244264, 4814.662973591955, 4817.301491283814], "unit": "ms", "name": "dojo.html", "value": 4607.411198582585}, {"lowerIsBetter": false, "replicates": [534.6685055265735, 537.100356902189, 539.6950722841594, 540.3515781062725, 542.755759908041, 25001.74998250017, 25458.61812072818, 34311.656883431155, 35373.82313088431, 35426.2914741705, 39959.40060899089, 40558.79720601393, 40581.797091014574, 40600.0, 40623.59376406235, 6897.6206308653, 7724.382049436045, 7852.528848269122, 7897.921020789776, 7900.565468899208, 6987.0, 10141.695749127539, 10395.480225988671, 10411.947940260327, 10412.68761937143, 10001.199904007663, 10091.091801737843, 10105.343152695088, 10108.44403557804, 10115.494225288743, 7108.751193708247, 7289.5261807982315, 9918.404895706244, 10029.648962286285, 10105.696829095139, 9812.65655702047, 9962.352447090989, 9965.40207587547, 9975.600975961026, 9980.500974951296, 36110.81944590287, 36628.450573241425, 36638.267234655155, 36644.0, 36674.26651466983, 2708.5530887403556, 2740.4245108527034, 3157.2264795125343, 3326.9833650831833, 3527.5590551181103, 27478.862605686845, 27661.446771064468, 27781.16656500288, 28057.346386501245, 28280.434391312265, 3363.025628265738, 3451.5858097028267, 3454.274602333513, 3525.365434221839, 3570.1788588624763, 214967.0, 216319.0, 216452.0, 216639.91680041657, 216995.0, 53534.19698704522, 53723.73138134284, 53759.19361209585, 53827.0, 53895.73052134714, 38920.8053959734, 39361.21277574432, 63350.683246583474, 64822.0, 64887.35112648813, 13260.801087983687, 13429.66425839362, 13517.32413379327, 13518.729625407437, 13535.661608459868, 9991.300608957303, 10070.244731645156, 10074.143697785623, 10079.949600251952, 10085.344452610703, 18403.355882544045, 18534.721979170325, 18624.348147814762, 18639.440816775517, 18684.7578290606, 6960.234374218832, 7144.749933752294, 7288.526245794006, 7334.339909408179, 7421.220771818989, 848.6817443458702, 893.8033632600817, 901.3059943843205, 938.2728385501291, 960.1166926427563, 25685.3578660535, 26339.341516462242, 27003.729962700123, 27705.0, 28220.15339539817, 840.369722707969, 876.1457578860687, 936.639393833379, 964.2141654551518, 1002.4185972136144, 12994.545190918272, 13248.0, 13342.53301134475, 13377.0, 13389.464421423034, 255837.0, 260688.0, 261167.0, 261382.0, 262356.0, 44072.779636101615, 44370.33444498335, 44410.555894440644, 44493.77753111214, 44527.777361113636, 1202.5911190195375, 1206.390772659801, 1209.2925638501574, 1213.4782043721284, 1217.604278609473, 22143.889280553492, 24856.502869942862, 25497.61753573661, 25822.096226631977, 25851.353716156493, 36455.635443646286, 36801.81599092094, 36809.81595092007, 36812.0, 36823.63176368202, 199244.0, 200308.0, 200653.0, 200873.0, 200883.0, 22440.551188976457, 24955.381469687156, 27567.31081722973, 28330.0, 29334.266643333234, 32025.35949281048, 32769.01692949215, 33311.0, 33691.663083368854, 33779.493307599914, 33293.33413331768, 35793.0, 36134.638653613125, 36456.453153202194, 36819.81590092032, 31787.841060794548, 32131.839340803148, 32168.51747223747, 32219.0, 32236.19409514781, 32099.0, 32566.83716581402, 33106.83446582848, 33624.1593960153, 33652.158696031816, 25182.244532664048, 27143.59284610693, 27151.72848271571, 27304.72695273022, 27569.331971196254, 21329.749229300505, 22754.544909101394, 22794.54410911806, 23077.307680769605, 23265.302040938797], "unit": "ms", "name": "ext.html", "value": 16619.46622140131}, {"lowerIsBetter": false, "replicates": [278.76645842148486, 283.146313863701, 284.0413604086209, 288.7805267996323, 291.4317081690703, 12191.51233950641, 12392.442340094694, 15483.922580387096, 15856.048637081769, 16050.19749012549, 11622.360770157638, 13907.165570065778, 14608.561743147722, 15451.768223476656, 15479.458218962338, 4760.8095676173, 4886.560209581137, 4894.877628059309, 5031.4465408805, 5168.198929165967, 3351.715104216132, 3428.8457019434186, 5155.664881782691, 5172.8706782330555, 6499.415052645261, 6487.41613254807, 6613.801585952429, 6655.733770649193, 6660.9000864987065, 6673.666316684171, 6597.37324954131, 6632.602043877383, 6642.3025582313885, 6646.9667651661675, 6660.100886380325, 5965.0, 6148.200733904609, 6374.043893415978, 6374.85252654522, 6378.043293505965, 20253.0, 20282.087306071262, 20496.282630107875, 20659.793402066087, 20817.479563010893, 1838.7665023850539, 1963.6367272054715, 1979.5941831924565, 1988.681810910262, 1995.3016444244543, 13309.800352994713, 13460.528881489101, 13634.454621815115, 13694.109882857681, 14338.713225735426, 1845.5847434327304, 1851.5278603955906, 1858.869879108463, 1864.925402983879, 1880.1445342369188, 50598.0, 51649.225261621104, 51826.48173518292, 53059.46940530623, 53940.730296348265, 15473.613159670873, 15504.224788760517, 15573.844261557238, 15616.92191539035, 15713.921430392775, 23301.7669823303, 23370.883145584165, 23458.061677532707, 23478.765212348, 23511.7648823513, 7736.535807851435, 7891.250331218525, 7949.3243074339325, 7961.920380796118, 8012.399070069768, 6579.407853293131, 6595.406413422815, 6614.503912206507, 6626.370494802986, 6665.766698165541, 7768.262015108556, 7780.8832867507035, 7813.960930195312, 7854.607269636495, 7872.212778722082, 1711.3753479979719, 1714.431041275013, 1729.6627157704127, 1758.8417042465983, 2153.612349777024, 836.8995720513577, 889.786451251695, 940.8776859008285, 972.863799068131, 976.3019441099506, 16006.759898601531, 16160.43438479671, 16273.10497922602, 16573.91713041427, 16604.6679066418, 820.3045281009016, 840.911704271055, 842.1704620948361, 860.0066922704286, 885.4288983605538, 8320.958395208107, 8445.746627601182, 8597.0, 8601.13988601135, 8720.43317184381, 454100.0, 459413.0, 460736.0, 473778.0, 494384.0, 57144.428555714745, 58060.41939580635, 65750.0, 66531.0, 68155.0, 1020.1074060197327, 1025.7948410317965, 1037.2479952034714, 1038.1798379280283, 1040.9739756505996, 14039.408866994976, 14061.156330620195, 14720.77918831197, 14885.0, 14928.850711492745, 31418.842905785325, 31653.525197122523, 31934.840325799152, 32637.673623263465, 34929.65070349264, 38681.41977870391, 39921.60078399179, 48622.27066594075, 48841.755791220814, 49287.0, 8460.534670593177, 8512.0, 8806.987196472232, 8877.289816814768, 8877.33419993516, 10206.387616743019, 10275.280730348804, 10293.794124117327, 10336.17310615134, 15520.0, 12986.805197921849, 13051.543195988095, 13259.337033148111, 13369.66575835573, 13457.259850708306, 12644.241345519298, 12703.301318427206, 12928.806067909178, 13139.54011609589, 13888.027838051643, 13634.659133521345, 13649.658758531115, 14250.501232456814, 14275.0, 14419.711605768036, 9021.0, 9140.862887056566, 9242.306826987868, 9282.071792820663, 9312.580933857857, 13666.93166534161, 13676.384562694504, 13842.930785346009, 13947.30263486842, 14389.0], "unit": "ms", "name": "jquery.html", "value": 8840.046700983576}, {"lowerIsBetter": false, "replicates": [1418.0711633879812, 1627.8697704183664, 1661.3354658136743, 1695.7541156532302, 1703.8125806161324, 5998.490128339091, 6675.7663481778145, 6846.075779769736, 6859.211190713069, 6866.24471308157, 6911.170659520852, 7150.642467876612, 7153.642317884098, 7154.821129471766, 7159.248278930715, 1978.277928556081, 1995.6308083004617, 1999.1803360622148, 2000.1799262302459, 2001.0495014867895, 1994.2421879685771, 2005.9598808023832, 2019.7778244393105, 2072.160774886166, 2089.059923034633, 2000.3898810862681, 2046.6623007203793, 2067.018166370977, 2069.0999415254337, 2075.273654221018, 2019.9394018179405, 2047.1504325704814, 2057.423921302038, 2058.0635810706094, 2059.268959519379, 2036.5010572409853, 2051.3333166720877, 2053.6098141353095, 2059.0, 2072.896355182235, 7105.111861017373, 7145.857082858313, 7177.35403813654, 7188.029616001825, 7190.856182876366, 3919.8824035278985, 3992.980035099835, 4001.4598029265967, 4010.1578668479656, 4013.7993100345157, 2575.5364034473787, 2577.0, 2610.2169349195165, 2654.8008899332626, 2656.9468610627678, 798.5448294472153, 812.4231795425255, 825.9545724985123, 843.696269343036, 844.4004756622805, 9599.904000960041, 9600.423974561549, 9601.519924003773, 9616.134547890724, 9619.230461563058, 3754.9061273467837, 3769.5288088988877, 3807.8286477108595, 3827.0623697194364, 3836.462895194675, 8296.792580185424, 8300.70947516834, 8313.459625124347, 8318.292945099734, 8327.20891515305, 4143.56492568276, 4146.129312844276, 4147.3778933160265, 4148.585141485888, 4156.355764856452, 3189.266468712163, 3308.652591477908, 3708.9443658345144, 3789.981050094732, 3793.905152371213, 3336.2493438976035, 3338.0987133473827, 3354.496825476198, 3373.5108409280515, 3379.6620337966497, 1022.0597050713361, 1032.3083534032216, 1033.684726158529, 1035.891231420705, 1037.2479952034864, 911.2482202183226, 915.977100572491, 918.9264858811413, 1000.8598796168542, 1044.556063672936, 6468.838279043061, 6524.119243902107, 6530.902036469457, 6531.412172904462, 6536.509761767887, 384.1686768516055, 398.42626617670464, 402.05717592246134, 402.502908907499, 409.17551134464077, 5108.489151084862, 5159.045576568347, 5163.3545806774155, 5166.819161329336, 5176.094183517869, 8298.875516867252, 8314.501129932223, 8431.873521897176, 8470.195331443503, 8520.0, 8411.158884111663, 8458.281046111026, 8483.575821208915, 8489.108643592457, 8491.745247642457, 6606.834829129214, 6608.4052435281055, 6713.798586042427, 6725.0, 6725.966370168216, 6192.628442293477, 6207.6585787782105, 6221.129041934042, 6223.813285601439, 6228.813135605939, 7552.358049565849, 7560.58416787082, 7562.584057876869, 7620.771376858703, 7676.078870535572, 7664.233576642291, 7722.575258360844, 7775.611219439119, 7842.411819113703, 7894.447388682737, 5161.896762064813, 5309.283246761792, 6162.075688646739, 6198.81403557894, 6218.906716399348, 6486.54594178403, 6629.7348106075215, 6708.127943367331, 6710.194776626836, 6713.227978782503, 6274.874502509833, 6402.263739669997, 6429.292777794532, 6499.350064993463, 6529.934700652932, 6065.423784740443, 6068.120122582289, 6100.389961003864, 6154.138420621027, 6169.84575385619, 6088.5737998341465, 6095.35998720128, 6128.540359472968, 6133.049377346519, 6144.8771024580155, 5627.240322556402, 5657.264555607745, 5660.037793575185, 5664.773409063591, 5689.118186681071, 5806.709664516842, 5836.124581312837, 5885.028970219866, 5887.411258874078, 5904.586678932434], "unit": "ms", "name": "mootools.html", "value": 3893.2167211193982}, {"lowerIsBetter": false, "replicates": [249.38526532098385, 253.04601651772816, 259.0634854999178, 259.5367269424078, 261.3961748361286, 5265.7367131643405, 5308.654937429064, 5314.707691076994, 5315.574754019679, 5339.119045357511, 5071.087204303224, 5123.0, 5194.246834209038, 5216.374035115791, 5234.816781412651, 4021.2158629067417, 4025.6980726445486, 4035.3139966205817, 4035.3139966205817, 4036.9798151009204, 4025.919481610366, 4027.0737730322044, 4032.6975476839207, 4032.9596704033024, 4037.454943582608, 3988.12261302513, 3994.081361286891, 3996.0609256824623, 3996.4005399190064, 3997.860074897379, 3857.0743021674875, 3983.203359328117, 3992.121733218687, 3999.740016898907, 4006.038550747814, 3423.2639982403903, 3424.8116353600544, 3427.845746941394, 3430.1767575781882, 3430.4682774169796, 5203.583713302926, 5204.115300398941, 5204.791808327663, 5208.895822083575, 5215.0, 4576.473705523841, 4579.908401831978, 4583.03756211196, 4585.358049873021, 4586.610138138262, 5616.1014237721765, 5620.381758006616, 5622.8313150605545, 5627.352854421712, 5629.268195134648, 3558.323918455511, 3639.217568222845, 3645.125169959217, 3648.616895226016, 3650.470681751158, 5686.516646085088, 5844.853878653025, 5875.471207591295, 5958.5828991970575, 5963.135345374896, 3721.8697345592773, 3790.3177428063213, 3800.049987503124, 3808.333541630204, 3822.866199682998, 3849.749766265184, 3860.9034774130873, 3869.96130038696, 3870.0905287257474, 3871.593482684334, 4534.7052441591195, 4539.0694907543875, 4544.818207271738, 4545.886352841206, 4546.568076032771, 5506.063969125258, 5605.383407825136, 5625.521830644441, 5648.322201335866, 5663.405342438985, 1328.7873940169527, 1331.8867896228928, 1341.0813592688844, 1342.5234041915176, 1344.4218985836185, 802.0175285275491, 809.3969992355615, 841.7937605286744, 861.5046348349724, 876.2245412809582, 4874.341963834908, 4877.219644856877, 4900.534449227318, 4902.264660300983, 4905.0, 5807.883842323215, 5808.39011903744, 5808.796692115756, 5809.128630705428, 5809.738561764731, 4878.56092951636, 4882.462929077798, 4888.755562221874, 4892.0705066037335, 4892.119418504703, 3076.5846610707717, 3100.612423447069, 3146.1819926819194, 3146.3078122812944, 3152.8738850445725, 5492.642978206404, 5497.917531237034, 5498.835034948958, 5501.697406642673, 5503.091989821634, 5973.283206015306, 5974.40255974399, 5982.73077711504, 5991.730372133265, 5996.400359963969, 5485.122380419114, 5485.286912701324, 5487.478689524569, 5492.231087647732, 5492.69790161537, 5642.181883626769, 5803.912941305968, 5812.33158186797, 5814.273215848019, 5816.970915145566, 5692.601517893708, 5696.943030569807, 5704.229928959538, 5704.80033198836, 5708.57185711065, 5454.072807622793, 5464.9180262296895, 5476.67139971603, 5482.095454250004, 5483.808066717806, 3718.628137186368, 3788.090858194069, 3823.369144091194, 3838.05967537955, 3841.9231615368094, 5724.255846739898, 5796.855078623068, 5799.449052340021, 5802.4197580241635, 5805.216295800013, 5588.385277619377, 5591.664500130005, 5593.049181639212, 5596.720163991703, 5601.327840659147, 5581.665100094007, 5586.888262234814, 5587.55299576041, 5593.552515798645, 5594.720263986703, 5339.199120132012, 5469.890602187855, 5471.2613797138465, 5475.260839786737, 5480.177973304037, 5458.645188062763, 5539.086050801734, 5586.106223004463, 5589.273394458694, 5612.214289999485, 5461.0, 5462.590305727166, 5524.06090964545, 5525.806596769094, 5539.335279766454], "unit": "ms", "name": "prototype.html", "value": 4105.479763751215}, {"lowerIsBetter": false, "replicates": [779.9571023593703, 791.8693415586429, 800.6997375984006, 801.5311043039818, 822.6339279020837, 12179.939100304497, 12444.377781110954, 12450.43973021214, 12452.377381130953, 12458.813117803229, 12991.74016519669, 13264.270465124438, 13287.534936277232, 13292.468301267938, 13311.201327920331, 622.0451606783588, 628.136312570216, 783.7374479549344, 788.1291173253529, 798.7483942558105, 796.1878883538787, 796.6494742313392, 803.4135081390589, 803.7709252862935, 804.6298702596813, 825.9587020648974, 829.8464784014947, 831.5177197225595, 832.1054866019024, 832.184459229955, 647.5273050673012, 653.2487639214893, 816.9183081691842, 828.2793969246734, 833.3832963606948, 611.8868009418272, 614.1064750787593, 614.6772944204329, 614.8678034222619, 616.9444749972479, 11355.659330220107, 11467.770644587144, 11517.884821151765, 11627.244229125079, 11672.533098676044, 10508.94745526275, 10820.458977051116, 11017.173711971554, 11274.887251127466, 11403.486843092081, 9289.581968811419, 9469.66856160038, 9492.050794920522, 9513.143817056498, 9520.571914212855, 3106.1775100801524, 3134.420132275536, 3161.367726454718, 3177.7457803375905, 3178.316661917676, 38292.80853595742, 38587.421188682194, 38594.03514912121, 38618.61381386178, 38632.03419914497, 8882.245009174163, 8927.776805579913, 9033.909660903308, 9413.341066125442, 9439.056094390506, 15665.29506172225, 15776.68446631061, 15811.604709882346, 15824.129672868103, 15853.445129420415, 6031.728572214261, 6263.843403914848, 6270.31026587075, 6336.746530138743, 6390.0734393512685, 3464.4803279508274, 3586.4105467405416, 3589.174489867293, 3666.138457462494, 3666.1934374437583, 2509.372656835791, 2562.0, 2569.3833479964674, 2570.3831080540535, 2571.344307201689, 446.8771087950839, 451.29147238834713, 455.19885002396023, 464.70026832692724, 467.99532004680196, 517.5911030286031, 569.4106599669323, 589.4223660812428, 596.3470000349611, 596.9462748352669, 7306.415486761046, 7336.38599508118, 7525.623718814038, 7563.773086807405, 7625.237476252441, 418.8534013095392, 513.3198511971652, 554.9223108764776, 599.9820005399845, 606.5147881694627, 3394.4399174135992, 3457.2048428861503, 3541.36255474012, 3551.0, 3565.108722819295, 47636.0, 47717.761411192725, 47823.0, 49015.264771028465, 49688.0, 41932.0, 42666.360004599956, 42688.57311426908, 42716.0, 42951.35572966408, 37234.25531489409, 37482.43776343357, 37961.430578541345, 38533.614663853565, 38803.029924251554, 7086.149662040382, 7177.569345839266, 7203.2076471589135, 7280.453965952681, 7383.778486645409, 29973.400531988802, 30208.395832083675, 30238.69761302447, 30589.388212236077, 30811.53782693306, 35961.640383595826, 36608.267834642626, 37325.4401183977, 39638.801805990784, 39648.00879978023, 8638.912048247037, 8897.644094236159, 8975.50634715097, 9087.591058402255, 9110.544472776202, 9824.4105353679, 9848.261380396356, 9861.457619830691, 9878.950605246928, 9888.950555247178, 8870.600822962853, 9120.452772833385, 9149.451032938045, 9226.169644732006, 9430.339876208875, 8685.478871267744, 8800.89988751406, 8813.074627164311, 8843.292536597186, 9534.904650953678, 8807.163319484638, 8848.601812918305, 8989.280857531512, 9141.908580914373, 9186.08139186076, 7631.618419078913, 7660.387169026353, 7715.3441957432005, 7862.646180921758, 8044.517328960281, 7403.18564957865, 7635.0, 7654.846903062019, 7762.456628035983, 7825.491343062683], "unit": "ms", "name": "yui.html", "value": 5454.367106728991}], "name": "dromaeo_css", "value": 6239.7288825775095}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 113.0, 113.0, 113.0, 102.0, 112.0, 114.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [155.0, 130.0, 153.0, 161.0, 131.0, 157.0, 154.0, 129.0, 166.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 159.0, 161.0, 165.0, 161.0, 161.0, 162.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 87.0, 96.0, 72.0, 73.0, 74.0, 116.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 131.0, 94.0, 95.0, 94.0, 130.0, 96.0, 95.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 82.0, 72.0, 73.0, 73.0, 73.0, 82.0, 71.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 74.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 85.0, 91.0, 84.0, 85.0, 84.0, 85.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [127.0, 121.0, 120.0, 120.0, 125.0, 129.0, 134.0, 127.0, 124.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [145.0, 142.0, 149.0, 148.0, 138.0, 135.0, 151.0, 146.0, 149.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 71.0, 71.0, 70.0, 70.0, 80.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1524.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.8608470181504], "unit": "score", "name": "Richards", "value": 204.22207000000006}, {"lowerIsBetter": false, "replicates": [185.56318426424198], "unit": "score", "name": "DeltaBlue", "value": 356.309902}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1966.6011787819255], "unit": "score", "name": "RayTrace", "value": 376.2781228771229}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [27486.486486486487], "unit": "score", "name": "RegExp", "value": 33.14301376597835}, {"lowerIsBetter": false, "replicates": [608.272506082725], "unit": "score", "name": "Splay", "value": 133.97120400000006}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19699.655826949238}]} 06:56:49 INFO - RETURN: dromaeo_css: 6239.73 06:56:49 INFO - RETURN: kraken: 1524.80 06:56:49 INFO - RETURN: v8_7: 19699.66 06:56:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19699.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1524.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6239.73"}}} 06:56:50 INFO - Return code: 0 06:56:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:56:50 ERROR - # TBPL SUCCESS # 06:56:50 INFO - Running post-action listener: _resource_record_post_action 06:56:50 INFO - Running post-run listener: _resource_record_post_run 06:56:51 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 509276160; Read time: 0; Write time: 435768 06:56:51 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231079936; Read time: 0; Write time: 274980 06:56:51 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 278196224; Read time: 0; Write time: 160788 06:56:51 INFO - Running post-run listener: _upload_blobber_files 06:56:51 INFO - Blob upload gear active. 06:56:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:56:51 INFO - Copying logs to upload dir... 06:56:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.742053 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-07 06:56:49.903339) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 06:56:49.906912) ========= 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=801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781 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.009980 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:49.959038) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:56:49.959413) ========= 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=801756c90a5e5cfe63934219000001c7-1449492758.764437-1620604781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 06:56:50.010289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 06:56:50.010621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 06:56:50.010930) ========= ========= Total master_lag: 0.25 =========