builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1447650544.07 results: success (0) buildid: 20151115200741 builduid: 3bc9a41288084e0e94841eadd4b550da revision: c13d0478272f4601e585db42390df660d2d824bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.071673) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.072209) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.072564) ========= 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=d3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006469 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.098635) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.098978) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.115691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.116058) ========= 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=d3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.165558) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.165902) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.166343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.166702) ========= 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=d3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 21:09:05-- 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% 222M=0s 2015-11-15 21:09:05 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150218 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.329699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.330054) ========= 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=d3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022429 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.451755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.452173) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c13d0478272f4601e585db42390df660d2d824bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c13d0478272f4601e585db42390df660d2d824bf --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=d3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 21:09:05,971 truncating revision to first 12 chars 2015-11-15 21:09:05,971 Setting DEBUG logging. 2015-11-15 21:09:05,971 attempt 1/10 2015-11-15 21:09:05,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c13d0478272f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 21:09:06,224 unpacking tar archive at: mozilla-inbound-c13d0478272f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526423 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.996171) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:04.996483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:05.006856) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:05.007159) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 21:09:05.007582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-15 21:09:05.007936) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-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', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-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=d3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:09:06 INFO - MultiFileLogger online at 20151115 21:09:06 in /builds/slave/test 21:09:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 21:09:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:09:06 INFO - {'append_to_log': False, 21:09:06 INFO - 'base_work_dir': '/builds/slave/test', 21:09:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 21:09:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:09:06 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 21:09:06 INFO - 'buildbot_json_path': 'buildprops.json', 21:09:06 INFO - 'config_files': ('talos/linux_config.py',), 21:09:06 INFO - 'default_actions': ('clobber', 21:09:06 INFO - 'read-buildbot-config', 21:09:06 INFO - 'download-and-extract', 21:09:06 INFO - 'populate-webroot', 21:09:06 INFO - 'create-virtualenv', 21:09:06 INFO - 'install', 21:09:06 INFO - 'run-tests'), 21:09:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:09:06 INFO - 'download_minidump_stackwalk': True, 21:09:06 INFO - 'download_symbols': 'ondemand', 21:09:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:09:06 INFO - 'tooltool.py': '/tools/tooltool.py', 21:09:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:09:06 INFO - '/tools/misc-python/virtualenv.py')}, 21:09:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:09:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:09:06 INFO - 'installer_path': 'installer.exe', 21:09:06 INFO - 'log_level': 'info', 21:09:06 INFO - 'log_name': 'talos', 21:09:06 INFO - 'log_to_console': True, 21:09:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:09:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:09:06 INFO - 'opt_config_files': (), 21:09:06 INFO - 'pip_index': False, 21:09:06 INFO - 'sps_profile': False, 21:09:06 INFO - 'sps_profile_interval': 0, 21:09:06 INFO - 'suite': 'dromaeojs', 21:09:06 INFO - 'system_bits': '64', 21:09:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:09:06 INFO - 'title': 'talos-linux64-ix-050', 21:09:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:09:06 INFO - 'use_talos_json': True, 21:09:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:09:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:09:06 INFO - 'work_dir': 'build'} 21:09:06 INFO - ##### 21:09:06 INFO - ##### Running clobber step. 21:09:06 INFO - ##### 21:09:06 INFO - Running pre-action listener: _resource_record_pre_action 21:09:06 INFO - Running main action method: clobber 21:09:06 INFO - rmtree: /builds/slave/test/build 21:09:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:09:07 INFO - Running post-action listener: _resource_record_post_action 21:09:07 INFO - ##### 21:09:07 INFO - ##### Running read-buildbot-config step. 21:09:07 INFO - ##### 21:09:07 INFO - Running pre-action listener: _resource_record_pre_action 21:09:07 INFO - Running main action method: read_buildbot_config 21:09:07 INFO - Using buildbot properties: 21:09:07 INFO - { 21:09:07 INFO - "properties": { 21:09:07 INFO - "buildnumber": 2864, 21:09:07 INFO - "product": "firefox", 21:09:07 INFO - "script_repo_revision": "production", 21:09:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:09:07 INFO - "repository": "", 21:09:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 21:09:07 INFO - "buildid": "20151115200741", 21:09:07 INFO - "slavename": "talos-linux64-ix-050", 21:09:07 INFO - "pgo_build": "False", 21:09:07 INFO - "basedir": "/builds/slave/test", 21:09:07 INFO - "project": "", 21:09:07 INFO - "platform": "ubuntu64_hw", 21:09:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:09:07 INFO - "slavebuilddir": "test", 21:09:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 21:09:07 INFO - "branch": "mozilla-inbound", 21:09:07 INFO - "repo_path": "integration/mozilla-inbound", 21:09:07 INFO - "stage_platform": "linux64", 21:09:07 INFO - "builduid": "3bc9a41288084e0e94841eadd4b550da", 21:09:07 INFO - "revision": "c13d0478272f4601e585db42390df660d2d824bf" 21:09:07 INFO - }, 21:09:07 INFO - "sourcestamp": { 21:09:07 INFO - "repository": "", 21:09:07 INFO - "hasPatch": false, 21:09:07 INFO - "project": "", 21:09:07 INFO - "branch": "mozilla-inbound-linux64-talos", 21:09:07 INFO - "changes": [ 21:09:07 INFO - { 21:09:07 INFO - "category": null, 21:09:07 INFO - "files": [ 21:09:07 INFO - { 21:09:07 INFO - "url": null, 21:09:07 INFO - "name": "https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:09:07 INFO - } 21:09:07 INFO - ], 21:09:07 INFO - "repository": "", 21:09:07 INFO - "rev": "c13d0478272f4601e585db42390df660d2d824bf", 21:09:07 INFO - "who": "mwoodrow@mozilla.com", 21:09:07 INFO - "when": 1447650440, 21:09:07 INFO - "number": 6664797, 21:09:07 INFO - "comments": "Bug 1217012 - Use doubles when untransforming points since we need the extra precision. r=kip", 21:09:07 INFO - "project": "", 21:09:07 INFO - "at": "Sun 15 Nov 2015 21:07:20", 21:09:07 INFO - "branch": "mozilla-inbound-linux64-talos", 21:09:07 INFO - "revlink": "", 21:09:07 INFO - "properties": [ 21:09:07 INFO - [ 21:09:07 INFO - "buildid", 21:09:07 INFO - "20151115200741", 21:09:07 INFO - "Change" 21:09:07 INFO - ], 21:09:07 INFO - [ 21:09:07 INFO - "builduid", 21:09:07 INFO - "3bc9a41288084e0e94841eadd4b550da", 21:09:07 INFO - "Change" 21:09:07 INFO - ], 21:09:07 INFO - [ 21:09:07 INFO - "pgo_build", 21:09:07 INFO - "False", 21:09:07 INFO - "Change" 21:09:07 INFO - ] 21:09:07 INFO - ], 21:09:07 INFO - "revision": "c13d0478272f4601e585db42390df660d2d824bf" 21:09:07 INFO - } 21:09:07 INFO - ], 21:09:07 INFO - "revision": "c13d0478272f4601e585db42390df660d2d824bf" 21:09:07 INFO - } 21:09:07 INFO - } 21:09:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:09:07 INFO - Running post-action listener: _resource_record_post_action 21:09:07 INFO - ##### 21:09:07 INFO - ##### Running download-and-extract step. 21:09:07 INFO - ##### 21:09:07 INFO - Running pre-action listener: _resource_record_pre_action 21:09:07 INFO - Running main action method: download_and_extract 21:09:07 INFO - mkdir: /builds/slave/test/build/tests 21:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:07 INFO - https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/test_packages.json 21:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/test_packages.json 21:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:09:11 INFO - Downloaded 1302 bytes. 21:09:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:09:11 INFO - Using the following test package requirements: 21:09:11 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:09:11 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:09:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:09:11 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:09:11 INFO - u'jsshell-linux-x86_64.zip'], 21:09:11 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:09:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:09:11 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:09:11 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:09:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:09:11 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:09:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:09:11 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:09:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:09:11 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:09:11 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:09:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:09:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:09:11 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')]} 21:09:11 INFO - https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:09:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:09:13 INFO - Downloaded 21278031 bytes. 21:09:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 21:09:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:09:14 INFO - Return code: 0 21:09:14 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:09: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')]} 21:09:14 INFO - https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:09:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:09:19 INFO - Downloaded 21278031 bytes. 21:09:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 21:09:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:09:21 INFO - Return code: 0 21:09:21 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')]} 21:09:21 INFO - https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:09:21 INFO - Downloaded 11131693 bytes. 21:09:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 21:09:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:09:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:09:22 INFO - Return code: 0 21:09:22 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')]} 21:09:22 INFO - https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:09:23 INFO - Downloaded 55594304 bytes. 21:09:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:23 INFO - mkdir: /builds/slave/test/properties 21:09:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:09:23 INFO - Writing to file /builds/slave/test/properties/build_url 21:09:23 INFO - Contents: 21:09:23 INFO - build_url:https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:23 INFO - Running post-action listener: _resource_record_post_action 21:09:23 INFO - Running post-action listener: set_extra_try_arguments 21:09:23 INFO - ##### 21:09:23 INFO - ##### Running populate-webroot step. 21:09:23 INFO - ##### 21:09:23 INFO - Running pre-action listener: _resource_record_pre_action 21:09:23 INFO - Running main action method: populate_webroot 21:09:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:09:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:09:23 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:09:23 INFO - '../fennec_ids.txt'], 21:09:23 INFO - 'tests': ['tcheck2']}, 21:09:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:09:23 INFO - '--tppagecycles', 21:09:23 INFO - '7'], 21:09:23 INFO - 'tests': ['tsvgm']}}, 21:09:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:09:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:09:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:09:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:09:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:09:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:23 INFO - 'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:09:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:23 INFO - 'tests': ['damp', 'tps']}, 21:09:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:23 INFO - 'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['damp', 'tps']}, 21:09:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:09:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:09:23 INFO - 'other': {'tests': ['a11yr', 21:09:23 INFO - 'ts_paint', 21:09:23 INFO - 'tpaint', 21:09:23 INFO - 'sessionrestore', 21:09:23 INFO - 'sessionrestore_no_auto_restore']}, 21:09:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['a11yr', 21:09:23 INFO - 'ts_paint', 21:09:23 INFO - 'tpaint', 21:09:23 INFO - 'sessionrestore', 21:09:23 INFO - 'sessionrestore_no_auto_restore']}, 21:09:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['a11yr', 21:09:23 INFO - 'ts_paint', 21:09:23 INFO - 'tpaint', 21:09:23 INFO - 'sessionrestore', 21:09:23 INFO - 'sessionrestore_no_auto_restore']}, 21:09:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['a11yr', 21:09:23 INFO - 'ts_paint', 21:09:23 INFO - 'tpaint', 21:09:23 INFO - 'sessionrestore', 21:09:23 INFO - 'sessionrestore_no_auto_restore']}, 21:09:23 INFO - 'other_l64': {'tests': ['a11yr', 21:09:23 INFO - 'ts_paint', 21:09:23 INFO - 'tpaint', 21:09:23 INFO - 'sessionrestore', 21:09:23 INFO - 'sessionrestore_no_auto_restore']}, 21:09:23 INFO - 'other_nol64': {'tests': ['a11yr', 21:09:23 INFO - 'ts_paint', 21:09:23 INFO - 'tpaint', 21:09:23 INFO - 'sessionrestore', 21:09:23 INFO - 'sessionrestore_no_auto_restore']}, 21:09:23 INFO - 'svgr': {'tests': ['tsvgx', 21:09:23 INFO - 'tsvgr_opacity', 21:09:23 INFO - 'tart', 21:09:23 INFO - 'tscrollx', 21:09:23 INFO - 'cart']}, 21:09:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['tsvgx', 21:09:23 INFO - 'tsvgr_opacity', 21:09:23 INFO - 'tart', 21:09:23 INFO - 'tscrollx', 21:09:23 INFO - 'cart']}, 21:09:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:23 INFO - 'tests': ['tp5o']}, 21:09:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:23 INFO - 'talos_options': ['--e10s'], 21:09:23 INFO - 'tests': ['tp5o']}, 21:09:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:23 INFO - 'talos_options': ['--xperf_path', 21:09:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:09:23 INFO - 'tests': ['tp5n']}, 21:09:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:23 INFO - 'talos_options': ['--e10s', 21:09:23 INFO - '--xperf_path', 21:09:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:09:23 INFO - 'tests': ['tp5n']}}, 21:09:23 INFO - 'talos.zip': {'path': '', 21:09:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:09:23 INFO - Running post-action listener: _resource_record_post_action 21:09:23 INFO - ##### 21:09:23 INFO - ##### Running create-virtualenv step. 21:09:23 INFO - ##### 21:09:23 INFO - Running pre-action listener: _resource_record_pre_action 21:09:23 INFO - Running main action method: create_virtualenv 21:09:23 INFO - Creating virtualenv /builds/slave/test/build/venv 21:09:23 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 21:09:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:09:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:09:24 INFO - Using real prefix '/usr' 21:09:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:09:24 INFO - Installing distribute.............................................................................................................................................................................................done. 21:09:26 INFO - Installing pip.................done. 21:09:26 INFO - Return code: 0 21:09:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:09:26 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')]} 21:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:26 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')]} 21:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:26 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 0x7fc54a629c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2704ac0>, '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 0x27059a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705e50>, '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': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', '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 21:09:26 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 21:09:26 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 21:09:26 INFO - Using env: {'DISPLAY': ':0', 21:09:26 INFO - 'HOME': '/home/cltbld', 21:09:26 INFO - 'LANG': 'en_US.UTF-8', 21:09:26 INFO - 'LANGUAGE': 'en_US:en', 21:09:26 INFO - 'LOGNAME': 'cltbld', 21:09:26 INFO - 'MAIL': '/var/mail/cltbld', 21:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:26 INFO - 'MOZ_NO_REMOTE': '1', 21:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:26 INFO - 'NO_EM_RESTART': '1', 21:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:26 INFO - 'PWD': '/builds/slave/test', 21:09:26 INFO - 'SHELL': '/bin/bash', 21:09:26 INFO - 'SHLVL': '1', 21:09:26 INFO - 'TERM': 'linux', 21:09:26 INFO - 'TMOUT': '86400', 21:09:26 INFO - 'USER': 'cltbld', 21:09:26 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', 21:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:26 INFO - '_': '/tools/buildbot/bin/python'} 21:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:26 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 21:09:26 INFO - Cleaning up... 21:09:26 INFO - Return code: 0 21:09:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:09:26 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')]} 21:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:26 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')]} 21:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:26 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 0x7fc54a629c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2704ac0>, '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 0x27059a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705e50>, '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': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', '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 21:09:26 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 21:09:26 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 21:09:26 INFO - Using env: {'DISPLAY': ':0', 21:09:26 INFO - 'HOME': '/home/cltbld', 21:09:26 INFO - 'LANG': 'en_US.UTF-8', 21:09:26 INFO - 'LANGUAGE': 'en_US:en', 21:09:26 INFO - 'LOGNAME': 'cltbld', 21:09:26 INFO - 'MAIL': '/var/mail/cltbld', 21:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:26 INFO - 'MOZ_NO_REMOTE': '1', 21:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:26 INFO - 'NO_EM_RESTART': '1', 21:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:26 INFO - 'PWD': '/builds/slave/test', 21:09:26 INFO - 'SHELL': '/bin/bash', 21:09:26 INFO - 'SHLVL': '1', 21:09:26 INFO - 'TERM': 'linux', 21:09:26 INFO - 'TMOUT': '86400', 21:09:26 INFO - 'USER': 'cltbld', 21:09:26 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', 21:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:26 INFO - '_': '/tools/buildbot/bin/python'} 21:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:27 INFO - Downloading/unpacking psutil>=0.7.1 21:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:09:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:09:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:28 INFO - Installing collected packages: psutil 21:09:28 INFO - Running setup.py install for psutil 21:09:28 INFO - building 'psutil._psutil_linux' extension 21:09:28 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 21:09:29 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 21:09:29 INFO - building 'psutil._psutil_posix' extension 21:09:29 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 21:09:29 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 21:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:29 INFO - Successfully installed psutil 21:09:29 INFO - Cleaning up... 21:09:29 INFO - Return code: 0 21:09:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc54a629c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2704ac0>, '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 0x27059a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705e50>, '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': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', '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 21:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:09:29 INFO - Using env: {'DISPLAY': ':0', 21:09:29 INFO - 'HOME': '/home/cltbld', 21:09:29 INFO - 'LANG': 'en_US.UTF-8', 21:09:29 INFO - 'LANGUAGE': 'en_US:en', 21:09:29 INFO - 'LOGNAME': 'cltbld', 21:09:29 INFO - 'MAIL': '/var/mail/cltbld', 21:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:29 INFO - 'MOZ_NO_REMOTE': '1', 21:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:29 INFO - 'NO_EM_RESTART': '1', 21:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:29 INFO - 'PWD': '/builds/slave/test', 21:09:29 INFO - 'SHELL': '/bin/bash', 21:09:29 INFO - 'SHLVL': '1', 21:09:29 INFO - 'TERM': 'linux', 21:09:29 INFO - 'TMOUT': '86400', 21:09:29 INFO - 'USER': 'cltbld', 21:09:29 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', 21:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:29 INFO - '_': '/tools/buildbot/bin/python'} 21:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:09:29 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 21:09:29 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 21:09:29 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 21:09:29 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 21:09:29 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 21:09:29 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 21:09:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:09:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:09:31 INFO - Installing collected packages: mozsystemmonitor 21:09:31 INFO - Running setup.py install for mozsystemmonitor 21:09:31 INFO - Successfully installed mozsystemmonitor 21:09:31 INFO - Cleaning up... 21:09:31 INFO - Return code: 0 21:09:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:09:31 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')]} 21:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:31 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')]} 21:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:31 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 0x7fc54a629c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2704ac0>, '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 0x27059a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705e50>, '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': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', '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 21:09:31 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 21:09:31 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 21:09:31 INFO - Using env: {'DISPLAY': ':0', 21:09:31 INFO - 'HOME': '/home/cltbld', 21:09:31 INFO - 'LANG': 'en_US.UTF-8', 21:09:31 INFO - 'LANGUAGE': 'en_US:en', 21:09:31 INFO - 'LOGNAME': 'cltbld', 21:09:31 INFO - 'MAIL': '/var/mail/cltbld', 21:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:31 INFO - 'MOZ_NO_REMOTE': '1', 21:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:31 INFO - 'NO_EM_RESTART': '1', 21:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:31 INFO - 'PWD': '/builds/slave/test', 21:09:31 INFO - 'SHELL': '/bin/bash', 21:09:31 INFO - 'SHLVL': '1', 21:09:31 INFO - 'TERM': 'linux', 21:09:31 INFO - 'TMOUT': '86400', 21:09:31 INFO - 'USER': 'cltbld', 21:09:31 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', 21:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:31 INFO - '_': '/tools/buildbot/bin/python'} 21:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:31 INFO - Downloading/unpacking blobuploader==1.2.4 21:09:31 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 21:09:31 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 21:09:31 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 21:09:31 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 21:09:31 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 21:09:31 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 21:09:33 INFO - Downloading blobuploader-1.2.4.tar.gz 21:09:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:09:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:09:33 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 21:09:33 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 21:09:33 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 21:09:33 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 21:09:33 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 21:09:33 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 21:09:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:09:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:09:33 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 21:09:33 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 21:09:33 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 21:09:33 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 21:09:33 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 21:09:33 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 21:09:33 INFO - Downloading docopt-0.6.1.tar.gz 21:09:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:09:33 INFO - Installing collected packages: blobuploader, requests, docopt 21:09:33 INFO - Running setup.py install for blobuploader 21:09:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:09:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:09:34 INFO - Running setup.py install for requests 21:09:34 INFO - Running setup.py install for docopt 21:09:34 INFO - Successfully installed blobuploader requests docopt 21:09:34 INFO - Cleaning up... 21:09:34 INFO - Return code: 0 21:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:34 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')]} 21:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:34 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')]} 21:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:34 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 0x7fc54a629c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2704ac0>, '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 0x27059a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705e50>, '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': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', '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 21:09:34 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 21:09:34 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 21:09:34 INFO - Using env: {'DISPLAY': ':0', 21:09:34 INFO - 'HOME': '/home/cltbld', 21:09:34 INFO - 'LANG': 'en_US.UTF-8', 21:09:34 INFO - 'LANGUAGE': 'en_US:en', 21:09:34 INFO - 'LOGNAME': 'cltbld', 21:09:34 INFO - 'MAIL': '/var/mail/cltbld', 21:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:34 INFO - 'MOZ_NO_REMOTE': '1', 21:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:34 INFO - 'NO_EM_RESTART': '1', 21:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:34 INFO - 'PWD': '/builds/slave/test', 21:09:34 INFO - 'SHELL': '/bin/bash', 21:09:34 INFO - 'SHLVL': '1', 21:09:34 INFO - 'TERM': 'linux', 21:09:34 INFO - 'TMOUT': '86400', 21:09:34 INFO - 'USER': 'cltbld', 21:09:34 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', 21:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:34 INFO - '_': '/tools/buildbot/bin/python'} 21:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:34 INFO - Running setup.py (path:/tmp/pip-FCncax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:34 INFO - Running setup.py (path:/tmp/pip-WKzuwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:34 INFO - Running setup.py (path:/tmp/pip-dW3hfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:34 INFO - Running setup.py (path:/tmp/pip-hFhdcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:35 INFO - Running setup.py (path:/tmp/pip-7Pjn0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:35 INFO - Running setup.py (path:/tmp/pip-lglB5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:35 INFO - Running setup.py (path:/tmp/pip-0OcbM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:35 INFO - Running setup.py (path:/tmp/pip-gpoiFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:35 INFO - Running setup.py (path:/tmp/pip-JBYfFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:35 INFO - Running setup.py (path:/tmp/pip-XXclLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:35 INFO - Running setup.py (path:/tmp/pip-GwgNne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:35 INFO - Running setup.py (path:/tmp/pip-osAaqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:35 INFO - Running setup.py (path:/tmp/pip-QxEozE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:35 INFO - Running setup.py (path:/tmp/pip-Sa_I1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:35 INFO - Running setup.py (path:/tmp/pip-2nACz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:35 INFO - Running setup.py (path:/tmp/pip-gMDW1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:35 INFO - Running setup.py (path:/tmp/pip-EUawUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:09:35 INFO - Running setup.py install for manifestparser 21:09:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Running setup.py install for mozcrash 21:09:36 INFO - Running setup.py install for mozdebug 21:09:36 INFO - Running setup.py install for mozdevice 21:09:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Running setup.py install for mozfile 21:09:36 INFO - Running setup.py install for mozhttpd 21:09:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Running setup.py install for mozinfo 21:09:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Running setup.py install for mozInstall 21:09:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Running setup.py install for mozleak 21:09:36 INFO - Running setup.py install for mozlog 21:09:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:09:36 INFO - Running setup.py install for moznetwork 21:09:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:09:37 INFO - Running setup.py install for mozprocess 21:09:37 INFO - Running setup.py install for mozprofile 21:09:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:09:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:09:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:09:37 INFO - Running setup.py install for mozrunner 21:09:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:09:37 INFO - Running setup.py install for mozscreenshot 21:09:37 INFO - Running setup.py install for moztest 21:09:37 INFO - Running setup.py install for mozversion 21:09:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:09:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:09:37 INFO - Cleaning up... 21:09:37 INFO - Return code: 0 21:09:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:37 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')]} 21:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:37 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')]} 21:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:37 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 0x7fc54a629c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2704ac0>, '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 0x27059a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705e50>, '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': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', '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 21:09:37 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 21:09:37 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 21:09:37 INFO - Using env: {'DISPLAY': ':0', 21:09:37 INFO - 'HOME': '/home/cltbld', 21:09:37 INFO - 'LANG': 'en_US.UTF-8', 21:09:37 INFO - 'LANGUAGE': 'en_US:en', 21:09:37 INFO - 'LOGNAME': 'cltbld', 21:09:37 INFO - 'MAIL': '/var/mail/cltbld', 21:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:37 INFO - 'MOZ_NO_REMOTE': '1', 21:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:37 INFO - 'NO_EM_RESTART': '1', 21:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:37 INFO - 'PWD': '/builds/slave/test', 21:09:37 INFO - 'SHELL': '/bin/bash', 21:09:37 INFO - 'SHLVL': '1', 21:09:37 INFO - 'TERM': 'linux', 21:09:37 INFO - 'TMOUT': '86400', 21:09:37 INFO - 'USER': 'cltbld', 21:09:37 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', 21:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:37 INFO - '_': '/tools/buildbot/bin/python'} 21:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:37 INFO - Running setup.py (path:/tmp/pip-1BcAyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:38 INFO - Running setup.py (path:/tmp/pip-Lq3To_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:38 INFO - Running setup.py (path:/tmp/pip-jwhkwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:38 INFO - Running setup.py (path:/tmp/pip-TxMd2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:38 INFO - Running setup.py (path:/tmp/pip-c7tGnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:38 INFO - Running setup.py (path:/tmp/pip-XRWLyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:38 INFO - Running setup.py (path:/tmp/pip-O_0JBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:38 INFO - Running setup.py (path:/tmp/pip-kTa_yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:38 INFO - Running setup.py (path:/tmp/pip-V0OfP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:38 INFO - Running setup.py (path:/tmp/pip-h57hcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:38 INFO - Running setup.py (path:/tmp/pip-YzFPxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:38 INFO - Running setup.py (path:/tmp/pip-QtgStj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:38 INFO - Running setup.py (path:/tmp/pip-W2XP9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:38 INFO - Running setup.py (path:/tmp/pip-vRB6nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:38 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)) 21:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:38 INFO - Running setup.py (path:/tmp/pip-UxjdZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:39 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)) 21:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:39 INFO - Running setup.py (path:/tmp/pip-mRELBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:39 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)) 21:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:39 INFO - Running setup.py (path:/tmp/pip-TOpA73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:39 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)) 21:09:39 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)) 21:09:39 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)) 21:09:39 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)) 21:09:39 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)) 21:09:39 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)) 21:09:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:39 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 21:09:39 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 21:09:39 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 21:09:39 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 21:09:39 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 21:09:39 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 21:09:40 INFO - Downloading blessings-1.5.1.tar.gz 21:09:40 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 21:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:09:40 INFO - Installing collected packages: blessings 21:09:40 INFO - Running setup.py install for blessings 21:09:41 INFO - Successfully installed blessings 21:09:41 INFO - Cleaning up... 21:09:41 INFO - Return code: 0 21:09:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:41 INFO - Reading from file tmpfile_stdout 21:09:41 INFO - Current package versions: 21:09:41 INFO - argparse == 1.2.1 21:09:41 INFO - blessings == 1.5.1 21:09:41 INFO - blobuploader == 1.2.4 21:09:41 INFO - docopt == 0.6.1 21:09:41 INFO - manifestparser == 1.1 21:09:41 INFO - mozInstall == 1.12 21:09:41 INFO - mozcrash == 0.16 21:09:41 INFO - mozdebug == 0.1 21:09:41 INFO - mozdevice == 0.47 21:09:41 INFO - mozfile == 1.2 21:09:41 INFO - mozhttpd == 0.7 21:09:41 INFO - mozinfo == 0.9 21:09:41 INFO - mozleak == 0.1 21:09:41 INFO - mozlog == 3.0 21:09:41 INFO - moznetwork == 0.27 21:09:41 INFO - mozprocess == 0.22 21:09:41 INFO - mozprofile == 0.27 21:09:41 INFO - mozrunner == 6.11 21:09:41 INFO - mozscreenshot == 0.1 21:09:41 INFO - mozsystemmonitor == 0.0 21:09:41 INFO - moztest == 0.7 21:09:41 INFO - mozversion == 1.4 21:09:41 INFO - psutil == 3.1.1 21:09:41 INFO - requests == 1.2.3 21:09:41 INFO - wsgiref == 0.1.2 21:09:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:41 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 0x7fc54a629c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2704ac0>, '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 0x27059a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705e50>, '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': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', '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 21:09:41 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 21:09:41 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 21:09:41 INFO - Using env: {'DISPLAY': ':0', 21:09:41 INFO - 'HOME': '/home/cltbld', 21:09:41 INFO - 'LANG': 'en_US.UTF-8', 21:09:41 INFO - 'LANGUAGE': 'en_US:en', 21:09:41 INFO - 'LOGNAME': 'cltbld', 21:09:41 INFO - 'MAIL': '/var/mail/cltbld', 21:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:41 INFO - 'MOZ_NO_REMOTE': '1', 21:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:41 INFO - 'NO_EM_RESTART': '1', 21:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:41 INFO - 'PWD': '/builds/slave/test', 21:09:41 INFO - 'SHELL': '/bin/bash', 21:09:41 INFO - 'SHLVL': '1', 21:09:41 INFO - 'TERM': 'linux', 21:09:41 INFO - 'TMOUT': '86400', 21:09:41 INFO - 'USER': 'cltbld', 21:09:41 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', 21:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:41 INFO - '_': '/tools/buildbot/bin/python'} 21:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 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)) 21:09:41 INFO - Cleaning up... 21:09:41 INFO - Return code: 0 21:09:41 INFO - Running post-action listener: _resource_record_post_action 21:09:41 INFO - Running post-action listener: _start_resource_monitoring 21:09:41 INFO - Starting resource monitoring. 21:09:41 INFO - ##### 21:09:41 INFO - ##### Running install step. 21:09:41 INFO - ##### 21:09:41 INFO - Running pre-action listener: _resource_record_pre_action 21:09:41 INFO - Running main action method: install 21:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:41 INFO - Reading from file tmpfile_stdout 21:09:41 INFO - Detecting whether we're running mozinstall >=1.0... 21:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:09:41 INFO - Reading from file tmpfile_stdout 21:09:41 INFO - Output received: 21:09:41 INFO - Usage: mozinstall [options] installer 21:09:41 INFO - Options: 21:09:41 INFO - -h, --help show this help message and exit 21:09:41 INFO - -d DEST, --destination=DEST 21:09:41 INFO - Directory to install application into. [default: 21:09:41 INFO - "/builds/slave/test"] 21:09:41 INFO - --app=APP Application being installed. [default: firefox] 21:09:41 INFO - mkdir: /builds/slave/test/build/application 21:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:09:55 INFO - Reading from file tmpfile_stdout 21:09:55 INFO - Output received: 21:09:55 INFO - /builds/slave/test/build/application/firefox/firefox 21:09:55 INFO - Running post-action listener: _resource_record_post_action 21:09:55 INFO - ##### 21:09:55 INFO - ##### Running run-tests step. 21:09:55 INFO - ##### 21:09:55 INFO - Running pre-action listener: _resource_record_pre_action 21:09:55 INFO - Running main action method: run_tests 21:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:09:55 INFO - Python 2.7.3 21:09:55 INFO - Return code: 0 21:09:55 INFO - grabbing minidump binary from tooltool 21:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:55 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 0x2704ac0>, '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 0x27059a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:09:55 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 21:09:55 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 21:09:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:09:55 INFO - Return code: 0 21:09:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:09:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:09:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:09:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:09:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] in /builds/slave/test/build 21:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost 21:09:55 INFO - Using env: {'DISPLAY': ':0', 21:09:55 INFO - 'HOME': '/home/cltbld', 21:09:55 INFO - 'LANG': 'en_US.UTF-8', 21:09:55 INFO - 'LANGUAGE': 'en_US:en', 21:09:55 INFO - 'LOGNAME': 'cltbld', 21:09:55 INFO - 'MAIL': '/var/mail/cltbld', 21:09:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:09:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:55 INFO - 'MOZ_NO_REMOTE': '1', 21:09:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:55 INFO - 'NO_EM_RESTART': '1', 21:09:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:55 INFO - 'PWD': '/builds/slave/test', 21:09:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:09:55 INFO - 'SHELL': '/bin/bash', 21:09:55 INFO - 'SHLVL': '1', 21:09:55 INFO - 'TERM': 'linux', 21:09:55 INFO - 'TMOUT': '86400', 21:09:55 INFO - 'USER': 'cltbld', 21:09:55 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800', 21:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:55 INFO - '_': '/tools/buildbot/bin/python'} 21:09:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] with output_timeout 3600 21:09:56 INFO - mozversion INFO | application_buildid: 20151115200741 21:09:56 INFO - mozversion INFO | application_changeset: c13d0478272f4601e585db42390df660d2d824bf 21:09:56 INFO - mozversion INFO | application_display_name: Nightly 21:09:56 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:09:56 INFO - mozversion INFO | application_name: Firefox 21:09:56 INFO - mozversion INFO | application_remotingname: firefox 21:09:56 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:09:56 INFO - mozversion INFO | application_vendor: Mozilla 21:09:56 INFO - mozversion INFO | application_version: 45.0a1 21:09:56 INFO - mozversion INFO | platform_buildid: 20151115200741 21:09:56 INFO - mozversion INFO | platform_changeset: c13d0478272f4601e585db42390df660d2d824bf 21:09:56 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:09:56 INFO - mozversion INFO | platform_version: 45.0a1 21:09:56 INFO - 2015-11-15 21:09:56,142 DEBUG : using testdate: 1447650596 21:09:56 INFO - 2015-11-15 21:09:56,142 DEBUG : actual date: 1447650596 21:09:56 INFO - 2015-11-15 21:09:56,194 INFO : starting webserver on 'localhost:60746' 21:09:56 INFO - 2015-11-15 21:09:56,194 INFO : Starting test suite talos-linux64-ix-050 21:09:56 INFO - 2015-11-15 21:09:56,194 INFO : Starting test dromaeo_css 21:09:56 INFO - 2015-11-15 21:09:56,195 DEBUG : operating with platform_type : linux_ 21:09:56 INFO - 2015-11-15 21:09:56,195 INFO : Initialising browser for dromaeo_css test... 21:09:56 INFO - 2015-11-15 21:09:56,202 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdju5N/profile http://localhost:60746/getInfo.html 21:10:00 INFO - 2015-11-15 21:10:00,385 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:10:00 INFO - 2015-11-15 21:10:00,385 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:10:00 INFO - 2015-11-15 21:10:00,385 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:10:00 INFO - 2015-11-15 21:10:00,386 DEBUG : BROWSER_OUTPUT: __metrics 21:10:00 INFO - 2015-11-15 21:10:00,508 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:10:01 INFO - 2015-11-15 21:10:01,821 INFO : Browser initialized. 21:10:01 INFO - 2015-11-15 21:10:01,822 INFO : Running cycle 1/1 for dromaeo_css test... 21:10:01 INFO - 2015-11-15 21:10:01,822 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdju5N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:10:13 INFO - 2015-11-15 21:10:13,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 141463552 21:10:13 INFO - 2015-11-15 21:10:13,727 DEBUG : BROWSER_OUTPUT: 21:11:04 INFO - 2015-11-15 21:11:04,898 DEBUG : BROWSER_OUTPUT: 1447650664898 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] 21:13:18 INFO - 2015-11-15 21:13:18,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60746/tests/dromaeo/cssquery-ext.html) 21:13:19 INFO - 2015-11-15 21:13:19,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 252837888 21:13:19 INFO - 2015-11-15 21:13:19,452 DEBUG : BROWSER_OUTPUT: 21:16:22 INFO - 2015-11-15 21:16:22,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/dromaeo/cssquery-ext.html (next: http://localhost:60746/tests/dromaeo/cssquery-jquery.html) 21:16:22 INFO - 2015-11-15 21:16:22,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 218054656 21:16:22 INFO - 2015-11-15 21:16:22,623 DEBUG : BROWSER_OUTPUT: 21:19:24 INFO - 2015-11-15 21:19:24,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60746/tests/dromaeo/cssquery-mootools.html) 21:19:25 INFO - 2015-11-15 21:19:25,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 206188544 21:19:25 INFO - 2015-11-15 21:19:25,255 DEBUG : BROWSER_OUTPUT: 21:22:27 INFO - 2015-11-15 21:22:27,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60746/tests/dromaeo/cssquery-prototype.html) 21:22:27 INFO - 2015-11-15 21:22:27,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 198909952 21:22:27 INFO - 2015-11-15 21:22:27,803 DEBUG : BROWSER_OUTPUT: 21:25:30 INFO - 2015-11-15 21:25:30,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60746/tests/dromaeo/cssquery-yui.html) 21:25:31 INFO - 2015-11-15 21:25:31,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 206073856 21:25:31 INFO - 2015-11-15 21:25:31,043 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/dromaeo/cssquery-yui.html (next: http://localhost:60746/tests/dromaeo/cssquery-dojo.html) 21:28:33 INFO - 2015-11-15 21:28:33,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 252071936 21:28:33 INFO - 2015-11-15 21:28:33,654 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,658 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:28:33 INFO - 2015-11-15 21:28:33,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:28:33 INFO - 2015-11-15 21:28:33,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:28:33 INFO - 2015-11-15 21:28:33,658 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:28:33 INFO - 2015-11-15 21:28:33,659 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2673.0510668712604;2768.238734348054;2769.113883557261;2773.8890444382228;2794.0220922677067;4607.861764147073;4749.263864101061;4761.880952976173;4779.498152693969;4779.856604301872;4688.765561721917;4695.976520117395;4757.0723708876785;4768.952310476894;4774.9761251193695;4351.586599273064;4361.040571074366;4415.757133357664;4486.573775491323;4524.253498172798;4262.147570485899;4457.866264012085;4477.037436951055;4531.13908357411;4534.455865296152;4327.199468098412;4408.669349798778;4423.557644235583;4425.579569940851;4436.844710435152;4412.602865742067;4413.227685155117;4429.114177164548;4443.888902777424;4443.933340999887;4236.406903033547;4373.956260437419;4401.5818497243035;4404.427424434835;4436.134953684033;4623;4674.018456124218;4701.200795864711;4738.384010078702;4766.952330476685;5135.38375394955;5180.093483640348;5188.5849132069725;5209.062368773619;5223.895522089575;4913.754312284407;5196.168613021899;5202.557782588485;5209.114450543417;5228.058949389108;4667.929981050287;4683.110209060268;4691.366665500113;4751.028323245883;4752.500987396274;5244.816431424958;5246.213068039825;5246.711430871263;5249.790008399621;5258.526732594085;4849.709017458964;5046;5060.7722652480725;5060.797568097309;5088.872778180576;4926.704397736147;4929.383827021622;5001.624878134155;5054.671446355975;5078.314427552307;5065.670731402521;5081.0854046272025;5089.847304580869;5102.081625307406;5140.460251673595;4852.587530059985;5062.088824011639;5063.645544811828;5074.543291103744;5076.82231121909;4144.668426525871;4194.979025104855;4217.388478670576;4227.87316380509;4245.27830268855;3714.647108524686;3716.5168528091176;3728.6271372862498;3728.627137286304;3744.363458212056;4264.061906380592;4382;4394.648428125806;4396.07682386696;4422.29243321067;4950.8267210647455;5023.221400682827;5028.5977121830165;5071.366079240095;5097.719625420637;4342.956570434319;4383.3863259143745;4384.013596940663;4398.164348773723;4406.581374769392;4326.480822301344;4446.355278484666;4540.432445944257;4544.091181763594;4574.565416285448;4744.478107408251;4757.215059515142;4794.352762377174;4820.108279968217;4850.5149485051215;5085.211792172219;5116.9744151279;5117.795288188431;5133.563647090039;5160.793568257228;4585.839495617771;4699.929501057419;4863.659543831898;4866.29438731389;4909.5090490950615;4893.73084480357;4941.061198372297;4956.628252880976;4964.652474326763;4997.225430058346;5032.6225533084435;5111.361079865017;5114.539691427789;5122.641415100908;5174.482551744795;4795.856124316276;4925.261210818406;4940.258961155855;4966.900661986812;4971.502849715;4833.492483289345;4872.123017856819;4910.7544622768;4914.803407863646;4926.704397736147;4844.224924012141;4847.587955023862;4857.101436234308;4858.465568787501;4894.216925291937;4829.517048295143;4937.160682683881;4948.901021979612;4949.406071271471;4999.125153098266;4728.739919304471;4757.690750101232;4765.7140571565815;4782.665213435026;4811.903761924812 21:28:33 INFO - 2015-11-15 21:28:33,662 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.5984251181661;570.0821677099868;570.1077813222307;578.2887048929817;593.0155941137713;27857;28657.570136447943;34638.99999999997;35505.46741798875;35526.2894742105;39849;40425.59574404255;40449;40500.39249411254;40515;6960.269171736971;7932.881006784888;8094.635741391651;8099.838003239932;8112.878306825402;6947.027416161742;10289.742756431075;10530.736731581734;10532.315399499008;10533.420661863594;9972.85040724386;10059.34614250075;10060.647877324294;10061.698149055503;10064.04391582802;6977.720891164347;7116.074910261685;10114.190864730805;10132.696019119438;10207.693769186937;9715.61137554497;9930.602775888956;9970.351927124713;9990.90009099907;10025.59897604095;36558;37185.62814371849;37209.62790372089;37255.441168382495;37265.25469490595;2850.8432036238;2920.7225313595172;2935.2074939766358;2960.259935016246;3320.335932813447;28046.859765701243;28482.715172848213;28616.71383286182;28963.131106066852;29188.562171567442;2997.9400411991637;3020.5469179623014;3026.9394612107635;3058.9847050764824;3064.9387012259854;200107.99999999854;229252;230684;231154;231203.84398078072;40006;52172.73913630407;53180.20229696557;53254.46745532495;53270.467295327326;49830.252546211836;49834.25248621274;49835;49883;50006;13220;13413;13416.262105584092;13460.528881489101;13501.987350948719;10020.949895250624;10147.137493313152;10150.340227885164;10164.237682173718;10166.694999150037;18304.450866474028;18400.26398944054;18401.263949441873;18417;18474.907625462056;7348;7496.7750967471065;7527.473076884566;7553.395728341719;7663.846723065619;838.4172999765227;860.9483430994161;873.4540911930044;884.9513276769711;927.3601215161517;26055.869720651277;26058.478830423664;27348.726512735015;27524.174274771787;27559.86220068927;918.2332752152028;918.7473444802599;921.755734730297;965.7344230336713;966.6906589891308;12548.458281147441;12688.80966785499;12759.362031898369;12802.359882005863;12918.870811291954;270956;278124;278394;278446;279123;44207.77896110499;44411;44453.77773111178;44459.777701111285;44466.33005049269;1023.764534157148;1116.5366372955132;1156.1906665334468;1209.5887398284626;1285.010541882745;23736.762632374146;25493.87253063723;27065.323366915985;28424.43151137007;28576.285592859513;36319;41770.58229417667;41934.370984434645;42057;42075.7896210517;166973;246356;251230;251398;252039;26126.477470450864;26616.7338326622;26773.330666733487;26807.463850723267;26853.194404167905;36106.4584031245;36211.27577448384;36531.81734091313;36966;37104.25791484209;30833.229169270948;30862.53706194364;31148.844255779484;32174.356512869144;34586.30827383388;33074.83462582672;33618.15954601154;33865;33978.66021339755;34031.48952765661;32773.34453310968;32825.67174328226;32859;32908.50637240396;33361.332773343915;29670.703292966795;30042.549361759153;30812.69187308098;30852.69147308588;31037;23406.64890026685;23448.179313723937;23745;23826.64260036066;23918.52162956766 21:28:33 INFO - 2015-11-15 21:28:33,662 DEBUG : BROWSER_OUTPUT: |2;jquery.html;320.27937141431784;324.6947869003138;330.1054143271733;330.1696233971562;336.14115933789174;11752.647420577376;12130.150889437742;14794.852051479482;15289.85941968124;15405.152716600582;13962.232077235749;14342.641433964156;14517.128972261671;15049.097054176757;15063.54809355721;4354.804033818486;4854.393200849894;4856.6357523185725;5001.624878134155;5021.974890125544;4924.532169443915;4925.556699897009;4934.605231581465;4949.653524253304;4950.801967921297;4753.405824271966;4852.805887764485;4908.656394052417;4917.606591472691;4918.557329840313;4837.080954618611;4874.390701162355;4890.828820991266;4891.413030436335;4897.7795999180125;4325.026868954492;4340.110277393127;4349.3041113421705;4351.3472979053395;4363.803628836678;19324.420267392;19443.222271109138;19833.206671733114;19862.404127876187;20126.89936550308;1803.179553303244;1887.6979683250613;1963.0864136112716;1975.150685205361;2115.1433669363932;12685.302308373035;12738.936305318413;12806.871931280753;12981.675458113528;13153.473861045546;1748.1346733367066;1774.8846324988963;1882.4634979030911;1889.0743535667561;1891.489297889576;59287.70356148192;60091.699541502014;60812.391876081114;61137.69431152816;61493.38506614921;14657.988578838518;14913.552593422215;15035.699286014218;15065.246737663074;15130;18003;18525.722114168297;21523;22240.777592224193;22309;7897.921020789719;7901.525908445512;7950.403719721044;7993.72021979228;8056.597170141469;6636.834832407924;6659.866802664016;6716.697748601325;6804.183497980274;6945.027696122547;7353.80109652303;7467.701291948261;7481.9251807482315;7487.475876688688;7488.663010164556;2850.5296626056884;2881.4093110912213;3007.5639032340187;3070.171053815502;3081.5839861618397;393.10568456760524;396.6509471664974;399.257381270836;406.2626333205223;436.52636888975815;10259.333143345659;10417.791644167075;10581.576736930436;10659.4137322448;10815.83776243357;418.0864810389309;433.17047853360464;433.43003949805905;434.13823560232913;439.731763624189;4783.378160839069;5624.6625202487985;5639.605227634108;5707.6290041147195;5854.4730974212525;522063;529213;531845;534807;538959;58925;66660.33339666638;74938;75118.62440687761;75356.62321688466;384.2142817937325;398.5814894360909;420.4492115328929;432.1637631183607;433.59892099808184;8635.050144484227;8838.248748856418;8860.64557417696;9025.142611451902;9071.228945539702;29242.41515169727;29555.408891822473;30270.243243919078;31468.213294667818;32871.67128328686;44347.33478997753;44836.32745508755;45551;45846.85382865321;45875;7007.614581198083;7152.392046676091;7166.319199676022;7230.457715671451;7246.311600397954;10856.402897840695;10910.345379277269;10923.453827308762;11019.559217631526;11022.228444008842;9537.093976072261;9751.414915105117;9909.256805739455;9933.106020458194;9943.30396872212;8457.492550446992;8668.219860212612;9581.952090239503;9658.517074146404;9717.757056073655;9166.17504424605;9388.483633399956;9478.763030924281;9555.283353748358;9581.329306948726;6638.502112341497;6743.52795304324;6787.966060169668;6794.252632210354;6801.353871382211;8815.206631402947;8982.910170898469;8998.055204203465;9067.727968160965;9069.954650226706 21:28:33 INFO - 2015-11-15 21:28:33,666 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1244.5955064604007;1592.3073463043577;1595.6728870581533;1605.189379363422;1656.6935117003352;6285.685715714213;6973.790786276413;7152.535085219463;7157.105361829771;7158.17680966689;7130.821729456753;7221.097362829646;7239.529430587021;7245.89131163033;7299.233580474053;1705.3434427745283;1739.6955532781776;1969.6454638165123;2031.522592190834;2054.9280775172874;1867.561123136062;1872.5693090589173;1875.5311172206948;1879.8590105742055;1881.8306352428278;1944.4555524453176;1970.044528403723;1981.0688976181173;1982.6431242376366;1983.4049785064424;1766.496548483689;1776.546980519972;1793.2826869252274;1798.190814133645;1799.856011519082;2030;2052.2406709517427;2052.8152466278107;2052.9076191571417;2054.1269960266827;7289.271072892721;7341.816454588625;7352.63236838156;7365.226651201654;7367.668454919542;4044.8786536403954;4110.897227569335;4153.252414565377;4156.168766246733;4160.105577300895;2346.9295921122393;2723.6867760207433;2725.6592925884265;2784.49879021776;2802.1033269353816;810.2505182705974;866.2939704141105;876.6055275126218;891.7636826241052;903.9050899655507;9946.35348702332;10080.445575493344;10083.647072352433;10088.293819432643;10094.242931780145;3845.288621605012;3878.437626544135;3884.1454879926373;3951.0714981979213;3954.367301231847;8534.061253262136;8537.957310213409;8545.017323007809;8546.487210767375;8557.01594316649;4230;4233.026403927114;4236.957630423718;4237.194932962789;4239;3833.3674943634546;3851.9037024074623;3860.3051450738576;3862.246861861966;3867.5358956925347;3462.8614855406004;3481.3907566176326;3483.5819701635965;3494.947575786365;3512.069301635018;1032.5250384822916;1038.1435315864442;1042.8122937871256;1051.5425789781316;1090.5147209491859;926.2266007883358;952.4951775558965;953.9427634341962;992.9205663546899;1203.1457665057733;6975.965120174468;7006.229314775371;7023.086998690138;7027.4729395294535;7030.191527974246;372.5417736184508;374.0797637810961;1098.3245304138056;1125.352922069813;1149.4540093455541;5381.865453363697;5439.020976224318;5450.972745136249;5453.863653408617;5460.34475862891;8781.780455488537;8833.469991800512;9095.090490950985;9114.04302548223;9227.815443691088;9070.047644997312;9137;9162.908370916339;9164.541772911327;9176.724698259062;6844.5208835381045;6921.307869213038;7030.9296907030275;7051.54164979285;7054.2240353561065;6644.568103073285;6662.966685166543;6665.600063996176;6673.265940746611;6680.432163265982;7651.5409075455655;7916.247956444128;7930.127685954656;7951.125376208497;7951.2843844051995;7662.846743065219;7896.763097107096;8007.15924827908;8008.679652813822;8107.8378432429845;6397.744090236339;6401.64790936503;6441.581297215666;6462.676866156768;6499.3175716549085;6904.482163837632;6914.896276555755;6948.756793512405;6956.652167391711;6964.895526567004;6543.476521878333;6646.60120392778;6653.800385988428;6684.16447944007;6767.154105736783;6464.191976003;6532.150820393318;6615.702293396713;6644.867102658017;6696.363845434676;6499.870002599827;6531.052997315458;6555.606663600009;6557.868842623217;6564.179477565304;6133.539984501091;6185.319614842454;6189.876202475835;6227.346128656426;6237.7193026314835;5448.482394172547;5605.607607467438;6254.405831446005;6274.278457977391;6286.088517165077 21:28:33 INFO - 2015-11-15 21:28:33,667 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.28263308814365;278.49453242365104;281.6859201989782;288.6968682882975;289.44137814018933;5307.469253074691;5331.57347412207;5351.224072509489;5358.758855851486;5359.812406565766;5029.949700502993;5077.365329333833;5171.4311425743235;5219.373675158986;5236.476352364762;4081.3061779497484;4081.795910204493;4102.302608556538;4131.73143745657;4138.151678905817;3896.2012787378662;4124.711270211072;4124.938125928098;4136.358864376027;4137.565555616662;3947.230290093433;3991.820368083443;4084.4690190275223;4103.199876024177;4118.691098167635;4089.8364065437645;4096.651784598313;4107.691923105779;4108.239975604508;4118.361653943643;3604.6936010439144;3605.675489205958;3627.256412435471;3633.981830090859;3640.053586067615;5115.769790359405;5121.871953201163;5129.846104616868;5131.127708289562;5138.177891537336;4543.454785425737;4677.111348843743;4694.882627934295;4703.3885594872445;4706.29405589161;5555.111182210827;5564.276644036249;5568.303962004749;5570.6657600544095;5570.6657600544095;3907.1013666856784;3910.393888947189;3913.099987002977;3915.980420097881;3917.1773927475265;5754.251947246873;5829.067349224104;5835.008048631743;5847.853803654943;5849.005669036274;3874.535055793323;3949.960500394959;3958.782266975344;3959.4654721612214;3971.146203566247;4002.9199416011515;4009.659178969762;4011.5988401159652;4014.1971605678395;4014.578469260744;4611.100835337077;4613.653975951817;4660.813567457331;4664.440267167894;4670.95329046712;5527.088030474926;5539.6150962259435;5544.972275138599;5548.223248745179;5563.054280772279;1389.5970168651181;1407.4159223922163;1414.0384538513908;1414.794854746056;1442.834074081473;948.5921053946869;964.5659453246068;978.3836183204678;983.7688143286322;989.4310771306527;4803.303520989437;4819.903601927942;4821.180399332052;4821.252705830602;4822.734749588736;5611.943880561143;5667.631603945731;5690.317161940594;5708.686022268732;5711.029125048752;4679.883002924954;4734.455537613218;4803.831865884677;4813.879653008703;4891.021795640886;3070.7236348728275;3082.5222090576;3100.3954228925595;3103.968960310413;3107.782455228112;5433.049216387117;5478.534324582455;5479.6164268500825;5486.8203336282895;5494.313210848644;5765.798197063083;5908.20239267702;5909.3795151508475;5917.52659787216;5919.940800591939;5476.959377718221;5478.123500239943;5487.314085739283;5487.75305111271;5491.588130890199;5750.741216645178;5756.56825738063;5762.94237057624;5763.538916886723;5767.192593036894;5627.606067575231;5632;5633.830985070291;5634.464725851038;5641.717914104196;5342.786288548415;5480.753366098615;5486.533644640251;5513;5520.503154716095;3889.824957876959;3942.2115576884166;3944.8224829883297;3945.763254204757;3946.526416829884;5776.595638305278;5783.971080144573;5785.537157027512;5786.363500015079;5790.478856902899;5578.609497335147;5583.274174357308;5587.580931430078;5588.30146231721;5590.496855283044;5423.728813559227;5594.888102238014;5602.663840169603;5604.8038318658655;5612.326520817528;5429.104197807317;5433.728313584226;5464.398916119144;5483.369412517612;5484.753186106555;5580.86047848807;5581.413951535031;5647.0964645656495;5653.745581448927;5659.9151012735665;5394.919076213781;5499.725013749377;5503.697296648723;5503.9174412383045;5505.889882202414 21:28:33 INFO - 2015-11-15 21:28:33,667 DEBUG : BROWSER_OUTPUT: |5;yui.html;699.912510936133;754.7924320811776;766.7009866152198;769.1808224241179;793.8372633610109;11304.660860174197;13995.440182392706;14177.574672759834;14191.503297384594;14210.644733881658;12870.742585148291;13052.738945221114;13087.607371778862;13087.934560327185;13093.476260949574;605.252513146264;609.5002098279413;766.0960067120809;769.1347234361343;780.8321210939647;768.1281745219161;768.6156921539231;770.2913319745848;775.1937984496145;775.4068137874531;805.4442434720054;813.3290035720524;813.5403497024192;814.287498438866;815.1155995744595;622.4802290087782;630.3318482408662;790.93277071449;802.9357651387875;804.8350088231898;587.5358466811214;590.6751286792247;591.1428428778289;591.781041014823;591.8757061017192;11138.888611113865;11249.943750281278;11257.437128143642;11315.094792416668;11392.316461012282;8702.216800487924;9426.811463770686;9431.151196392357;9598.088181622734;9745.658901938397;8791;8801.295896328342;8974.102589741038;9215.262778977665;9264.49045302508;2794.0919201259467;2794.8109115604475;2823.1953893140562;2829.773618110546;2831.773458123366;37596.62403375959;38099.80950095259;38136.80931595352;38137;38162.23675526474;6725.092112564839;6814.591124532544;6865.794026179223;6906.37842594169;6921.273266307066;10658.520366583522;10682.252242343116;10712.089472394779;10725.785484290427;10735.463226838627;5400.756965936543;5407.540359069523;5465.9726701366235;5574.470425309589;5715.885682286331;3605.152789094561;3607.6933460655614;3698.3158115748674;3715.238376132886;3779.7354185206773;2334.183035937442;2357.669926210332;2358.9882050589636;2360.091364824555;2363.6454531820023;404.2904702247537;406.2383031815346;407.1978202940203;407.7410844114009;409.98155083021334;515.718933181417;554.8113641361956;557.3228527339302;573.9397363276796;612.8958077126899;7304.926950730531;7357.915851514368;7753.4572579919995;7984.361251099898;8450.957745211235;464.5493870945178;510.45587099025744;584.3834754334218;606.8240210338952;617.962922224668;3710.6474884885893;3840.4431357453573;3886.9611303887164;4004.8598299059395;4015.1367455996515;49830;50051.749741251064;50100.498995009584;50340.748296259015;50396.24405633919;42574;43235.783821080695;43286.78356608197;43770.34344484835;44131.77934110309;41131.58868411277;41320;41553.79223103925;42595;43049.61879765029;7939.325157361458;8057.43597948138;8185.836283274421;8246.422750407413;8356.749297521084;30534.38931221319;30595;31271;31655.366892662478;31692.366152677278;40253.597464024984;40607.796961015;41110;41126.383104254055;41332.76001719953;6282.654454005074;6320.462760665395;6465.353464653497;6546.574472659262;6627.072209890523;10177.18582513412;10705.571777129138;10740.355578665305;10826.133909287395;11006.394648294421;8951.552422378985;9107.908920910706;9510.667126650535;10094.798104038025;10825.945870270598;9828.4102953823;9870.861142032685;10016.549255283384;10138.695839124837;10170.898291016994;9502.239820814457;9609.663661771805;9646.662366817127;9684.972962246311;9910.900890990997;9023.601793597201;9035.548222588714;9049.59276832531;9058.864117038382;9447.291453141179;8608.741737747878;8649.524276164871;9162.450252984841;9268.907310926805;9366.297527685314 21:28:33 INFO - 2015-11-15 21:28:33,667 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:28:33 INFO - 2015-11-15 21:28:33,667 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:28:33 INFO - 2015-11-15 21:28:33,667 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 21:28:33 INFO - 2015-11-15 21:28:33,667 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:28:33 INFO - 2015-11-15 21:28:33,667 DEBUG : BROWSER_OUTPUT: __startTimestamp1447651713655__endTimestamp 21:28:33 INFO - 2015-11-15 21:28:33,667 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,669 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:28:33 INFO - 2015-11-15 21:28:33,669 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:28:33 INFO - 2015-11-15 21:28:33,669 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,669 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4690.76 Median:4782.67 stddev:482.88 (10.1%) stddev-sans-first:457.69 21:28:33 INFO - 2015-11-15 21:28:33,670 DEBUG : BROWSER_OUTPUT: Values: 2673.1 2768.2 2769.1 2773.9 2794.0 4607.9 4749.3 4761.9 4779.5 4779.9 4688.8 4696.0 4757.1 4769.0 4775.0 4351.6 4361.0 4415.8 4486.6 4524.3 4262.1 4457.9 4477.0 4531.1 4534.5 4327.2 4408.7 4423.6 4425.6 4436.8 4412.6 4413.2 4429.1 4443.9 4443.9 4236.4 4374.0 4401.6 4404.4 4436.1 4623.0 4674.0 4701.2 4738.4 4767.0 5135.4 5180.1 5188.6 5209.1 5223.9 4913.8 5196.2 5202.6 5209.1 5228.1 4667.9 4683.1 4691.4 4751.0 4752.5 5244.8 5246.2 5246.7 5249.8 5258.5 4849.7 5046.0 5060.8 5060.8 5088.9 4926.7 4929.4 5001.6 5054.7 5078.3 5065.7 5081.1 5089.8 5102.1 5140.5 4852.6 5062.1 5063.6 5074.5 5076.8 4144.7 4195.0 4217.4 4227.9 4245.3 3714.6 3716.5 3728.6 3728.6 3744.4 4264.1 4382.0 4394.6 4396.1 4422.3 4950.8 5023.2 5028.6 5071.4 5097.7 4343.0 4383.4 4384.0 4398.2 4406.6 4326.5 4446.4 4540.4 4544.1 4574.6 4744.5 4757.2 4794.4 4820.1 4850.5 5085.2 5117.0 5117.8 5133.6 5160.8 4585.8 4699.9 4863.7 4866.3 4909.5 4893.7 4941.1 4956.6 4964.7 4997.2 5032.6 5111.4 5114.5 5122.6 5174.5 4795.9 4925.3 4940.3 4966.9 4971.5 4833.5 4872.1 4910.8 4914.8 4926.7 4844.2 4847.6 4857.1 4858.5 4894.2 4829.5 4937.2 4948.9 4949.4 4999.1 4728.7 4757.7 4765.7 4782.7 4811.9 21:28:33 INFO - 2015-11-15 21:28:33,670 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,670 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40191.49 Median:30822.96 stddev:64279.46 (208.5%) stddev-sans-first:64390.92 21:28:33 INFO - 2015-11-15 21:28:33,670 DEBUG : BROWSER_OUTPUT: Values: 565.6 570.1 570.1 578.3 593.0 27857.0 28657.6 34639.0 35505.5 35526.3 39849.0 40425.6 40449.0 40500.4 40515.0 6960.3 7932.9 8094.6 8099.8 8112.9 6947.0 10289.7 10530.7 10532.3 10533.4 9972.9 10059.3 10060.6 10061.7 10064.0 6977.7 7116.1 10114.2 10132.7 10207.7 9715.6 9930.6 9970.4 9990.9 10025.6 36558.0 37185.6 37209.6 37255.4 37265.3 2850.8 2920.7 2935.2 2960.3 3320.3 28046.9 28482.7 28616.7 28963.1 29188.6 2997.9 3020.5 3026.9 3059.0 3064.9 200108.0 229252.0 230684.0 231154.0 231203.8 40006.0 52172.7 53180.2 53254.5 53270.5 49830.3 49834.3 49835.0 49883.0 50006.0 13220.0 13413.0 13416.3 13460.5 13502.0 10020.9 10147.1 10150.3 10164.2 10166.7 18304.5 18400.3 18401.3 18417.0 18474.9 7348.0 7496.8 7527.5 7553.4 7663.8 838.4 860.9 873.5 885.0 927.4 26055.9 26058.5 27348.7 27524.2 27559.9 918.2 918.7 921.8 965.7 966.7 12548.5 12688.8 12759.4 12802.4 12918.9 270956.0 278124.0 278394.0 278446.0 279123.0 44207.8 44411.0 44453.8 44459.8 44466.3 1023.8 1116.5 1156.2 1209.6 1285.0 23736.8 25493.9 27065.3 28424.4 28576.3 36319.0 41770.6 41934.4 42057.0 42075.8 166973.0 246356.0 251230.0 251398.0 252039.0 26126.5 26616.7 26773.3 26807.5 26853.2 36106.5 36211.3 36531.8 36966.0 37104.3 30833.2 30862.5 31148.8 32174.4 34586.3 33074.8 33618.2 33865.0 33978.7 34031.5 32773.3 32825.7 32859.0 32908.5 33361.3 29670.7 30042.5 30812.7 30852.7 31037.0 23406.6 23448.2 23745.0 23826.6 23918.5 21:28:33 INFO - 2015-11-15 21:28:33,670 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,670 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27118.83 Median:25314.20 stddev:86884.00 (343.2%) stddev-sans-first:87104.43 21:28:33 INFO - 2015-11-15 21:28:33,671 DEBUG : BROWSER_OUTPUT: Values: 320.3 324.7 330.1 330.2 336.1 11752.6 12130.2 14794.9 15289.9 15405.2 13962.2 14342.6 14517.1 15049.1 15063.5 4354.8 4854.4 4856.6 5001.6 5022.0 4924.5 4925.6 4934.6 4949.7 4950.8 4753.4 4852.8 4908.7 4917.6 4918.6 4837.1 4874.4 4890.8 4891.4 4897.8 4325.0 4340.1 4349.3 4351.3 4363.8 19324.4 19443.2 19833.2 19862.4 20126.9 1803.2 1887.7 1963.1 1975.2 2115.1 12685.3 12738.9 12806.9 12981.7 13153.5 1748.1 1774.9 1882.5 1889.1 1891.5 59287.7 60091.7 60812.4 61137.7 61493.4 14658.0 14913.6 15035.7 15065.2 15130.0 18003.0 18525.7 21523.0 22240.8 22309.0 7897.9 7901.5 7950.4 7993.7 8056.6 6636.8 6659.9 6716.7 6804.2 6945.0 7353.8 7467.7 7481.9 7487.5 7488.7 2850.5 2881.4 3007.6 3070.2 3081.6 393.1 396.7 399.3 406.3 436.5 10259.3 10417.8 10581.6 10659.4 10815.8 418.1 433.2 433.4 434.1 439.7 4783.4 5624.7 5639.6 5707.6 5854.5 522063.0 529213.0 531845.0 534807.0 538959.0 58925.0 66660.3 74938.0 75118.6 75356.6 384.2 398.6 420.4 432.2 433.6 8635.1 8838.2 8860.6 9025.1 9071.2 29242.4 29555.4 30270.2 31468.2 32871.7 44347.3 44836.3 45551.0 45846.9 45875.0 7007.6 7152.4 7166.3 7230.5 7246.3 10856.4 10910.3 10923.5 11019.6 11022.2 9537.1 9751.4 9909.3 9933.1 9943.3 8457.5 8668.2 9582.0 9658.5 9717.8 9166.2 9388.5 9478.8 9555.3 9581.3 6638.5 6743.5 6788.0 6794.3 6801.4 8815.2 8982.9 8998.1 9067.7 9070.0 21:28:33 INFO - 2015-11-15 21:28:33,671 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,671 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5074.35 Median:6341.92 stddev:2730.32 (43.1%) stddev-sans-first:2722.81 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: Values: 1244.6 1592.3 1595.7 1605.2 1656.7 6285.7 6973.8 7152.5 7157.1 7158.2 7130.8 7221.1 7239.5 7245.9 7299.2 1705.3 1739.7 1969.6 2031.5 2054.9 1867.6 1872.6 1875.5 1879.9 1881.8 1944.5 1970.0 1981.1 1982.6 1983.4 1766.5 1776.5 1793.3 1798.2 1799.9 2030.0 2052.2 2052.8 2052.9 2054.1 7289.3 7341.8 7352.6 7365.2 7367.7 4044.9 4110.9 4153.3 4156.2 4160.1 2346.9 2723.7 2725.7 2784.5 2802.1 810.3 866.3 876.6 891.8 903.9 9946.4 10080.4 10083.6 10088.3 10094.2 3845.3 3878.4 3884.1 3951.1 3954.4 8534.1 8538.0 8545.0 8546.5 8557.0 4230.0 4233.0 4237.0 4237.2 4239.0 3833.4 3851.9 3860.3 3862.2 3867.5 3462.9 3481.4 3483.6 3494.9 3512.1 1032.5 1038.1 1042.8 1051.5 1090.5 926.2 952.5 953.9 992.9 1203.1 6976.0 7006.2 7023.1 7027.5 7030.2 372.5 374.1 1098.3 1125.4 1149.5 5381.9 5439.0 5451.0 5453.9 5460.3 8781.8 8833.5 9095.1 9114.0 9227.8 9070.0 9137.0 9162.9 9164.5 9176.7 6844.5 6921.3 7030.9 7051.5 7054.2 6644.6 6663.0 6665.6 6673.3 6680.4 7651.5 7916.2 7930.1 7951.1 7951.3 7662.8 7896.8 8007.2 8008.7 8107.8 6397.7 6401.6 6441.6 6462.7 6499.3 6904.5 6914.9 6948.8 6956.7 6964.9 6543.5 6646.6 6653.8 6684.2 6767.2 6464.2 6532.2 6615.7 6644.9 6696.4 6499.9 6531.1 6555.6 6557.9 6564.2 6133.5 6185.3 6189.9 6227.3 6237.7 5448.5 5605.6 6254.4 6274.3 6286.1 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4607.68 Median:5319.52 stddev:1356.98 (25.5%) stddev-sans-first:1321.21 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: Values: 273.3 278.5 281.7 288.7 289.4 5307.5 5331.6 5351.2 5358.8 5359.8 5029.9 5077.4 5171.4 5219.4 5236.5 4081.3 4081.8 4102.3 4131.7 4138.2 3896.2 4124.7 4124.9 4136.4 4137.6 3947.2 3991.8 4084.5 4103.2 4118.7 4089.8 4096.7 4107.7 4108.2 4118.4 3604.7 3605.7 3627.3 3634.0 3640.1 5115.8 5121.9 5129.8 5131.1 5138.2 4543.5 4677.1 4694.9 4703.4 4706.3 5555.1 5564.3 5568.3 5570.7 5570.7 3907.1 3910.4 3913.1 3916.0 3917.2 5754.3 5829.1 5835.0 5847.9 5849.0 3874.5 3950.0 3958.8 3959.5 3971.1 4002.9 4009.7 4011.6 4014.2 4014.6 4611.1 4613.7 4660.8 4664.4 4671.0 5527.1 5539.6 5545.0 5548.2 5563.1 1389.6 1407.4 1414.0 1414.8 1442.8 948.6 964.6 978.4 983.8 989.4 4803.3 4819.9 4821.2 4821.3 4822.7 5611.9 5667.6 5690.3 5708.7 5711.0 4679.9 4734.5 4803.8 4813.9 4891.0 3070.7 3082.5 3100.4 3104.0 3107.8 5433.0 5478.5 5479.6 5486.8 5494.3 5765.8 5908.2 5909.4 5917.5 5919.9 5477.0 5478.1 5487.3 5487.8 5491.6 5750.7 5756.6 5762.9 5763.5 5767.2 5627.6 5632.0 5633.8 5634.5 5641.7 5342.8 5480.8 5486.5 5513.0 5520.5 3889.8 3942.2 3944.8 3945.8 3946.5 5776.6 5784.0 5785.5 5786.4 5790.5 5578.6 5583.3 5587.6 5588.3 5590.5 5423.7 5594.9 5602.7 5604.8 5612.3 5429.1 5433.7 5464.4 5483.4 5484.8 5580.9 5581.4 5647.1 5653.7 5659.9 5394.9 5499.7 5503.7 5503.9 5505.9 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11780.16 Median:3010.39 stddev:13858.29 (460.3%) stddev-sans-first:13872.19 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: Values: 699.9 754.8 766.7 769.2 793.8 11304.7 13995.4 14177.6 14191.5 14210.6 12870.7 13052.7 13087.6 13087.9 13093.5 605.3 609.5 766.1 769.1 780.8 768.1 768.6 770.3 775.2 775.4 805.4 813.3 813.5 814.3 815.1 622.5 630.3 790.9 802.9 804.8 587.5 590.7 591.1 591.8 591.9 11138.9 11249.9 11257.4 11315.1 11392.3 8702.2 9426.8 9431.2 9598.1 9745.7 8791.0 8801.3 8974.1 9215.3 9264.5 2794.1 2794.8 2823.2 2829.8 2831.8 37596.6 38099.8 38136.8 38137.0 38162.2 6725.1 6814.6 6865.8 6906.4 6921.3 10658.5 10682.3 10712.1 10725.8 10735.5 5400.8 5407.5 5466.0 5574.5 5715.9 3605.2 3607.7 3698.3 3715.2 3779.7 2334.2 2357.7 2359.0 2360.1 2363.6 404.3 406.2 407.2 407.7 410.0 515.7 554.8 557.3 573.9 612.9 7304.9 7357.9 7753.5 7984.4 8451.0 464.5 510.5 584.4 606.8 618.0 3710.6 3840.4 3887.0 4004.9 4015.1 49830.0 50051.7 50100.5 50340.7 50396.2 42574.0 43235.8 43286.8 43770.3 44131.8 41131.6 41320.0 41553.8 42595.0 43049.6 7939.3 8057.4 8185.8 8246.4 8356.7 30534.4 30595.0 31271.0 31655.4 31692.4 40253.6 40607.8 41110.0 41126.4 41332.8 6282.7 6320.5 6465.4 6546.6 6627.1 10177.2 10705.6 10740.4 10826.1 11006.4 8951.6 9107.9 9510.7 10094.8 10825.9 9828.4 9870.9 10016.5 10138.7 10170.9 9502.2 9609.7 9646.7 9685.0 9910.9 9023.6 9035.5 9049.6 9058.9 9447.3 8608.7 8649.5 9162.5 9268.9 9366.3 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:28:33 INFO - 2015-11-15 21:28:33,672 DEBUG : BROWSER_OUTPUT: 21:28:34 INFO - 2015-11-15 21:28:34,434 INFO : Browser exited with error code: 0 21:28:34 INFO - 2015-11-15 21:28:34,453 INFO : Completed test dromaeo_css (00:18:38) 21:28:34 INFO - 2015-11-15 21:28:34,453 INFO : Starting test kraken 21:28:34 INFO - 2015-11-15 21:28:34,453 DEBUG : operating with platform_type : linux_ 21:28:34 INFO - 2015-11-15 21:28:34,453 INFO : Initialising browser for kraken test... 21:28:34 INFO - 2015-11-15 21:28:34,459 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9vOvOA/profile http://localhost:60746/getInfo.html 21:28:38 INFO - 2015-11-15 21:28:38,240 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:28:38 INFO - 2015-11-15 21:28:38,241 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:28:38 INFO - 2015-11-15 21:28:38,241 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:28:38 INFO - 2015-11-15 21:28:38,241 DEBUG : BROWSER_OUTPUT: __metrics 21:28:38 INFO - 2015-11-15 21:28:38,357 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:28:39 INFO - 2015-11-15 21:28:39,527 INFO : Browser initialized. 21:28:39 INFO - 2015-11-15 21:28:39,528 INFO : Running cycle 1/1 for kraken test... 21:28:39 INFO - 2015-11-15 21:28:39,528 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9vOvOA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:28:51 INFO - 2015-11-15 21:28:51,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 141221888 21:28:51 INFO - 2015-11-15 21:28:51,396 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-11-15 21:28:53,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60746/tests/kraken/driver.html?testName=audio-beat-detection) 21:28:54 INFO - 2015-11-15 21:28:54,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 179224576 21:28:54 INFO - 2015-11-15 21:28:54,561 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-15 21:28:57,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60746/tests/kraken/driver.html?testName=audio-dft) 21:28:57 INFO - 2015-11-15 21:28:57,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 168620032 21:28:57 INFO - 2015-11-15 21:28:57,836 DEBUG : BROWSER_OUTPUT: 21:29:00 INFO - 2015-11-15 21:29:00,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60746/tests/kraken/driver.html?testName=audio-fft) 21:29:01 INFO - 2015-11-15 21:29:01,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 151699456 21:29:01 INFO - 2015-11-15 21:29:01,383 DEBUG : BROWSER_OUTPUT: 21:29:03 INFO - 2015-11-15 21:29:03,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60746/tests/kraken/driver.html?testName=audio-oscillator) 21:29:04 INFO - 2015-11-15 21:29:04,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 153681920 21:29:04 INFO - 2015-11-15 21:29:04,015 DEBUG : BROWSER_OUTPUT: 21:29:06 INFO - 2015-11-15 21:29:06,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:29:06 INFO - 2015-11-15 21:29:06,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 154550272 21:29:06 INFO - 2015-11-15 21:29:06,816 DEBUG : BROWSER_OUTPUT: 21:29:09 INFO - 2015-11-15 21:29:09,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60746/tests/kraken/driver.html?testName=imaging-darkroom) 21:29:10 INFO - 2015-11-15 21:29:10,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 155729920 21:29:10 INFO - 2015-11-15 21:29:10,369 DEBUG : BROWSER_OUTPUT: 21:29:13 INFO - 2015-11-15 21:29:13,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60746/tests/kraken/driver.html?testName=imaging-desaturate) 21:29:14 INFO - 2015-11-15 21:29:14,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 157609984 21:29:14 INFO - 2015-11-15 21:29:14,413 DEBUG : BROWSER_OUTPUT: 21:29:17 INFO - 2015-11-15 21:29:17,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60746/tests/kraken/driver.html?testName=json-parse-financial) 21:29:17 INFO - 2015-11-15 21:29:17,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 156164096 21:29:17 INFO - 2015-11-15 21:29:17,819 DEBUG : BROWSER_OUTPUT: 21:29:19 INFO - 2015-11-15 21:29:19,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:29:20 INFO - 2015-11-15 21:29:20,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 165302272 21:29:20 INFO - 2015-11-15 21:29:20,135 DEBUG : BROWSER_OUTPUT: 21:29:22 INFO - 2015-11-15 21:29:22,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60746/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:29:22 INFO - 2015-11-15 21:29:22,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 165367808 21:29:22 INFO - 2015-11-15 21:29:22,631 DEBUG : BROWSER_OUTPUT: 21:29:24 INFO - 2015-11-15 21:29:24,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:29:25 INFO - 2015-11-15 21:29:25,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 170278912 21:29:25 INFO - 2015-11-15 21:29:25,311 DEBUG : BROWSER_OUTPUT: 21:29:27 INFO - 2015-11-15 21:29:27,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:29:28 INFO - 2015-11-15 21:29:28,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 178880512 21:29:28 INFO - 2015-11-15 21:29:28,429 DEBUG : BROWSER_OUTPUT: 21:29:31 INFO - 2015-11-15 21:29:31,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:29:31 INFO - 2015-11-15 21:29:31,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 177074176 21:29:31 INFO - 2015-11-15 21:29:31,651 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60746/tests/kraken/driver.html?testName=ai-astar) 21:29:33 INFO - 2015-11-15 21:29:33,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 235974656 21:29:33 INFO - 2015-11-15 21:29:33,650 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,652 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:29:33 INFO - 2015-11-15 21:29:33,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:29:33 INFO - 2015-11-15 21:29:33,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:29:33 INFO - 2015-11-15 21:29:33,652 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:29:33 INFO - 2015-11-15 21:29:33,652 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;113;106;111;112;113;100;110;113;111 21:29:33 INFO - 2015-11-15 21:29:33,652 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;133;152;167;129;155;153;130;167;130 21:29:33 INFO - 2015-11-15 21:29:33,653 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;168;160;162;161;160;161;162;163;162 21:29:33 INFO - 2015-11-15 21:29:33,653 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;81;93;73;73;72;102;88;72 21:29:33 INFO - 2015-11-15 21:29:33,653 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;125;91;91;91;136;91;93;126 21:29:33 INFO - 2015-11-15 21:29:33,653 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;110;110;109 21:29:33 INFO - 2015-11-15 21:29:33,653 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;149;148;149;147;149;147;148;148 21:29:33 INFO - 2015-11-15 21:29:33,653 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;95;96;96;95;96;95 21:29:33 INFO - 2015-11-15 21:29:33,654 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;68;67;69;68;68;68;76;66;65 21:29:33 INFO - 2015-11-15 21:29:33,654 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;70;68;69;68;68;68 21:29:33 INFO - 2015-11-15 21:29:33,654 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;83;84;85;83;83;83;84;89 21:29:33 INFO - 2015-11-15 21:29:33,654 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;122;128;121;131;122;138;133;122;125 21:29:33 INFO - 2015-11-15 21:29:33,655 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;141;163;144;145;155;150;162;143;140 21:29:33 INFO - 2015-11-15 21:29:33,655 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;71;70;71;69;70;72;69;70 21:29:33 INFO - 2015-11-15 21:29:33,655 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:29:33 INFO - 2015-11-15 21:29:33,655 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:29:33 INFO - 2015-11-15 21:29:33,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1017 21:29:33 INFO - 2015-11-15 21:29:33,655 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:29:33 INFO - 2015-11-15 21:29:33,656 DEBUG : BROWSER_OUTPUT: __startTimestamp1447651773651__endTimestamp 21:29:33 INFO - 2015-11-15 21:29:33,656 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:4.08 (3.7%) stddev-sans-first:4.31 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 106.0 111.0 112.0 113.0 100.0 110.0 113.0 111.0 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.60 Median:154.00 stddev:15.59 (10.1%) stddev-sans-first:15.88 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: Values: 160.0 133.0 152.0 167.0 129.0 155.0 153.0 130.0 167.0 130.0 21:29:33 INFO - 2015-11-15 21:29:33,657 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.42 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: Values: 161.0 168.0 160.0 162.0 161.0 160.0 161.0 162.0 163.0 162.0 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.50 stddev:10.69 (14.5%) stddev-sans-first:11.03 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 81.0 93.0 73.0 73.0 72.0 102.0 88.0 72.0 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:91.00 stddev:18.32 (20.1%) stddev-sans-first:19.01 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 125.0 91.0 91.0 91.0 136.0 91.0 93.0 126.0 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:29:33 INFO - 2015-11-15 21:29:33,658 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 149.0 148.0 149.0 147.0 149.0 147.0 148.0 148.0 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.30 Median:68.00 stddev:2.95 (4.3%) stddev-sans-first:3.12 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 69.0 68.0 68.0 68.0 76.0 66.0 65.0 21:29:33 INFO - 2015-11-15 21:29:33,659 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,660 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 70.0 68.0 69.0 68.0 68.0 68.0 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.10 (2.5%) stddev-sans-first:1.96 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 83.0 84.0 85.0 83.0 83.0 83.0 84.0 89.0 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:127.50 stddev:5.67 (4.4%) stddev-sans-first:6.01 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: Values: 127.0 122.0 128.0 121.0 131.0 122.0 138.0 133.0 122.0 125.0 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,661 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:150.50 stddev:8.34 (5.5%) stddev-sans-first:8.83 21:29:33 INFO - 2015-11-15 21:29:33,662 DEBUG : BROWSER_OUTPUT: Values: 151.0 141.0 163.0 144.0 145.0 155.0 150.0 162.0 143.0 140.0 21:29:33 INFO - 2015-11-15 21:29:33,662 DEBUG : BROWSER_OUTPUT: 21:29:33 INFO - 2015-11-15 21:29:33,662 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:0.95 (1.3%) stddev-sans-first:0.97 21:29:33 INFO - 2015-11-15 21:29:33,662 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 71.0 69.0 70.0 72.0 69.0 70.0 21:29:33 INFO - 2015-11-15 21:29:33,662 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:29:33 INFO - 2015-11-15 21:29:33,662 DEBUG : BROWSER_OUTPUT: 21:29:34 INFO - 2015-11-15 21:29:34,558 INFO : Browser exited with error code: 0 21:29:34 INFO - 2015-11-15 21:29:34,606 INFO : Completed test kraken (00:01:00) 21:29:34 INFO - 2015-11-15 21:29:34,607 INFO : Starting test v8_7 21:29:34 INFO - 2015-11-15 21:29:34,607 DEBUG : operating with platform_type : linux_ 21:29:34 INFO - 2015-11-15 21:29:34,607 INFO : Initialising browser for v8_7 test... 21:29:34 INFO - 2015-11-15 21:29:34,613 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1AwH8t/profile http://localhost:60746/getInfo.html 21:29:38 INFO - 2015-11-15 21:29:38,473 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:29:38 INFO - 2015-11-15 21:29:38,473 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:29:38 INFO - 2015-11-15 21:29:38,473 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:29:38 INFO - 2015-11-15 21:29:38,473 DEBUG : BROWSER_OUTPUT: __metrics 21:29:38 INFO - 2015-11-15 21:29:38,670 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:29:39 INFO - 2015-11-15 21:29:39,832 INFO : Browser initialized. 21:29:39 INFO - 2015-11-15 21:29:39,832 INFO : Running cycle 1/1 for v8_7 test... 21:29:39 INFO - 2015-11-15 21:29:39,832 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1AwH8t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:29:51 INFO - 2015-11-15 21:29:51,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 141189120 21:29:51 INFO - 2015-11-15 21:29:51,727 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60746/tests/v8_7/run.html (next: http://localhost:60746/tests/v8_7/run.html) 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 444243968 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: |0;Richards;171.32088401576152 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.90174630589138 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.58361391694723 21:30:13 INFO - 2015-11-15 21:30:13,383 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: |5;Earley;813.0081300813008 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: |6;Boyer;11928.57142857143 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: |8;Splay;609.0133982947625 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4901.9607843137255 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: __startTimestamp1447651813377__endTimestamp 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.32 Median:171.32 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: Values: 171.3 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,384 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.90 Median:191.90 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: Values: 191.9 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: Values: 280.6 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: Values: 5035.2 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: Values: 2002.0 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:813.01 Median:813.01 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: Values: 813.0 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11928.57 Median:11928.57 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,385 DEBUG : BROWSER_OUTPUT: Values: 11928.6 21:30:13 INFO - 2015-11-15 21:30:13,386 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,386 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,386 DEBUG : BROWSER_OUTPUT: Values: 26868.4 21:30:13 INFO - 2015-11-15 21:30:13,386 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,386 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.01 Median:609.01 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,386 DEBUG : BROWSER_OUTPUT: Values: 609.0 21:30:13 INFO - 2015-11-15 21:30:13,386 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-15 21:30:13,387 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4901.96 Median:4901.96 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-15 21:30:13,387 DEBUG : BROWSER_OUTPUT: Values: 4902.0 21:30:13 INFO - 2015-11-15 21:30:13,387 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:30:13 INFO - 2015-11-15 21:30:13,387 DEBUG : BROWSER_OUTPUT: 21:30:14 INFO - 2015-11-15 21:30:14,258 INFO : Browser exited with error code: 0 21:30:14 INFO - 2015-11-15 21:30:14,275 INFO : Completed test v8_7 (00:00:39) 21:30:14 INFO - 2015-11-15 21:30:14,394 INFO : Completed test suite (00:20:18) 21:30:14 INFO - 2015-11-15 21:30:14,394 DEBUG : Working with test: dromaeo_css 21:30:14 INFO - 2015-11-15 21:30:14,394 DEBUG : Generating results file: dromaeo_css 21:30:14 INFO - 2015-11-15 21:30:14,395 DEBUG : Working with test: kraken 21:30:14 INFO - 2015-11-15 21:30:14,396 DEBUG : Generating results file: kraken 21:30:14 INFO - 2015-11-15 21:30:14,396 INFO : javascript benchmark 21:30:14 INFO - 2015-11-15 21:30:14,396 DEBUG : Working with test: v8_7 21:30:14 INFO - 2015-11-15 21:30:14,396 DEBUG : Generating results file: v8_7 21:30:14 INFO - 2015-11-15 21:30:14,396 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:30:14 INFO - 2015-11-15 21:30:14,575 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 21:30:14 INFO - 2015-11-15 21:30:14,575 DEBUG : process_Request line: dromaeo_css 6135.90 graph.html#tests=[[72,131,35]] 21:30:14 INFO - 2015-11-15 21:30:14,575 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:30:14 INFO - 2015-11-15 21:30:14,751 DEBUG : process_Request line: kraken 1522.40 graph.html#tests=[[232,131,35]] 21:30:14 INFO - 2015-11-15 21:30:14,752 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:30:14 INFO - 2015-11-15 21:30:14,874 DEBUG : process_Request line: v8_7 19654.26 graph.html#tests=[[230,131,35]] 21:30:14 INFO - 2015-11-15 21:30:14,875 INFO : javascript benchmark 21:30:14 INFO - 2015-11-15 21:30:14,879 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [320.27937141431784, 324.6947869003138, 330.1054143271733, 330.1696233971562, 336.14115933789174, 11752.647420577376, 12130.150889437742, 14794.852051479482, 15289.85941968124, 15405.152716600582, 13962.232077235749, 14342.641433964156, 14517.128972261671, 15049.097054176757, 15063.54809355721, 4354.804033818486, 4854.393200849894, 4856.6357523185725, 5001.624878134155, 5021.974890125544, 4924.532169443915, 4925.556699897009, 4934.605231581465, 4949.653524253304, 4950.801967921297, 4753.405824271966, 4852.805887764485, 4908.656394052417, 4917.606591472691, 4918.557329840313, 4837.080954618611, 4874.390701162355, 4890.828820991266, 4891.413030436335, 4897.7795999180125, 4325.026868954492, 4340.110277393127, 4349.3041113421705, 4351.3472979053395, 4363.803628836678, 19324.420267392, 19443.222271109138, 19833.206671733114, 19862.404127876187, 20126.89936550308, 1803.179553303244, 1887.6979683250613, 1963.0864136112716, 1975.150685205361, 2115.1433669363932, 12685.302308373035, 12738.936305318413, 12806.871931280753, 12981.675458113528, 13153.473861045546, 1748.1346733367066, 1774.8846324988963, 1882.4634979030911, 1889.0743535667561, 1891.489297889576, 59287.70356148192, 60091.699541502014, 60812.391876081114, 61137.69431152816, 61493.38506614921, 14657.988578838518, 14913.552593422215, 15035.699286014218, 15065.246737663074, 15130.0, 18003.0, 18525.722114168297, 21523.0, 22240.777592224193, 22309.0, 7897.921020789719, 7901.525908445512, 7950.403719721044, 7993.72021979228, 8056.597170141469, 6636.834832407924, 6659.866802664016, 6716.697748601325, 6804.183497980274, 6945.027696122547, 7353.80109652303, 7467.701291948261, 7481.9251807482315, 7487.475876688688, 7488.663010164556, 2850.5296626056884, 2881.4093110912213, 3007.5639032340187, 3070.171053815502, 3081.5839861618397, 393.10568456760524, 396.6509471664974, 399.257381270836, 406.2626333205223, 436.52636888975815, 10259.333143345659, 10417.791644167075, 10581.576736930436, 10659.4137322448, 10815.83776243357, 418.0864810389309, 433.17047853360464, 433.43003949805905, 434.13823560232913, 439.731763624189, 4783.378160839069, 5624.6625202487985, 5639.605227634108, 5707.6290041147195, 5854.4730974212525, 522063.0, 529213.0, 531845.0, 534807.0, 538959.0, 58925.0, 66660.33339666638, 74938.0, 75118.62440687761, 75356.62321688466, 384.2142817937325, 398.5814894360909, 420.4492115328929, 432.1637631183607, 433.59892099808184, 8635.050144484227, 8838.248748856418, 8860.64557417696, 9025.142611451902, 9071.228945539702, 29242.41515169727, 29555.408891822473, 30270.243243919078, 31468.213294667818, 32871.67128328686, 44347.33478997753, 44836.32745508755, 45551.0, 45846.85382865321, 45875.0, 7007.614581198083, 7152.392046676091, 7166.319199676022, 7230.457715671451, 7246.311600397954, 10856.402897840695, 10910.345379277269, 10923.453827308762, 11019.559217631526, 11022.228444008842, 9537.093976072261, 9751.414915105117, 9909.256805739455, 9933.106020458194, 9943.30396872212, 8457.492550446992, 8668.219860212612, 9581.952090239503, 9658.517074146404, 9717.757056073655, 9166.17504424605, 9388.483633399956, 9478.763030924281, 9555.283353748358, 9581.329306948726, 6638.502112341497, 6743.52795304324, 6787.966060169668, 6794.252632210354, 6801.353871382211, 8815.206631402947, 8982.910170898469, 8998.055204203465, 9067.727968160965, 9069.954650226706], "dojo.html": [2673.0510668712604, 2768.238734348054, 2769.113883557261, 2773.8890444382228, 2794.0220922677067, 4607.861764147073, 4749.263864101061, 4761.880952976173, 4779.498152693969, 4779.856604301872, 4688.765561721917, 4695.976520117395, 4757.0723708876785, 4768.952310476894, 4774.9761251193695, 4351.586599273064, 4361.040571074366, 4415.757133357664, 4486.573775491323, 4524.253498172798, 4262.147570485899, 4457.866264012085, 4477.037436951055, 4531.13908357411, 4534.455865296152, 4327.199468098412, 4408.669349798778, 4423.557644235583, 4425.579569940851, 4436.844710435152, 4412.602865742067, 4413.227685155117, 4429.114177164548, 4443.888902777424, 4443.933340999887, 4236.406903033547, 4373.956260437419, 4401.5818497243035, 4404.427424434835, 4436.134953684033, 4623.0, 4674.018456124218, 4701.200795864711, 4738.384010078702, 4766.952330476685, 5135.38375394955, 5180.093483640348, 5188.5849132069725, 5209.062368773619, 5223.895522089575, 4913.754312284407, 5196.168613021899, 5202.557782588485, 5209.114450543417, 5228.058949389108, 4667.929981050287, 4683.110209060268, 4691.366665500113, 4751.028323245883, 4752.500987396274, 5244.816431424958, 5246.213068039825, 5246.711430871263, 5249.790008399621, 5258.526732594085, 4849.709017458964, 5046.0, 5060.7722652480725, 5060.797568097309, 5088.872778180576, 4926.704397736147, 4929.383827021622, 5001.624878134155, 5054.671446355975, 5078.314427552307, 5065.670731402521, 5081.0854046272025, 5089.847304580869, 5102.081625307406, 5140.460251673595, 4852.587530059985, 5062.088824011639, 5063.645544811828, 5074.543291103744, 5076.82231121909, 4144.668426525871, 4194.979025104855, 4217.388478670576, 4227.87316380509, 4245.27830268855, 3714.647108524686, 3716.5168528091176, 3728.6271372862498, 3728.627137286304, 3744.363458212056, 4264.061906380592, 4382.0, 4394.648428125806, 4396.07682386696, 4422.29243321067, 4950.8267210647455, 5023.221400682827, 5028.5977121830165, 5071.366079240095, 5097.719625420637, 4342.956570434319, 4383.3863259143745, 4384.013596940663, 4398.164348773723, 4406.581374769392, 4326.480822301344, 4446.355278484666, 4540.432445944257, 4544.091181763594, 4574.565416285448, 4744.478107408251, 4757.215059515142, 4794.352762377174, 4820.108279968217, 4850.5149485051215, 5085.211792172219, 5116.9744151279, 5117.795288188431, 5133.563647090039, 5160.793568257228, 4585.839495617771, 4699.929501057419, 4863.659543831898, 4866.29438731389, 4909.5090490950615, 4893.73084480357, 4941.061198372297, 4956.628252880976, 4964.652474326763, 4997.225430058346, 5032.6225533084435, 5111.361079865017, 5114.539691427789, 5122.641415100908, 5174.482551744795, 4795.856124316276, 4925.261210818406, 4940.258961155855, 4966.900661986812, 4971.502849715, 4833.492483289345, 4872.123017856819, 4910.7544622768, 4914.803407863646, 4926.704397736147, 4844.224924012141, 4847.587955023862, 4857.101436234308, 4858.465568787501, 4894.216925291937, 4829.517048295143, 4937.160682683881, 4948.901021979612, 4949.406071271471, 4999.125153098266, 4728.739919304471, 4757.690750101232, 4765.7140571565815, 4782.665213435026, 4811.903761924812], "mootools.html": [1244.5955064604007, 1592.3073463043577, 1595.6728870581533, 1605.189379363422, 1656.6935117003352, 6285.685715714213, 6973.790786276413, 7152.535085219463, 7157.105361829771, 7158.17680966689, 7130.821729456753, 7221.097362829646, 7239.529430587021, 7245.89131163033, 7299.233580474053, 1705.3434427745283, 1739.6955532781776, 1969.6454638165123, 2031.522592190834, 2054.9280775172874, 1867.561123136062, 1872.5693090589173, 1875.5311172206948, 1879.8590105742055, 1881.8306352428278, 1944.4555524453176, 1970.044528403723, 1981.0688976181173, 1982.6431242376366, 1983.4049785064424, 1766.496548483689, 1776.546980519972, 1793.2826869252274, 1798.190814133645, 1799.856011519082, 2030.0, 2052.2406709517427, 2052.8152466278107, 2052.9076191571417, 2054.1269960266827, 7289.271072892721, 7341.816454588625, 7352.63236838156, 7365.226651201654, 7367.668454919542, 4044.8786536403954, 4110.897227569335, 4153.252414565377, 4156.168766246733, 4160.105577300895, 2346.9295921122393, 2723.6867760207433, 2725.6592925884265, 2784.49879021776, 2802.1033269353816, 810.2505182705974, 866.2939704141105, 876.6055275126218, 891.7636826241052, 903.9050899655507, 9946.35348702332, 10080.445575493344, 10083.647072352433, 10088.293819432643, 10094.242931780145, 3845.288621605012, 3878.437626544135, 3884.1454879926373, 3951.0714981979213, 3954.367301231847, 8534.061253262136, 8537.957310213409, 8545.017323007809, 8546.487210767375, 8557.01594316649, 4230.0, 4233.026403927114, 4236.957630423718, 4237.194932962789, 4239.0, 3833.3674943634546, 3851.9037024074623, 3860.3051450738576, 3862.246861861966, 3867.5358956925347, 3462.8614855406004, 3481.3907566176326, 3483.5819701635965, 3494.947575786365, 3512.069301635018, 1032.5250384822916, 1038.1435315864442, 1042.8122937871256, 1051.5425789781316, 1090.5147209491859, 926.2266007883358, 952.4951775558965, 953.9427634341962, 992.9205663546899, 1203.1457665057733, 6975.965120174468, 7006.229314775371, 7023.086998690138, 7027.4729395294535, 7030.191527974246, 372.5417736184508, 374.0797637810961, 1098.3245304138056, 1125.352922069813, 1149.4540093455541, 5381.865453363697, 5439.020976224318, 5450.972745136249, 5453.863653408617, 5460.34475862891, 8781.780455488537, 8833.469991800512, 9095.090490950985, 9114.04302548223, 9227.815443691088, 9070.047644997312, 9137.0, 9162.908370916339, 9164.541772911327, 9176.724698259062, 6844.5208835381045, 6921.307869213038, 7030.9296907030275, 7051.54164979285, 7054.2240353561065, 6644.568103073285, 6662.966685166543, 6665.600063996176, 6673.265940746611, 6680.432163265982, 7651.5409075455655, 7916.247956444128, 7930.127685954656, 7951.125376208497, 7951.2843844051995, 7662.846743065219, 7896.763097107096, 8007.15924827908, 8008.679652813822, 8107.8378432429845, 6397.744090236339, 6401.64790936503, 6441.581297215666, 6462.676866156768, 6499.3175716549085, 6904.482163837632, 6914.896276555755, 6948.756793512405, 6956.652167391711, 6964.895526567004, 6543.476521878333, 6646.60120392778, 6653.800385988428, 6684.16447944007, 6767.154105736783, 6464.191976003, 6532.150820393318, 6615.702293396713, 6644.867102658017, 6696.363845434676, 6499.870002599827, 6531.052997315458, 6555.606663600009, 6557.868842623217, 6564.179477565304, 6133.539984501091, 6185.319614842454, 6189.876202475835, 6227.346128656426, 6237.7193026314835, 5448.482394172547, 5605.607607467438, 6254.405831446005, 6274.278457977391, 6286.088517165077], "ext.html": [565.5984251181661, 570.0821677099868, 570.1077813222307, 578.2887048929817, 593.0155941137713, 27857.0, 28657.570136447943, 34638.99999999997, 35505.46741798875, 35526.2894742105, 39849.0, 40425.59574404255, 40449.0, 40500.39249411254, 40515.0, 6960.269171736971, 7932.881006784888, 8094.635741391651, 8099.838003239932, 8112.878306825402, 6947.027416161742, 10289.742756431075, 10530.736731581734, 10532.315399499008, 10533.420661863594, 9972.85040724386, 10059.34614250075, 10060.647877324294, 10061.698149055503, 10064.04391582802, 6977.720891164347, 7116.074910261685, 10114.190864730805, 10132.696019119438, 10207.693769186937, 9715.61137554497, 9930.602775888956, 9970.351927124713, 9990.90009099907, 10025.59897604095, 36558.0, 37185.62814371849, 37209.62790372089, 37255.441168382495, 37265.25469490595, 2850.8432036238, 2920.7225313595172, 2935.2074939766358, 2960.259935016246, 3320.335932813447, 28046.859765701243, 28482.715172848213, 28616.71383286182, 28963.131106066852, 29188.562171567442, 2997.9400411991637, 3020.5469179623014, 3026.9394612107635, 3058.9847050764824, 3064.9387012259854, 200107.99999999854, 229252.0, 230684.0, 231154.0, 231203.84398078072, 40006.0, 52172.73913630407, 53180.20229696557, 53254.46745532495, 53270.467295327326, 49830.252546211836, 49834.25248621274, 49835.0, 49883.0, 50006.0, 13220.0, 13413.0, 13416.262105584092, 13460.528881489101, 13501.987350948719, 10020.949895250624, 10147.137493313152, 10150.340227885164, 10164.237682173718, 10166.694999150037, 18304.450866474028, 18400.26398944054, 18401.263949441873, 18417.0, 18474.907625462056, 7348.0, 7496.7750967471065, 7527.473076884566, 7553.395728341719, 7663.846723065619, 838.4172999765227, 860.9483430994161, 873.4540911930044, 884.9513276769711, 927.3601215161517, 26055.869720651277, 26058.478830423664, 27348.726512735015, 27524.174274771787, 27559.86220068927, 918.2332752152028, 918.7473444802599, 921.755734730297, 965.7344230336713, 966.6906589891308, 12548.458281147441, 12688.80966785499, 12759.362031898369, 12802.359882005863, 12918.870811291954, 270956.0, 278124.0, 278394.0, 278446.0, 279123.0, 44207.77896110499, 44411.0, 44453.77773111178, 44459.777701111285, 44466.33005049269, 1023.764534157148, 1116.5366372955132, 1156.1906665334468, 1209.5887398284626, 1285.010541882745, 23736.762632374146, 25493.87253063723, 27065.323366915985, 28424.43151137007, 28576.285592859513, 36319.0, 41770.58229417667, 41934.370984434645, 42057.0, 42075.7896210517, 166973.0, 246356.0, 251230.0, 251398.0, 252039.0, 26126.477470450864, 26616.7338326622, 26773.330666733487, 26807.463850723267, 26853.194404167905, 36106.4584031245, 36211.27577448384, 36531.81734091313, 36966.0, 37104.25791484209, 30833.229169270948, 30862.53706194364, 31148.844255779484, 32174.356512869144, 34586.30827383388, 33074.83462582672, 33618.15954601154, 33865.0, 33978.66021339755, 34031.48952765661, 32773.34453310968, 32825.67174328226, 32859.0, 32908.50637240396, 33361.332773343915, 29670.703292966795, 30042.549361759153, 30812.69187308098, 30852.69147308588, 31037.0, 23406.64890026685, 23448.179313723937, 23745.0, 23826.64260036066, 23918.52162956766], "prototype.html": [273.28263308814365, 278.49453242365104, 281.6859201989782, 288.6968682882975, 289.44137814018933, 5307.469253074691, 5331.57347412207, 5351.224072509489, 5358.758855851486, 5359.812406565766, 5029.949700502993, 5077.365329333833, 5171.4311425743235, 5219.373675158986, 5236.476352364762, 4081.3061779497484, 4081.795910204493, 4102.302608556538, 4131.73143745657, 4138.151678905817, 3896.2012787378662, 4124.711270211072, 4124.938125928098, 4136.358864376027, 4137.565555616662, 3947.230290093433, 3991.820368083443, 4084.4690190275223, 4103.199876024177, 4118.691098167635, 4089.8364065437645, 4096.651784598313, 4107.691923105779, 4108.239975604508, 4118.361653943643, 3604.6936010439144, 3605.675489205958, 3627.256412435471, 3633.981830090859, 3640.053586067615, 5115.769790359405, 5121.871953201163, 5129.846104616868, 5131.127708289562, 5138.177891537336, 4543.454785425737, 4677.111348843743, 4694.882627934295, 4703.3885594872445, 4706.29405589161, 5555.111182210827, 5564.276644036249, 5568.303962004749, 5570.6657600544095, 5570.6657600544095, 3907.1013666856784, 3910.393888947189, 3913.099987002977, 3915.980420097881, 3917.1773927475265, 5754.251947246873, 5829.067349224104, 5835.008048631743, 5847.853803654943, 5849.005669036274, 3874.535055793323, 3949.960500394959, 3958.782266975344, 3959.4654721612214, 3971.146203566247, 4002.9199416011515, 4009.659178969762, 4011.5988401159652, 4014.1971605678395, 4014.578469260744, 4611.100835337077, 4613.653975951817, 4660.813567457331, 4664.440267167894, 4670.95329046712, 5527.088030474926, 5539.6150962259435, 5544.972275138599, 5548.223248745179, 5563.054280772279, 1389.5970168651181, 1407.4159223922163, 1414.0384538513908, 1414.794854746056, 1442.834074081473, 948.5921053946869, 964.5659453246068, 978.3836183204678, 983.7688143286322, 989.4310771306527, 4803.303520989437, 4819.903601927942, 4821.180399332052, 4821.252705830602, 4822.734749588736, 5611.943880561143, 5667.631603945731, 5690.317161940594, 5708.686022268732, 5711.029125048752, 4679.883002924954, 4734.455537613218, 4803.831865884677, 4813.879653008703, 4891.021795640886, 3070.7236348728275, 3082.5222090576, 3100.3954228925595, 3103.968960310413, 3107.782455228112, 5433.049216387117, 5478.534324582455, 5479.6164268500825, 5486.8203336282895, 5494.313210848644, 5765.798197063083, 5908.20239267702, 5909.3795151508475, 5917.52659787216, 5919.940800591939, 5476.959377718221, 5478.123500239943, 5487.314085739283, 5487.75305111271, 5491.588130890199, 5750.741216645178, 5756.56825738063, 5762.94237057624, 5763.538916886723, 5767.192593036894, 5627.606067575231, 5632.0, 5633.830985070291, 5634.464725851038, 5641.717914104196, 5342.786288548415, 5480.753366098615, 5486.533644640251, 5513.0, 5520.503154716095, 3889.824957876959, 3942.2115576884166, 3944.8224829883297, 3945.763254204757, 3946.526416829884, 5776.595638305278, 5783.971080144573, 5785.537157027512, 5786.363500015079, 5790.478856902899, 5578.609497335147, 5583.274174357308, 5587.580931430078, 5588.30146231721, 5590.496855283044, 5423.728813559227, 5594.888102238014, 5602.663840169603, 5604.8038318658655, 5612.326520817528, 5429.104197807317, 5433.728313584226, 5464.398916119144, 5483.369412517612, 5484.753186106555, 5580.86047848807, 5581.413951535031, 5647.0964645656495, 5653.745581448927, 5659.9151012735665, 5394.919076213781, 5499.725013749377, 5503.697296648723, 5503.9174412383045, 5505.889882202414], "yui.html": [699.912510936133, 754.7924320811776, 766.7009866152198, 769.1808224241179, 793.8372633610109, 11304.660860174197, 13995.440182392706, 14177.574672759834, 14191.503297384594, 14210.644733881658, 12870.742585148291, 13052.738945221114, 13087.607371778862, 13087.934560327185, 13093.476260949574, 605.252513146264, 609.5002098279413, 766.0960067120809, 769.1347234361343, 780.8321210939647, 768.1281745219161, 768.6156921539231, 770.2913319745848, 775.1937984496145, 775.4068137874531, 805.4442434720054, 813.3290035720524, 813.5403497024192, 814.287498438866, 815.1155995744595, 622.4802290087782, 630.3318482408662, 790.93277071449, 802.9357651387875, 804.8350088231898, 587.5358466811214, 590.6751286792247, 591.1428428778289, 591.781041014823, 591.8757061017192, 11138.888611113865, 11249.943750281278, 11257.437128143642, 11315.094792416668, 11392.316461012282, 8702.216800487924, 9426.811463770686, 9431.151196392357, 9598.088181622734, 9745.658901938397, 8791.0, 8801.295896328342, 8974.102589741038, 9215.262778977665, 9264.49045302508, 2794.0919201259467, 2794.8109115604475, 2823.1953893140562, 2829.773618110546, 2831.773458123366, 37596.62403375959, 38099.80950095259, 38136.80931595352, 38137.0, 38162.23675526474, 6725.092112564839, 6814.591124532544, 6865.794026179223, 6906.37842594169, 6921.273266307066, 10658.520366583522, 10682.252242343116, 10712.089472394779, 10725.785484290427, 10735.463226838627, 5400.756965936543, 5407.540359069523, 5465.9726701366235, 5574.470425309589, 5715.885682286331, 3605.152789094561, 3607.6933460655614, 3698.3158115748674, 3715.238376132886, 3779.7354185206773, 2334.183035937442, 2357.669926210332, 2358.9882050589636, 2360.091364824555, 2363.6454531820023, 404.2904702247537, 406.2383031815346, 407.1978202940203, 407.7410844114009, 409.98155083021334, 515.718933181417, 554.8113641361956, 557.3228527339302, 573.9397363276796, 612.8958077126899, 7304.926950730531, 7357.915851514368, 7753.4572579919995, 7984.361251099898, 8450.957745211235, 464.5493870945178, 510.45587099025744, 584.3834754334218, 606.8240210338952, 617.962922224668, 3710.6474884885893, 3840.4431357453573, 3886.9611303887164, 4004.8598299059395, 4015.1367455996515, 49830.0, 50051.749741251064, 50100.498995009584, 50340.748296259015, 50396.24405633919, 42574.0, 43235.783821080695, 43286.78356608197, 43770.34344484835, 44131.77934110309, 41131.58868411277, 41320.0, 41553.79223103925, 42595.0, 43049.61879765029, 7939.325157361458, 8057.43597948138, 8185.836283274421, 8246.422750407413, 8356.749297521084, 30534.38931221319, 30595.0, 31271.0, 31655.366892662478, 31692.366152677278, 40253.597464024984, 40607.796961015, 41110.0, 41126.383104254055, 41332.76001719953, 6282.654454005074, 6320.462760665395, 6465.353464653497, 6546.574472659262, 6627.072209890523, 10177.18582513412, 10705.571777129138, 10740.355578665305, 10826.133909287395, 11006.394648294421, 8951.552422378985, 9107.908920910706, 9510.667126650535, 10094.798104038025, 10825.945870270598, 9828.4102953823, 9870.861142032685, 10016.549255283384, 10138.695839124837, 10170.898291016994, 9502.239820814457, 9609.663661771805, 9646.662366817127, 9684.972962246311, 9910.900890990997, 9023.601793597201, 9035.548222588714, 9049.59276832531, 9058.864117038382, 9447.291453141179, 8608.741737747878, 8649.524276164871, 9162.450252984841, 9268.907310926805, 9366.297527685314]}, "summary": {"lowerIsBetter": false, "suite": 6135.90137397315, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7460.4648022477795, "unit": "ms", "value": 7460.4648022477795}, "dojo.html": {"lowerIsBetter": false, "filtered": 4661.364722906718, "unit": "ms", "value": 4661.364722906718}, "mootools.html": {"lowerIsBetter": false, "filtered": 4085.8978749603516, "unit": "ms", "value": 4085.8978749603516}, "ext.html": {"lowerIsBetter": false, "filtered": 16818.213052152572, "unit": "ms", "value": 16818.213052152572}, "prototype.html": {"lowerIsBetter": false, "filtered": 4164.785452361154, "unit": "ms", "value": 4164.785452361154}, "yui.html": {"lowerIsBetter": false, "filtered": 5361.510649411118, "unit": "ms", "value": 5361.510649411118}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-050"}, "testrun": {"date": 1447650596, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115200741", "branch": "Mozilla-Inbound-Non-PGO", "revision": "c13d0478272f4601e585db42390df660d2d824bf"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 168.0, 160.0, 162.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0], "ai-astar": [109.0, 113.0, 106.0, 111.0, 112.0, 113.0, 100.0, 110.0, 113.0, 111.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "audio-beat-detection": [160.0, 133.0, 152.0, 167.0, 129.0, 155.0, 153.0, 130.0, 167.0, 130.0], "json-stringify-tinderbox": [69.0, 69.0, 68.0, 69.0, 70.0, 68.0, 69.0, 68.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [151.0, 141.0, 163.0, 144.0, 145.0, 155.0, 150.0, 162.0, 143.0, 140.0], "json-parse-financial": [68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 76.0, 66.0, 65.0], "stanford-crypto-sha256-iterative": [71.0, 70.0, 71.0, 70.0, 71.0, 69.0, 70.0, 72.0, 69.0, 70.0], "audio-fft": [73.0, 74.0, 81.0, 93.0, 73.0, 73.0, 72.0, 102.0, 88.0, 72.0], "imaging-darkroom": [148.0, 147.0, 149.0, 148.0, 149.0, 147.0, 149.0, 147.0, 148.0, 148.0], "stanford-crypto-ccm": [127.0, 122.0, 128.0, 121.0, 131.0, 122.0, 138.0, 133.0, 122.0, 125.0], "audio-oscillator": [92.0, 92.0, 125.0, 91.0, 91.0, 91.0, 136.0, 91.0, 93.0, 126.0], "stanford-crypto-aes": [81.0, 83.0, 83.0, 84.0, 85.0, 83.0, 83.0, 83.0, 84.0, 89.0], "imaging-desaturate": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1522.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.1, "unit": "ms", "value": 80.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.4, "unit": "ms", "value": 149.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 147.6, "unit": "ms", "value": 147.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 126.9, "unit": "ms", "value": 126.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.0, "unit": "ms", "value": 148.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 68.3, "unit": "ms", "value": 68.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.8, "unit": "ms", "value": 102.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.0, "unit": "ms", "value": 162.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.3, "unit": "ms", "value": 70.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.6, "unit": "ms", "value": 68.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 83.8, "unit": "ms", "value": 83.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-050"}, "testrun": {"date": 1447650596, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115200741", "branch": "Mozilla-Inbound-Non-PGO", "revision": "c13d0478272f4601e585db42390df660d2d824bf"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.90174630589138], "Encrypt": [280.58361391694723], "NavierStokes": [4901.9607843137255], "Decrypt": [5035.175879396985], "Splay": [609.0133982947625], "Richards": [171.32088401576152], "RegExp": [26868.42105263158], "Earley": [813.0081300813008], "Boyer": [11928.57142857143], "RayTrace": [2002.0]}, "summary": {"lowerIsBetter": false, "suite": 19654.256595378458, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.54089799999997, "unit": "score", "value": 344.54089799999997}, "Encrypt": {"lowerIsBetter": false, "filtered": 948.6690839999999, "unit": "score", "value": 948.6690839999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 302.7359999999999, "unit": "score", "value": 302.7359999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 133.80822200000003, "unit": "score", "value": 133.80822200000003}, "RegExp": {"lowerIsBetter": false, "filtered": 33.90541625857002, "unit": "score", "value": 33.90541625857002}, "Richards": {"lowerIsBetter": false, "filtered": 206.05777399999997, "unit": "score", "value": 206.05777399999997}, "Earley": {"lowerIsBetter": false, "filtered": 819.7494899999999, "unit": "score", "value": 819.7494899999999}, "Boyer": {"lowerIsBetter": false, "filtered": 55.871149700598814, "unit": "score", "value": 55.871149700598814}, "RayTrace": {"lowerIsBetter": false, "filtered": 369.62487512487513, "unit": "score", "value": 369.62487512487513}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-050"}, "testrun": {"date": 1447650596, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115200741", "branch": "Mozilla-Inbound-Non-PGO", "revision": "c13d0478272f4601e585db42390df660d2d824bf"}}] 21:30:14 INFO - RETURN: dromaeo_css: 6135.90 21:30:14 INFO - RETURN: kraken: 1522.40 21:30:14 INFO - RETURN: v8_7: 19654.26 21:30:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19654.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1522.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "6135.90"}}} 21:30:14 INFO - Return code: 0 21:30:14 INFO - # TBPL SUCCESS # 21:30:14 INFO - Running post-action listener: _resource_record_post_action 21:30:14 INFO - Running post-run listener: _resource_record_post_run 21:30:16 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 509464576; Read time: 0; Write time: 292356 21:30:16 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 118120448; Read time: 0; Write time: 74148 21:30:16 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 303050752; Read time: 0; Write time: 169508 21:30:16 INFO - Running post-run listener: _upload_blobber_files 21:30:16 INFO - Blob upload gear active. 21:30:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:30:16 INFO - Copying logs to upload dir... 21:30:16 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.608458 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-15 21:30:14.622086) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:30:14.625570) ========= 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=d3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009901 build_url: 'https://queue.taskcluster.net/v1/task/gfFZ2CbWQAafsJiyunmN_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:30:14.676946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:30:14.677299) ========= 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=d3f2be9b0713ec03b22325b2000001be-1447630641.986221-1093381800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:30:14.727039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 21:30:14.727357) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 21:30:14.727647) ========= ========= Total master_lag: 0.29 =========