builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1450268197.6 results: success (0) buildid: 20151216030231 builduid: 08c0a5efce44464daf9a5a72f5daac2d revision: 0babaa3edcf908c393b68a3dc2d1c2a2450c31ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.596250) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.596687) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.596977) ========= 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=01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006413 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.623663) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.624019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.668876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.669149) ========= 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=01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.718059) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.718556) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.719108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.719389) ========= 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=01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 04:16:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.2M=0s 2015-12-16 04:16:38 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195003 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.942587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.942870) ========= 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=01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015000 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:37.995650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:16:37.996016) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0babaa3edcf908c393b68a3dc2d1c2a2450c31ed --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 0babaa3edcf908c393b68a3dc2d1c2a2450c31ed --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=01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 04:16:38,443 truncating revision to first 12 chars 2015-12-16 04:16:38,443 Setting DEBUG logging. 2015-12-16 04:16:38,443 attempt 1/10 2015-12-16 04:16:38,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0babaa3edcf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 04:16:39,004 unpacking tar archive at: mozilla-central-0babaa3edcf9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.824140 ========= master_lag: 0.93 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:16:39.746163) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:39.746455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:39.775578) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:39.776251) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:16:39.776733) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-16 04:16:39.777104) ========= /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=01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:40 INFO - MultiFileLogger online at 20151216 04:16:40 in /builds/slave/test 04:16:40 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 04:16:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:40 INFO - {'append_to_log': False, 04:16:40 INFO - 'base_work_dir': '/builds/slave/test', 04:16:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:16:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:40 INFO - 'branch': 'Firefox-Non-PGO', 04:16:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:40 INFO - 'config_files': ('talos/linux_config.py',), 04:16:40 INFO - 'default_actions': ('clobber', 04:16:40 INFO - 'read-buildbot-config', 04:16:40 INFO - 'download-and-extract', 04:16:40 INFO - 'populate-webroot', 04:16:40 INFO - 'create-virtualenv', 04:16:40 INFO - 'install', 04:16:40 INFO - 'run-tests'), 04:16:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:40 INFO - 'download_minidump_stackwalk': True, 04:16:40 INFO - 'download_symbols': 'ondemand', 04:16:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:40 INFO - 'installer_path': 'installer.exe', 04:16:40 INFO - 'log_level': 'info', 04:16:40 INFO - 'log_name': 'talos', 04:16:40 INFO - 'log_to_console': True, 04:16:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:40 INFO - 'opt_config_files': (), 04:16:40 INFO - 'pip_index': False, 04:16:40 INFO - 'sps_profile': False, 04:16:40 INFO - 'sps_profile_interval': 0, 04:16:40 INFO - 'suite': 'dromaeojs', 04:16:40 INFO - 'system_bits': '64', 04:16:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:40 INFO - 'title': 'talos-linux64-ix-014', 04:16:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:40 INFO - 'use_talos_json': True, 04:16:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:40 INFO - 'work_dir': 'build'} 04:16:40 INFO - ##### 04:16:40 INFO - ##### Running clobber step. 04:16:40 INFO - ##### 04:16:40 INFO - Running pre-action listener: _resource_record_pre_action 04:16:40 INFO - Running main action method: clobber 04:16:40 INFO - rmtree: /builds/slave/test/build 04:16:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:41 INFO - Running post-action listener: _resource_record_post_action 04:16:41 INFO - ##### 04:16:41 INFO - ##### Running read-buildbot-config step. 04:16:41 INFO - ##### 04:16:41 INFO - Running pre-action listener: _resource_record_pre_action 04:16:41 INFO - Running main action method: read_buildbot_config 04:16:41 INFO - Using buildbot properties: 04:16:41 INFO - { 04:16:41 INFO - "properties": { 04:16:41 INFO - "buildnumber": 407, 04:16:41 INFO - "product": "firefox", 04:16:41 INFO - "script_repo_revision": "production", 04:16:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:16:41 INFO - "repository": "", 04:16:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:16:41 INFO - "buildid": "20151216030231", 04:16:41 INFO - "slavename": "talos-linux64-ix-014", 04:16:41 INFO - "pgo_build": "False", 04:16:41 INFO - "basedir": "/builds/slave/test", 04:16:41 INFO - "project": "", 04:16:41 INFO - "platform": "ubuntu64_hw", 04:16:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:16:41 INFO - "slavebuilddir": "test", 04:16:41 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:16:41 INFO - "branch": "mozilla-central", 04:16:41 INFO - "repo_path": "mozilla-central", 04:16:41 INFO - "stage_platform": "linux64", 04:16:41 INFO - "builduid": "08c0a5efce44464daf9a5a72f5daac2d", 04:16:41 INFO - "revision": "0babaa3edcf908c393b68a3dc2d1c2a2450c31ed" 04:16:41 INFO - }, 04:16:41 INFO - "sourcestamp": { 04:16:41 INFO - "repository": "", 04:16:41 INFO - "hasPatch": false, 04:16:41 INFO - "project": "", 04:16:41 INFO - "branch": "mozilla-central-linux64-talos", 04:16:41 INFO - "changes": [ 04:16:41 INFO - { 04:16:41 INFO - "category": null, 04:16:41 INFO - "files": [ 04:16:41 INFO - { 04:16:41 INFO - "url": null, 04:16:41 INFO - "name": "https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:16:41 INFO - } 04:16:41 INFO - ], 04:16:41 INFO - "repository": "", 04:16:41 INFO - "rev": "0babaa3edcf908c393b68a3dc2d1c2a2450c31ed", 04:16:41 INFO - "who": "cbook@mozilla.com", 04:16:41 INFO - "when": 1450268161, 04:16:41 INFO - "number": 7365649, 04:16:41 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 04:16:41 INFO - "project": "", 04:16:41 INFO - "at": "Wed 16 Dec 2015 04:16:01", 04:16:41 INFO - "branch": "mozilla-central-linux64-talos", 04:16:41 INFO - "revlink": "", 04:16:41 INFO - "properties": [ 04:16:41 INFO - [ 04:16:41 INFO - "buildid", 04:16:41 INFO - "20151216030231", 04:16:41 INFO - "Change" 04:16:41 INFO - ], 04:16:41 INFO - [ 04:16:41 INFO - "builduid", 04:16:41 INFO - "08c0a5efce44464daf9a5a72f5daac2d", 04:16:41 INFO - "Change" 04:16:41 INFO - ], 04:16:41 INFO - [ 04:16:41 INFO - "pgo_build", 04:16:41 INFO - "False", 04:16:41 INFO - "Change" 04:16:41 INFO - ] 04:16:41 INFO - ], 04:16:41 INFO - "revision": "0babaa3edcf908c393b68a3dc2d1c2a2450c31ed" 04:16:41 INFO - } 04:16:41 INFO - ], 04:16:41 INFO - "revision": "0babaa3edcf908c393b68a3dc2d1c2a2450c31ed" 04:16:41 INFO - } 04:16:41 INFO - } 04:16:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:16:41 INFO - Running post-action listener: _resource_record_post_action 04:16:41 INFO - ##### 04:16:41 INFO - ##### Running download-and-extract step. 04:16:41 INFO - ##### 04:16:41 INFO - Running pre-action listener: _resource_record_pre_action 04:16:41 INFO - Running main action method: download_and_extract 04:16:41 INFO - mkdir: /builds/slave/test/build/tests 04:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:41 INFO - https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/test_packages.json 04:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/test_packages.json 04:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:16:43 INFO - Downloaded 1302 bytes. 04:16:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:16:43 INFO - Using the following test package requirements: 04:16:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:43 INFO - u'jsshell-linux-x86_64.zip'], 04:16:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:43 INFO - https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:16:44 INFO - Downloaded 21868914 bytes. 04:16:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:16:45 INFO - Return code: 0 04:16:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:45 INFO - https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:16:50 INFO - Downloaded 21868914 bytes. 04:16:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:16:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:16:52 INFO - Return code: 0 04:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:52 INFO - https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:16:52 INFO - Downloaded 11132052 bytes. 04:16:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:16:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:16:53 INFO - Return code: 0 04:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:53 INFO - https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:16:54 INFO - Downloaded 57744342 bytes. 04:16:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:54 INFO - mkdir: /builds/slave/test/properties 04:16:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:54 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:54 INFO - Contents: 04:16:54 INFO - build_url:https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:54 INFO - Running post-action listener: _resource_record_post_action 04:16:54 INFO - Running post-action listener: set_extra_try_arguments 04:16:54 INFO - ##### 04:16:54 INFO - ##### Running populate-webroot step. 04:16:54 INFO - ##### 04:16:54 INFO - Running pre-action listener: _resource_record_pre_action 04:16:54 INFO - Running main action method: populate_webroot 04:16:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:54 INFO - '--tppagecycles', 04:16:54 INFO - '7'], 04:16:54 INFO - 'tests': ['tsvgm']}}, 04:16:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:16:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:16:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:16:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:54 INFO - 'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:54 INFO - 'tests': ['damp', 'tps']}, 04:16:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:54 INFO - 'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['damp', 'tps']}, 04:16:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:16:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:54 INFO - 'other': {'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore']}, 04:16:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore']}, 04:16:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore']}, 04:16:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore']}, 04:16:54 INFO - 'other_l64': {'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore']}, 04:16:54 INFO - 'other_nol64': {'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore']}, 04:16:54 INFO - 'svgr': {'tests': ['tsvgx', 04:16:54 INFO - 'tsvgr_opacity', 04:16:54 INFO - 'tart', 04:16:54 INFO - 'tscrollx', 04:16:54 INFO - 'cart']}, 04:16:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['tsvgx', 04:16:54 INFO - 'tsvgr_opacity', 04:16:54 INFO - 'tart', 04:16:54 INFO - 'tscrollx', 04:16:54 INFO - 'cart']}, 04:16:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:54 INFO - 'tests': ['tp5o']}, 04:16:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:54 INFO - 'talos_options': ['--e10s'], 04:16:54 INFO - 'tests': ['tp5o']}, 04:16:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:54 INFO - 'talos_options': ['--xperf_path', 04:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:54 INFO - 'tests': ['tp5n']}, 04:16:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:54 INFO - 'talos_options': ['--e10s', 04:16:54 INFO - '--xperf_path', 04:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:54 INFO - 'tests': ['tp5n']}}, 04:16:54 INFO - 'talos.zip': {'path': '', 04:16:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:54 INFO - Running post-action listener: _resource_record_post_action 04:16:54 INFO - ##### 04:16:54 INFO - ##### Running create-virtualenv step. 04:16:54 INFO - ##### 04:16:54 INFO - Running pre-action listener: _resource_record_pre_action 04:16:54 INFO - Running main action method: create_virtualenv 04:16:54 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:16:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:54 INFO - Using real prefix '/usr' 04:16:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:55 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:57 INFO - Installing pip.................done. 04:16:57 INFO - Return code: 0 04:16:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:16:57 INFO - Using env: {'DISPLAY': ':0', 04:16:57 INFO - 'HOME': '/home/cltbld', 04:16:57 INFO - 'LANG': 'en_US.UTF-8', 04:16:57 INFO - 'LANGUAGE': 'en_US:en', 04:16:57 INFO - 'LOGNAME': 'cltbld', 04:16:57 INFO - 'MAIL': '/var/mail/cltbld', 04:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:57 INFO - 'MOZ_NO_REMOTE': '1', 04:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:57 INFO - 'NO_EM_RESTART': '1', 04:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:57 INFO - 'PWD': '/builds/slave/test', 04:16:57 INFO - 'SHELL': '/bin/bash', 04:16:57 INFO - 'SHLVL': '1', 04:16:57 INFO - 'TERM': 'linux', 04:16:57 INFO - 'TMOUT': '86400', 04:16:57 INFO - 'USER': 'cltbld', 04:16:57 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:57 INFO - '_': '/tools/buildbot/bin/python'} 04:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:16:57 INFO - Cleaning up... 04:16:57 INFO - Return code: 0 04:16:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:16:57 INFO - Using env: {'DISPLAY': ':0', 04:16:57 INFO - 'HOME': '/home/cltbld', 04:16:57 INFO - 'LANG': 'en_US.UTF-8', 04:16:57 INFO - 'LANGUAGE': 'en_US:en', 04:16:57 INFO - 'LOGNAME': 'cltbld', 04:16:57 INFO - 'MAIL': '/var/mail/cltbld', 04:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:57 INFO - 'MOZ_NO_REMOTE': '1', 04:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:57 INFO - 'NO_EM_RESTART': '1', 04:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:57 INFO - 'PWD': '/builds/slave/test', 04:16:57 INFO - 'SHELL': '/bin/bash', 04:16:57 INFO - 'SHLVL': '1', 04:16:57 INFO - 'TERM': 'linux', 04:16:57 INFO - 'TMOUT': '86400', 04:16:57 INFO - 'USER': 'cltbld', 04:16:57 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:57 INFO - '_': '/tools/buildbot/bin/python'} 04:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:57 INFO - Downloading/unpacking psutil>=0.7.1 04:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:16:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:59 INFO - Installing collected packages: psutil 04:16:59 INFO - Running setup.py install for psutil 04:16:59 INFO - building 'psutil._psutil_linux' extension 04:16:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:16:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:16:59 INFO - building 'psutil._psutil_posix' extension 04:16:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:16:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:59 INFO - Successfully installed psutil 04:16:59 INFO - Cleaning up... 04:16:59 INFO - Return code: 0 04:16:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:16:59 INFO - Using env: {'DISPLAY': ':0', 04:16:59 INFO - 'HOME': '/home/cltbld', 04:16:59 INFO - 'LANG': 'en_US.UTF-8', 04:16:59 INFO - 'LANGUAGE': 'en_US:en', 04:16:59 INFO - 'LOGNAME': 'cltbld', 04:16:59 INFO - 'MAIL': '/var/mail/cltbld', 04:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:59 INFO - 'MOZ_NO_REMOTE': '1', 04:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:59 INFO - 'NO_EM_RESTART': '1', 04:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:59 INFO - 'PWD': '/builds/slave/test', 04:16:59 INFO - 'SHELL': '/bin/bash', 04:16:59 INFO - 'SHLVL': '1', 04:16:59 INFO - 'TERM': 'linux', 04:16:59 INFO - 'TMOUT': '86400', 04:16:59 INFO - 'USER': 'cltbld', 04:16:59 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:59 INFO - '_': '/tools/buildbot/bin/python'} 04:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:17:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:17:01 INFO - Installing collected packages: mozsystemmonitor 04:17:01 INFO - Running setup.py install for mozsystemmonitor 04:17:01 INFO - Successfully installed mozsystemmonitor 04:17:01 INFO - Cleaning up... 04:17:02 INFO - Return code: 0 04:17:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:17:02 INFO - Using env: {'DISPLAY': ':0', 04:17:02 INFO - 'HOME': '/home/cltbld', 04:17:02 INFO - 'LANG': 'en_US.UTF-8', 04:17:02 INFO - 'LANGUAGE': 'en_US:en', 04:17:02 INFO - 'LOGNAME': 'cltbld', 04:17:02 INFO - 'MAIL': '/var/mail/cltbld', 04:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:02 INFO - 'MOZ_NO_REMOTE': '1', 04:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:02 INFO - 'NO_EM_RESTART': '1', 04:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:02 INFO - 'PWD': '/builds/slave/test', 04:17:02 INFO - 'SHELL': '/bin/bash', 04:17:02 INFO - 'SHLVL': '1', 04:17:02 INFO - 'TERM': 'linux', 04:17:02 INFO - 'TMOUT': '86400', 04:17:02 INFO - 'USER': 'cltbld', 04:17:02 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:02 INFO - '_': '/tools/buildbot/bin/python'} 04:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:04 INFO - Downloading docopt-0.6.1.tar.gz 04:17:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:04 INFO - Running setup.py install for blobuploader 04:17:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:04 INFO - Running setup.py install for requests 04:17:05 INFO - Running setup.py install for docopt 04:17:05 INFO - Successfully installed blobuploader requests docopt 04:17:05 INFO - Cleaning up... 04:17:05 INFO - Return code: 0 04:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:05 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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:05 INFO - Using env: {'DISPLAY': ':0', 04:17:05 INFO - 'HOME': '/home/cltbld', 04:17:05 INFO - 'LANG': 'en_US.UTF-8', 04:17:05 INFO - 'LANGUAGE': 'en_US:en', 04:17:05 INFO - 'LOGNAME': 'cltbld', 04:17:05 INFO - 'MAIL': '/var/mail/cltbld', 04:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:05 INFO - 'MOZ_NO_REMOTE': '1', 04:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:05 INFO - 'NO_EM_RESTART': '1', 04:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:05 INFO - 'PWD': '/builds/slave/test', 04:17:05 INFO - 'SHELL': '/bin/bash', 04:17:05 INFO - 'SHLVL': '1', 04:17:05 INFO - 'TERM': 'linux', 04:17:05 INFO - 'TMOUT': '86400', 04:17:05 INFO - 'USER': 'cltbld', 04:17:05 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:05 INFO - '_': '/tools/buildbot/bin/python'} 04:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:05 INFO - Running setup.py (path:/tmp/pip-iGRKi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:05 INFO - Running setup.py (path:/tmp/pip-t4IOn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:05 INFO - Running setup.py (path:/tmp/pip-vXDna5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:05 INFO - Running setup.py (path:/tmp/pip-yZiTpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:05 INFO - Running setup.py (path:/tmp/pip-IhHK23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:05 INFO - Running setup.py (path:/tmp/pip-cRSpPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:05 INFO - Running setup.py (path:/tmp/pip-wgDmE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:06 INFO - Running setup.py (path:/tmp/pip-FqKfAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:06 INFO - Running setup.py (path:/tmp/pip-sdQ_qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:06 INFO - Running setup.py (path:/tmp/pip-4vuk2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:06 INFO - Running setup.py (path:/tmp/pip-RYDqXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:06 INFO - Running setup.py (path:/tmp/pip-CXd5Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:06 INFO - Running setup.py (path:/tmp/pip-iboiCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:06 INFO - Running setup.py (path:/tmp/pip-fYAe1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:06 INFO - Running setup.py (path:/tmp/pip-RKnQeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:06 INFO - Running setup.py (path:/tmp/pip-PmkZHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:06 INFO - Running setup.py (path:/tmp/pip-xJiHxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:06 INFO - Running setup.py install for manifestparser 04:17:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:06 INFO - Running setup.py install for mozcrash 04:17:06 INFO - Running setup.py install for mozdebug 04:17:07 INFO - Running setup.py install for mozdevice 04:17:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozfile 04:17:07 INFO - Running setup.py install for mozhttpd 04:17:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozinfo 04:17:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozInstall 04:17:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozleak 04:17:07 INFO - Running setup.py install for mozlog 04:17:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for moznetwork 04:17:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozprocess 04:17:07 INFO - Running setup.py install for mozprofile 04:17:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:08 INFO - Running setup.py install for mozrunner 04:17:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:08 INFO - Running setup.py install for mozscreenshot 04:17:08 INFO - Running setup.py install for moztest 04:17:08 INFO - Running setup.py install for mozversion 04:17:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:08 INFO - Cleaning up... 04:17:08 INFO - Return code: 0 04:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:08 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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:08 INFO - Using env: {'DISPLAY': ':0', 04:17:08 INFO - 'HOME': '/home/cltbld', 04:17:08 INFO - 'LANG': 'en_US.UTF-8', 04:17:08 INFO - 'LANGUAGE': 'en_US:en', 04:17:08 INFO - 'LOGNAME': 'cltbld', 04:17:08 INFO - 'MAIL': '/var/mail/cltbld', 04:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:08 INFO - 'MOZ_NO_REMOTE': '1', 04:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:08 INFO - 'NO_EM_RESTART': '1', 04:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:08 INFO - 'PWD': '/builds/slave/test', 04:17:08 INFO - 'SHELL': '/bin/bash', 04:17:08 INFO - 'SHLVL': '1', 04:17:08 INFO - 'TERM': 'linux', 04:17:08 INFO - 'TMOUT': '86400', 04:17:08 INFO - 'USER': 'cltbld', 04:17:08 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:08 INFO - '_': '/tools/buildbot/bin/python'} 04:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:08 INFO - Running setup.py (path:/tmp/pip-LalSRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:08 INFO - Running setup.py (path:/tmp/pip-llhLQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:08 INFO - Running setup.py (path:/tmp/pip-twVYWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:08 INFO - Running setup.py (path:/tmp/pip-UD_4Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:09 INFO - Running setup.py (path:/tmp/pip-GXzSIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:09 INFO - Running setup.py (path:/tmp/pip-Ipzk_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:09 INFO - Running setup.py (path:/tmp/pip-nU9nSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:09 INFO - Running setup.py (path:/tmp/pip-va0ht2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:09 INFO - Running setup.py (path:/tmp/pip-mGBqfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:09 INFO - Running setup.py (path:/tmp/pip-lzQ0ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:09 INFO - Running setup.py (path:/tmp/pip-Xjjvuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:09 INFO - Running setup.py (path:/tmp/pip-zrbRLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:09 INFO - Running setup.py (path:/tmp/pip-6z8X5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:09 INFO - Running setup.py (path:/tmp/pip-gbrAvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:09 INFO - Running setup.py (path:/tmp/pip-506eZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:09 INFO - Running setup.py (path:/tmp/pip-YgqHAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:09 INFO - Running setup.py (path:/tmp/pip-_U7Qbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:11 INFO - Downloading blessings-1.5.1.tar.gz 04:17:11 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:11 INFO - Installing collected packages: blessings 04:17:11 INFO - Running setup.py install for blessings 04:17:11 INFO - Successfully installed blessings 04:17:11 INFO - Cleaning up... 04:17:11 INFO - Return code: 0 04:17:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:12 INFO - Reading from file tmpfile_stdout 04:17:12 INFO - Current package versions: 04:17:12 INFO - argparse == 1.2.1 04:17:12 INFO - blessings == 1.5.1 04:17:12 INFO - blobuploader == 1.2.4 04:17:12 INFO - docopt == 0.6.1 04:17:12 INFO - manifestparser == 1.1 04:17:12 INFO - mozInstall == 1.12 04:17:12 INFO - mozcrash == 0.16 04:17:12 INFO - mozdebug == 0.1 04:17:12 INFO - mozdevice == 0.47 04:17:12 INFO - mozfile == 1.2 04:17:12 INFO - mozhttpd == 0.7 04:17:12 INFO - mozinfo == 0.9 04:17:12 INFO - mozleak == 0.1 04:17:12 INFO - mozlog == 3.1 04:17:12 INFO - moznetwork == 0.27 04:17:12 INFO - mozprocess == 0.22 04:17:12 INFO - mozprofile == 0.27 04:17:12 INFO - mozrunner == 6.11 04:17:12 INFO - mozscreenshot == 0.1 04:17:12 INFO - mozsystemmonitor == 0.0 04:17:12 INFO - moztest == 0.7 04:17:12 INFO - mozversion == 1.4 04:17:12 INFO - psutil == 3.1.1 04:17:12 INFO - requests == 1.2.3 04:17:12 INFO - wsgiref == 0.1.2 04:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:12 INFO - Using env: {'DISPLAY': ':0', 04:17:12 INFO - 'HOME': '/home/cltbld', 04:17:12 INFO - 'LANG': 'en_US.UTF-8', 04:17:12 INFO - 'LANGUAGE': 'en_US:en', 04:17:12 INFO - 'LOGNAME': 'cltbld', 04:17:12 INFO - 'MAIL': '/var/mail/cltbld', 04:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:12 INFO - 'MOZ_NO_REMOTE': '1', 04:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:12 INFO - 'NO_EM_RESTART': '1', 04:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:12 INFO - 'PWD': '/builds/slave/test', 04:17:12 INFO - 'SHELL': '/bin/bash', 04:17:12 INFO - 'SHLVL': '1', 04:17:12 INFO - 'TERM': 'linux', 04:17:12 INFO - 'TMOUT': '86400', 04:17:12 INFO - 'USER': 'cltbld', 04:17:12 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:12 INFO - '_': '/tools/buildbot/bin/python'} 04:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:12 INFO - Cleaning up... 04:17:12 INFO - Return code: 0 04:17:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:17:12 INFO - Using env: {'DISPLAY': ':0', 04:17:12 INFO - 'HOME': '/home/cltbld', 04:17:12 INFO - 'LANG': 'en_US.UTF-8', 04:17:12 INFO - 'LANGUAGE': 'en_US:en', 04:17:12 INFO - 'LOGNAME': 'cltbld', 04:17:12 INFO - 'MAIL': '/var/mail/cltbld', 04:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:12 INFO - 'MOZ_NO_REMOTE': '1', 04:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:12 INFO - 'NO_EM_RESTART': '1', 04:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:12 INFO - 'PWD': '/builds/slave/test', 04:17:12 INFO - 'SHELL': '/bin/bash', 04:17:12 INFO - 'SHLVL': '1', 04:17:12 INFO - 'TERM': 'linux', 04:17:12 INFO - 'TMOUT': '86400', 04:17:12 INFO - 'USER': 'cltbld', 04:17:12 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:12 INFO - '_': '/tools/buildbot/bin/python'} 04:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:12 INFO - Downloading/unpacking jsonschema 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:17:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:14 INFO - warning: no files found matching '*.txt' 04:17:14 INFO - no previously-included directories found matching 'build' 04:17:14 INFO - no previously-included directories found matching 'dist' 04:17:14 INFO - no previously-included directories found matching '.git*' 04:17:14 INFO - Installing collected packages: jsonschema, functools32 04:17:14 INFO - Running setup.py install for functools32 04:17:14 INFO - warning: no files found matching '*.txt' 04:17:14 INFO - no previously-included directories found matching 'build' 04:17:14 INFO - no previously-included directories found matching 'dist' 04:17:14 INFO - no previously-included directories found matching '.git*' 04:17:14 INFO - Successfully installed jsonschema functools32 04:17:14 INFO - Cleaning up... 04:17:14 INFO - Return code: 0 04:17:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:14 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 0x7fe5fd345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:17:14 INFO - Using env: {'DISPLAY': ':0', 04:17:14 INFO - 'HOME': '/home/cltbld', 04:17:14 INFO - 'LANG': 'en_US.UTF-8', 04:17:14 INFO - 'LANGUAGE': 'en_US:en', 04:17:14 INFO - 'LOGNAME': 'cltbld', 04:17:14 INFO - 'MAIL': '/var/mail/cltbld', 04:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:14 INFO - 'MOZ_NO_REMOTE': '1', 04:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:14 INFO - 'NO_EM_RESTART': '1', 04:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:14 INFO - 'PWD': '/builds/slave/test', 04:17:14 INFO - 'SHELL': '/bin/bash', 04:17:14 INFO - 'SHLVL': '1', 04:17:14 INFO - 'TERM': 'linux', 04:17:14 INFO - 'TMOUT': '86400', 04:17:14 INFO - 'USER': 'cltbld', 04:17:14 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:14 INFO - '_': '/tools/buildbot/bin/python'} 04:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:14 INFO - Downloading/unpacking flake8 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:17:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:17:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:17:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:17 INFO - no previously-included directories found matching 'docs/_build' 04:17:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:17 INFO - Running setup.py install for pep8 04:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:17 INFO - no previously-included directories found matching 'docs/_build' 04:17:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:17 INFO - Cleaning up... 04:17:17 INFO - Return code: 0 04:17:17 INFO - Running post-action listener: _resource_record_post_action 04:17:17 INFO - Running post-action listener: _start_resource_monitoring 04:17:17 INFO - Starting resource monitoring. 04:17:17 INFO - ##### 04:17:17 INFO - ##### Running install step. 04:17:17 INFO - ##### 04:17:17 INFO - Running pre-action listener: _resource_record_pre_action 04:17:17 INFO - Running main action method: install 04:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:17 INFO - Reading from file tmpfile_stdout 04:17:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:17 INFO - Reading from file tmpfile_stdout 04:17:17 INFO - Output received: 04:17:17 INFO - Usage: mozinstall [options] installer 04:17:17 INFO - Options: 04:17:17 INFO - -h, --help show this help message and exit 04:17:17 INFO - -d DEST, --destination=DEST 04:17:17 INFO - Directory to install application into. [default: 04:17:17 INFO - "/builds/slave/test"] 04:17:17 INFO - --app=APP Application being installed. [default: firefox] 04:17:17 INFO - mkdir: /builds/slave/test/build/application 04:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:17:32 INFO - Reading from file tmpfile_stdout 04:17:32 INFO - Output received: 04:17:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:17:32 INFO - Running post-action listener: _resource_record_post_action 04:17:32 INFO - ##### 04:17:32 INFO - ##### Running run-tests step. 04:17:32 INFO - ##### 04:17:32 INFO - Running pre-action listener: _resource_record_pre_action 04:17:32 INFO - Running main action method: run_tests 04:17:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:32 INFO - Python 2.7.3 04:17:32 INFO - Return code: 0 04:17:32 INFO - grabbing minidump binary from tooltool 04:17: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')]} 04:17:32 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 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:17:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:17:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:32 INFO - Return code: 0 04:17:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:17:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:17:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:17:33 INFO - Return code: 0 04:17:33 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/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 04:17:33 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/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 04:17:33 INFO - Using env: {'DISPLAY': ':0', 04:17:33 INFO - 'HOME': '/home/cltbld', 04:17:33 INFO - 'LANG': 'en_US.UTF-8', 04:17:33 INFO - 'LANGUAGE': 'en_US:en', 04:17:33 INFO - 'LOGNAME': 'cltbld', 04:17:33 INFO - 'MAIL': '/var/mail/cltbld', 04:17:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:33 INFO - 'MOZ_NO_REMOTE': '1', 04:17:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:33 INFO - 'NO_EM_RESTART': '1', 04:17:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:33 INFO - 'PWD': '/builds/slave/test', 04:17:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:33 INFO - 'SHELL': '/bin/bash', 04:17:33 INFO - 'SHLVL': '1', 04:17:33 INFO - 'TERM': 'linux', 04:17:33 INFO - 'TMOUT': '86400', 04:17:33 INFO - 'USER': 'cltbld', 04:17:33 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076', 04:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:33 INFO - '_': '/tools/buildbot/bin/python'} 04:17:33 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/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 04:17:33 INFO - mozversion INFO | application_buildid: 20151216030231 04:17:33 INFO - mozversion INFO | application_changeset: 0babaa3edcf908c393b68a3dc2d1c2a2450c31ed 04:17:33 INFO - mozversion INFO | application_display_name: Nightly 04:17:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:33 INFO - mozversion INFO | application_name: Firefox 04:17:33 INFO - mozversion INFO | application_remotingname: firefox 04:17:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:17:33 INFO - mozversion INFO | application_vendor: Mozilla 04:17:33 INFO - mozversion INFO | application_version: 46.0a1 04:17:33 INFO - mozversion INFO | platform_buildid: 20151216030231 04:17:33 INFO - mozversion INFO | platform_changeset: 0babaa3edcf908c393b68a3dc2d1c2a2450c31ed 04:17:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:17:33 INFO - mozversion INFO | platform_version: 46.0a1 04:17:33 INFO - 2015-12-16 04:17:33,635 DEBUG : using testdate: 1450268253 04:17:33 INFO - 2015-12-16 04:17:33,635 DEBUG : actual date: 1450268253 04:17:33 INFO - 2015-12-16 04:17:33,682 INFO : starting webserver on 'localhost:59200' 04:17:33 INFO - 2015-12-16 04:17:33,684 INFO : Starting test suite talos-linux64-ix-014 04:17:33 INFO - 2015-12-16 04:17:33,684 INFO : Starting test dromaeo_css 04:17:33 INFO - 2015-12-16 04:17:33,684 DEBUG : operating with platform_type : linux_ 04:17:33 INFO - 2015-12-16 04:17:33,684 INFO : Initialising browser for dromaeo_css test... 04:17:33 INFO - 2015-12-16 04:17:33,699 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3iIXr9/profile http://localhost:59200/getInfo.html 04:17:38 INFO - 2015-12-16 04:17:38,310 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:17:38 INFO - 2015-12-16 04:17:38,310 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:17:38 INFO - 2015-12-16 04:17:38,310 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:17:38 INFO - 2015-12-16 04:17:38,310 DEBUG : BROWSER_OUTPUT: __metrics 04:17:38 INFO - 2015-12-16 04:17:38,427 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:17:38 INFO - 2015-12-16 04:17:38,495 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] 04:17:39 INFO - 2015-12-16 04:17:39,707 INFO : Browser initialized. 04:17:39 INFO - 2015-12-16 04:17:39,707 INFO : Running cycle 1/1 for dromaeo_css test... 04:17:39 INFO - 2015-12-16 04:17:39,707 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3iIXr9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:17:51 INFO - 2015-12-16 04:17:51,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 142606336 04:17:51 INFO - 2015-12-16 04:17:51,692 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-12-16 04:18:42,790 DEBUG : BROWSER_OUTPUT: 1450268322786 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:20:54 INFO - 2015-12-16 04:20:54,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59200/tests/dromaeo/cssquery-ext.html) 04:20:56 INFO - 2015-12-16 04:20:56,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 238809088 04:20:56 INFO - 2015-12-16 04:20:56,014 DEBUG : BROWSER_OUTPUT: 04:23:58 INFO - 2015-12-16 04:23:58,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-ext.html (next: http://localhost:59200/tests/dromaeo/cssquery-jquery.html) 04:23:59 INFO - 2015-12-16 04:23:59,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 220684288 04:23:59 INFO - 2015-12-16 04:23:59,204 DEBUG : BROWSER_OUTPUT: 04:27:01 INFO - 2015-12-16 04:27:01,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59200/tests/dromaeo/cssquery-mootools.html) 04:27:01 INFO - 2015-12-16 04:27:01,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 224768000 04:27:01 INFO - 2015-12-16 04:27:01,814 DEBUG : BROWSER_OUTPUT: 04:30:03 INFO - 2015-12-16 04:30:03,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59200/tests/dromaeo/cssquery-prototype.html) 04:30:04 INFO - 2015-12-16 04:30:04,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 209420288 04:30:04 INFO - 2015-12-16 04:30:04,345 DEBUG : BROWSER_OUTPUT: 04:33:06 INFO - 2015-12-16 04:33:06,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59200/tests/dromaeo/cssquery-yui.html) 04:33:07 INFO - 2015-12-16 04:33:07,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 207917056 04:33:07 INFO - 2015-12-16 04:33:07,515 DEBUG : BROWSER_OUTPUT: 04:36:09 INFO - 2015-12-16 04:36:09,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-yui.html (next: http://localhost:59200/tests/dromaeo/cssquery-dojo.html) 04:36:10 INFO - 2015-12-16 04:36:10,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 251207680 04:36:10 INFO - 2015-12-16 04:36:10,228 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-16 04:36:10,229 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:36:10 INFO - 2015-12-16 04:36:10,229 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:36:10 INFO - 2015-12-16 04:36:10,229 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:36:10 INFO - 2015-12-16 04:36:10,230 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:36:10 INFO - 2015-12-16 04:36:10,233 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2625.3567875870413;2688.9462210755796;2690.1929421173654;2703.148508219912;2733.480638678651;4523.773811309437;4656.9534304656945;4666.78999445025;4668.463126740426;4680.344751734756;4573.7027093239;4633;4639.211334073208;4650.162970665279;4743.691660042095;4275.46556680415;4285.228658841415;4285.614294713475;4286.785660716967;4355.5208927018;4203.684723645723;4369.694121411502;4383.561643835623;4429.1806015887005;4443.244648409762;4212.326027835532;4297.484301883763;4317.848875289381;4323;4328.2209202343565;4316.201502721975;4345.674074444398;4347.760873151976;4348.173846969065;4368.759718215497;4293.3130699088;4311.223979683656;4322.740635561876;4326.567343265649;4339.305711086243;4519.118771839492;4549.499555048942;4641.164590373765;4656.301554766812;4676.392069031038;5035.345405097314;5035.672681275705;5048.924266136011;5103.4896510349035;5141.820036298749;5063.898722025576;5079.902424453598;5084.898302033938;5085.669431486942;5126.846194614168;4518.774061296987;4616.330632058332;4616.907661846744;4724.929126063077;4729.787159577827;5043.773030213576;5122.078025955364;5122.180451127876;5124.385073791094;5155.845324640267;4982.676126051795;5015.22264049073;5016.899662006813;5017.448080711119;5059.165237735806;4841.443234028132;4967.875803104951;4969.155243608595;5097.439281679012;5100.515451032146;4842.58837998767;4922.950770492249;4970.776315065831;4983.5763960063805;4984.003199360142;4988.077205716954;4999.175136102575;5002.799888004439;5004.799808007711;5038.571721403721;4204.495460544754;4205.3481710334945;4206.242876282298;4208.389783481378;4210.136921930997;3548.946765798515;3618.203995121069;3670.284294562588;3687.9078023049638;3717.665410113103;4379.1241751649795;4382.496012958487;4390.868273951786;4395.670324725658;4434.756088415168;5094.133997220481;5100.336956195745;5104.387473503203;5106.234064890296;5148.150555158431;4160.750354978711;4247.51153617338;4251.4685664291965;4289.378040184219;4398.098389830077;4467.24056910326;4488.775561221991;4490.214212512862;4502.57225563571;4520.547945205453;4829.106615276185;4829.879253018703;4844.346013288302;4845.030993801183;4893.412790465096;4815.446223684321;4912.263160525807;4921.4832442593015;5048;5172.870678232924;4775;4829.9275510868065;4892.437369702529;4897.779599917941;4928.211486162197;5047.2429135629945;5047.823326183566;5056.191009438472;5058.696478211319;5096.745162741774;4831.541003604652;4941.33292005589;4944.505549445027;4980.178270585313;5099.643024988363;4893.7063776173545;4903.092927808367;4907.092187945242;4907.386576677915;4953.702777833341;4928.581070608895;4932.383452068491;4932.63005274613;4933.77797999098;4990.72551009698;4601.838935637236;4699.765011749467;4754.381930349171;4757.3577567028005;4800.3759511263315;4885.487023862585;4913.680610760289;4914.754262286943;4920.409550853778;4957.182064959241;4802.648914432275;4809.78355973989;4812.398450193726;4821.059893320768;4852.320675105418 04:36:10 INFO - 2015-12-16 04:36:10,233 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.4514443561964;570.891530609184;575.1545228514083;579.1052823387867;591.1398914579288;26319.473610527803;26792.59811102835;26843.328916777067;32525.83737081311;33208.83395583019;38107.618923810754;38408.615913840855;38683.22633547327;38741.225175496475;38796.41805372922;7853.764387068397;7972.402069844756;8017.6392062357045;8018;8021.438499305051;7086.574805511686;7255.927440725604;10234.846477302846;10508.159347252202;10524.789504209912;9893.75265618358;9978;9982;9983.251256155781;9990.9500452498;7081.681324340417;7236.638168091627;9857.704268871945;9941.353812002233;9955.701328960144;6965.33829286222;10118.342307750047;10386.948065259701;10392;10414.583416663325;35691;35716.64283357159;36031.63968360309;36149.63850361489;36160.819195904114;2944.3375240570913;3001.819890806537;3006.939861202786;3031.2876474028585;3560.572731272264;27908.302292442648;28111.29721756952;28312;28319.150425487267;28335;3334.283129127225;3435.2270739083756;3438.1748380388776;3458.4985177149174;3537.4693795930557;204536;207586;208150;208514;208831;50304.748476258115;51041.74479127581;53242.21503451964;53438.7328063365;53784.46215537873;48691.83503072289;48740.756296219;48922.26616600754;49028.26457603139;49043.50956490389;13783.310834458238;13922.721545569235;13928.094673846168;13962.790558141636;14011.299435028208;10551.20865935058;10657.147428205724;10725.51735171919;10799.67600971972;10815.242932994772;17912;18633.161507732184;18702.345417910306;18788.436346909613;18816;7217.963910180415;7455.179930207672;7487.812804679817;7559.395248380117;7678.616069196518;856.8928883889514;917.9495127767904;1027.912627426662;1044.6134930075768;1056.6882769582992;25811.09661161888;26050.34874128124;26060.60909086365;26419.867900660374;26445.33886652849;914.5884352041608;932.9673461428818;944.9527523623791;1035.9585616575253;1058.4125810175426;13613.727725445435;13725.725485490433;13843.4462621494;13850.930745346208;13852.653683657787;261128;264792;265006;265464;265665;43382.78308608437;43754;43854.12291754147;43882.56117438849;43922.560774392485;1027.3527677563236;1200.9459574319003;1208.6434501821984;1228.0543981134476;1229.569650622293;17498.099652720528;26243.868780655976;27298;27415.862920685267;27559.86220068887;41385.37921931113;41775;41858.58141418669;41862.1627567453;41898.58101418947;230650;245587;247159;247194;247451;23158.421039473473;27659.308517287227;28187.43625127445;28211;28389.716102838705;32968.175795605304;35829.28341433105;36625;36937.81531092327;37122.25755484929;31281.8435907819;31303.217419564695;37274.627253727114;38012.12676350877;39154.216915662095;31939.520907186874;32493;32512;32596.511052334707;32619.673803261663;32881.835590821895;35081.298374032885;35720.82139589285;35810.64189358073;35839.104022399646;27619.30951726223;33839.661603383654;35119.82440087885;35523.82238088793;35606.821965890005;23010.654840177747;23394.415139621644;23440.413989650395;24096.15663451771;24621 04:36:10 INFO - 2015-12-16 04:36:10,234 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.1042753283534;337.7821305258107;337.8327727774751;338.80857315616674;345.4179707193379;12642.367881605905;13022.934885325583;14415.711685766291;15041.947063705531;16814.159292035394;8558.272546833527;14499;14597.854021459782;15224.923875380608;15257.160856152906;3942.9605703943025;4484.97757511212;4602.14860250853;4608.331791890174;5198;3436.501707252447;3535.6817886390218;5012.949870501303;5211.062008838408;5218.1650935850275;5149.665271757323;5181.87045323868;5183.714895680736;5194.532492075712;5200.453952335007;5167.974160129194;5223.555997740196;5679.346875109374;5689.288838895138;5690.658560486384;5046.520580544842;5056.317397151411;5061.190209566488;5061.5950723942;5063.341765570489;12232.266064036186;12235.632931012084;12282.447289871978;12310.876891231062;15495.225238738018;1763.144874735765;1817.2276782367574;1863.5806943437617;1908.6850669639493;1938.331275709878;9236.261099112055;9420.905790942072;11426.828597571042;12687.682807929783;12900.354982250943;1705.590658242013;1713.4516954574542;1721.6470623522148;1742.2247100040488;1756.9472915812546;54586.72706636481;57372.71313643447;57486.712566437316;57650.964432489745;58012;9867.901320986699;9877;9905.10854023127;9931.453770042572;9998.250131240186;12604.180728252633;12627.558035468715;12628.621141365773;12643.810342844865;12656.493740250287;7274.0543729315905;7283.126024876943;7284.6721897514735;7334.633268336562;7349.522281051714;7068.787936361815;7098.645067746592;7134.464915131386;7141.035960145417;7180.8922866157045;4094.754314741125;4133.400656904732;4177.582241775859;4179.749215047107;4231.4710661167355;1521.300201907113;1598.7362085256036;1601.4154833485693;1653.338664534196;1663.7088509510788;882.911708829112;900.9279257659372;937.5687183895349;964.3490643815396;978.7112801723508;15729.528114156594;15750.133742644264;16029.19854007295;16396.26216820246;16414.835851641332;722.8795367180849;763.1300317637897;817.3257062923112;871.7166920750782;874.0909454167721;9185;9382;9390.295727820441;9480.95259523698;9635;479887;482475;483519;504965.2765625556;507907;72338;73878.63060684662;74457.25542744504;74555;75274;1058.8941105889348;1074.0923919288189;1095.956161753537;1104.0946423932298;1104.9502772375263;13670.52153174634;13994.510192143227;14008.649783755487;14469.348879300667;14534;31671.20821979469;32330.676693232766;32385.838070809496;32876.34247315088;34171.82914085413;37997.24005519929;38864.41703374395;39516.60483395244;40548.1890362197;40956;8911.688090916787;8916.19754222123;8920.152585504367;8930.151635594608;9158.358914876162;16090.597735056717;16368.508944731677;16397.180140992663;16572.58568535796;16790.328386864876;14149.717005660035;14150.080244784056;14303.64240893986;14372.640683982983;14630.634234143805;13456.46174153023;13457.743755515408;13501;14017.018808683295;14133.787993179905;10381.740456488647;12720.363981801058;14186.645333866736;14359.138451692932;14771.704565908836;8657.61040753155;8709.477431354138;8820.382573219813;8846.11538846136;8946.821063578562;13022.088453808143;13095.738085238432;13305.334733263491;13323.33383330849;13493.257870817199 04:36:10 INFO - 2015-12-16 04:36:10,236 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1443.2783608195903;1662.916854157292;1714.4770844892312;1745.5985123421606;1747.2486830662815;5670.149477578365;7108.111486064242;7286.599237041961;7295.1610564785;7322.414206863452;7260.056192694942;7304.379127774132;7327.8534429311385;7377.077865266841;7398.149212840525;1739.8782085254038;1775.973360399595;2037.4091513461078;2078.968815467769;2081.469225347534;2114.6405111131144;2168.5554461335387;2171.934841954736;2172.2071443922932;2173.793489618484;2068.2864411777914;2092.3304542546393;2103.3059090500174;2105.947351316214;2114.312848324293;2055.126571207231;2066.1322244657204;2075.086961736846;2089.2478707665227;2089.300084471696;2125.08621292844;2143.0570548958563;2146.0450099705636;2146.8175205107586;2147.6241657709993;7254.963725181393;7311.378532824716;7326.194118646945;7333.156686981012;7345.816354591125;4174.853880114181;4270.743755374688;4274.337477690931;4278.871633850989;4286.37847512109;2665.2803742989286;2694.892204311825;2734.0840818325883;2746.134967485236;2757.1866299441713;861.4615865084322;871.0592560035146;892.5135800988477;896.7489103051156;918.9494577798218;10062.496875156214;10065.69802905914;10087.848682269772;10103.343282686601;10105;3826.7129965252716;3906.374980003186;3936.173403585279;3936.842526298916;3953.4069889516804;7734.690612375554;7848.3328917041545;7860.371170306476;7861.410394220342;7863.764087077397;4342.370356298319;4350.499692535335;4350.8042138103865;4350.956490435118;4360.411344468456;3971.344728119828;4012.057166565913;4014.0767623446773;4014.879553613396;4027.556968733437;2776.8750406231366;2893.537034074538;2894.4645240630553;3193.9361212775616;3222.9677703223138;844.2106630300689;950.6577632052456;959.8944116147358;964.9951750241204;965.5703212070702;935.0882889182992;943.2595412601075;945.7399215215871;988.5502096546054;1190.8451901252781;6891.862162756717;6959.4432445404245;6961.338672826073;6965.721371145199;6974.476914231453;727.31995584129;1102.3385968418884;1120.6245907620876;1130.5195292000867;1150.5455345138623;5409.107497262908;5441.700706461103;5524.640898341595;5531.529819965268;5534.501894829485;8682.782930426663;8712.91287087121;8764.342674299452;8826.602802873886;8886.555672216364;8892;8892.510911899779;8895.154960278764;8946.86579701305;8986.505742184243;6911.550749201387;6980.371766541036;7002.614856182959;7008.579485230903;7026.683799229149;6562.114114594659;6745.494087943326;6750.189977202767;6754.358335958076;6770.492213084137;7689;7932.286094251545;7961.283484486424;8022.077461092049;8033.35733141359;8074.111847696866;8212.46618969765;8219.1369906159;8235.34117270605;8244.175582441709;6056.606320589148;6123.173371594778;6125.571210015256;6130.63216207029;6136.723847426787;7111.217766045627;7145.1425828900865;7218.89171662436;7240.493165478577;7248.347648711641;5464.863378415572;5566.248556444828;6463.709133088928;6579.407853293226;6679.06493090958;6515.869682606416;6562.442192413699;6633.402993730588;6651.900221496779;6689.163854518185;6677.76627818024;6719.932800671931;6722.731090756315;6728.495362847904;6728.663566821541;6066.666333351532;6195.349488303663;6207.596506227081;6213.782517611862;6238.407351301619;6276.184096067482;6303.149074875017;6306.054091886253;6306.558540902093;6320.367963203827 04:36:10 INFO - 2015-12-16 04:36:10,236 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.85530800523753;311.0373394344504;312.89391999282526;313.9340738444927;315.2827317851888;5350.545203657689;5429.049916264653;5469.644473109245;5480.671159730419;5489.58828087894;5308.495692909177;5319.335083114611;5325.467453254682;5359.517643412092;5367.570594352453;3925.7055720821054;4072.124493233954;4194.601512856274;4200.97899510502;4213.5997080277475;4095.856645017425;4186.183694179636;4188.5811418858175;4211.663066954651;4220.493540775111;4166.958330416703;4171.895702607444;4174.749515029092;4176.853810116647;4179.414881916534;3936.822842972059;4043.65628921542;4045.4740883685226;4134.152498737752;4157.0023194433425;3676.246369494247;3683.1528748388023;3685.5024571682748;3689.7048236141045;3696.1868388954385;5145.33110695611;5149.176131818928;5155.200943853709;5164.096283150471;5170.896582068338;4787.16224660683;4796.736179510125;4797;4797.472278049412;4800.303955926371;5497.725113744336;5616.550675945915;5641.746121424546;5647.915281270784;5651.2935883014625;4014.7992600370158;4024.094578719794;4028.979855100735;4029.7380670256634;4033.2740106780766;5966.820995370146;5969.283685957713;5969.462748352669;5972.552058595623;5973.970130149321;4150.418941348214;4155.771432571177;4156.542780294165;4156.875293741193;4159.188958153191;3947.467091942551;4081.20416518776;4086.0397806515443;4208.494980602286;4208.642265407475;4663.906721865544;4665.930011049837;4679.532046795293;4680.204365257914;4687.67186296956;5646.661200327993;5648.915266271009;5650.576206784508;5651.717414129277;5655.0386434306265;1419.5457453614745;1446.7395868743727;1447.486142419447;1447.5006122887587;1448.8551144885428;961.7018724195522;963.710886733977;970.0687340153531;985.3496692183124;990.6186118344489;4968.776405061781;4976.353074100416;4979.975100124476;4982.975085124624;4984.2025275955675;5877.617954833007;5889.1755154278435;5889.352171261244;5895.056790913433;5898.970505147447;4961.2806143109765;4962.330085438492;4969.130402179604;4971.304017437562;4980.929100243465;2920.3721199942115;3011.5128557740677;3072.7864428304815;3148.622165340128;3179.8092114472743;5583.553315734732;5601.887962240732;5602.719864006784;5616.297962754656;5630.521405680481;6034.336223015464;6041.818745437644;6043.063325184516;6044.607100538539;6047.455728984412;5474.151506516497;5611.466910643482;5613.354464236583;5615.971920140373;5617.32592088952;5935.228420305332;5938.61399009063;5944.227250457413;5944.791932282523;5946.256717910262;5778;5780.248567686174;5782.624129431573;5784.623999440023;5791.507721843691;5622.718864056863;5624.212610234488;5629.127485239795;5629.915551266816;5629.943700562942;3959.2675355059405;3993.8003099845473;4007.599240075969;4009.0578714001604;4058.066644671801;5844.883102338014;5896.882062358814;5897.262842144732;5899.292084949833;5904.143899134516;5662.688552129673;5667.801626943037;5667.914981275367;5673.149027645886;5674.971625141848;5586.413426590312;5693.089105743061;5701.714914254354;5708.885822283448;5714.457126572969;5565.5825813063375;5574.470425309589;5578.916316255179;5579.525740311957;5584.972075139598;5744.770209191753;5751.798687045934;5754.597178197653;5760.020796464527;5763.827085187451;5595.664260144405;5608.214849921096;5610.046292130266;5610.719464026701;5616.073347897551 04:36:10 INFO - 2015-12-16 04:36:10,237 DEBUG : BROWSER_OUTPUT: |5;yui.html;711.0542977839474;757.8234122856546;763.5266134996302;767.4090949968528;795.9721409750658;11635.185537012412;11910.642680719582;11913.285202887833;11915.165938384316;11930.045596352293;11555.884441155586;12480.188787728792;12627.62117136485;12650.873491265085;12654.873451265485;646.5926466326208;655.0534477679755;811.4928169893816;818.4516374029399;832.2426591801462;817.5544328341039;817.7342363731811;825.7522743177053;825.8719898415756;825.8761185822144;855.6064210463195;863.3222920007795;863.4819108534891;863.5984267315697;864.3042350907548;616.836538317344;621.3351713666356;835.5195762436563;845.8392905347964;848.3594885861197;632.0140580694132;632.4181752787447;632.6267502173694;632.8449529865167;633.3919437340159;11810.468528916133;11909.583164589198;11911.404429778562;11929.880701192964;11966.162368634199;10526.631567895163;10593.84109238362;10614.628488002883;10911.83632245517;11104.389258590774;9148.908510914873;9418.576164072632;9445.66940157098;9459.054094590554;9494.620215191384;3269.623993240784;3278.344331133783;3300.1914530940076;3308.801471911693;3318.070940136766;39715;39801.80099099486;40242.39636405456;40278.19443611112;40345.39481907774;8886.644534218558;8987.146221108984;8994.370394072483;9103.226225770752;9129.178373946377;15840.287187076608;15854.207289635473;15857.365705371656;15860.92069539645;15876.761848572281;6141.692915354214;6387.808365749035;6422.614643121335;6554.901676474857;6680;3416.3167366526795;3552.7157827374267;3582.46263060543;3587.2287458196615;3594.478800573902;2535.847849129021;2545.3763827862294;2563.6026415905562;2563.794896408283;2564.7307032761664;469.4413647759156;473.3160582957593;477.0982842427814;488.2456604545985;492.0896341767773;483.99032019359413;542.8045903474746;554.3680204566797;594.3105997043496;603.2067830802481;7755;7919.485233459806;7982.800429989296;8125.471844330218;8215.178482151856;564.7882044233412;589.1427972300378;623.840920565253;632.8006677896448;637.611057255074;3599.6940260077663;3740.981295093507;3752;3789.109559253573;3888.572257051722;49970.25044624261;50130.49869501331;50153.24770128451;50278.49721502811;50500.74749626228;43368.3494747579;43581.78209108934;43751.56248437538;43820.3426948596;43873.34189987153;40246.59753402487;40251.59748402479;40396.596034039285;41555.1688966213;41559.58440415618;7666.348360389429;7752.177774230047;7868.72459463916;7926.207379262028;8046;29266.975655851944;29351.706482934896;30089.69910300869;30114.24714382158;30185.547216792205;36385;38923.416148758355;39672.60327396689;39725.60274397219;39933;9173.174414302744;9207.631694732403;9304;9407.952960235156;9435.952820236129;10152.289339746147;10217.948910255402;10315.638952636622;10365.222608304559;10484.318519296221;9685.515724213901;9892.208623309974;9943.651972180938;10081.798364032531;10151;9090.727278181665;9266.583003764712;9272.304577156876;9649.131578158;9721.659741909;9357.298202634693;9520.904790952001;9530.094641009093;9531.618735250513;9631.662891798753;8300.958300958177;8358.87461688063;8722.825543489222;9020.86468702983;9533.094356036165;8294.834103317778;8838.779030524289;8906.376553641183;9116.817663646823;9244.625711615347 04:36:10 INFO - 2015-12-16 04:36:10,237 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:36:10 INFO - 2015-12-16 04:36:10,237 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:36:10 INFO - 2015-12-16 04:36:10,237 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,886 04:36:10 INFO - 2015-12-16 04:36:10,237 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:36:10 INFO - 2015-12-16 04:36:10,237 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269370228__endTimestamp 04:36:10 INFO - 2015-12-16 04:36:10,237 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-16 04:36:10,237 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:36:10 INFO - 2015-12-16 04:36:10,238 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:36:10 INFO - 2015-12-16 04:36:10,238 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-16 04:36:10,239 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4643.51 Median:4809.78 stddev:490.30 (10.2%) stddev-sans-first:465.54 04:36:10 INFO - 2015-12-16 04:36:10,239 DEBUG : BROWSER_OUTPUT: Values: 2625.4 2688.9 2690.2 2703.1 2733.5 4523.8 4657.0 4666.8 4668.5 4680.3 4573.7 4633.0 4639.2 4650.2 4743.7 4275.5 4285.2 4285.6 4286.8 4355.5 4203.7 4369.7 4383.6 4429.2 4443.2 4212.3 4297.5 4317.8 4323.0 4328.2 4316.2 4345.7 4347.8 4348.2 4368.8 4293.3 4311.2 4322.7 4326.6 4339.3 4519.1 4549.5 4641.2 4656.3 4676.4 5035.3 5035.7 5048.9 5103.5 5141.8 5063.9 5079.9 5084.9 5085.7 5126.8 4518.8 4616.3 4616.9 4724.9 4729.8 5043.8 5122.1 5122.2 5124.4 5155.8 4982.7 5015.2 5016.9 5017.4 5059.2 4841.4 4967.9 4969.2 5097.4 5100.5 4842.6 4923.0 4970.8 4983.6 4984.0 4988.1 4999.2 5002.8 5004.8 5038.6 4204.5 4205.3 4206.2 4208.4 4210.1 3548.9 3618.2 3670.3 3687.9 3717.7 4379.1 4382.5 4390.9 4395.7 4434.8 5094.1 5100.3 5104.4 5106.2 5148.2 4160.8 4247.5 4251.5 4289.4 4398.1 4467.2 4488.8 4490.2 4502.6 4520.5 4829.1 4829.9 4844.3 4845.0 4893.4 4815.4 4912.3 4921.5 5048.0 5172.9 4775.0 4829.9 4892.4 4897.8 4928.2 5047.2 5047.8 5056.2 5058.7 5096.7 4831.5 4941.3 4944.5 4980.2 5099.6 4893.7 4903.1 4907.1 4907.4 4953.7 4928.6 4932.4 4932.6 4933.8 4990.7 4601.8 4699.8 4754.4 4757.4 4800.4 4885.5 4913.7 4914.8 4920.4 4957.2 4802.6 4809.8 4812.4 4821.1 4852.3 04:36:10 INFO - 2015-12-16 04:36:10,239 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-16 04:36:10,239 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39692.55 Median:32561.17 stddev:62274.26 (191.3%) stddev-sans-first:62379.66 04:36:10 INFO - 2015-12-16 04:36:10,239 DEBUG : BROWSER_OUTPUT: Values: 568.5 570.9 575.2 579.1 591.1 26319.5 26792.6 26843.3 32525.8 33208.8 38107.6 38408.6 38683.2 38741.2 38796.4 7853.8 7972.4 8017.6 8018.0 8021.4 7086.6 7255.9 10234.8 10508.2 10524.8 9893.8 9978.0 9982.0 9983.3 9991.0 7081.7 7236.6 9857.7 9941.4 9955.7 6965.3 10118.3 10386.9 10392.0 10414.6 35691.0 35716.6 36031.6 36149.6 36160.8 2944.3 3001.8 3006.9 3031.3 3560.6 27908.3 28111.3 28312.0 28319.2 28335.0 3334.3 3435.2 3438.2 3458.5 3537.5 204536.0 207586.0 208150.0 208514.0 208831.0 50304.7 51041.7 53242.2 53438.7 53784.5 48691.8 48740.8 48922.3 49028.3 49043.5 13783.3 13922.7 13928.1 13962.8 14011.3 10551.2 10657.1 10725.5 10799.7 10815.2 17912.0 18633.2 18702.3 18788.4 18816.0 7218.0 7455.2 7487.8 7559.4 7678.6 856.9 917.9 1027.9 1044.6 1056.7 25811.1 26050.3 26060.6 26419.9 26445.3 914.6 933.0 945.0 1036.0 1058.4 13613.7 13725.7 13843.4 13850.9 13852.7 261128.0 264792.0 265006.0 265464.0 265665.0 43382.8 43754.0 43854.1 43882.6 43922.6 1027.4 1200.9 1208.6 1228.1 1229.6 17498.1 26243.9 27298.0 27415.9 27559.9 41385.4 41775.0 41858.6 41862.2 41898.6 230650.0 245587.0 247159.0 247194.0 247451.0 23158.4 27659.3 28187.4 28211.0 28389.7 32968.2 35829.3 36625.0 36937.8 37122.3 31281.8 31303.2 37274.6 38012.1 39154.2 31939.5 32493.0 32512.0 32596.5 32619.7 32881.8 35081.3 35720.8 35810.6 35839.1 27619.3 33839.7 35119.8 35523.8 35606.8 23010.7 23394.4 23440.4 24096.2 24621.0 04:36:10 INFO - 2015-12-16 04:36:10,239 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-16 04:36:10,239 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26385.23 Median:21403.69 stddev:80365.52 (375.5%) stddev-sans-first:80567.15 04:36:10 INFO - 2015-12-16 04:36:10,240 DEBUG : BROWSER_OUTPUT: Values: 328.1 337.8 337.8 338.8 345.4 12642.4 13022.9 14415.7 15041.9 16814.2 8558.3 14499.0 14597.9 15224.9 15257.2 3943.0 4485.0 4602.1 4608.3 5198.0 3436.5 3535.7 5012.9 5211.1 5218.2 5149.7 5181.9 5183.7 5194.5 5200.5 5168.0 5223.6 5679.3 5689.3 5690.7 5046.5 5056.3 5061.2 5061.6 5063.3 12232.3 12235.6 12282.4 12310.9 15495.2 1763.1 1817.2 1863.6 1908.7 1938.3 9236.3 9420.9 11426.8 12687.7 12900.4 1705.6 1713.5 1721.6 1742.2 1756.9 54586.7 57372.7 57486.7 57651.0 58012.0 9867.9 9877.0 9905.1 9931.5 9998.3 12604.2 12627.6 12628.6 12643.8 12656.5 7274.1 7283.1 7284.7 7334.6 7349.5 7068.8 7098.6 7134.5 7141.0 7180.9 4094.8 4133.4 4177.6 4179.7 4231.5 1521.3 1598.7 1601.4 1653.3 1663.7 882.9 900.9 937.6 964.3 978.7 15729.5 15750.1 16029.2 16396.3 16414.8 722.9 763.1 817.3 871.7 874.1 9185.0 9382.0 9390.3 9481.0 9635.0 479887.0 482475.0 483519.0 504965.3 507907.0 72338.0 73878.6 74457.3 74555.0 75274.0 1058.9 1074.1 1096.0 1104.1 1105.0 13670.5 13994.5 14008.6 14469.3 14534.0 31671.2 32330.7 32385.8 32876.3 34171.8 37997.2 38864.4 39516.6 40548.2 40956.0 8911.7 8916.2 8920.2 8930.2 9158.4 16090.6 16368.5 16397.2 16572.6 16790.3 14149.7 14150.1 14303.6 14372.6 14630.6 13456.5 13457.7 13501.0 14017.0 14133.8 10381.7 12720.4 14186.6 14359.1 14771.7 8657.6 8709.5 8820.4 8846.1 8946.8 13022.1 13095.7 13305.3 13323.3 13493.3 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5081.45 Median:6306.31 stddev:2671.59 (42.4%) stddev-sans-first:2665.09 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: Values: 1443.3 1662.9 1714.5 1745.6 1747.2 5670.1 7108.1 7286.6 7295.2 7322.4 7260.1 7304.4 7327.9 7377.1 7398.1 1739.9 1776.0 2037.4 2079.0 2081.5 2114.6 2168.6 2171.9 2172.2 2173.8 2068.3 2092.3 2103.3 2105.9 2114.3 2055.1 2066.1 2075.1 2089.2 2089.3 2125.1 2143.1 2146.0 2146.8 2147.6 7255.0 7311.4 7326.2 7333.2 7345.8 4174.9 4270.7 4274.3 4278.9 4286.4 2665.3 2694.9 2734.1 2746.1 2757.2 861.5 871.1 892.5 896.7 918.9 10062.5 10065.7 10087.8 10103.3 10105.0 3826.7 3906.4 3936.2 3936.8 3953.4 7734.7 7848.3 7860.4 7861.4 7863.8 4342.4 4350.5 4350.8 4351.0 4360.4 3971.3 4012.1 4014.1 4014.9 4027.6 2776.9 2893.5 2894.5 3193.9 3223.0 844.2 950.7 959.9 965.0 965.6 935.1 943.3 945.7 988.6 1190.8 6891.9 6959.4 6961.3 6965.7 6974.5 727.3 1102.3 1120.6 1130.5 1150.5 5409.1 5441.7 5524.6 5531.5 5534.5 8682.8 8712.9 8764.3 8826.6 8886.6 8892.0 8892.5 8895.2 8946.9 8986.5 6911.6 6980.4 7002.6 7008.6 7026.7 6562.1 6745.5 6750.2 6754.4 6770.5 7689.0 7932.3 7961.3 8022.1 8033.4 8074.1 8212.5 8219.1 8235.3 8244.2 6056.6 6123.2 6125.6 6130.6 6136.7 7111.2 7145.1 7218.9 7240.5 7248.3 5464.9 5566.2 6463.7 6579.4 6679.1 6515.9 6562.4 6633.4 6651.9 6689.2 6677.8 6719.9 6722.7 6728.5 6728.7 6066.7 6195.3 6207.6 6213.8 6238.4 6276.2 6303.1 6306.1 6306.6 6320.4 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4709.97 Median:5398.31 stddev:1392.93 (25.8%) stddev-sans-first:1357.09 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: Values: 307.9 311.0 312.9 313.9 315.3 5350.5 5429.0 5469.6 5480.7 5489.6 5308.5 5319.3 5325.5 5359.5 5367.6 3925.7 4072.1 4194.6 4201.0 4213.6 4095.9 4186.2 4188.6 4211.7 4220.5 4167.0 4171.9 4174.7 4176.9 4179.4 3936.8 4043.7 4045.5 4134.2 4157.0 3676.2 3683.2 3685.5 3689.7 3696.2 5145.3 5149.2 5155.2 5164.1 5170.9 4787.2 4796.7 4797.0 4797.5 4800.3 5497.7 5616.6 5641.7 5647.9 5651.3 4014.8 4024.1 4029.0 4029.7 4033.3 5966.8 5969.3 5969.5 5972.6 5974.0 4150.4 4155.8 4156.5 4156.9 4159.2 3947.5 4081.2 4086.0 4208.5 4208.6 4663.9 4665.9 4679.5 4680.2 4687.7 5646.7 5648.9 5650.6 5651.7 5655.0 1419.5 1446.7 1447.5 1447.5 1448.9 961.7 963.7 970.1 985.3 990.6 4968.8 4976.4 4980.0 4983.0 4984.2 5877.6 5889.2 5889.4 5895.1 5899.0 4961.3 4962.3 4969.1 4971.3 4980.9 2920.4 3011.5 3072.8 3148.6 3179.8 5583.6 5601.9 5602.7 5616.3 5630.5 6034.3 6041.8 6043.1 6044.6 6047.5 5474.2 5611.5 5613.4 5616.0 5617.3 5935.2 5938.6 5944.2 5944.8 5946.3 5778.0 5780.2 5782.6 5784.6 5791.5 5622.7 5624.2 5629.1 5629.9 5629.9 3959.3 3993.8 4007.6 4009.1 4058.1 5844.9 5896.9 5897.3 5899.3 5904.1 5662.7 5667.8 5667.9 5673.1 5675.0 5586.4 5693.1 5701.7 5708.9 5714.5 5565.6 5574.5 5578.9 5579.5 5585.0 5744.8 5751.8 5754.6 5760.0 5763.8 5595.7 5608.2 5610.0 5610.7 5616.1 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12013.58 Median:576.97 stddev:13706.39 (2375.6%) stddev-sans-first:13718.55 04:36:10 INFO - 2015-12-16 04:36:10,241 DEBUG : BROWSER_OUTPUT: Values: 711.1 757.8 763.5 767.4 796.0 11635.2 11910.6 11913.3 11915.2 11930.0 11555.9 12480.2 12627.6 12650.9 12654.9 646.6 655.1 811.5 818.5 832.2 817.6 817.7 825.8 825.9 825.9 855.6 863.3 863.5 863.6 864.3 616.8 621.3 835.5 845.8 848.4 632.0 632.4 632.6 632.8 633.4 11810.5 11909.6 11911.4 11929.9 11966.2 10526.6 10593.8 10614.6 10911.8 11104.4 9148.9 9418.6 9445.7 9459.1 9494.6 3269.6 3278.3 3300.2 3308.8 3318.1 39715.0 39801.8 40242.4 40278.2 40345.4 8886.6 8987.1 8994.4 9103.2 9129.2 15840.3 15854.2 15857.4 15860.9 15876.8 6141.7 6387.8 6422.6 6554.9 6680.0 3416.3 3552.7 3582.5 3587.2 3594.5 2535.8 2545.4 2563.6 2563.8 2564.7 469.4 473.3 477.1 488.2 492.1 484.0 542.8 554.4 594.3 603.2 7755.0 7919.5 7982.8 8125.5 8215.2 564.8 589.1 623.8 632.8 637.6 3599.7 3741.0 3752.0 3789.1 3888.6 49970.3 50130.5 50153.2 50278.5 50500.7 43368.3 43581.8 43751.6 43820.3 43873.3 40246.6 40251.6 40396.6 41555.2 41559.6 7666.3 7752.2 7868.7 7926.2 8046.0 29267.0 29351.7 30089.7 30114.2 30185.5 36385.0 38923.4 39672.6 39725.6 39933.0 9173.2 9207.6 9304.0 9408.0 9436.0 10152.3 10217.9 10315.6 10365.2 10484.3 9685.5 9892.2 9943.7 10081.8 10151.0 9090.7 9266.6 9272.3 9649.1 9721.7 9357.3 9520.9 9530.1 9531.6 9631.7 8301.0 8358.9 8722.8 9020.9 9533.1 8294.8 8838.8 8906.4 9116.8 9244.6 04:36:10 INFO - 2015-12-16 04:36:10,242 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:36:10 INFO - 2015-12-16 04:36:10,242 DEBUG : BROWSER_OUTPUT: 04:36:11 INFO - 2015-12-16 04:36:11,005 INFO : Browser exited with error code: 0 04:36:11 INFO - 2015-12-16 04:36:11,021 INFO : Completed test dromaeo_css (00:18:37) 04:36:11 INFO - 2015-12-16 04:36:11,021 INFO : Starting test kraken 04:36:11 INFO - 2015-12-16 04:36:11,022 DEBUG : operating with platform_type : linux_ 04:36:11 INFO - 2015-12-16 04:36:11,022 INFO : Initialising browser for kraken test... 04:36:11 INFO - 2015-12-16 04:36:11,028 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHjYug/profile http://localhost:59200/getInfo.html 04:36:15 INFO - 2015-12-16 04:36:15,370 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:36:15 INFO - 2015-12-16 04:36:15,371 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:36:15 INFO - 2015-12-16 04:36:15,371 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:36:15 INFO - 2015-12-16 04:36:15,371 DEBUG : BROWSER_OUTPUT: __metrics 04:36:15 INFO - 2015-12-16 04:36:15,499 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:36:15 INFO - 2015-12-16 04:36:15,575 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] 04:36:16 INFO - 2015-12-16 04:36:16,748 INFO : Browser initialized. 04:36:16 INFO - 2015-12-16 04:36:16,749 INFO : Running cycle 1/1 for kraken test... 04:36:16 INFO - 2015-12-16 04:36:16,749 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHjYug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:36:28 INFO - 2015-12-16 04:36:28,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 142028800 04:36:28 INFO - 2015-12-16 04:36:28,756 DEBUG : BROWSER_OUTPUT: 04:36:31 INFO - 2015-12-16 04:36:31,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59200/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:31 INFO - 2015-12-16 04:36:31,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 176508928 04:36:31 INFO - 2015-12-16 04:36:31,970 DEBUG : BROWSER_OUTPUT: 04:36:34 INFO - 2015-12-16 04:36:34,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59200/tests/kraken/driver.html?testName=audio-dft) 04:36:35 INFO - 2015-12-16 04:36:35,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 165928960 04:36:35 INFO - 2015-12-16 04:36:35,313 DEBUG : BROWSER_OUTPUT: 04:36:38 INFO - 2015-12-16 04:36:38,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59200/tests/kraken/driver.html?testName=audio-fft) 04:36:38 INFO - 2015-12-16 04:36:38,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 152838144 04:36:38 INFO - 2015-12-16 04:36:38,922 DEBUG : BROWSER_OUTPUT: 04:36:40 INFO - 2015-12-16 04:36:40,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59200/tests/kraken/driver.html?testName=audio-oscillator) 04:36:41 INFO - 2015-12-16 04:36:41,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 156491776 04:36:41 INFO - 2015-12-16 04:36:41,544 DEBUG : BROWSER_OUTPUT: 04:36:43 INFO - 2015-12-16 04:36:43,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:44 INFO - 2015-12-16 04:36:44,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 157425664 04:36:44 INFO - 2015-12-16 04:36:44,370 DEBUG : BROWSER_OUTPUT: 04:36:47 INFO - 2015-12-16 04:36:47,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59200/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:47 INFO - 2015-12-16 04:36:47,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 156520448 04:36:47 INFO - 2015-12-16 04:36:47,916 DEBUG : BROWSER_OUTPUT: 04:36:51 INFO - 2015-12-16 04:36:51,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59200/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:51 INFO - 2015-12-16 04:36:51,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 157478912 04:36:51 INFO - 2015-12-16 04:36:51,851 DEBUG : BROWSER_OUTPUT: 04:36:54 INFO - 2015-12-16 04:36:54,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59200/tests/kraken/driver.html?testName=json-parse-financial) 04:36:55 INFO - 2015-12-16 04:36:55,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 158228480 04:36:55 INFO - 2015-12-16 04:36:55,270 DEBUG : BROWSER_OUTPUT: 04:36:57 INFO - 2015-12-16 04:36:57,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:57 INFO - 2015-12-16 04:36:57,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 165281792 04:36:57 INFO - 2015-12-16 04:36:57,654 DEBUG : BROWSER_OUTPUT: 04:36:59 INFO - 2015-12-16 04:36:59,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:00 INFO - 2015-12-16 04:37:00,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 163635200 04:37:00 INFO - 2015-12-16 04:37:00,151 DEBUG : BROWSER_OUTPUT: 04:37:02 INFO - 2015-12-16 04:37:02,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:02 INFO - 2015-12-16 04:37:02,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 178733056 04:37:02 INFO - 2015-12-16 04:37:02,849 DEBUG : BROWSER_OUTPUT: 04:37:05 INFO - 2015-12-16 04:37:05,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:06 INFO - 2015-12-16 04:37:05,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 183189504 04:37:06 INFO - 2015-12-16 04:37:06,000 DEBUG : BROWSER_OUTPUT: 04:37:08 INFO - 2015-12-16 04:37:08,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:09 INFO - 2015-12-16 04:37:09,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 181469184 04:37:09 INFO - 2015-12-16 04:37:09,193 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-12-16 04:37:10,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59200/tests/kraken/driver.html?testName=ai-astar) 04:37:11 INFO - 2015-12-16 04:37:11,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 239706112 04:37:11 INFO - 2015-12-16 04:37:11,213 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,214 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:37:11 INFO - 2015-12-16 04:37:11,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:37:11 INFO - 2015-12-16 04:37:11,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:37:11 INFO - 2015-12-16 04:37:11,215 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:37:11 INFO - 2015-12-16 04:37:11,215 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;106;112;114;115;101;112;112;110 04:37:11 INFO - 2015-12-16 04:37:11,215 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;131;153;173;130;154;165;135;167;133 04:37:11 INFO - 2015-12-16 04:37:11,216 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;160;162;162;161;162;160;162;164 04:37:11 INFO - 2015-12-16 04:37:11,216 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;88;89;72;72;72;109;91;71 04:37:11 INFO - 2015-12-16 04:37:11,216 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;130;95;95;95;130;95;95;135 04:37:11 INFO - 2015-12-16 04:37:11,216 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;109;109 04:37:11 INFO - 2015-12-16 04:37:11,217 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;146;147;146;147;146;147;146 04:37:11 INFO - 2015-12-16 04:37:11,217 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;95;95;94;95;95;95;95;96;95 04:37:11 INFO - 2015-12-16 04:37:11,217 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;72;74;73;73;83;71;70 04:37:11 INFO - 2015-12-16 04:37:11,217 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;69;69;68;69;69 04:37:11 INFO - 2015-12-16 04:37:11,218 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;84;85;86;85;85;86;85 04:37:11 INFO - 2015-12-16 04:37:11,218 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;137;123;121;127;129;131;127;124;129 04:37:11 INFO - 2015-12-16 04:37:11,218 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;142;149;147;147;152;145;147;152;145 04:37:11 INFO - 2015-12-16 04:37:11,218 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;69;71;73;70;71;69;70;72;69 04:37:11 INFO - 2015-12-16 04:37:11,218 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:37:11 INFO - 2015-12-16 04:37:11,218 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:37:11 INFO - 2015-12-16 04:37:11,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 04:37:11 INFO - 2015-12-16 04:37:11,218 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:37:11 INFO - 2015-12-16 04:37:11,220 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269431213__endTimestamp 04:37:11 INFO - 2015-12-16 04:37:11,220 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,220 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:37:11 INFO - 2015-12-16 04:37:11,220 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:37:11 INFO - 2015-12-16 04:37:11,220 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,220 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:4.19 (3.7%) stddev-sans-first:4.42 04:37:11 INFO - 2015-12-16 04:37:11,220 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 106.0 112.0 114.0 115.0 101.0 112.0 112.0 110.0 04:37:11 INFO - 2015-12-16 04:37:11,220 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,221 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:155.00 stddev:16.26 (10.5%) stddev-sans-first:17.08 04:37:11 INFO - 2015-12-16 04:37:11,222 DEBUG : BROWSER_OUTPUT: Values: 156.0 131.0 153.0 173.0 130.0 154.0 165.0 135.0 167.0 133.0 04:37:11 INFO - 2015-12-16 04:37:11,222 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,222 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.24 04:37:11 INFO - 2015-12-16 04:37:11,222 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 160.0 162.0 162.0 161.0 162.0 160.0 162.0 164.0 04:37:11 INFO - 2015-12-16 04:37:11,222 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,222 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:72.50 stddev:12.84 (17.7%) stddev-sans-first:13.21 04:37:11 INFO - 2015-12-16 04:37:11,222 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 88.0 89.0 72.0 72.0 72.0 109.0 91.0 71.0 04:37:11 INFO - 2015-12-16 04:37:11,223 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,223 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:17.70 (18.6%) stddev-sans-first:18.31 04:37:11 INFO - 2015-12-16 04:37:11,223 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 130.0 95.0 95.0 95.0 130.0 95.0 95.0 135.0 04:37:11 INFO - 2015-12-16 04:37:11,223 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,223 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:37:11 INFO - 2015-12-16 04:37:11,223 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 04:37:11 INFO - 2015-12-16 04:37:11,224 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,224 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:37:11 INFO - 2015-12-16 04:37:11,224 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 04:37:11 INFO - 2015-12-16 04:37:11,224 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,224 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 04:37:11 INFO - 2015-12-16 04:37:11,224 DEBUG : BROWSER_OUTPUT: Values: 97.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:73.00 stddev:3.57 (4.9%) stddev-sans-first:3.78 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 72.0 74.0 73.0 73.0 83.0 71.0 70.0 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 69.0 69.0 68.0 69.0 69.0 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 04:37:11 INFO - 2015-12-16 04:37:11,225 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 84.0 85.0 86.0 85.0 85.0 86.0 85.0 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:128.00 stddev:4.50 (3.5%) stddev-sans-first:4.77 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: Values: 127.0 137.0 123.0 121.0 127.0 129.0 131.0 127.0 124.0 129.0 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.20 Median:147.00 stddev:4.73 (3.2%) stddev-sans-first:3.28 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: Values: 136.0 142.0 149.0 147.0 147.0 152.0 145.0 147.0 152.0 145.0 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.43 (2.0%) stddev-sans-first:1.42 04:37:11 INFO - 2015-12-16 04:37:11,226 DEBUG : BROWSER_OUTPUT: Values: 72.0 69.0 71.0 73.0 70.0 71.0 69.0 70.0 72.0 69.0 04:37:11 INFO - 2015-12-16 04:37:11,227 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:37:11 INFO - 2015-12-16 04:37:11,227 DEBUG : BROWSER_OUTPUT: 04:37:12 INFO - 2015-12-16 04:37:12,170 INFO : Browser exited with error code: 0 04:37:12 INFO - 2015-12-16 04:37:12,218 INFO : Completed test kraken (00:01:01) 04:37:12 INFO - 2015-12-16 04:37:12,218 INFO : Starting test v8_7 04:37:12 INFO - 2015-12-16 04:37:12,218 DEBUG : operating with platform_type : linux_ 04:37:12 INFO - 2015-12-16 04:37:12,218 INFO : Initialising browser for v8_7 test... 04:37:12 INFO - 2015-12-16 04:37:12,224 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCvjwRQ/profile http://localhost:59200/getInfo.html 04:37:16 INFO - 2015-12-16 04:37:16,641 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:37:16 INFO - 2015-12-16 04:37:16,642 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:37:16 INFO - 2015-12-16 04:37:16,642 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:37:16 INFO - 2015-12-16 04:37:16,642 DEBUG : BROWSER_OUTPUT: __metrics 04:37:16 INFO - 2015-12-16 04:37:16,746 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:37:16 INFO - 2015-12-16 04:37:16,808 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] 04:37:18 INFO - 2015-12-16 04:37:18,145 INFO : Browser initialized. 04:37:18 INFO - 2015-12-16 04:37:18,145 INFO : Running cycle 1/1 for v8_7 test... 04:37:18 INFO - 2015-12-16 04:37:18,146 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCvjwRQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:37:30 INFO - 2015-12-16 04:37:30,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 143007744 04:37:30 INFO - 2015-12-16 04:37:30,063 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59200/tests/v8_7/run.html (next: http://localhost:59200/tests/v8_7/run.html) 04:37:51 INFO - 2015-12-16 04:37:51,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 458678272 04:37:51 INFO - 2015-12-16 04:37:51,684 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,685 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:37:51 INFO - 2015-12-16 04:37:51,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:37:51 INFO - 2015-12-16 04:37:51,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:37:51 INFO - 2015-12-16 04:37:51,686 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:37:51 INFO - 2015-12-16 04:37:51,686 DEBUG : BROWSER_OUTPUT: |0;Richards;166.11295681063123 04:37:51 INFO - 2015-12-16 04:37:51,686 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.39117538005192 04:37:51 INFO - 2015-12-16 04:37:51,687 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 04:37:51 INFO - 2015-12-16 04:37:51,687 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 04:37:51 INFO - 2015-12-16 04:37:51,687 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 04:37:51 INFO - 2015-12-16 04:37:51,687 DEBUG : BROWSER_OUTPUT: |5;Earley;797.4481658692185 04:37:51 INFO - 2015-12-16 04:37:51,688 DEBUG : BROWSER_OUTPUT: |6;Boyer;12600 04:37:51 INFO - 2015-12-16 04:37:51,688 DEBUG : BROWSER_OUTPUT: |7;RegExp;27567.567567567567 04:37:51 INFO - 2015-12-16 04:37:51,688 DEBUG : BROWSER_OUTPUT: |8;Splay;604.5949214026602 04:37:51 INFO - 2015-12-16 04:37:51,688 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:37:51 INFO - 2015-12-16 04:37:51,688 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:37:51 INFO - 2015-12-16 04:37:51,689 DEBUG : BROWSER_OUTPUT: __startTimestamp1450269471685__endTimestamp 04:37:51 INFO - 2015-12-16 04:37:51,689 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,690 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:37:51 INFO - 2015-12-16 04:37:51,691 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:37:51 INFO - 2015-12-16 04:37:51,691 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,691 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,691 DEBUG : BROWSER_OUTPUT: Values: 166.1 04:37:51 INFO - 2015-12-16 04:37:51,691 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,692 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.39 Median:185.39 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,692 DEBUG : BROWSER_OUTPUT: Values: 185.4 04:37:51 INFO - 2015-12-16 04:37:51,692 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,692 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,692 DEBUG : BROWSER_OUTPUT: Values: 279.0 04:37:51 INFO - 2015-12-16 04:37:51,693 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,693 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,693 DEBUG : BROWSER_OUTPUT: Values: 5181.3 04:37:51 INFO - 2015-12-16 04:37:51,693 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,693 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,693 DEBUG : BROWSER_OUTPUT: Values: 1992.0 04:37:51 INFO - 2015-12-16 04:37:51,693 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: Values: 797.4 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12600.00 Median:12600.00 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: Values: 12600.0 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27567.57 Median:27567.57 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: Values: 27567.6 04:37:51 INFO - 2015-12-16 04:37:51,694 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,695 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.59 Median:604.59 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,695 DEBUG : BROWSER_OUTPUT: Values: 604.6 04:37:51 INFO - 2015-12-16 04:37:51,695 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-12-16 04:37:51,695 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:37:51 INFO - 2015-12-16 04:37:51,695 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:37:51 INFO - 2015-12-16 04:37:51,695 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:37:51 INFO - 2015-12-16 04:37:51,695 DEBUG : BROWSER_OUTPUT: 04:37:52 INFO - 2015-12-16 04:37:52,569 INFO : Browser exited with error code: 0 04:37:52 INFO - 2015-12-16 04:37:52,584 INFO : Completed test v8_7 (00:00:40) 04:37:52 INFO - 2015-12-16 04:37:52,739 INFO : Completed test suite (00:20:19) 04:37:52 INFO - 2015-12-16 04:37:52,739 DEBUG : Working with test: dromaeo_css 04:37:52 INFO - 2015-12-16 04:37:52,739 DEBUG : Generating results file: dromaeo_css 04:37:52 INFO - 2015-12-16 04:37:52,740 DEBUG : Working with test: kraken 04:37:52 INFO - 2015-12-16 04:37:52,741 DEBUG : Generating results file: kraken 04:37:52 INFO - 2015-12-16 04:37:52,741 INFO : javascript benchmark 04:37:52 INFO - 2015-12-16 04:37:52,741 DEBUG : Working with test: v8_7 04:37:52 INFO - 2015-12-16 04:37:52,741 DEBUG : Generating results file: v8_7 04:37:52 INFO - 2015-12-16 04:37:52,742 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:52 INFO - 2015-12-16 04:37:52,796 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:37:52 INFO - 2015-12-16 04:37:52,796 DEBUG : process_Request line: dromaeo_css 6321.59 graph.html#tests=[[72,94,35]] 04:37:52 INFO - 2015-12-16 04:37:52,796 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:52 INFO - 2015-12-16 04:37:52,827 DEBUG : process_Request line: kraken 1531.50 graph.html#tests=[[232,94,35]] 04:37:52 INFO - 2015-12-16 04:37:52,828 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:52 INFO - 2015-12-16 04:37:52,857 DEBUG : process_Request line: v8_7 19674.01 graph.html#tests=[[230,94,35]] 04:37:52 INFO - 2015-12-16 04:37:52,858 INFO : javascript benchmark 04:37:52 INFO - 2015-12-16 04:37:52,862 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2625.3567875870413, 2688.9462210755796, 2690.1929421173654, 2703.148508219912, 2733.480638678651, 4523.773811309437, 4656.9534304656945, 4666.78999445025, 4668.463126740426, 4680.344751734756, 4573.7027093239, 4633.0, 4639.211334073208, 4650.162970665279, 4743.691660042095, 4275.46556680415, 4285.228658841415, 4285.614294713475, 4286.785660716967, 4355.5208927018, 4203.684723645723, 4369.694121411502, 4383.561643835623, 4429.1806015887005, 4443.244648409762, 4212.326027835532, 4297.484301883763, 4317.848875289381, 4323.0, 4328.2209202343565, 4316.201502721975, 4345.674074444398, 4347.760873151976, 4348.173846969065, 4368.759718215497, 4293.3130699088, 4311.223979683656, 4322.740635561876, 4326.567343265649, 4339.305711086243, 4519.118771839492, 4549.499555048942, 4641.164590373765, 4656.301554766812, 4676.392069031038, 5035.345405097314, 5035.672681275705, 5048.924266136011, 5103.4896510349035, 5141.820036298749, 5063.898722025576, 5079.902424453598, 5084.898302033938, 5085.669431486942, 5126.846194614168, 4518.774061296987, 4616.330632058332, 4616.907661846744, 4724.929126063077, 4729.787159577827, 5043.773030213576, 5122.078025955364, 5122.180451127876, 5124.385073791094, 5155.845324640267, 4982.676126051795, 5015.22264049073, 5016.899662006813, 5017.448080711119, 5059.165237735806, 4841.443234028132, 4967.875803104951, 4969.155243608595, 5097.439281679012, 5100.515451032146, 4842.58837998767, 4922.950770492249, 4970.776315065831, 4983.5763960063805, 4984.003199360142, 4988.077205716954, 4999.175136102575, 5002.799888004439, 5004.799808007711, 5038.571721403721, 4204.495460544754, 4205.3481710334945, 4206.242876282298, 4208.389783481378, 4210.136921930997, 3548.946765798515, 3618.203995121069, 3670.284294562588, 3687.9078023049638, 3717.665410113103, 4379.1241751649795, 4382.496012958487, 4390.868273951786, 4395.670324725658, 4434.756088415168, 5094.133997220481, 5100.336956195745, 5104.387473503203, 5106.234064890296, 5148.150555158431, 4160.750354978711, 4247.51153617338, 4251.4685664291965, 4289.378040184219, 4398.098389830077, 4467.24056910326, 4488.775561221991, 4490.214212512862, 4502.57225563571, 4520.547945205453, 4829.106615276185, 4829.879253018703, 4844.346013288302, 4845.030993801183, 4893.412790465096, 4815.446223684321, 4912.263160525807, 4921.4832442593015, 5048.0, 5172.870678232924, 4775.0, 4829.9275510868065, 4892.437369702529, 4897.779599917941, 4928.211486162197, 5047.2429135629945, 5047.823326183566, 5056.191009438472, 5058.696478211319, 5096.745162741774, 4831.541003604652, 4941.33292005589, 4944.505549445027, 4980.178270585313, 5099.643024988363, 4893.7063776173545, 4903.092927808367, 4907.092187945242, 4907.386576677915, 4953.702777833341, 4928.581070608895, 4932.383452068491, 4932.63005274613, 4933.77797999098, 4990.72551009698, 4601.838935637236, 4699.765011749467, 4754.381930349171, 4757.3577567028005, 4800.3759511263315, 4885.487023862585, 4913.680610760289, 4914.754262286943, 4920.409550853778, 4957.182064959241, 4802.648914432275, 4809.78355973989, 4812.398450193726, 4821.059893320768, 4852.320675105418], "unit": "score", "name": "dojo.html", "value": 4612.6273154081755}, {"lowerIsBetter": false, "replicates": [568.4514443561964, 570.891530609184, 575.1545228514083, 579.1052823387867, 591.1398914579288, 26319.473610527803, 26792.59811102835, 26843.328916777067, 32525.83737081311, 33208.83395583019, 38107.618923810754, 38408.615913840855, 38683.22633547327, 38741.225175496475, 38796.41805372922, 7853.764387068397, 7972.402069844756, 8017.6392062357045, 8018.0, 8021.438499305051, 7086.574805511686, 7255.927440725604, 10234.846477302846, 10508.159347252202, 10524.789504209912, 9893.75265618358, 9978.0, 9982.0, 9983.251256155781, 9990.9500452498, 7081.681324340417, 7236.638168091627, 9857.704268871945, 9941.353812002233, 9955.701328960144, 6965.33829286222, 10118.342307750047, 10386.948065259701, 10392.0, 10414.583416663325, 35691.0, 35716.64283357159, 36031.63968360309, 36149.63850361489, 36160.819195904114, 2944.3375240570913, 3001.819890806537, 3006.939861202786, 3031.2876474028585, 3560.572731272264, 27908.302292442648, 28111.29721756952, 28312.0, 28319.150425487267, 28335.0, 3334.283129127225, 3435.2270739083756, 3438.1748380388776, 3458.4985177149174, 3537.4693795930557, 204536.0, 207586.0, 208150.0, 208514.0, 208831.0, 50304.748476258115, 51041.74479127581, 53242.21503451964, 53438.7328063365, 53784.46215537873, 48691.83503072289, 48740.756296219, 48922.26616600754, 49028.26457603139, 49043.50956490389, 13783.310834458238, 13922.721545569235, 13928.094673846168, 13962.790558141636, 14011.299435028208, 10551.20865935058, 10657.147428205724, 10725.51735171919, 10799.67600971972, 10815.242932994772, 17912.0, 18633.161507732184, 18702.345417910306, 18788.436346909613, 18816.0, 7217.963910180415, 7455.179930207672, 7487.812804679817, 7559.395248380117, 7678.616069196518, 856.8928883889514, 917.9495127767904, 1027.912627426662, 1044.6134930075768, 1056.6882769582992, 25811.09661161888, 26050.34874128124, 26060.60909086365, 26419.867900660374, 26445.33886652849, 914.5884352041608, 932.9673461428818, 944.9527523623791, 1035.9585616575253, 1058.4125810175426, 13613.727725445435, 13725.725485490433, 13843.4462621494, 13850.930745346208, 13852.653683657787, 261128.0, 264792.0, 265006.0, 265464.0, 265665.0, 43382.78308608437, 43754.0, 43854.12291754147, 43882.56117438849, 43922.560774392485, 1027.3527677563236, 1200.9459574319003, 1208.6434501821984, 1228.0543981134476, 1229.569650622293, 17498.099652720528, 26243.868780655976, 27298.0, 27415.862920685267, 27559.86220068887, 41385.37921931113, 41775.0, 41858.58141418669, 41862.1627567453, 41898.58101418947, 230650.0, 245587.0, 247159.0, 247194.0, 247451.0, 23158.421039473473, 27659.308517287227, 28187.43625127445, 28211.0, 28389.716102838705, 32968.175795605304, 35829.28341433105, 36625.0, 36937.81531092327, 37122.25755484929, 31281.8435907819, 31303.217419564695, 37274.627253727114, 38012.12676350877, 39154.216915662095, 31939.520907186874, 32493.0, 32512.0, 32596.511052334707, 32619.673803261663, 32881.835590821895, 35081.298374032885, 35720.82139589285, 35810.64189358073, 35839.104022399646, 27619.30951726223, 33839.661603383654, 35119.82440087885, 35523.82238088793, 35606.821965890005, 23010.654840177747, 23394.415139621644, 23440.413989650395, 24096.15663451771, 24621.0], "unit": "score", "name": "ext.html", "value": 16957.009617465876}, {"lowerIsBetter": false, "replicates": [328.1042753283534, 337.7821305258107, 337.8327727774751, 338.80857315616674, 345.4179707193379, 12642.367881605905, 13022.934885325583, 14415.711685766291, 15041.947063705531, 16814.159292035394, 8558.272546833527, 14499.0, 14597.854021459782, 15224.923875380608, 15257.160856152906, 3942.9605703943025, 4484.97757511212, 4602.14860250853, 4608.331791890174, 5198.0, 3436.501707252447, 3535.6817886390218, 5012.949870501303, 5211.062008838408, 5218.1650935850275, 5149.665271757323, 5181.87045323868, 5183.714895680736, 5194.532492075712, 5200.453952335007, 5167.974160129194, 5223.555997740196, 5679.346875109374, 5689.288838895138, 5690.658560486384, 5046.520580544842, 5056.317397151411, 5061.190209566488, 5061.5950723942, 5063.341765570489, 12232.266064036186, 12235.632931012084, 12282.447289871978, 12310.876891231062, 15495.225238738018, 1763.144874735765, 1817.2276782367574, 1863.5806943437617, 1908.6850669639493, 1938.331275709878, 9236.261099112055, 9420.905790942072, 11426.828597571042, 12687.682807929783, 12900.354982250943, 1705.590658242013, 1713.4516954574542, 1721.6470623522148, 1742.2247100040488, 1756.9472915812546, 54586.72706636481, 57372.71313643447, 57486.712566437316, 57650.964432489745, 58012.0, 9867.901320986699, 9877.0, 9905.10854023127, 9931.453770042572, 9998.250131240186, 12604.180728252633, 12627.558035468715, 12628.621141365773, 12643.810342844865, 12656.493740250287, 7274.0543729315905, 7283.126024876943, 7284.6721897514735, 7334.633268336562, 7349.522281051714, 7068.787936361815, 7098.645067746592, 7134.464915131386, 7141.035960145417, 7180.8922866157045, 4094.754314741125, 4133.400656904732, 4177.582241775859, 4179.749215047107, 4231.4710661167355, 1521.300201907113, 1598.7362085256036, 1601.4154833485693, 1653.338664534196, 1663.7088509510788, 882.911708829112, 900.9279257659372, 937.5687183895349, 964.3490643815396, 978.7112801723508, 15729.528114156594, 15750.133742644264, 16029.19854007295, 16396.26216820246, 16414.835851641332, 722.8795367180849, 763.1300317637897, 817.3257062923112, 871.7166920750782, 874.0909454167721, 9185.0, 9382.0, 9390.295727820441, 9480.95259523698, 9635.0, 479887.0, 482475.0, 483519.0, 504965.2765625556, 507907.0, 72338.0, 73878.63060684662, 74457.25542744504, 74555.0, 75274.0, 1058.8941105889348, 1074.0923919288189, 1095.956161753537, 1104.0946423932298, 1104.9502772375263, 13670.52153174634, 13994.510192143227, 14008.649783755487, 14469.348879300667, 14534.0, 31671.20821979469, 32330.676693232766, 32385.838070809496, 32876.34247315088, 34171.82914085413, 37997.24005519929, 38864.41703374395, 39516.60483395244, 40548.1890362197, 40956.0, 8911.688090916787, 8916.19754222123, 8920.152585504367, 8930.151635594608, 9158.358914876162, 16090.597735056717, 16368.508944731677, 16397.180140992663, 16572.58568535796, 16790.328386864876, 14149.717005660035, 14150.080244784056, 14303.64240893986, 14372.640683982983, 14630.634234143805, 13456.46174153023, 13457.743755515408, 13501.0, 14017.018808683295, 14133.787993179905, 10381.740456488647, 12720.363981801058, 14186.645333866736, 14359.138451692932, 14771.704565908836, 8657.61040753155, 8709.477431354138, 8820.382573219813, 8846.11538846136, 8946.821063578562, 13022.088453808143, 13095.738085238432, 13305.334733263491, 13323.33383330849, 13493.257870817199], "unit": "score", "name": "jquery.html", "value": 8213.291783058678}, {"lowerIsBetter": false, "replicates": [1443.2783608195903, 1662.916854157292, 1714.4770844892312, 1745.5985123421606, 1747.2486830662815, 5670.149477578365, 7108.111486064242, 7286.599237041961, 7295.1610564785, 7322.414206863452, 7260.056192694942, 7304.379127774132, 7327.8534429311385, 7377.077865266841, 7398.149212840525, 1739.8782085254038, 1775.973360399595, 2037.4091513461078, 2078.968815467769, 2081.469225347534, 2114.6405111131144, 2168.5554461335387, 2171.934841954736, 2172.2071443922932, 2173.793489618484, 2068.2864411777914, 2092.3304542546393, 2103.3059090500174, 2105.947351316214, 2114.312848324293, 2055.126571207231, 2066.1322244657204, 2075.086961736846, 2089.2478707665227, 2089.300084471696, 2125.08621292844, 2143.0570548958563, 2146.0450099705636, 2146.8175205107586, 2147.6241657709993, 7254.963725181393, 7311.378532824716, 7326.194118646945, 7333.156686981012, 7345.816354591125, 4174.853880114181, 4270.743755374688, 4274.337477690931, 4278.871633850989, 4286.37847512109, 2665.2803742989286, 2694.892204311825, 2734.0840818325883, 2746.134967485236, 2757.1866299441713, 861.4615865084322, 871.0592560035146, 892.5135800988477, 896.7489103051156, 918.9494577798218, 10062.496875156214, 10065.69802905914, 10087.848682269772, 10103.343282686601, 10105.0, 3826.7129965252716, 3906.374980003186, 3936.173403585279, 3936.842526298916, 3953.4069889516804, 7734.690612375554, 7848.3328917041545, 7860.371170306476, 7861.410394220342, 7863.764087077397, 4342.370356298319, 4350.499692535335, 4350.8042138103865, 4350.956490435118, 4360.411344468456, 3971.344728119828, 4012.057166565913, 4014.0767623446773, 4014.879553613396, 4027.556968733437, 2776.8750406231366, 2893.537034074538, 2894.4645240630553, 3193.9361212775616, 3222.9677703223138, 844.2106630300689, 950.6577632052456, 959.8944116147358, 964.9951750241204, 965.5703212070702, 935.0882889182992, 943.2595412601075, 945.7399215215871, 988.5502096546054, 1190.8451901252781, 6891.862162756717, 6959.4432445404245, 6961.338672826073, 6965.721371145199, 6974.476914231453, 727.31995584129, 1102.3385968418884, 1120.6245907620876, 1130.5195292000867, 1150.5455345138623, 5409.107497262908, 5441.700706461103, 5524.640898341595, 5531.529819965268, 5534.501894829485, 8682.782930426663, 8712.91287087121, 8764.342674299452, 8826.602802873886, 8886.555672216364, 8892.0, 8892.510911899779, 8895.154960278764, 8946.86579701305, 8986.505742184243, 6911.550749201387, 6980.371766541036, 7002.614856182959, 7008.579485230903, 7026.683799229149, 6562.114114594659, 6745.494087943326, 6750.189977202767, 6754.358335958076, 6770.492213084137, 7689.0, 7932.286094251545, 7961.283484486424, 8022.077461092049, 8033.35733141359, 8074.111847696866, 8212.46618969765, 8219.1369906159, 8235.34117270605, 8244.175582441709, 6056.606320589148, 6123.173371594778, 6125.571210015256, 6130.63216207029, 6136.723847426787, 7111.217766045627, 7145.1425828900865, 7218.89171662436, 7240.493165478577, 7248.347648711641, 5464.863378415572, 5566.248556444828, 6463.709133088928, 6579.407853293226, 6679.06493090958, 6515.869682606416, 6562.442192413699, 6633.402993730588, 6651.900221496779, 6689.163854518185, 6677.76627818024, 6719.932800671931, 6722.731090756315, 6728.495362847904, 6728.663566821541, 6066.666333351532, 6195.349488303663, 6207.596506227081, 6213.782517611862, 6238.407351301619, 6276.184096067482, 6303.149074875017, 6306.054091886253, 6306.558540902093, 6320.367963203827], "unit": "score", "name": "mootools.html", "value": 4143.856763487836}, {"lowerIsBetter": false, "replicates": [307.85530800523753, 311.0373394344504, 312.89391999282526, 313.9340738444927, 315.2827317851888, 5350.545203657689, 5429.049916264653, 5469.644473109245, 5480.671159730419, 5489.58828087894, 5308.495692909177, 5319.335083114611, 5325.467453254682, 5359.517643412092, 5367.570594352453, 3925.7055720821054, 4072.124493233954, 4194.601512856274, 4200.97899510502, 4213.5997080277475, 4095.856645017425, 4186.183694179636, 4188.5811418858175, 4211.663066954651, 4220.493540775111, 4166.958330416703, 4171.895702607444, 4174.749515029092, 4176.853810116647, 4179.414881916534, 3936.822842972059, 4043.65628921542, 4045.4740883685226, 4134.152498737752, 4157.0023194433425, 3676.246369494247, 3683.1528748388023, 3685.5024571682748, 3689.7048236141045, 3696.1868388954385, 5145.33110695611, 5149.176131818928, 5155.200943853709, 5164.096283150471, 5170.896582068338, 4787.16224660683, 4796.736179510125, 4797.0, 4797.472278049412, 4800.303955926371, 5497.725113744336, 5616.550675945915, 5641.746121424546, 5647.915281270784, 5651.2935883014625, 4014.7992600370158, 4024.094578719794, 4028.979855100735, 4029.7380670256634, 4033.2740106780766, 5966.820995370146, 5969.283685957713, 5969.462748352669, 5972.552058595623, 5973.970130149321, 4150.418941348214, 4155.771432571177, 4156.542780294165, 4156.875293741193, 4159.188958153191, 3947.467091942551, 4081.20416518776, 4086.0397806515443, 4208.494980602286, 4208.642265407475, 4663.906721865544, 4665.930011049837, 4679.532046795293, 4680.204365257914, 4687.67186296956, 5646.661200327993, 5648.915266271009, 5650.576206784508, 5651.717414129277, 5655.0386434306265, 1419.5457453614745, 1446.7395868743727, 1447.486142419447, 1447.5006122887587, 1448.8551144885428, 961.7018724195522, 963.710886733977, 970.0687340153531, 985.3496692183124, 990.6186118344489, 4968.776405061781, 4976.353074100416, 4979.975100124476, 4982.975085124624, 4984.2025275955675, 5877.617954833007, 5889.1755154278435, 5889.352171261244, 5895.056790913433, 5898.970505147447, 4961.2806143109765, 4962.330085438492, 4969.130402179604, 4971.304017437562, 4980.929100243465, 2920.3721199942115, 3011.5128557740677, 3072.7864428304815, 3148.622165340128, 3179.8092114472743, 5583.553315734732, 5601.887962240732, 5602.719864006784, 5616.297962754656, 5630.521405680481, 6034.336223015464, 6041.818745437644, 6043.063325184516, 6044.607100538539, 6047.455728984412, 5474.151506516497, 5611.466910643482, 5613.354464236583, 5615.971920140373, 5617.32592088952, 5935.228420305332, 5938.61399009063, 5944.227250457413, 5944.791932282523, 5946.256717910262, 5778.0, 5780.248567686174, 5782.624129431573, 5784.623999440023, 5791.507721843691, 5622.718864056863, 5624.212610234488, 5629.127485239795, 5629.915551266816, 5629.943700562942, 3959.2675355059405, 3993.8003099845473, 4007.599240075969, 4009.0578714001604, 4058.066644671801, 5844.883102338014, 5896.882062358814, 5897.262842144732, 5899.292084949833, 5904.143899134516, 5662.688552129673, 5667.801626943037, 5667.914981275367, 5673.149027645886, 5674.971625141848, 5586.413426590312, 5693.089105743061, 5701.714914254354, 5708.885822283448, 5714.457126572969, 5565.5825813063375, 5574.470425309589, 5578.916316255179, 5579.525740311957, 5584.972075139598, 5744.770209191753, 5751.798687045934, 5754.597178197653, 5760.020796464527, 5763.827085187451, 5595.664260144405, 5608.214849921096, 5610.046292130266, 5610.719464026701, 5616.073347897551], "unit": "score", "name": "prototype.html", "value": 4261.862739002247}, {"lowerIsBetter": false, "replicates": [711.0542977839474, 757.8234122856546, 763.5266134996302, 767.4090949968528, 795.9721409750658, 11635.185537012412, 11910.642680719582, 11913.285202887833, 11915.165938384316, 11930.045596352293, 11555.884441155586, 12480.188787728792, 12627.62117136485, 12650.873491265085, 12654.873451265485, 646.5926466326208, 655.0534477679755, 811.4928169893816, 818.4516374029399, 832.2426591801462, 817.5544328341039, 817.7342363731811, 825.7522743177053, 825.8719898415756, 825.8761185822144, 855.6064210463195, 863.3222920007795, 863.4819108534891, 863.5984267315697, 864.3042350907548, 616.836538317344, 621.3351713666356, 835.5195762436563, 845.8392905347964, 848.3594885861197, 632.0140580694132, 632.4181752787447, 632.6267502173694, 632.8449529865167, 633.3919437340159, 11810.468528916133, 11909.583164589198, 11911.404429778562, 11929.880701192964, 11966.162368634199, 10526.631567895163, 10593.84109238362, 10614.628488002883, 10911.83632245517, 11104.389258590774, 9148.908510914873, 9418.576164072632, 9445.66940157098, 9459.054094590554, 9494.620215191384, 3269.623993240784, 3278.344331133783, 3300.1914530940076, 3308.801471911693, 3318.070940136766, 39715.0, 39801.80099099486, 40242.39636405456, 40278.19443611112, 40345.39481907774, 8886.644534218558, 8987.146221108984, 8994.370394072483, 9103.226225770752, 9129.178373946377, 15840.287187076608, 15854.207289635473, 15857.365705371656, 15860.92069539645, 15876.761848572281, 6141.692915354214, 6387.808365749035, 6422.614643121335, 6554.901676474857, 6680.0, 3416.3167366526795, 3552.7157827374267, 3582.46263060543, 3587.2287458196615, 3594.478800573902, 2535.847849129021, 2545.3763827862294, 2563.6026415905562, 2563.794896408283, 2564.7307032761664, 469.4413647759156, 473.3160582957593, 477.0982842427814, 488.2456604545985, 492.0896341767773, 483.99032019359413, 542.8045903474746, 554.3680204566797, 594.3105997043496, 603.2067830802481, 7755.0, 7919.485233459806, 7982.800429989296, 8125.471844330218, 8215.178482151856, 564.7882044233412, 589.1427972300378, 623.840920565253, 632.8006677896448, 637.611057255074, 3599.6940260077663, 3740.981295093507, 3752.0, 3789.109559253573, 3888.572257051722, 49970.25044624261, 50130.49869501331, 50153.24770128451, 50278.49721502811, 50500.74749626228, 43368.3494747579, 43581.78209108934, 43751.56248437538, 43820.3426948596, 43873.34189987153, 40246.59753402487, 40251.59748402479, 40396.596034039285, 41555.1688966213, 41559.58440415618, 7666.348360389429, 7752.177774230047, 7868.72459463916, 7926.207379262028, 8046.0, 29266.975655851944, 29351.706482934896, 30089.69910300869, 30114.24714382158, 30185.547216792205, 36385.0, 38923.416148758355, 39672.60327396689, 39725.60274397219, 39933.0, 9173.174414302744, 9207.631694732403, 9304.0, 9407.952960235156, 9435.952820236129, 10152.289339746147, 10217.948910255402, 10315.638952636622, 10365.222608304559, 10484.318519296221, 9685.515724213901, 9892.208623309974, 9943.651972180938, 10081.798364032531, 10151.0, 9090.727278181665, 9266.583003764712, 9272.304577156876, 9649.131578158, 9721.659741909, 9357.298202634693, 9520.904790952001, 9530.094641009093, 9531.618735250513, 9631.662891798753, 8300.958300958177, 8358.87461688063, 8722.825543489222, 9020.86468702983, 9533.094356036165, 8294.834103317778, 8838.779030524289, 8906.376553641183, 9116.817663646823, 9244.625711615347], "unit": "score", "name": "yui.html", "value": 5624.6089320406545}], "name": "dromaeo_css", "value": 6321.584677310492}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 106.0, 112.0, 114.0, 115.0, 101.0, 112.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 153.0, 173.0, 130.0, 154.0, 165.0, 135.0, 167.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 160.0, 162.0, 162.0, 161.0, 162.0, 160.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 88.0, 89.0, 72.0, 72.0, 72.0, 109.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 130.0, 95.0, 95.0, 95.0, 130.0, 95.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 74.0, 73.0, 73.0, 83.0, 71.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 73.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 84.0, 85.0, 86.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [127.0, 137.0, 123.0, 121.0, 127.0, 129.0, 131.0, 127.0, 124.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.5}, {"lowerIsBetter": true, "replicates": [136.0, 142.0, 149.0, 147.0, 147.0, 152.0, 145.0, 147.0, 152.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.2}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 71.0, 73.0, 70.0, 71.0, 69.0, 70.0, 72.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1531.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [185.39117538005192], "unit": "score", "name": "DeltaBlue", "value": 356.6404920000001}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [12600.0], "unit": "score", "name": "Boyer", "value": 52.89388888888888}, {"lowerIsBetter": false, "replicates": [27567.567567567567], "unit": "score", "name": "RegExp", "value": 33.04553431372551}, {"lowerIsBetter": false, "replicates": [604.5949214026602], "unit": "score", "name": "Splay", "value": 134.78611399999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19674.014160247636}]} 04:37:52 INFO - RETURN: dromaeo_css: 6321.59 04:37:52 INFO - RETURN: kraken: 1531.50 04:37:52 INFO - RETURN: v8_7: 19674.01 04:37:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19674.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1531.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6321.59"}}} 04:37:52 INFO - Return code: 0 04:37:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:37:52 INFO - # TBPL SUCCESS # 04:37:52 INFO - Running post-action listener: _resource_record_post_action 04:37:52 INFO - Running post-run listener: _resource_record_post_run 04:37:54 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515194880; Read time: 16; Write time: 765368 04:37:54 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 240758784; Read time: 0; Write time: 510392 04:37:54 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274436096; Read time: 16; Write time: 254976 04:37:54 INFO - Running post-run listener: _upload_blobber_files 04:37:54 INFO - Blob upload gear active. 04:37:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:37:54 INFO - Copying logs to upload dir... 04:37:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.908927 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-16 04:37:53.707782) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:37:53.711392) ========= 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=01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009885 build_url: 'https://queue.taskcluster.net/v1/task/zRrC9vLyTrGSXBAosBnbJg/artifacts/public/build/firefox-46.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-16 04:37:53.761839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:37:53.762165) ========= 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=01deea79d00cc2c334834894000001d2-1450268135.241125-1726388076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:37:53.811729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 04:37:53.812043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 04:37:53.812321) ========= ========= Total master_lag: 1.16 =========