builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1447431937.22 results: success (0) buildid: 20151113072730 builduid: 9714227fb40e48d6ba79cf124e1e44f6 revision: 97e1e855ec9ae5776ce04919f0da1d650d4f410f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.215622) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.216294) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.219753) ========= 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=928fd09416829678a2f67a56000001ac-1447431933.625129-473351241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004363 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.249680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.250006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.266551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.266980) ========= 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=928fd09416829678a2f67a56000001ac-1447431933.625129-473351241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.316812) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.317109) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.317477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.317760) ========= 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=928fd09416829678a2f67a56000001ac-1447431933.625129-473351241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 08:25:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-13 08:25:37 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.470588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.470931) ========= 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=928fd09416829678a2f67a56000001ac-1447431933.625129-473351241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022245 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.520700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:37.521177) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 97e1e855ec9ae5776ce04919f0da1d650d4f410f --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 97e1e855ec9ae5776ce04919f0da1d650d4f410f --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=928fd09416829678a2f67a56000001ac-1447431933.625129-473351241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 08:25:37,899 truncating revision to first 12 chars 2015-11-13 08:25:37,899 Setting DEBUG logging. 2015-11-13 08:25:37,899 attempt 1/10 2015-11-13 08:25:37,899 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/97e1e855ec9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 08:25:38,137 unpacking tar archive at: mozilla-inbound-97e1e855ec9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526585 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:38.060460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:38.060862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:38.068792) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:38.069086) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 08:25:38.069503) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-13 08:25:38.069829) ========= /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=928fd09416829678a2f67a56000001ac-1447431933.625129-473351241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:25:38 INFO - MultiFileLogger online at 20151113 08:25:38 in /builds/slave/test 08:25:38 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 08:25:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:25:38 INFO - {'append_to_log': False, 08:25:38 INFO - 'base_work_dir': '/builds/slave/test', 08:25:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 08:25:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:25:38 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 08:25:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:25:38 INFO - 'config_files': ('talos/linux_config.py',), 08:25:38 INFO - 'default_actions': ('clobber', 08:25:38 INFO - 'read-buildbot-config', 08:25:38 INFO - 'download-and-extract', 08:25:38 INFO - 'populate-webroot', 08:25:38 INFO - 'create-virtualenv', 08:25:38 INFO - 'install', 08:25:38 INFO - 'run-tests'), 08:25:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:25:38 INFO - 'download_minidump_stackwalk': True, 08:25:38 INFO - 'download_symbols': 'ondemand', 08:25:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:25:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:25:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:25:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:25:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:25:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:25:38 INFO - 'installer_path': 'installer.exe', 08:25:38 INFO - 'log_level': 'info', 08:25:38 INFO - 'log_name': 'talos', 08:25:38 INFO - 'log_to_console': True, 08:25:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:25:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:25:38 INFO - 'opt_config_files': (), 08:25:38 INFO - 'pip_index': False, 08:25:38 INFO - 'sps_profile': False, 08:25:38 INFO - 'sps_profile_interval': 0, 08:25:38 INFO - 'suite': 'dromaeojs', 08:25:38 INFO - 'system_bits': '64', 08:25:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:25:38 INFO - 'title': 'talos-linux64-ix-012', 08:25:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:25:38 INFO - 'use_talos_json': True, 08:25:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:25:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:25:38 INFO - 'work_dir': 'build'} 08:25:38 INFO - ##### 08:25:38 INFO - ##### Running clobber step. 08:25:38 INFO - ##### 08:25:38 INFO - Running pre-action listener: _resource_record_pre_action 08:25:38 INFO - Running main action method: clobber 08:25:38 INFO - rmtree: /builds/slave/test/build 08:25:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:25:39 INFO - Running post-action listener: _resource_record_post_action 08:25:39 INFO - ##### 08:25:39 INFO - ##### Running read-buildbot-config step. 08:25:39 INFO - ##### 08:25:39 INFO - Running pre-action listener: _resource_record_pre_action 08:25:39 INFO - Running main action method: read_buildbot_config 08:25:39 INFO - Using buildbot properties: 08:25:39 INFO - { 08:25:39 INFO - "properties": { 08:25:39 INFO - "buildnumber": 2534, 08:25:39 INFO - "product": "firefox", 08:25:39 INFO - "script_repo_revision": "production", 08:25:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 08:25:39 INFO - "repository": "", 08:25:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 08:25:39 INFO - "buildid": "20151113072730", 08:25:39 INFO - "slavename": "talos-linux64-ix-012", 08:25:39 INFO - "pgo_build": "False", 08:25:39 INFO - "basedir": "/builds/slave/test", 08:25:39 INFO - "project": "", 08:25:39 INFO - "platform": "ubuntu64_hw", 08:25:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:25:39 INFO - "slavebuilddir": "test", 08:25:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 08:25:39 INFO - "branch": "mozilla-inbound", 08:25:39 INFO - "repo_path": "integration/mozilla-inbound", 08:25:39 INFO - "stage_platform": "linux64", 08:25:39 INFO - "builduid": "9714227fb40e48d6ba79cf124e1e44f6", 08:25:39 INFO - "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f" 08:25:39 INFO - }, 08:25:39 INFO - "sourcestamp": { 08:25:39 INFO - "repository": "", 08:25:39 INFO - "hasPatch": false, 08:25:39 INFO - "project": "", 08:25:39 INFO - "branch": "mozilla-inbound-linux64-talos", 08:25:39 INFO - "changes": [ 08:25:39 INFO - { 08:25:39 INFO - "category": null, 08:25:39 INFO - "files": [ 08:25:39 INFO - { 08:25:39 INFO - "url": null, 08:25:39 INFO - "name": "https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:25:39 INFO - } 08:25:39 INFO - ], 08:25:39 INFO - "repository": "", 08:25:39 INFO - "rev": "97e1e855ec9ae5776ce04919f0da1d650d4f410f", 08:25:39 INFO - "who": "philip.chee@gmail.com", 08:25:39 INFO - "when": 1447431208, 08:25:39 INFO - "number": 6658911, 08:25:39 INFO - "comments": "Merge Bug 1204338 Followup to Bug 403800 Refactor netError.dtd/netErrorApp.dtd to simplify per-application overrides r=Pike", 08:25:39 INFO - "project": "", 08:25:39 INFO - "at": "Fri 13 Nov 2015 08:13:28", 08:25:39 INFO - "branch": "mozilla-inbound-linux64-talos", 08:25:39 INFO - "revlink": "", 08:25:39 INFO - "properties": [ 08:25:39 INFO - [ 08:25:39 INFO - "buildid", 08:25:39 INFO - "20151113072730", 08:25:39 INFO - "Change" 08:25:39 INFO - ], 08:25:39 INFO - [ 08:25:39 INFO - "builduid", 08:25:39 INFO - "9714227fb40e48d6ba79cf124e1e44f6", 08:25:39 INFO - "Change" 08:25:39 INFO - ], 08:25:39 INFO - [ 08:25:39 INFO - "pgo_build", 08:25:39 INFO - "False", 08:25:39 INFO - "Change" 08:25:39 INFO - ] 08:25:39 INFO - ], 08:25:39 INFO - "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f" 08:25:39 INFO - } 08:25:39 INFO - ], 08:25:39 INFO - "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f" 08:25:39 INFO - } 08:25:39 INFO - } 08:25:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:25:39 INFO - Running post-action listener: _resource_record_post_action 08:25:39 INFO - ##### 08:25:39 INFO - ##### Running download-and-extract step. 08:25:39 INFO - ##### 08:25:39 INFO - Running pre-action listener: _resource_record_pre_action 08:25:39 INFO - Running main action method: download_and_extract 08:25:39 INFO - mkdir: /builds/slave/test/build/tests 08:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:39 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json 08:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json 08:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:25:40 INFO - Downloaded 1302 bytes. 08:25:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:25:40 INFO - Using the following test package requirements: 08:25:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:25:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:25:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:40 INFO - u'jsshell-linux-x86_64.zip'], 08:25:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:25:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:25:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:25:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:25:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:25:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:25:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:25:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:40 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:25:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:25:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:25:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:25:41 INFO - Downloaded 21256903 bytes. 08:25:41 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 08:25:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:25:41 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 08:25:42 INFO - Return code: 0 08:25:42 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 08:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:42 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:25:43 INFO - Downloaded 21256903 bytes. 08:25:43 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 08:25:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:25:43 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 08:25:44 INFO - Return code: 0 08:25:44 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')]} 08:25:44 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:25:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:25:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:25:45 INFO - Downloaded 11131693 bytes. 08:25:45 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 08:25:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:45 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 08:25:45 INFO - Return code: 0 08:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:45 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:25:48 INFO - Downloaded 55625122 bytes. 08:25:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:25:48 INFO - mkdir: /builds/slave/test/properties 08:25:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:25:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:25:48 INFO - Contents: 08:25:48 INFO - build_url:https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:25:48 INFO - Running post-action listener: _resource_record_post_action 08:25:48 INFO - Running post-action listener: set_extra_try_arguments 08:25:48 INFO - ##### 08:25:48 INFO - ##### Running populate-webroot step. 08:25:48 INFO - ##### 08:25:48 INFO - Running pre-action listener: _resource_record_pre_action 08:25:48 INFO - Running main action method: populate_webroot 08:25:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:25:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:25:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:25:48 INFO - '../fennec_ids.txt'], 08:25:48 INFO - 'tests': ['tcheck2']}, 08:25:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:25:48 INFO - '--tppagecycles', 08:25:48 INFO - '7'], 08:25:48 INFO - 'tests': ['tsvgm']}}, 08:25:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:25:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:25:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:25:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:25:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'tests': ['damp', 'tps']}, 08:25:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['damp', 'tps']}, 08:25:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:25:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:25:48 INFO - 'other': {'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore']}, 08:25:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore']}, 08:25:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore']}, 08:25:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore']}, 08:25:48 INFO - 'other_l64': {'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore']}, 08:25:48 INFO - 'other_nol64': {'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore']}, 08:25:48 INFO - 'svgr': {'tests': ['tsvgx', 08:25:48 INFO - 'tsvgr_opacity', 08:25:48 INFO - 'tart', 08:25:48 INFO - 'tscrollx', 08:25:48 INFO - 'cart']}, 08:25:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['tsvgx', 08:25:48 INFO - 'tsvgr_opacity', 08:25:48 INFO - 'tart', 08:25:48 INFO - 'tscrollx', 08:25:48 INFO - 'cart']}, 08:25:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'tests': ['tp5o']}, 08:25:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--e10s'], 08:25:48 INFO - 'tests': ['tp5o']}, 08:25:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--xperf_path', 08:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:48 INFO - 'tests': ['tp5n']}, 08:25:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--e10s', 08:25:48 INFO - '--xperf_path', 08:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:48 INFO - 'tests': ['tp5n']}}, 08:25:48 INFO - 'talos.zip': {'path': '', 08:25:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:25:48 INFO - Running post-action listener: _resource_record_post_action 08:25:48 INFO - ##### 08:25:48 INFO - ##### Running create-virtualenv step. 08:25:48 INFO - ##### 08:25:48 INFO - Running pre-action listener: _resource_record_pre_action 08:25:48 INFO - Running main action method: create_virtualenv 08:25:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:25:48 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 08:25:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:25:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:25:48 INFO - Using real prefix '/usr' 08:25:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:25:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:25:51 INFO - Installing pip.................done. 08:25:51 INFO - Return code: 0 08:25:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:51 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 0x7f4edace5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e626c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f139a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2ac0>, '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 0x1fa39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3e50>, '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': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', '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 08:25:51 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 08:25:51 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 08:25:51 INFO - Using env: {'DISPLAY': ':0', 08:25:51 INFO - 'HOME': '/home/cltbld', 08:25:51 INFO - 'LANG': 'en_US.UTF-8', 08:25:51 INFO - 'LANGUAGE': 'en_US:en', 08:25:51 INFO - 'LOGNAME': 'cltbld', 08:25:51 INFO - 'MAIL': '/var/mail/cltbld', 08:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:51 INFO - 'MOZ_NO_REMOTE': '1', 08:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:51 INFO - 'NO_EM_RESTART': '1', 08:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:51 INFO - 'PWD': '/builds/slave/test', 08:25:51 INFO - 'SHELL': '/bin/bash', 08:25:51 INFO - 'SHLVL': '1', 08:25:51 INFO - 'TERM': 'linux', 08:25:51 INFO - 'TMOUT': '86400', 08:25:51 INFO - 'USER': 'cltbld', 08:25:51 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', 08:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:51 INFO - '_': '/tools/buildbot/bin/python'} 08:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:51 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 08:25:51 INFO - Cleaning up... 08:25:51 INFO - Return code: 0 08:25:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:51 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 0x7f4edace5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e626c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f139a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2ac0>, '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 0x1fa39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3e50>, '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': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', '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 08:25:51 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 08:25:51 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 08:25:51 INFO - Using env: {'DISPLAY': ':0', 08:25:51 INFO - 'HOME': '/home/cltbld', 08:25:51 INFO - 'LANG': 'en_US.UTF-8', 08:25:51 INFO - 'LANGUAGE': 'en_US:en', 08:25:51 INFO - 'LOGNAME': 'cltbld', 08:25:51 INFO - 'MAIL': '/var/mail/cltbld', 08:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:51 INFO - 'MOZ_NO_REMOTE': '1', 08:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:51 INFO - 'NO_EM_RESTART': '1', 08:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:51 INFO - 'PWD': '/builds/slave/test', 08:25:51 INFO - 'SHELL': '/bin/bash', 08:25:51 INFO - 'SHLVL': '1', 08:25:51 INFO - 'TERM': 'linux', 08:25:51 INFO - 'TMOUT': '86400', 08:25:51 INFO - 'USER': 'cltbld', 08:25:51 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', 08:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:51 INFO - '_': '/tools/buildbot/bin/python'} 08:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:51 INFO - Downloading/unpacking psutil>=0.7.1 08:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:25:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:53 INFO - Installing collected packages: psutil 08:25:53 INFO - Running setup.py install for psutil 08:25:53 INFO - building 'psutil._psutil_linux' extension 08:25:53 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 08:25:53 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 08:25:53 INFO - building 'psutil._psutil_posix' extension 08:25:53 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 08:25:53 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 08:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:53 INFO - Successfully installed psutil 08:25:53 INFO - Cleaning up... 08:25:53 INFO - Return code: 0 08:25:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:53 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 0x7f4edace5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e626c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f139a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2ac0>, '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 0x1fa39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3e50>, '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': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', '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 08:25:53 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 08:25:53 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 08:25:53 INFO - Using env: {'DISPLAY': ':0', 08:25:53 INFO - 'HOME': '/home/cltbld', 08:25:53 INFO - 'LANG': 'en_US.UTF-8', 08:25:53 INFO - 'LANGUAGE': 'en_US:en', 08:25:53 INFO - 'LOGNAME': 'cltbld', 08:25:53 INFO - 'MAIL': '/var/mail/cltbld', 08:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:53 INFO - 'MOZ_NO_REMOTE': '1', 08:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:53 INFO - 'NO_EM_RESTART': '1', 08:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:53 INFO - 'PWD': '/builds/slave/test', 08:25:53 INFO - 'SHELL': '/bin/bash', 08:25:53 INFO - 'SHLVL': '1', 08:25:53 INFO - 'TERM': 'linux', 08:25:53 INFO - 'TMOUT': '86400', 08:25:53 INFO - 'USER': 'cltbld', 08:25:53 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', 08:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:53 INFO - '_': '/tools/buildbot/bin/python'} 08:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:25:54 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 08:25:54 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 08:25:54 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 08:25:54 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 08:25:54 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 08:25:54 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 08:25:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:25:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:25:55 INFO - Installing collected packages: mozsystemmonitor 08:25:55 INFO - Running setup.py install for mozsystemmonitor 08:25:55 INFO - Successfully installed mozsystemmonitor 08:25:55 INFO - Cleaning up... 08:25:56 INFO - Return code: 0 08:25:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f4edace5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e626c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f139a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2ac0>, '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 0x1fa39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3e50>, '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': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', '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 08:25:56 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 08:25:56 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 08:25:56 INFO - Using env: {'DISPLAY': ':0', 08:25:56 INFO - 'HOME': '/home/cltbld', 08:25:56 INFO - 'LANG': 'en_US.UTF-8', 08:25:56 INFO - 'LANGUAGE': 'en_US:en', 08:25:56 INFO - 'LOGNAME': 'cltbld', 08:25:56 INFO - 'MAIL': '/var/mail/cltbld', 08:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:56 INFO - 'MOZ_NO_REMOTE': '1', 08:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:56 INFO - 'NO_EM_RESTART': '1', 08:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:56 INFO - 'PWD': '/builds/slave/test', 08:25:56 INFO - 'SHELL': '/bin/bash', 08:25:56 INFO - 'SHLVL': '1', 08:25:56 INFO - 'TERM': 'linux', 08:25:56 INFO - 'TMOUT': '86400', 08:25:56 INFO - 'USER': 'cltbld', 08:25:56 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', 08:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:56 INFO - '_': '/tools/buildbot/bin/python'} 08:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:58 INFO - Downloading docopt-0.6.1.tar.gz 08:25:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:58 INFO - Running setup.py install for blobuploader 08:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:58 INFO - Running setup.py install for requests 08:25:59 INFO - Running setup.py install for docopt 08:25:59 INFO - Successfully installed blobuploader requests docopt 08:25:59 INFO - Cleaning up... 08:25:59 INFO - Return code: 0 08:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:59 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 0x7f4edace5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e626c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f139a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2ac0>, '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 0x1fa39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3e50>, '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': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', '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 08:25:59 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 08:25:59 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 08:25:59 INFO - Using env: {'DISPLAY': ':0', 08:25:59 INFO - 'HOME': '/home/cltbld', 08:25:59 INFO - 'LANG': 'en_US.UTF-8', 08:25:59 INFO - 'LANGUAGE': 'en_US:en', 08:25:59 INFO - 'LOGNAME': 'cltbld', 08:25:59 INFO - 'MAIL': '/var/mail/cltbld', 08:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:59 INFO - 'MOZ_NO_REMOTE': '1', 08:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:59 INFO - 'NO_EM_RESTART': '1', 08:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:59 INFO - 'PWD': '/builds/slave/test', 08:25:59 INFO - 'SHELL': '/bin/bash', 08:25:59 INFO - 'SHLVL': '1', 08:25:59 INFO - 'TERM': 'linux', 08:25:59 INFO - 'TMOUT': '86400', 08:25:59 INFO - 'USER': 'cltbld', 08:25:59 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', 08:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:59 INFO - '_': '/tools/buildbot/bin/python'} 08:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:59 INFO - Running setup.py (path:/tmp/pip-2eE4CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:59 INFO - Running setup.py (path:/tmp/pip-9MKfda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:59 INFO - Running setup.py (path:/tmp/pip-ieN3OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:59 INFO - Running setup.py (path:/tmp/pip-tpNkEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:59 INFO - Running setup.py (path:/tmp/pip-sJ3pzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:59 INFO - Running setup.py (path:/tmp/pip-RIkzxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:59 INFO - Running setup.py (path:/tmp/pip-tRgIxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:59 INFO - Running setup.py (path:/tmp/pip-QEHkMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:59 INFO - Running setup.py (path:/tmp/pip-kPcYT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:00 INFO - Running setup.py (path:/tmp/pip-vMDrqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:00 INFO - Running setup.py (path:/tmp/pip-VbCku_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:00 INFO - Running setup.py (path:/tmp/pip-jAOcPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:00 INFO - Running setup.py (path:/tmp/pip-naiMUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:00 INFO - Running setup.py (path:/tmp/pip-8gRyOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:00 INFO - Running setup.py (path:/tmp/pip-IMBs4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:00 INFO - Running setup.py (path:/tmp/pip-JbWtF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:00 INFO - Running setup.py (path:/tmp/pip-60FAiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:00 INFO - Running setup.py install for manifestparser 08:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Running setup.py install for mozcrash 08:26:00 INFO - Running setup.py install for mozdebug 08:26:00 INFO - Running setup.py install for mozdevice 08:26:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozfile 08:26:01 INFO - Running setup.py install for mozhttpd 08:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozinfo 08:26:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozInstall 08:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozleak 08:26:01 INFO - Running setup.py install for mozlog 08:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for moznetwork 08:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozprocess 08:26:01 INFO - Running setup.py install for mozprofile 08:26:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozrunner 08:26:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:26:02 INFO - Running setup.py install for mozscreenshot 08:26:02 INFO - Running setup.py install for moztest 08:26:02 INFO - Running setup.py install for mozversion 08:26:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:26:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:26:02 INFO - Cleaning up... 08:26:02 INFO - Return code: 0 08:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4edace5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e626c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f139a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2ac0>, '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 0x1fa39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3e50>, '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': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', '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 08:26:02 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 08:26:02 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 08:26:02 INFO - Using env: {'DISPLAY': ':0', 08:26:02 INFO - 'HOME': '/home/cltbld', 08:26:02 INFO - 'LANG': 'en_US.UTF-8', 08:26:02 INFO - 'LANGUAGE': 'en_US:en', 08:26:02 INFO - 'LOGNAME': 'cltbld', 08:26:02 INFO - 'MAIL': '/var/mail/cltbld', 08:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:02 INFO - 'MOZ_NO_REMOTE': '1', 08:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:02 INFO - 'NO_EM_RESTART': '1', 08:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:02 INFO - 'PWD': '/builds/slave/test', 08:26:02 INFO - 'SHELL': '/bin/bash', 08:26:02 INFO - 'SHLVL': '1', 08:26:02 INFO - 'TERM': 'linux', 08:26:02 INFO - 'TMOUT': '86400', 08:26:02 INFO - 'USER': 'cltbld', 08:26:02 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', 08:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:02 INFO - '_': '/tools/buildbot/bin/python'} 08:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:02 INFO - Running setup.py (path:/tmp/pip-1FGHGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:02 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)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:02 INFO - Running setup.py (path:/tmp/pip-ABnO6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:02 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)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:02 INFO - Running setup.py (path:/tmp/pip-7bD9Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:02 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)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:02 INFO - Running setup.py (path:/tmp/pip-xIoVEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:02 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)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:02 INFO - Running setup.py (path:/tmp/pip-3XWf0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:02 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)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:02 INFO - Running setup.py (path:/tmp/pip-Sozjq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:03 INFO - Running setup.py (path:/tmp/pip-fCcevr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:03 INFO - Running setup.py (path:/tmp/pip-nEd9N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:03 INFO - Running setup.py (path:/tmp/pip-oqWuSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:03 INFO - Running setup.py (path:/tmp/pip-2FKykl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:03 INFO - Running setup.py (path:/tmp/pip-tskF18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:03 INFO - Running setup.py (path:/tmp/pip-DwxFp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:03 INFO - Running setup.py (path:/tmp/pip-aa5QrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:03 INFO - Running setup.py (path:/tmp/pip-CmKzwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:03 INFO - Running setup.py (path:/tmp/pip-kSvHvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:03 INFO - Running setup.py (path:/tmp/pip-2qdsrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:03 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)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:03 INFO - Running setup.py (path:/tmp/pip-RT3_Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:03 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)) 08:26:03 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)) 08:26:03 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)) 08:26:03 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)) 08:26:03 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)) 08:26:03 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)) 08:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:03 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 08:26:03 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 08:26:03 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 08:26:03 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 08:26:03 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 08:26:03 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 08:26:05 INFO - Downloading blessings-1.5.1.tar.gz 08:26:05 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 08:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:26:05 INFO - Installing collected packages: blessings 08:26:05 INFO - Running setup.py install for blessings 08:26:05 INFO - Successfully installed blessings 08:26:05 INFO - Cleaning up... 08:26:05 INFO - Return code: 0 08:26:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:05 INFO - Reading from file tmpfile_stdout 08:26:05 INFO - Current package versions: 08:26:05 INFO - argparse == 1.2.1 08:26:05 INFO - blessings == 1.5.1 08:26:05 INFO - blobuploader == 1.2.4 08:26:05 INFO - docopt == 0.6.1 08:26:05 INFO - manifestparser == 1.1 08:26:05 INFO - mozInstall == 1.12 08:26:05 INFO - mozcrash == 0.16 08:26:05 INFO - mozdebug == 0.1 08:26:05 INFO - mozdevice == 0.47 08:26:05 INFO - mozfile == 1.2 08:26:05 INFO - mozhttpd == 0.7 08:26:05 INFO - mozinfo == 0.9 08:26:05 INFO - mozleak == 0.1 08:26:05 INFO - mozlog == 3.0 08:26:05 INFO - moznetwork == 0.27 08:26:05 INFO - mozprocess == 0.22 08:26:05 INFO - mozprofile == 0.27 08:26:05 INFO - mozrunner == 6.11 08:26:05 INFO - mozscreenshot == 0.1 08:26:05 INFO - mozsystemmonitor == 0.0 08:26:05 INFO - moztest == 0.7 08:26:05 INFO - mozversion == 1.4 08:26:05 INFO - psutil == 3.1.1 08:26:05 INFO - requests == 1.2.3 08:26:05 INFO - wsgiref == 0.1.2 08:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:05 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 0x7f4edace5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e626c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f139a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2ac0>, '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 0x1fa39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3e50>, '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': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', '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 08:26:05 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 08:26:05 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 08:26:05 INFO - Using env: {'DISPLAY': ':0', 08:26:05 INFO - 'HOME': '/home/cltbld', 08:26:05 INFO - 'LANG': 'en_US.UTF-8', 08:26:05 INFO - 'LANGUAGE': 'en_US:en', 08:26:05 INFO - 'LOGNAME': 'cltbld', 08:26:05 INFO - 'MAIL': '/var/mail/cltbld', 08:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:05 INFO - 'MOZ_NO_REMOTE': '1', 08:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:05 INFO - 'NO_EM_RESTART': '1', 08:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:05 INFO - 'PWD': '/builds/slave/test', 08:26:05 INFO - 'SHELL': '/bin/bash', 08:26:05 INFO - 'SHLVL': '1', 08:26:05 INFO - 'TERM': 'linux', 08:26:05 INFO - 'TMOUT': '86400', 08:26:05 INFO - 'USER': 'cltbld', 08:26:05 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', 08:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:05 INFO - '_': '/tools/buildbot/bin/python'} 08:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 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)) 08:26:06 INFO - Cleaning up... 08:26:06 INFO - Return code: 0 08:26:06 INFO - Running post-action listener: _resource_record_post_action 08:26:06 INFO - Running post-action listener: _start_resource_monitoring 08:26:06 INFO - Starting resource monitoring. 08:26:06 INFO - ##### 08:26:06 INFO - ##### Running install step. 08:26:06 INFO - ##### 08:26:06 INFO - Running pre-action listener: _resource_record_pre_action 08:26:06 INFO - Running main action method: install 08:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:06 INFO - Reading from file tmpfile_stdout 08:26:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:26:06 INFO - Reading from file tmpfile_stdout 08:26:06 INFO - Output received: 08:26:06 INFO - Usage: mozinstall [options] installer 08:26:06 INFO - Options: 08:26:06 INFO - -h, --help show this help message and exit 08:26:06 INFO - -d DEST, --destination=DEST 08:26:06 INFO - Directory to install application into. [default: 08:26:06 INFO - "/builds/slave/test"] 08:26:06 INFO - --app=APP Application being installed. [default: firefox] 08:26:06 INFO - mkdir: /builds/slave/test/build/application 08:26:06 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'] 08:26:06 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 08:26:20 INFO - Reading from file tmpfile_stdout 08:26:20 INFO - Output received: 08:26:20 INFO - /builds/slave/test/build/application/firefox/firefox 08:26:20 INFO - Running post-action listener: _resource_record_post_action 08:26:20 INFO - ##### 08:26:20 INFO - ##### Running run-tests step. 08:26:20 INFO - ##### 08:26:20 INFO - Running pre-action listener: _resource_record_pre_action 08:26:20 INFO - Running main action method: run_tests 08:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:26:20 INFO - Python 2.7.3 08:26:20 INFO - Return code: 0 08:26:20 INFO - grabbing minidump binary from tooltool 08:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2ac0>, '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 0x1fa39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:26:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:26:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:26:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:26:20 INFO - Return code: 0 08:26:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:26:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:26:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:26:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:26:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:26:20 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/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] in /builds/slave/test/build 08:26:20 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/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost 08:26:20 INFO - Using env: {'DISPLAY': ':0', 08:26:20 INFO - 'HOME': '/home/cltbld', 08:26:20 INFO - 'LANG': 'en_US.UTF-8', 08:26:20 INFO - 'LANGUAGE': 'en_US:en', 08:26:20 INFO - 'LOGNAME': 'cltbld', 08:26:20 INFO - 'MAIL': '/var/mail/cltbld', 08:26:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:26:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:20 INFO - 'MOZ_NO_REMOTE': '1', 08:26:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:20 INFO - 'NO_EM_RESTART': '1', 08:26:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:20 INFO - 'PWD': '/builds/slave/test', 08:26:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:26:20 INFO - 'SHELL': '/bin/bash', 08:26:20 INFO - 'SHLVL': '1', 08:26:20 INFO - 'TERM': 'linux', 08:26:20 INFO - 'TMOUT': '86400', 08:26:20 INFO - 'USER': 'cltbld', 08:26:20 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447431933.625129-473351241', 08:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:20 INFO - '_': '/tools/buildbot/bin/python'} 08:26:20 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/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] with output_timeout 3600 08:26:20 INFO - mozversion INFO | application_buildid: 20151113072730 08:26:20 INFO - mozversion INFO | application_changeset: 97e1e855ec9ae5776ce04919f0da1d650d4f410f 08:26:20 INFO - mozversion INFO | application_display_name: Nightly 08:26:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:26:20 INFO - mozversion INFO | application_name: Firefox 08:26:20 INFO - mozversion INFO | application_remotingname: firefox 08:26:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:26:20 INFO - mozversion INFO | application_vendor: Mozilla 08:26:20 INFO - mozversion INFO | application_version: 45.0a1 08:26:20 INFO - mozversion INFO | platform_buildid: 20151113072730 08:26:20 INFO - mozversion INFO | platform_changeset: 97e1e855ec9ae5776ce04919f0da1d650d4f410f 08:26:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:26:20 INFO - mozversion INFO | platform_version: 45.0a1 08:26:20 INFO - 2015-11-13 08:26:20,817 DEBUG : using testdate: 1447431980 08:26:20 INFO - 2015-11-13 08:26:20,817 DEBUG : actual date: 1447431980 08:26:20 INFO - 2015-11-13 08:26:20,828 INFO : starting webserver on 'localhost:36412' 08:26:20 INFO - 2015-11-13 08:26:20,830 INFO : Starting test suite talos-linux64-ix-012 08:26:20 INFO - 2015-11-13 08:26:20,830 INFO : Starting test dromaeo_css 08:26:20 INFO - 2015-11-13 08:26:20,830 DEBUG : operating with platform_type : linux_ 08:26:20 INFO - 2015-11-13 08:26:20,831 INFO : Initialising browser for dromaeo_css test... 08:26:20 INFO - 2015-11-13 08:26:20,844 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAK3eiH/profile http://localhost:36412/getInfo.html 08:26:24 INFO - 2015-11-13 08:26:24,903 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:26:24 INFO - 2015-11-13 08:26:24,904 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:26:24 INFO - 2015-11-13 08:26:24,904 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:26:24 INFO - 2015-11-13 08:26:24,904 DEBUG : BROWSER_OUTPUT: __metrics 08:26:25 INFO - 2015-11-13 08:26:25,000 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:26:26 INFO - 2015-11-13 08:26:26,615 INFO : Browser initialized. 08:26:26 INFO - 2015-11-13 08:26:26,615 INFO : Running cycle 1/1 for dromaeo_css test... 08:26:26 INFO - 2015-11-13 08:26:26,615 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAK3eiH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:26:38 INFO - 2015-11-13 08:26:38,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 140783616 08:26:38 INFO - 2015-11-13 08:26:38,518 DEBUG : BROWSER_OUTPUT: 08:27:29 INFO - 2015-11-13 08:27:29,936 DEBUG : BROWSER_OUTPUT: 1447432049930 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] 08:29:41 INFO - 2015-11-13 08:29:41,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36412/tests/dromaeo/cssquery-ext.html) 08:29:42 INFO - 2015-11-13 08:29:42,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 252448768 08:29:42 INFO - 2015-11-13 08:29:42,853 DEBUG : BROWSER_OUTPUT: 08:32:45 INFO - 2015-11-13 08:32:45,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/dromaeo/cssquery-ext.html (next: http://localhost:36412/tests/dromaeo/cssquery-jquery.html) 08:32:45 INFO - 2015-11-13 08:32:45,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 220037120 08:32:45 INFO - 2015-11-13 08:32:45,948 DEBUG : BROWSER_OUTPUT: 08:35:47 INFO - 2015-11-13 08:35:47,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36412/tests/dromaeo/cssquery-mootools.html) 08:35:48 INFO - 2015-11-13 08:35:48,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 215875584 08:35:48 INFO - 2015-11-13 08:35:48,486 DEBUG : BROWSER_OUTPUT: 08:38:50 INFO - 2015-11-13 08:38:50,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36412/tests/dromaeo/cssquery-prototype.html) 08:38:51 INFO - 2015-11-13 08:38:51,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 200110080 08:38:51 INFO - 2015-11-13 08:38:51,025 DEBUG : BROWSER_OUTPUT: 08:41:53 INFO - 2015-11-13 08:41:53,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36412/tests/dromaeo/cssquery-yui.html) 08:41:54 INFO - 2015-11-13 08:41:54,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 204005376 08:41:54 INFO - 2015-11-13 08:41:54,283 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/dromaeo/cssquery-yui.html (next: http://localhost:36412/tests/dromaeo/cssquery-dojo.html) 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 246738944 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2666.400059986503;2752.6696796384435;2767.3358393985436;2769.612254284402;2772.3207814085554;4598.2872654738485;4707.952920470794;4781.856544303672;4826.469088400273;4844.0554091952035;4717.9764101179535;4762.714237145774;4790.257510085942;4791;4909.926351104737;4362.607365337119;4373.606375426211;4384.517703052654;4391.319345501436;4412.205802955466;4194.077302993336;4444.2444784386735;4472;4507.211238033331;4525.683202175849;4320.6327462165755;4330.220560299145;4405.889852753675;4421.624161946238;4464.977675111603;4444.711093778894;4449.488308844459;4454.9777251113865;4455.086707225011;4508.932366014513;4202.306619407794;4328.761918094535;4416.470023597157;4436.44544431946;4488.775561221926;4599.67802253839;4701.835435759766;4725.291206319045;4729.59798417135;4756.548127927841;5122.667026643257;5123.2827404163445;5125.1287281162295;5133.717645529532;5163.561097306733;4956.603471722254;5065.772040258197;5077.162268225775;5155.5617772489;5167.586593072545;4546.8863278417975;4594.19601569724;4603.6777425579885;4621.145088158634;4660.417447819056;5171.5862730981435;5180.740962951837;5240.816571419982;5269.473052694777;5279.155335146435;4778.283257511401;4885;4888.731119788375;4941.061198372297;4953.72754498506;4962.255661650709;5053.7220452875445;5063.746812659352;5066.316047333637;5105.923411148836;5032.874178145503;5071.822486212965;5073.695578265316;5086.16078347076;5128.487151284916;4835.95164048355;4962.751862406865;5063.06333328328;5065.214891691794;5072.416672082684;4121.4848143982;4195.937060944088;4197.139586384784;4221.113566151082;4227.957720422756;3723.906902327409;3749.8500059997295;3750.624937506282;3758.812059397074;3784.6026167252594;4185.958140418617;4427.778611069433;4449.154660614473;4453.665975051884;4495.595396414273;5033.874153146201;5038.244263360525;5069.087564238399;5195.870103247449;5245.449227831099;4359;4390.363397307373;4392;4401.801918913657;4416.4037854889175;4399.5380485049245;4515.277555591089;4517.028838799673;4524.25349817283;4569.95430045702;4708.552687494683;4745.738984355894;4751.904961900743;4788.353572267839;4847.927281090716;5080;5117.9764047189965;5120.923186152285;5124.154514505214;5167.121589329748;4664.650151238603;4820.25286080658;4828.517148285284;4830.830920917751;4860.73265970375;4917.164082105979;4981.178105612534;5019.548240658212;5030.4466508684745;5039.798408063636;5055.494450554915;5056.7471626419265;5061.924071138862;5068.113080211022;5097.108006098992;4736.715797052188;4905.583025442877;4910.337104490848;4911.754412279301;4953.18272485036;4762.595179409789;4780.904381912412;4781.617470602413;4837.37114175155;4861;4778.498257682893;4819.180739274402;4833.492483289204;4839.346688197048;4872.196087645499;4787.736674482798;4901.264810278487;4953.529414705597;4962.751862406937;4996.200607902718;4818;4826.638002149783;4846.975765121152;4897.681650692693;4946.975265123651 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.6585916731626;559.1780083277581;560.3220103674554;564.8954943335481;583.3437382944188;28452.443444569428;37525.62474375255;38005.429918551206;38129.23741525168;38230.426543601796;39947.80026099866;40417.59582404175;40420.19159616806;40474.59525404745;40547;6984.825379365506;7081.716731330766;8014.438989270768;8183.754487365389;8196.098429172785;10065.899341006607;10291.073803357696;10291.125254353352;10295.124914382286;10303.3817970922;10163.339382940123;10273.17814574836;10275.229357798158;10290.897091029106;10292.713410823648;9908.603655853758;9991.950040249752;9995.45025023627;9997.80004399908;9999.850002249972;10031.297809153362;10128.696139115838;10161.288709790319;10165.89834101657;10168.389896606228;36611.81694091539;37056.25887482262;37141.442878356844;37148.28517148291;37160.81419592912;2732.7540521353176;2851.1019029005797;3302.2239773653173;3326.4843949187916;3538.5046093546925;27778.444431111468;27891;28145.15564533047;28414.85792571024;28437.715622843712;3092.9536056959164;3100.1319630503494;3127.62468503781;3136;3180.7296379807744;221899;222765;223602;223916.99999999837;223970;50515;51721;53885.730571346896;54525.454745452036;55521.72239138859;50015.749921250164;50101.49898501041;50299;50380.244296335586;50396.748016259684;12095.879041209475;13867.791983120262;13996.090254133449;14084;14127;8517.190866867637;10390.740231494274;10912.127029837595;10923.672289831318;10928.125749939985;18113.094345282683;18404.631907362047;18518.16668249932;18635.254589816257;18682.34611788581;7037.437005039585;7200.783976480714;7259.237780033126;7353.485256032133;7441.330280274801;809.29591255608;820.7004443378244;847.6270441005938;886.689658619491;1048.3919326790444;23524.41188970255;25087.62368564473;25403.491930161294;25545.489090218092;25571.488570228492;917.1012407840353;991;1021.6271061062807;1045.639254457211;1062.990159348622;13505.662358441117;13996.720065598834;14751.336189871266;14787.260636968109;15436.691266174837;252449;253709;255869;256371;256502;46461.76769116133;46702.29946550805;46791;46819.29771053437;46842.29736553955;1176.347127344315;1184.5709632042542;1205.764875849201;1213.308414203913;1215.5927764198916;26183.73816261889;26927.192184234504;27305;27309;27398.315042124108;41006.79496602498;41242.58757412388;41372.58627413688;41451.58548414477;41510.37734433926;215727;216754;314129;319371;322702;28265.858670706515;28308.292292692848;28318.57522137211;28653.426931461672;28703.712962870104;38855.41716874306;40032.199356012134;40057.79971100126;40188.45489868255;40223.79888100658;33595;34494.82752586221;34993.82503087468;35076;35397;25869.6838866553;30417;31229.843850780602;32186.19534511656;32319.51520727238;30439.847800760854;30724.84637576798;30893.227669308446;30936;30938;25897.741022589533;27205;27827.304317392227;29424.705752943053;29913.551296730133;23174.768252317936;23657.52684946326;23990.28029159128;23999.400014999766;24007.879960600087 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.00729817844643;335.2273010710313;335.3962866839688;336.1361301455258;337.7399402460106;12413;12883.613491595244;15194.784417246621;15477.921652513569;17409.04250266235;14860.108393496397;14977.101373917572;14977.850221497782;14989.700205995874;15205.163715995615;4575.87890966712;4617.976910115462;4778.116048531024;4966.652334336598;4967.403911530621;4876.634252431064;4910.656254062217;4917.262410638397;4919.13915064864;4921.926171107436;4164.8125834337525;4868.148074087038;4871.7076975381415;5003.574696150831;5009.4239162496415;4910.337104490884;4939.53074457926;4952.653314268003;4953.281774142747;4957.727324997124;4280.614744672995;4398.362237475548;4403.867883963454;4403.9779801100785;4419.469663640351;18574.907125464288;18700.719489207673;18892.71660925087;19383.127759250725;19590.608187836307;1841.6316736652589;1848.3992702371784;1853.629274145163;1883.077292126848;1896.1277812206401;12634.873651263553;12679.809802852964;12771.169873958162;13087.607371778862;13094.410751516109;1594.1630643911924;1699.1504247876062;1722.8018777840584;1740.5648587853036;1798.1818272685896;53030;54523.727381363235;54885.1767223492;55899.72050139764;56295;6020.367861374492;6263.874722505616;6279.96860015697;6332.905006424908;6409.55133140685;6968.3728464438445;7038.085048943707;7244.38422734063;7347.8163045924275;7361.852762944711;4888.535589119028;4955.231939049453;4958.033183529177;5086.4659210783075;5124.461931497213;5137.075326441276;5165.715885626251;5207.843764687065;5221.895562088737;5270.367555893241;2892.190186747714;2957.8668959896854;2965.584818125464;2979.3743313904324;2982.9552556711233;1048.7692707604315;1051.1380667852288;1053.7787064716495;1056.529844219315;1102.5920409448556;368.0706216802595;402.86302657096144;406.30319002910153;424.1876805916697;449.3663933853251;8939.329550283755;9179.541022948826;9418.90581094194;9573.425594464354;9720.562574684156;380.40086863190584;387.8041588997538;388.3533916029835;388.6036243032148;398.27513924657427;5176.741162941913;5181.300524429229;5224.373075230997;5246.895062098737;5248.8425347239645;430017;432476;459326;490776;503825;63680.68159659172;66705;66708.33291667118;68064.6596767013;68345;470.3274317725685;476.1310608140158;476.90223504180864;476.988783778392;478.0629965268044;8549.401541892008;9694.127528522467;9697.6605818796;9719.805603888024;9895.356801808148;29142.854285728437;29487.410251794416;30993.225169370948;32581.18547036343;32734;38415.807920960215;43004;43398;44488.55511444844;44906;5900.911486327795;5956.225690660186;6002.489788368038;6067.787627433018;6080.48315893154;10836;11025.558977640805;11101.444927753742;11437.313761174357;11522.251053681484;9808.705738827846;9859.112679858847;9862.358946668444;10219.693409197736;10264.178865690876;9700.223982081558;9839.409635421898;9965.750856228653;9977.501124943868;10002.599896004078;9326.487043212688;9337.299702522203;10092.192624589869;10346.844797327896;10351.275410721177;6022.36765139654;6067.059605761114;6086.2087928569;6087.847803804763;6170.660613666291;9212.631494740403;9341.626334946526;10122;10148.492575371054;10260.948695256477 08:44:57 INFO - 2015-11-13 08:44:57,285 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1232.5193174661888;1632.6000129968158;1673.4226691791328;1693.2718930859726;1708.2654458582804;5536.086545719956;6660.267370589231;6885.173779146497;6888.10454640896;6893.931060689391;6835.7607483738075;7034.472414568902;7051.400630946376;7053.682584283707;7058.15302163741;2003.819656230939;2040.9795902040937;2043.795620437959;2046.2531176120758;2049.5695903860205;2018.0918586635999;2046.2735728816278;2054.0243384392443;2057.567910738747;2064.7728749837506;1963.5189378602263;1972.7139564763102;1989.6518109330882;1997.7702564205158;2004.1282042311568;1980.7524059492564;2006.6889632107047;2008.4577164165594;2009.0657844102489;2010.2963962613114;2002.339228054753;2027.3816485971772;2028.5537181819975;2029.7767245602972;2034.074496104269;5992.940070599282;6135.417135372132;6907.274736152682;6990.650467476606;6997;4154;4233.809478573472;4265.360195970598;4266.637335826458;4270.850520231808;2668.919932402031;2678.2099280712237;2718.7417195366406;2721.18364490654;2743.7942154338502;880.330948479154;886.7871710789428;895.8118795053047;902.3863772634605;903.2142036428284;9246.398984066014;9375.953120234355;9392;9399.154076133182;9449.622015119387;3893.844246230119;3894.162755007687;3940.271049855786;3950.0322421006463;3954.387070004154;8314.542700151549;8340.29107525867;8358.749237522885;8368.288695460833;8376.329893608498;4309.6552275818485;4310.094880075157;4310.676699247569;4312.978435107804;4315.784210789448;3871.3031654302495;3875.1280961783937;3876.6317199865966;3877.418387241936;3879.2241551689776;3328.0681409205463;3333.4833100869405;3348.9162770930434;3354.781939173946;3367.2255381261957;1046.9790604188026;1057.038095333243;1058.8570542976754;1065.7548763784218;1067.2475904487317;965.8261512927741;977.9266555008403;978.9755256118654;1043.8486419469286;1203.2179083595734;6734.259231484532;6790.966045169743;6793.966030169916;6794.796156115324;6802.727890884408;414.4632700652662;420.7286300336266;421.25017468905395;429.11387983813324;430.13972055888223;4891.437484689235;5225.947740522546;5250.868728281747;5303.231031500411;5320.334958130234;7453.888191677129;8443.113473085361;8546.102659220816;8556;8582.184692454206;8251.381146414044;8310.916890831015;8360.331173506105;8385.832283354299;8390.412671112963;6443.355664433519;6628.23775265841;6634.104395906491;6663.400293973566;6682.532222744361;6525.967370163119;6548.607083575001;6615.239247486601;6617.470602351704;6623.801285961236;6904;7456.217097204715;7470.962645186739;7484.738034168778;7501.437392195498;7517.361024312994;7725.111612164448;7731.188225236269;7742.8451430969935;7754.418418618739;5969.492593129459;6190.102435146789;6193.38066193377;6223.564350495603;6258.780942666985;6689.565178263398;6718.563293385914;6725.730970761115;6736.326367363225;6740.561863478858;6238.095476156022;6352.809415717536;6375.553711240169;6387.297397286202;6390.808275751735;5965.8806823862415;6049.969750151221;6082.847928801815;6168.599041062316;6184.690765461619;6467.902981455376;6499.415052645285;6501.804945851632;6505.642189679424;6513.088167656627;5982.850428739142;6002.769432266462;6031.607945483705;6046.1535385045245;6048.758049677964;6163.8150855474405;6211.316755156839;6220.409061139185;6223.284322302993;6225.28409232944 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.4663372760393;290.7499550386667;290.93308539036013;296.1456198866272;297.9925501862452;5081.46644602317;5398.3521977362725;5457.481539253769;5473.124300111983;5489.615726899118;5072.974635126829;5189.6506908203855;5212.895742085156;5382.515573598375;5395.838124856251;4122.196171746511;4140.8964775880695;4141.39949707293;4149.273877071516;4152.2733521633745;3945.80270986451;4110.958890411088;4151.522574903895;4153;4153.7507749535125;3986.40203969404;4015.7791321477307;4048.089179934506;4070.87787366378;4115.197536480373;4061.6750659947133;4085.4893138357706;4089.141280331134;4094.7338423002557;4101.384792281182;3588.4079126944025;3589.4974703541525;3590.4434812603827;3598.964010359889;3599.4240921452442;5180.870478238075;5189.662671926313;5192.818251361222;5193.740312984336;5196.558292545138;4513.932291015637;4667.113248482778;4679.22792739201;4680.531946805327;4741.431028276595;5661.886762264731;5662.518685911702;5666;5667.178259152441;5671.7164141793155;3825.598312177209;3827.502424684801;3833.7891415972113;3838.539375274957;3838.558565764917;5886.852828679274;5968.7612495500125;5979.880402391927;5985.910211346877;5990.820275391745;3836.405357169643;3929.292727309112;3930.371140617545;3932.980335098306;3952.980235098806;3969.3450580653866;3993.3011722948368;3995.820188091485;3997.420374045747;4008.178323443687;4630.86107416778;4638.304254361873;4644.790984405642;4647.09381670571;4650.906981860411;5667.376588575254;5669.206311116447;5671.893980673729;5674.943250567441;5680.40355762639;1383.073340861605;1387.9930600346934;1415.6390120519202;1418.212891845036;1422.0543338679663;918.9218916392048;932.0586207930039;933.8179055084194;934.0939288889766;940.4874343482818;4973.701577905337;4982.701037937735;4987.600991920638;4990.8752281193265;4996.275540046746;5890.204822349014;5892.440218179266;5897.52819774417;5897.764089436375;5908.261467316585;4794.736289504111;4861.975690121598;4902.0441014002645;4954.3311652926395;4984.22744474607;3165.0663054399006;3188.6970737779875;3202.99105781678;3204.279037216654;3208.1017315151794;5576.33084029919;5597.552195824324;5612.045952188138;5619.297587801525;5619.550435965113;5984.611000284967;6057.939420605826;6076.3012253591405;6082.057281121433;6096.756129754849;5612;5615.606907516435;5619.719014049281;5625.931073096181;5626.493615574536;5935.554833387427;5944.64332140073;5945.227120474311;5950.31571369298;5951.434613711691;5781.248437703071;5789.884202316014;5791.276090488689;5795.739191736467;5798.768049277982;5501.493304851795;5583.55331573465;5616.971915140398;5618.073017951992;5619.241402410786;3949.6445319921345;3951.150502641946;3951.4863067801;3952.505936757905;3958.18857134281;5880.529557635294;5929.229200203946;5929.288485381781;5930.822075337746;5940.495057919952;5596.916046259391;5618.7190640467;5672.319321681424;5722.113072473773;5730.856728581652;5716.628419152742;5719.542436605145;5721.22763426932;5722.74247658848;5731.398203188605;5598.440155984369;5603.859903502445;5605.215269862141;5606.495415412633;5613.663180209201;5719.542436604978;5721.170430287668;5755.65466072037;5759.609761948745;5767.279090113736;5443.972780136074;5608.971955140199;5635.872825434847;5636.126400407943;5642.689652069175 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: |5;yui.html;632.3549979021398;734.7979305690931;748.5059860492076;749.7713197474768;757.9658915348808;11462.369569673665;11724.941375293112;11757.882421175786;11764.2353247039;11767.176297659156;11126.49930753116;11379.032782213522;11381.089512838973;11381.374024428653;11383.089352851774;604.4650484321385;613.1844646620007;771.9961400193005;777.3742137579246;799.9480033797785;780.2704471319335;785.35600807338;786.0292538714683;790.2216316927821;793.1235984237393;634.0330995232262;827.8178800663875;835.031363618203;839.5844057191699;839.7228914458215;635.7997230872261;807.5719868469691;824.8309096635176;825.5376988886213;826.6073615032872;610.1610285856947;611.2054329371844;611.9535594134036;612.9785457508966;613.1660941120073;12077.818832717516;12181.93909030458;12277.815832762426;12293.262404255773;12293.938530307381;10371.533281002297;11817;11819.51790124075;12184.634460966185;12238.755224895453;9134.36059475837;9365.719028429157;9373.390729602554;9404.15362617361;9405.435673859522;3226.8063916165106;3239.578854748891;3278.6229583597715;3284.096873359821;3350.547676063725;39992.20015599701;40163.59836401628;40278.39582406237;40310.596894030976;40704.9999999997;9051.547422628842;9269.212116969999;9288.34981551285;9369.672061477815;9445.433274003582;10111.494425278706;10213.08082272599;10238.692839214835;10242.283040187116;10242.436665983294;5845.678487683133;5857.853553661107;5892.469677729025;5942.168096466498;5965.492933100648;3646.4165733482514;3698.9458004468597;3732.8133593320226;3749;3764.2095160016156;2485.6768620079633;2524.482481091372;2525.987370063138;2527.8230523863153;2530.5318516074585;386.88780253726105;392.976421414716;393.26066994051;396.1680471010912;396.6866175721148;465.84004836807634;592.7717828636006;603.9245094363205;606.4996377988177;629.3140476880222;7733.92266077332;8170.591470426574;8331.750047498585;8434.789130271793;8732.170443807829;530.151757188503;605.4581149870929;611.1474493082126;627.8524546731514;630.5208041888199;3399.456087026064;3576.3204991051616;3613.765105268149;3734.738568300247;3761.3793724035227;46965;48010.75994620004;48356.75821620869;48561.5143848557;49122;45655;46529.5347046532;46541;46697.766511167225;46774;42337.78831105825;42969.570304296554;43331.78334108309;43511.129777404276;43856;7814.765557033298;8089.406610912034;8116.107228204774;8116.918830811853;8383.119772424052;30154.54768178523;30235.69764302329;30607.693923060484;31131.53302700416;31138.844305778326;35837.46243806397;36090.45864311985;36995;40968.59031409648;41052.384214237405;6843.931560684528;6887;6981.022656827947;7098.929010709827;7148.213696493278;11309.547618095185;11463.885361146615;11660.18378713482;11704.94147529257;11938.880611193777;10557.20820938448;10722.356658600509;10923.945380273048;11167.49746261404;11541.711457213301;10632.946835265775;10761.946190268998;10799.298045627009;11016.889831101586;11077.224594278323;8443.577821109044;8565.143485651384;10703.732406689895;11325.433728313716;11355.261907975955;8732.78168045804;8920.598573064099;9021.684241051531;9183.127602877716;9506;8898.822023559622;9153.816923661623;9374.390664606779;9408.62498937997;9536.141747242782 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: __startTimestamp1447433097278__endTimestamp 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:44:57 INFO - 2015-11-13 08:44:57,286 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,287 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4682.65 Median:4790.26 stddev:477.95 (10.0%) stddev-sans-first:452.49 08:44:57 INFO - 2015-11-13 08:44:57,288 DEBUG : BROWSER_OUTPUT: Values: 2666.4 2752.7 2767.3 2769.6 2772.3 4598.3 4708.0 4781.9 4826.5 4844.1 4718.0 4762.7 4790.3 4791.0 4909.9 4362.6 4373.6 4384.5 4391.3 4412.2 4194.1 4444.2 4472.0 4507.2 4525.7 4320.6 4330.2 4405.9 4421.6 4465.0 4444.7 4449.5 4455.0 4455.1 4508.9 4202.3 4328.8 4416.5 4436.4 4488.8 4599.7 4701.8 4725.3 4729.6 4756.5 5122.7 5123.3 5125.1 5133.7 5163.6 4956.6 5065.8 5077.2 5155.6 5167.6 4546.9 4594.2 4603.7 4621.1 4660.4 5171.6 5180.7 5240.8 5269.5 5279.2 4778.3 4885.0 4888.7 4941.1 4953.7 4962.3 5053.7 5063.7 5066.3 5105.9 5032.9 5071.8 5073.7 5086.2 5128.5 4836.0 4962.8 5063.1 5065.2 5072.4 4121.5 4195.9 4197.1 4221.1 4228.0 3723.9 3749.9 3750.6 3758.8 3784.6 4186.0 4427.8 4449.2 4453.7 4495.6 5033.9 5038.2 5069.1 5195.9 5245.4 4359.0 4390.4 4392.0 4401.8 4416.4 4399.5 4515.3 4517.0 4524.3 4570.0 4708.6 4745.7 4751.9 4788.4 4847.9 5080.0 5118.0 5120.9 5124.2 5167.1 4664.7 4820.3 4828.5 4830.8 4860.7 4917.2 4981.2 5019.5 5030.4 5039.8 5055.5 5056.7 5061.9 5068.1 5097.1 4736.7 4905.6 4910.3 4911.8 4953.2 4762.6 4780.9 4781.6 4837.4 4861.0 4778.5 4819.2 4833.5 4839.3 4872.2 4787.7 4901.3 4953.5 4962.8 4996.2 4818.0 4826.6 4847.0 4897.7 4947.0 08:44:57 INFO - 2015-11-13 08:44:57,288 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,288 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41099.33 Median:30582.35 stddev:66360.54 (217.0%) stddev-sans-first:66476.86 08:44:57 INFO - 2015-11-13 08:44:57,288 DEBUG : BROWSER_OUTPUT: Values: 550.7 559.2 560.3 564.9 583.3 28452.4 37525.6 38005.4 38129.2 38230.4 39947.8 40417.6 40420.2 40474.6 40547.0 6984.8 7081.7 8014.4 8183.8 8196.1 10065.9 10291.1 10291.1 10295.1 10303.4 10163.3 10273.2 10275.2 10290.9 10292.7 9908.6 9992.0 9995.5 9997.8 9999.9 10031.3 10128.7 10161.3 10165.9 10168.4 36611.8 37056.3 37141.4 37148.3 37160.8 2732.8 2851.1 3302.2 3326.5 3538.5 27778.4 27891.0 28145.2 28414.9 28437.7 3093.0 3100.1 3127.6 3136.0 3180.7 221899.0 222765.0 223602.0 223917.0 223970.0 50515.0 51721.0 53885.7 54525.5 55521.7 50015.7 50101.5 50299.0 50380.2 50396.7 12095.9 13867.8 13996.1 14084.0 14127.0 8517.2 10390.7 10912.1 10923.7 10928.1 18113.1 18404.6 18518.2 18635.3 18682.3 7037.4 7200.8 7259.2 7353.5 7441.3 809.3 820.7 847.6 886.7 1048.4 23524.4 25087.6 25403.5 25545.5 25571.5 917.1 991.0 1021.6 1045.6 1063.0 13505.7 13996.7 14751.3 14787.3 15436.7 252449.0 253709.0 255869.0 256371.0 256502.0 46461.8 46702.3 46791.0 46819.3 46842.3 1176.3 1184.6 1205.8 1213.3 1215.6 26183.7 26927.2 27305.0 27309.0 27398.3 41006.8 41242.6 41372.6 41451.6 41510.4 215727.0 216754.0 314129.0 319371.0 322702.0 28265.9 28308.3 28318.6 28653.4 28703.7 38855.4 40032.2 40057.8 40188.5 40223.8 33595.0 34494.8 34993.8 35076.0 35397.0 25869.7 30417.0 31229.8 32186.2 32319.5 30439.8 30724.8 30893.2 30936.0 30938.0 25897.7 27205.0 27827.3 29424.7 29913.6 23174.8 23657.5 23990.3 23999.4 24007.9 08:44:57 INFO - 2015-11-13 08:44:57,288 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,288 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23998.15 Median:473.23 stddev:76060.15 (16072.6%) stddev-sans-first:76252.76 08:44:57 INFO - 2015-11-13 08:44:57,288 DEBUG : BROWSER_OUTPUT: Values: 332.0 335.2 335.4 336.1 337.7 12413.0 12883.6 15194.8 15477.9 17409.0 14860.1 14977.1 14977.9 14989.7 15205.2 4575.9 4618.0 4778.1 4966.7 4967.4 4876.6 4910.7 4917.3 4919.1 4921.9 4164.8 4868.1 4871.7 5003.6 5009.4 4910.3 4939.5 4952.7 4953.3 4957.7 4280.6 4398.4 4403.9 4404.0 4419.5 18574.9 18700.7 18892.7 19383.1 19590.6 1841.6 1848.4 1853.6 1883.1 1896.1 12634.9 12679.8 12771.2 13087.6 13094.4 1594.2 1699.2 1722.8 1740.6 1798.2 53030.0 54523.7 54885.2 55899.7 56295.0 6020.4 6263.9 6280.0 6332.9 6409.6 6968.4 7038.1 7244.4 7347.8 7361.9 4888.5 4955.2 4958.0 5086.5 5124.5 5137.1 5165.7 5207.8 5221.9 5270.4 2892.2 2957.9 2965.6 2979.4 2983.0 1048.8 1051.1 1053.8 1056.5 1102.6 368.1 402.9 406.3 424.2 449.4 8939.3 9179.5 9418.9 9573.4 9720.6 380.4 387.8 388.4 388.6 398.3 5176.7 5181.3 5224.4 5246.9 5248.8 430017.0 432476.0 459326.0 490776.0 503825.0 63680.7 66705.0 66708.3 68064.7 68345.0 470.3 476.1 476.9 477.0 478.1 8549.4 9694.1 9697.7 9719.8 9895.4 29142.9 29487.4 30993.2 32581.2 32734.0 38415.8 43004.0 43398.0 44488.6 44906.0 5900.9 5956.2 6002.5 6067.8 6080.5 10836.0 11025.6 11101.4 11437.3 11522.3 9808.7 9859.1 9862.4 10219.7 10264.2 9700.2 9839.4 9965.8 9977.5 10002.6 9326.5 9337.3 10092.2 10346.8 10351.3 6022.4 6067.1 6086.2 6087.8 6170.7 9212.6 9341.6 10122.0 10148.5 10260.9 08:44:57 INFO - 2015-11-13 08:44:57,289 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,290 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4898.86 Median:6176.64 stddev:2545.14 (41.2%) stddev-sans-first:2537.36 08:44:57 INFO - 2015-11-13 08:44:57,290 DEBUG : BROWSER_OUTPUT: Values: 1232.5 1632.6 1673.4 1693.3 1708.3 5536.1 6660.3 6885.2 6888.1 6893.9 6835.8 7034.5 7051.4 7053.7 7058.2 2003.8 2041.0 2043.8 2046.3 2049.6 2018.1 2046.3 2054.0 2057.6 2064.8 1963.5 1972.7 1989.7 1997.8 2004.1 1980.8 2006.7 2008.5 2009.1 2010.3 2002.3 2027.4 2028.6 2029.8 2034.1 5992.9 6135.4 6907.3 6990.7 6997.0 4154.0 4233.8 4265.4 4266.6 4270.9 2668.9 2678.2 2718.7 2721.2 2743.8 880.3 886.8 895.8 902.4 903.2 9246.4 9376.0 9392.0 9399.2 9449.6 3893.8 3894.2 3940.3 3950.0 3954.4 8314.5 8340.3 8358.7 8368.3 8376.3 4309.7 4310.1 4310.7 4313.0 4315.8 3871.3 3875.1 3876.6 3877.4 3879.2 3328.1 3333.5 3348.9 3354.8 3367.2 1047.0 1057.0 1058.9 1065.8 1067.2 965.8 977.9 979.0 1043.8 1203.2 6734.3 6791.0 6794.0 6794.8 6802.7 414.5 420.7 421.3 429.1 430.1 4891.4 5225.9 5250.9 5303.2 5320.3 7453.9 8443.1 8546.1 8556.0 8582.2 8251.4 8310.9 8360.3 8385.8 8390.4 6443.4 6628.2 6634.1 6663.4 6682.5 6526.0 6548.6 6615.2 6617.5 6623.8 6904.0 7456.2 7471.0 7484.7 7501.4 7517.4 7725.1 7731.2 7742.8 7754.4 5969.5 6190.1 6193.4 6223.6 6258.8 6689.6 6718.6 6725.7 6736.3 6740.6 6238.1 6352.8 6375.6 6387.3 6390.8 5965.9 6050.0 6082.8 6168.6 6184.7 6467.9 6499.4 6501.8 6505.6 6513.1 5982.9 6002.8 6031.6 6046.2 6048.8 6163.8 6211.3 6220.4 6223.3 6225.3 08:44:57 INFO - 2015-11-13 08:44:57,290 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,290 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4682.21 Median:5397.10 stddev:1410.24 (26.1%) stddev-sans-first:1375.10 08:44:57 INFO - 2015-11-13 08:44:57,290 DEBUG : BROWSER_OUTPUT: Values: 288.5 290.7 290.9 296.1 298.0 5081.5 5398.4 5457.5 5473.1 5489.6 5073.0 5189.7 5212.9 5382.5 5395.8 4122.2 4140.9 4141.4 4149.3 4152.3 3945.8 4111.0 4151.5 4153.0 4153.8 3986.4 4015.8 4048.1 4070.9 4115.2 4061.7 4085.5 4089.1 4094.7 4101.4 3588.4 3589.5 3590.4 3599.0 3599.4 5180.9 5189.7 5192.8 5193.7 5196.6 4513.9 4667.1 4679.2 4680.5 4741.4 5661.9 5662.5 5666.0 5667.2 5671.7 3825.6 3827.5 3833.8 3838.5 3838.6 5886.9 5968.8 5979.9 5985.9 5990.8 3836.4 3929.3 3930.4 3933.0 3953.0 3969.3 3993.3 3995.8 3997.4 4008.2 4630.9 4638.3 4644.8 4647.1 4650.9 5667.4 5669.2 5671.9 5674.9 5680.4 1383.1 1388.0 1415.6 1418.2 1422.1 918.9 932.1 933.8 934.1 940.5 4973.7 4982.7 4987.6 4990.9 4996.3 5890.2 5892.4 5897.5 5897.8 5908.3 4794.7 4862.0 4902.0 4954.3 4984.2 3165.1 3188.7 3203.0 3204.3 3208.1 5576.3 5597.6 5612.0 5619.3 5619.6 5984.6 6057.9 6076.3 6082.1 6096.8 5612.0 5615.6 5619.7 5625.9 5626.5 5935.6 5944.6 5945.2 5950.3 5951.4 5781.2 5789.9 5791.3 5795.7 5798.8 5501.5 5583.6 5617.0 5618.1 5619.2 3949.6 3951.2 3951.5 3952.5 3958.2 5880.5 5929.2 5929.3 5930.8 5940.5 5596.9 5618.7 5672.3 5722.1 5730.9 5716.6 5719.5 5721.2 5722.7 5731.4 5598.4 5603.9 5605.2 5606.5 5613.7 5719.5 5721.2 5755.7 5759.6 5767.3 5444.0 5609.0 5635.9 5636.1 5642.7 08:44:57 INFO - 2015-11-13 08:44:57,290 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,290 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12028.43 Median:46535.27 stddev:13889.84 (29.8%) stddev-sans-first:13902.44 08:44:57 INFO - 2015-11-13 08:44:57,291 DEBUG : BROWSER_OUTPUT: Values: 632.4 734.8 748.5 749.8 758.0 11462.4 11724.9 11757.9 11764.2 11767.2 11126.5 11379.0 11381.1 11381.4 11383.1 604.5 613.2 772.0 777.4 799.9 780.3 785.4 786.0 790.2 793.1 634.0 827.8 835.0 839.6 839.7 635.8 807.6 824.8 825.5 826.6 610.2 611.2 612.0 613.0 613.2 12077.8 12181.9 12277.8 12293.3 12293.9 10371.5 11817.0 11819.5 12184.6 12238.8 9134.4 9365.7 9373.4 9404.2 9405.4 3226.8 3239.6 3278.6 3284.1 3350.5 39992.2 40163.6 40278.4 40310.6 40705.0 9051.5 9269.2 9288.3 9369.7 9445.4 10111.5 10213.1 10238.7 10242.3 10242.4 5845.7 5857.9 5892.5 5942.2 5965.5 3646.4 3698.9 3732.8 3749.0 3764.2 2485.7 2524.5 2526.0 2527.8 2530.5 386.9 393.0 393.3 396.2 396.7 465.8 592.8 603.9 606.5 629.3 7733.9 8170.6 8331.8 8434.8 8732.2 530.2 605.5 611.1 627.9 630.5 3399.5 3576.3 3613.8 3734.7 3761.4 46965.0 48010.8 48356.8 48561.5 49122.0 45655.0 46529.5 46541.0 46697.8 46774.0 42337.8 42969.6 43331.8 43511.1 43856.0 7814.8 8089.4 8116.1 8116.9 8383.1 30154.5 30235.7 30607.7 31131.5 31138.8 35837.5 36090.5 36995.0 40968.6 41052.4 6843.9 6887.0 6981.0 7098.9 7148.2 11309.5 11463.9 11660.2 11704.9 11938.9 10557.2 10722.4 10923.9 11167.5 11541.7 10632.9 10761.9 10799.3 11016.9 11077.2 8443.6 8565.1 10703.7 11325.4 11355.3 8732.8 8920.6 9021.7 9183.1 9506.0 8898.8 9153.8 9374.4 9408.6 9536.1 08:44:57 INFO - 2015-11-13 08:44:57,291 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:44:57 INFO - 2015-11-13 08:44:57,291 DEBUG : BROWSER_OUTPUT: 08:44:57 INFO - 2015-11-13 08:44:57,985 INFO : Browser exited with error code: 0 08:44:58 INFO - 2015-11-13 08:44:58,007 INFO : Completed test dromaeo_css (00:18:37) 08:44:58 INFO - 2015-11-13 08:44:58,007 INFO : Starting test kraken 08:44:58 INFO - 2015-11-13 08:44:58,007 DEBUG : operating with platform_type : linux_ 08:44:58 INFO - 2015-11-13 08:44:58,007 INFO : Initialising browser for kraken test... 08:44:58 INFO - 2015-11-13 08:44:58,013 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ViaNl/profile http://localhost:36412/getInfo.html 08:45:01 INFO - 2015-11-13 08:45:01,806 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:45:01 INFO - 2015-11-13 08:45:01,806 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:45:01 INFO - 2015-11-13 08:45:01,806 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:45:01 INFO - 2015-11-13 08:45:01,806 DEBUG : BROWSER_OUTPUT: __metrics 08:45:01 INFO - 2015-11-13 08:45:01,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:03 INFO - 2015-11-13 08:45:03,232 INFO : Browser initialized. 08:45:03 INFO - 2015-11-13 08:45:03,232 INFO : Running cycle 1/1 for kraken test... 08:45:03 INFO - 2015-11-13 08:45:03,232 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ViaNl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:45:15 INFO - 2015-11-13 08:45:15,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 141103104 08:45:15 INFO - 2015-11-13 08:45:15,200 DEBUG : BROWSER_OUTPUT: 08:45:17 INFO - 2015-11-13 08:45:17,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36412/tests/kraken/driver.html?testName=audio-beat-detection) 08:45:18 INFO - 2015-11-13 08:45:18,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 182923264 08:45:18 INFO - 2015-11-13 08:45:18,405 DEBUG : BROWSER_OUTPUT: 08:45:21 INFO - 2015-11-13 08:45:21,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36412/tests/kraken/driver.html?testName=audio-dft) 08:45:21 INFO - 2015-11-13 08:45:21,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 172367872 08:45:21 INFO - 2015-11-13 08:45:21,731 DEBUG : BROWSER_OUTPUT: 08:45:24 INFO - 2015-11-13 08:45:24,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36412/tests/kraken/driver.html?testName=audio-fft) 08:45:25 INFO - 2015-11-13 08:45:25,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 150216704 08:45:25 INFO - 2015-11-13 08:45:25,304 DEBUG : BROWSER_OUTPUT: 08:45:27 INFO - 2015-11-13 08:45:27,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36412/tests/kraken/driver.html?testName=audio-oscillator) 08:45:27 INFO - 2015-11-13 08:45:27,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 153276416 08:45:27 INFO - 2015-11-13 08:45:27,962 DEBUG : BROWSER_OUTPUT: 08:45:30 INFO - 2015-11-13 08:45:30,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:45:30 INFO - 2015-11-13 08:45:30,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 155856896 08:45:30 INFO - 2015-11-13 08:45:30,713 DEBUG : BROWSER_OUTPUT: 08:45:33 INFO - 2015-11-13 08:45:33,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36412/tests/kraken/driver.html?testName=imaging-darkroom) 08:45:34 INFO - 2015-11-13 08:45:34,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 155758592 08:45:34 INFO - 2015-11-13 08:45:34,218 DEBUG : BROWSER_OUTPUT: 08:45:37 INFO - 2015-11-13 08:45:37,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36412/tests/kraken/driver.html?testName=imaging-desaturate) 08:45:38 INFO - 2015-11-13 08:45:38,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 158187520 08:45:38 INFO - 2015-11-13 08:45:38,228 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-11-13 08:45:41,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36412/tests/kraken/driver.html?testName=json-parse-financial) 08:45:41 INFO - 2015-11-13 08:45:41,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 157515776 08:45:41 INFO - 2015-11-13 08:45:41,641 DEBUG : BROWSER_OUTPUT: 08:45:43 INFO - 2015-11-13 08:45:43,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:45:43 INFO - 2015-11-13 08:45:43,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 162447360 08:45:43 INFO - 2015-11-13 08:45:43,978 DEBUG : BROWSER_OUTPUT: 08:45:45 INFO - 2015-11-13 08:45:45,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36412/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:45:46 INFO - 2015-11-13 08:45:46,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 162172928 08:45:46 INFO - 2015-11-13 08:45:46,440 DEBUG : BROWSER_OUTPUT: 08:45:48 INFO - 2015-11-13 08:45:48,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:45:49 INFO - 2015-11-13 08:45:49,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 172261376 08:45:49 INFO - 2015-11-13 08:45:49,124 DEBUG : BROWSER_OUTPUT: 08:45:51 INFO - 2015-11-13 08:45:51,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:45:52 INFO - 2015-11-13 08:45:52,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 177176576 08:45:52 INFO - 2015-11-13 08:45:52,237 DEBUG : BROWSER_OUTPUT: 08:45:54 INFO - 2015-11-13 08:45:54,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:55 INFO - 2015-11-13 08:45:55,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 176291840 08:45:55 INFO - 2015-11-13 08:45:55,393 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36412/tests/kraken/driver.html?testName=ai-astar) 08:45:57 INFO - 2015-11-13 08:45:57,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 234835968 08:45:57 INFO - 2015-11-13 08:45:57,409 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,412 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:45:57 INFO - 2015-11-13 08:45:57,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:45:57 INFO - 2015-11-13 08:45:57,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;105;111;112;112;101;112;112;110 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;138;153;166;137;160;164;139;165;132 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;163;162;161;163;162;163;162 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;91;92;73;72;72;106;90;72 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;128;92;92;92;125;91;92;127 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;108;109;110;109;109;110;109;109;110 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;148;147;146;147;146;148;146 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;96;95;96;96;95 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;70;69;69;72;70;78;70;68 08:45:57 INFO - 2015-11-13 08:45:57,413 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;66;66;66;66;67;67;67;66 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;83;81;81;83;91;84;84 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;119;127;120;125;119;125;129;128;131 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;137;150;145;151;133;145;143;157;133 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;73;68;68;71;69;69;67;70 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: __startTimestamp1447433157410__endTimestamp 08:45:57 INFO - 2015-11-13 08:45:57,414 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,417 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:45:57 INFO - 2015-11-13 08:45:57,417 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:4.17 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 105.0 111.0 112.0 112.0 101.0 112.0 112.0 110.0 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.20 Median:159.00 stddev:13.31 (8.4%) stddev-sans-first:13.88 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: Values: 158.0 138.0 153.0 166.0 137.0 160.0 164.0 139.0 165.0 132.0 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 163.0 162.0 161.0 163.0 162.0 163.0 162.0 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:73.00 stddev:12.37 (17.0%) stddev-sans-first:12.66 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 91.0 92.0 73.0 72.0 72.0 106.0 90.0 72.0 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:92.00 stddev:16.83 (18.3%) stddev-sans-first:17.44 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 128.0 92.0 92.0 92.0 125.0 91.0 92.0 127.0 08:45:57 INFO - 2015-11-13 08:45:57,418 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: Values: 110.0 108.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 110.0 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 148.0 147.0 146.0 147.0 146.0 148.0 146.0 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.00 stddev:2.79 (4.0%) stddev-sans-first:2.96 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 69.0 69.0 72.0 70.0 78.0 70.0 68.0 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 08:45:57 INFO - 2015-11-13 08:45:57,419 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 08:45:57 INFO - 2015-11-13 08:45:57,420 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,420 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:2.84 (3.4%) stddev-sans-first:2.96 08:45:57 INFO - 2015-11-13 08:45:57,420 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 83.0 81.0 81.0 83.0 91.0 84.0 84.0 08:45:57 INFO - 2015-11-13 08:45:57,420 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,420 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:4.29 (3.4%) stddev-sans-first:4.49 08:45:57 INFO - 2015-11-13 08:45:57,420 DEBUG : BROWSER_OUTPUT: Values: 127.0 119.0 127.0 120.0 125.0 119.0 125.0 129.0 128.0 131.0 08:45:57 INFO - 2015-11-13 08:45:57,420 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,420 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.70 Median:145.00 stddev:8.51 (5.9%) stddev-sans-first:8.27 08:45:57 INFO - 2015-11-13 08:45:57,421 DEBUG : BROWSER_OUTPUT: Values: 133.0 137.0 150.0 145.0 151.0 133.0 145.0 143.0 157.0 133.0 08:45:57 INFO - 2015-11-13 08:45:57,421 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-11-13 08:45:57,421 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.75 (2.5%) stddev-sans-first:1.80 08:45:57 INFO - 2015-11-13 08:45:57,421 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 73.0 68.0 68.0 71.0 69.0 69.0 67.0 70.0 08:45:57 INFO - 2015-11-13 08:45:57,421 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:45:57 INFO - 2015-11-13 08:45:57,421 DEBUG : BROWSER_OUTPUT: 08:45:58 INFO - 2015-11-13 08:45:58,338 INFO : Browser exited with error code: 0 08:45:58 INFO - 2015-11-13 08:45:58,389 INFO : Completed test kraken (00:01:00) 08:45:58 INFO - 2015-11-13 08:45:58,389 INFO : Starting test v8_7 08:45:58 INFO - 2015-11-13 08:45:58,389 DEBUG : operating with platform_type : linux_ 08:45:58 INFO - 2015-11-13 08:45:58,389 INFO : Initialising browser for v8_7 test... 08:45:58 INFO - 2015-11-13 08:45:58,395 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJJJde/profile http://localhost:36412/getInfo.html 08:46:02 INFO - 2015-11-13 08:46:02,260 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:46:02 INFO - 2015-11-13 08:46:02,260 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:46:02 INFO - 2015-11-13 08:46:02,260 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:46:02 INFO - 2015-11-13 08:46:02,260 DEBUG : BROWSER_OUTPUT: __metrics 08:46:02 INFO - 2015-11-13 08:46:02,405 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:03 INFO - 2015-11-13 08:46:03,614 INFO : Browser initialized. 08:46:03 INFO - 2015-11-13 08:46:03,615 INFO : Running cycle 1/1 for v8_7 test... 08:46:03 INFO - 2015-11-13 08:46:03,615 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJJJde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:46:15 INFO - 2015-11-13 08:46:15,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 141713408 08:46:15 INFO - 2015-11-13 08:46:15,570 DEBUG : BROWSER_OUTPUT: 08:46:36 INFO - 2015-11-13 08:46:36,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36412/tests/v8_7/run.html (next: http://localhost:36412/tests/v8_7/run.html) 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 442572800 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: |0;Richards;171.02787754403968 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.71779141104295 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.1120448179272 08:46:37 INFO - 2015-11-13 08:46:37,217 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: |5;Earley;827.2727272727273 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: |6;Boyer;11767.441860465116 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: |8;Splay;621.1180124223603 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: __startTimestamp1447433197210__endTimestamp 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,218 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.03 Median:171.03 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: Values: 171.0 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.72 Median:191.72 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: Values: 191.7 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: Values: 280.1 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,219 DEBUG : BROWSER_OUTPUT: Values: 5045.2 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: Values: 2006.0 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:827.27 Median:827.27 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: Values: 827.3 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11767.44 Median:11767.44 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: Values: 11767.4 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: Values: 26736.8 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.12 Median:621.12 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,220 DEBUG : BROWSER_OUTPUT: Values: 621.1 08:46:37 INFO - 2015-11-13 08:46:37,221 DEBUG : BROWSER_OUTPUT: 08:46:37 INFO - 2015-11-13 08:46:37,221 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 08:46:37 INFO - 2015-11-13 08:46:37,221 DEBUG : BROWSER_OUTPUT: Values: 4822.1 08:46:37 INFO - 2015-11-13 08:46:37,221 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:46:37 INFO - 2015-11-13 08:46:37,221 DEBUG : BROWSER_OUTPUT: 08:46:38 INFO - 2015-11-13 08:46:38,137 INFO : Browser exited with error code: 0 08:46:38 INFO - 2015-11-13 08:46:38,154 INFO : Completed test v8_7 (00:00:39) 08:46:38 INFO - 2015-11-13 08:46:38,255 INFO : Completed test suite (00:20:17) 08:46:38 INFO - 2015-11-13 08:46:38,255 DEBUG : Working with test: dromaeo_css 08:46:38 INFO - 2015-11-13 08:46:38,255 DEBUG : Generating results file: dromaeo_css 08:46:38 INFO - 2015-11-13 08:46:38,256 DEBUG : Working with test: kraken 08:46:38 INFO - 2015-11-13 08:46:38,256 DEBUG : Generating results file: kraken 08:46:38 INFO - 2015-11-13 08:46:38,256 INFO : javascript benchmark 08:46:38 INFO - 2015-11-13 08:46:38,257 DEBUG : Working with test: v8_7 08:46:38 INFO - 2015-11-13 08:46:38,257 DEBUG : Generating results file: v8_7 08:46:38 INFO - 2015-11-13 08:46:38,257 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:46:38 INFO - 2015-11-13 08:46:38,319 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 08:46:38 INFO - 2015-11-13 08:46:38,319 DEBUG : process_Request line: dromaeo_css 6025.15 graph.html#tests=[[72,131,35]] 08:46:38 INFO - 2015-11-13 08:46:38,319 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:46:38 INFO - 2015-11-13 08:46:38,350 DEBUG : process_Request line: kraken 1515.90 graph.html#tests=[[232,131,35]] 08:46:38 INFO - 2015-11-13 08:46:38,351 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:46:38 INFO - 2015-11-13 08:46:38,387 DEBUG : process_Request line: v8_7 19650.27 graph.html#tests=[[230,131,35]] 08:46:38 INFO - 2015-11-13 08:46:38,388 INFO : javascript benchmark 08:46:38 INFO - 2015-11-13 08:46:38,392 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [332.00729817844643, 335.2273010710313, 335.3962866839688, 336.1361301455258, 337.7399402460106, 12413.0, 12883.613491595244, 15194.784417246621, 15477.921652513569, 17409.04250266235, 14860.108393496397, 14977.101373917572, 14977.850221497782, 14989.700205995874, 15205.163715995615, 4575.87890966712, 4617.976910115462, 4778.116048531024, 4966.652334336598, 4967.403911530621, 4876.634252431064, 4910.656254062217, 4917.262410638397, 4919.13915064864, 4921.926171107436, 4164.8125834337525, 4868.148074087038, 4871.7076975381415, 5003.574696150831, 5009.4239162496415, 4910.337104490884, 4939.53074457926, 4952.653314268003, 4953.281774142747, 4957.727324997124, 4280.614744672995, 4398.362237475548, 4403.867883963454, 4403.9779801100785, 4419.469663640351, 18574.907125464288, 18700.719489207673, 18892.71660925087, 19383.127759250725, 19590.608187836307, 1841.6316736652589, 1848.3992702371784, 1853.629274145163, 1883.077292126848, 1896.1277812206401, 12634.873651263553, 12679.809802852964, 12771.169873958162, 13087.607371778862, 13094.410751516109, 1594.1630643911924, 1699.1504247876062, 1722.8018777840584, 1740.5648587853036, 1798.1818272685896, 53030.0, 54523.727381363235, 54885.1767223492, 55899.72050139764, 56295.0, 6020.367861374492, 6263.874722505616, 6279.96860015697, 6332.905006424908, 6409.55133140685, 6968.3728464438445, 7038.085048943707, 7244.38422734063, 7347.8163045924275, 7361.852762944711, 4888.535589119028, 4955.231939049453, 4958.033183529177, 5086.4659210783075, 5124.461931497213, 5137.075326441276, 5165.715885626251, 5207.843764687065, 5221.895562088737, 5270.367555893241, 2892.190186747714, 2957.8668959896854, 2965.584818125464, 2979.3743313904324, 2982.9552556711233, 1048.7692707604315, 1051.1380667852288, 1053.7787064716495, 1056.529844219315, 1102.5920409448556, 368.0706216802595, 402.86302657096144, 406.30319002910153, 424.1876805916697, 449.3663933853251, 8939.329550283755, 9179.541022948826, 9418.90581094194, 9573.425594464354, 9720.562574684156, 380.40086863190584, 387.8041588997538, 388.3533916029835, 388.6036243032148, 398.27513924657427, 5176.741162941913, 5181.300524429229, 5224.373075230997, 5246.895062098737, 5248.8425347239645, 430017.0, 432476.0, 459326.0, 490776.0, 503825.0, 63680.68159659172, 66705.0, 66708.33291667118, 68064.6596767013, 68345.0, 470.3274317725685, 476.1310608140158, 476.90223504180864, 476.988783778392, 478.0629965268044, 8549.401541892008, 9694.127528522467, 9697.6605818796, 9719.805603888024, 9895.356801808148, 29142.854285728437, 29487.410251794416, 30993.225169370948, 32581.18547036343, 32734.0, 38415.807920960215, 43004.0, 43398.0, 44488.55511444844, 44906.0, 5900.911486327795, 5956.225690660186, 6002.489788368038, 6067.787627433018, 6080.48315893154, 10836.0, 11025.558977640805, 11101.444927753742, 11437.313761174357, 11522.251053681484, 9808.705738827846, 9859.112679858847, 9862.358946668444, 10219.693409197736, 10264.178865690876, 9700.223982081558, 9839.409635421898, 9965.750856228653, 9977.501124943868, 10002.599896004078, 9326.487043212688, 9337.299702522203, 10092.192624589869, 10346.844797327896, 10351.275410721177, 6022.36765139654, 6067.059605761114, 6086.2087928569, 6087.847803804763, 6170.660613666291, 9212.631494740403, 9341.626334946526, 10122.0, 10148.492575371054, 10260.948695256477], "dojo.html": [2666.400059986503, 2752.6696796384435, 2767.3358393985436, 2769.612254284402, 2772.3207814085554, 4598.2872654738485, 4707.952920470794, 4781.856544303672, 4826.469088400273, 4844.0554091952035, 4717.9764101179535, 4762.714237145774, 4790.257510085942, 4791.0, 4909.926351104737, 4362.607365337119, 4373.606375426211, 4384.517703052654, 4391.319345501436, 4412.205802955466, 4194.077302993336, 4444.2444784386735, 4472.0, 4507.211238033331, 4525.683202175849, 4320.6327462165755, 4330.220560299145, 4405.889852753675, 4421.624161946238, 4464.977675111603, 4444.711093778894, 4449.488308844459, 4454.9777251113865, 4455.086707225011, 4508.932366014513, 4202.306619407794, 4328.761918094535, 4416.470023597157, 4436.44544431946, 4488.775561221926, 4599.67802253839, 4701.835435759766, 4725.291206319045, 4729.59798417135, 4756.548127927841, 5122.667026643257, 5123.2827404163445, 5125.1287281162295, 5133.717645529532, 5163.561097306733, 4956.603471722254, 5065.772040258197, 5077.162268225775, 5155.5617772489, 5167.586593072545, 4546.8863278417975, 4594.19601569724, 4603.6777425579885, 4621.145088158634, 4660.417447819056, 5171.5862730981435, 5180.740962951837, 5240.816571419982, 5269.473052694777, 5279.155335146435, 4778.283257511401, 4885.0, 4888.731119788375, 4941.061198372297, 4953.72754498506, 4962.255661650709, 5053.7220452875445, 5063.746812659352, 5066.316047333637, 5105.923411148836, 5032.874178145503, 5071.822486212965, 5073.695578265316, 5086.16078347076, 5128.487151284916, 4835.95164048355, 4962.751862406865, 5063.06333328328, 5065.214891691794, 5072.416672082684, 4121.4848143982, 4195.937060944088, 4197.139586384784, 4221.113566151082, 4227.957720422756, 3723.906902327409, 3749.8500059997295, 3750.624937506282, 3758.812059397074, 3784.6026167252594, 4185.958140418617, 4427.778611069433, 4449.154660614473, 4453.665975051884, 4495.595396414273, 5033.874153146201, 5038.244263360525, 5069.087564238399, 5195.870103247449, 5245.449227831099, 4359.0, 4390.363397307373, 4392.0, 4401.801918913657, 4416.4037854889175, 4399.5380485049245, 4515.277555591089, 4517.028838799673, 4524.25349817283, 4569.95430045702, 4708.552687494683, 4745.738984355894, 4751.904961900743, 4788.353572267839, 4847.927281090716, 5080.0, 5117.9764047189965, 5120.923186152285, 5124.154514505214, 5167.121589329748, 4664.650151238603, 4820.25286080658, 4828.517148285284, 4830.830920917751, 4860.73265970375, 4917.164082105979, 4981.178105612534, 5019.548240658212, 5030.4466508684745, 5039.798408063636, 5055.494450554915, 5056.7471626419265, 5061.924071138862, 5068.113080211022, 5097.108006098992, 4736.715797052188, 4905.583025442877, 4910.337104490848, 4911.754412279301, 4953.18272485036, 4762.595179409789, 4780.904381912412, 4781.617470602413, 4837.37114175155, 4861.0, 4778.498257682893, 4819.180739274402, 4833.492483289204, 4839.346688197048, 4872.196087645499, 4787.736674482798, 4901.264810278487, 4953.529414705597, 4962.751862406937, 4996.200607902718, 4818.0, 4826.638002149783, 4846.975765121152, 4897.681650692693, 4946.975265123651], "mootools.html": [1232.5193174661888, 1632.6000129968158, 1673.4226691791328, 1693.2718930859726, 1708.2654458582804, 5536.086545719956, 6660.267370589231, 6885.173779146497, 6888.10454640896, 6893.931060689391, 6835.7607483738075, 7034.472414568902, 7051.400630946376, 7053.682584283707, 7058.15302163741, 2003.819656230939, 2040.9795902040937, 2043.795620437959, 2046.2531176120758, 2049.5695903860205, 2018.0918586635999, 2046.2735728816278, 2054.0243384392443, 2057.567910738747, 2064.7728749837506, 1963.5189378602263, 1972.7139564763102, 1989.6518109330882, 1997.7702564205158, 2004.1282042311568, 1980.7524059492564, 2006.6889632107047, 2008.4577164165594, 2009.0657844102489, 2010.2963962613114, 2002.339228054753, 2027.3816485971772, 2028.5537181819975, 2029.7767245602972, 2034.074496104269, 5992.940070599282, 6135.417135372132, 6907.274736152682, 6990.650467476606, 6997.0, 4154.0, 4233.809478573472, 4265.360195970598, 4266.637335826458, 4270.850520231808, 2668.919932402031, 2678.2099280712237, 2718.7417195366406, 2721.18364490654, 2743.7942154338502, 880.330948479154, 886.7871710789428, 895.8118795053047, 902.3863772634605, 903.2142036428284, 9246.398984066014, 9375.953120234355, 9392.0, 9399.154076133182, 9449.622015119387, 3893.844246230119, 3894.162755007687, 3940.271049855786, 3950.0322421006463, 3954.387070004154, 8314.542700151549, 8340.29107525867, 8358.749237522885, 8368.288695460833, 8376.329893608498, 4309.6552275818485, 4310.094880075157, 4310.676699247569, 4312.978435107804, 4315.784210789448, 3871.3031654302495, 3875.1280961783937, 3876.6317199865966, 3877.418387241936, 3879.2241551689776, 3328.0681409205463, 3333.4833100869405, 3348.9162770930434, 3354.781939173946, 3367.2255381261957, 1046.9790604188026, 1057.038095333243, 1058.8570542976754, 1065.7548763784218, 1067.2475904487317, 965.8261512927741, 977.9266555008403, 978.9755256118654, 1043.8486419469286, 1203.2179083595734, 6734.259231484532, 6790.966045169743, 6793.966030169916, 6794.796156115324, 6802.727890884408, 414.4632700652662, 420.7286300336266, 421.25017468905395, 429.11387983813324, 430.13972055888223, 4891.437484689235, 5225.947740522546, 5250.868728281747, 5303.231031500411, 5320.334958130234, 7453.888191677129, 8443.113473085361, 8546.102659220816, 8556.0, 8582.184692454206, 8251.381146414044, 8310.916890831015, 8360.331173506105, 8385.832283354299, 8390.412671112963, 6443.355664433519, 6628.23775265841, 6634.104395906491, 6663.400293973566, 6682.532222744361, 6525.967370163119, 6548.607083575001, 6615.239247486601, 6617.470602351704, 6623.801285961236, 6904.0, 7456.217097204715, 7470.962645186739, 7484.738034168778, 7501.437392195498, 7517.361024312994, 7725.111612164448, 7731.188225236269, 7742.8451430969935, 7754.418418618739, 5969.492593129459, 6190.102435146789, 6193.38066193377, 6223.564350495603, 6258.780942666985, 6689.565178263398, 6718.563293385914, 6725.730970761115, 6736.326367363225, 6740.561863478858, 6238.095476156022, 6352.809415717536, 6375.553711240169, 6387.297397286202, 6390.808275751735, 5965.8806823862415, 6049.969750151221, 6082.847928801815, 6168.599041062316, 6184.690765461619, 6467.902981455376, 6499.415052645285, 6501.804945851632, 6505.642189679424, 6513.088167656627, 5982.850428739142, 6002.769432266462, 6031.607945483705, 6046.1535385045245, 6048.758049677964, 6163.8150855474405, 6211.316755156839, 6220.409061139185, 6223.284322302993, 6225.28409232944], "ext.html": [550.6585916731626, 559.1780083277581, 560.3220103674554, 564.8954943335481, 583.3437382944188, 28452.443444569428, 37525.62474375255, 38005.429918551206, 38129.23741525168, 38230.426543601796, 39947.80026099866, 40417.59582404175, 40420.19159616806, 40474.59525404745, 40547.0, 6984.825379365506, 7081.716731330766, 8014.438989270768, 8183.754487365389, 8196.098429172785, 10065.899341006607, 10291.073803357696, 10291.125254353352, 10295.124914382286, 10303.3817970922, 10163.339382940123, 10273.17814574836, 10275.229357798158, 10290.897091029106, 10292.713410823648, 9908.603655853758, 9991.950040249752, 9995.45025023627, 9997.80004399908, 9999.850002249972, 10031.297809153362, 10128.696139115838, 10161.288709790319, 10165.89834101657, 10168.389896606228, 36611.81694091539, 37056.25887482262, 37141.442878356844, 37148.28517148291, 37160.81419592912, 2732.7540521353176, 2851.1019029005797, 3302.2239773653173, 3326.4843949187916, 3538.5046093546925, 27778.444431111468, 27891.0, 28145.15564533047, 28414.85792571024, 28437.715622843712, 3092.9536056959164, 3100.1319630503494, 3127.62468503781, 3136.0, 3180.7296379807744, 221899.0, 222765.0, 223602.0, 223916.99999999837, 223970.0, 50515.0, 51721.0, 53885.730571346896, 54525.454745452036, 55521.72239138859, 50015.749921250164, 50101.49898501041, 50299.0, 50380.244296335586, 50396.748016259684, 12095.879041209475, 13867.791983120262, 13996.090254133449, 14084.0, 14127.0, 8517.190866867637, 10390.740231494274, 10912.127029837595, 10923.672289831318, 10928.125749939985, 18113.094345282683, 18404.631907362047, 18518.16668249932, 18635.254589816257, 18682.34611788581, 7037.437005039585, 7200.783976480714, 7259.237780033126, 7353.485256032133, 7441.330280274801, 809.29591255608, 820.7004443378244, 847.6270441005938, 886.689658619491, 1048.3919326790444, 23524.41188970255, 25087.62368564473, 25403.491930161294, 25545.489090218092, 25571.488570228492, 917.1012407840353, 991.0, 1021.6271061062807, 1045.639254457211, 1062.990159348622, 13505.662358441117, 13996.720065598834, 14751.336189871266, 14787.260636968109, 15436.691266174837, 252449.0, 253709.0, 255869.0, 256371.0, 256502.0, 46461.76769116133, 46702.29946550805, 46791.0, 46819.29771053437, 46842.29736553955, 1176.347127344315, 1184.5709632042542, 1205.764875849201, 1213.308414203913, 1215.5927764198916, 26183.73816261889, 26927.192184234504, 27305.0, 27309.0, 27398.315042124108, 41006.79496602498, 41242.58757412388, 41372.58627413688, 41451.58548414477, 41510.37734433926, 215727.0, 216754.0, 314129.0, 319371.0, 322702.0, 28265.858670706515, 28308.292292692848, 28318.57522137211, 28653.426931461672, 28703.712962870104, 38855.41716874306, 40032.199356012134, 40057.79971100126, 40188.45489868255, 40223.79888100658, 33595.0, 34494.82752586221, 34993.82503087468, 35076.0, 35397.0, 25869.6838866553, 30417.0, 31229.843850780602, 32186.19534511656, 32319.51520727238, 30439.847800760854, 30724.84637576798, 30893.227669308446, 30936.0, 30938.0, 25897.741022589533, 27205.0, 27827.304317392227, 29424.705752943053, 29913.551296730133, 23174.768252317936, 23657.52684946326, 23990.28029159128, 23999.400014999766, 24007.879960600087], "prototype.html": [288.4663372760393, 290.7499550386667, 290.93308539036013, 296.1456198866272, 297.9925501862452, 5081.46644602317, 5398.3521977362725, 5457.481539253769, 5473.124300111983, 5489.615726899118, 5072.974635126829, 5189.6506908203855, 5212.895742085156, 5382.515573598375, 5395.838124856251, 4122.196171746511, 4140.8964775880695, 4141.39949707293, 4149.273877071516, 4152.2733521633745, 3945.80270986451, 4110.958890411088, 4151.522574903895, 4153.0, 4153.7507749535125, 3986.40203969404, 4015.7791321477307, 4048.089179934506, 4070.87787366378, 4115.197536480373, 4061.6750659947133, 4085.4893138357706, 4089.141280331134, 4094.7338423002557, 4101.384792281182, 3588.4079126944025, 3589.4974703541525, 3590.4434812603827, 3598.964010359889, 3599.4240921452442, 5180.870478238075, 5189.662671926313, 5192.818251361222, 5193.740312984336, 5196.558292545138, 4513.932291015637, 4667.113248482778, 4679.22792739201, 4680.531946805327, 4741.431028276595, 5661.886762264731, 5662.518685911702, 5666.0, 5667.178259152441, 5671.7164141793155, 3825.598312177209, 3827.502424684801, 3833.7891415972113, 3838.539375274957, 3838.558565764917, 5886.852828679274, 5968.7612495500125, 5979.880402391927, 5985.910211346877, 5990.820275391745, 3836.405357169643, 3929.292727309112, 3930.371140617545, 3932.980335098306, 3952.980235098806, 3969.3450580653866, 3993.3011722948368, 3995.820188091485, 3997.420374045747, 4008.178323443687, 4630.86107416778, 4638.304254361873, 4644.790984405642, 4647.09381670571, 4650.906981860411, 5667.376588575254, 5669.206311116447, 5671.893980673729, 5674.943250567441, 5680.40355762639, 1383.073340861605, 1387.9930600346934, 1415.6390120519202, 1418.212891845036, 1422.0543338679663, 918.9218916392048, 932.0586207930039, 933.8179055084194, 934.0939288889766, 940.4874343482818, 4973.701577905337, 4982.701037937735, 4987.600991920638, 4990.8752281193265, 4996.275540046746, 5890.204822349014, 5892.440218179266, 5897.52819774417, 5897.764089436375, 5908.261467316585, 4794.736289504111, 4861.975690121598, 4902.0441014002645, 4954.3311652926395, 4984.22744474607, 3165.0663054399006, 3188.6970737779875, 3202.99105781678, 3204.279037216654, 3208.1017315151794, 5576.33084029919, 5597.552195824324, 5612.045952188138, 5619.297587801525, 5619.550435965113, 5984.611000284967, 6057.939420605826, 6076.3012253591405, 6082.057281121433, 6096.756129754849, 5612.0, 5615.606907516435, 5619.719014049281, 5625.931073096181, 5626.493615574536, 5935.554833387427, 5944.64332140073, 5945.227120474311, 5950.31571369298, 5951.434613711691, 5781.248437703071, 5789.884202316014, 5791.276090488689, 5795.739191736467, 5798.768049277982, 5501.493304851795, 5583.55331573465, 5616.971915140398, 5618.073017951992, 5619.241402410786, 3949.6445319921345, 3951.150502641946, 3951.4863067801, 3952.505936757905, 3958.18857134281, 5880.529557635294, 5929.229200203946, 5929.288485381781, 5930.822075337746, 5940.495057919952, 5596.916046259391, 5618.7190640467, 5672.319321681424, 5722.113072473773, 5730.856728581652, 5716.628419152742, 5719.542436605145, 5721.22763426932, 5722.74247658848, 5731.398203188605, 5598.440155984369, 5603.859903502445, 5605.215269862141, 5606.495415412633, 5613.663180209201, 5719.542436604978, 5721.170430287668, 5755.65466072037, 5759.609761948745, 5767.279090113736, 5443.972780136074, 5608.971955140199, 5635.872825434847, 5636.126400407943, 5642.689652069175], "yui.html": [632.3549979021398, 734.7979305690931, 748.5059860492076, 749.7713197474768, 757.9658915348808, 11462.369569673665, 11724.941375293112, 11757.882421175786, 11764.2353247039, 11767.176297659156, 11126.49930753116, 11379.032782213522, 11381.089512838973, 11381.374024428653, 11383.089352851774, 604.4650484321385, 613.1844646620007, 771.9961400193005, 777.3742137579246, 799.9480033797785, 780.2704471319335, 785.35600807338, 786.0292538714683, 790.2216316927821, 793.1235984237393, 634.0330995232262, 827.8178800663875, 835.031363618203, 839.5844057191699, 839.7228914458215, 635.7997230872261, 807.5719868469691, 824.8309096635176, 825.5376988886213, 826.6073615032872, 610.1610285856947, 611.2054329371844, 611.9535594134036, 612.9785457508966, 613.1660941120073, 12077.818832717516, 12181.93909030458, 12277.815832762426, 12293.262404255773, 12293.938530307381, 10371.533281002297, 11817.0, 11819.51790124075, 12184.634460966185, 12238.755224895453, 9134.36059475837, 9365.719028429157, 9373.390729602554, 9404.15362617361, 9405.435673859522, 3226.8063916165106, 3239.578854748891, 3278.6229583597715, 3284.096873359821, 3350.547676063725, 39992.20015599701, 40163.59836401628, 40278.39582406237, 40310.596894030976, 40704.9999999997, 9051.547422628842, 9269.212116969999, 9288.34981551285, 9369.672061477815, 9445.433274003582, 10111.494425278706, 10213.08082272599, 10238.692839214835, 10242.283040187116, 10242.436665983294, 5845.678487683133, 5857.853553661107, 5892.469677729025, 5942.168096466498, 5965.492933100648, 3646.4165733482514, 3698.9458004468597, 3732.8133593320226, 3749.0, 3764.2095160016156, 2485.6768620079633, 2524.482481091372, 2525.987370063138, 2527.8230523863153, 2530.5318516074585, 386.88780253726105, 392.976421414716, 393.26066994051, 396.1680471010912, 396.6866175721148, 465.84004836807634, 592.7717828636006, 603.9245094363205, 606.4996377988177, 629.3140476880222, 7733.92266077332, 8170.591470426574, 8331.750047498585, 8434.789130271793, 8732.170443807829, 530.151757188503, 605.4581149870929, 611.1474493082126, 627.8524546731514, 630.5208041888199, 3399.456087026064, 3576.3204991051616, 3613.765105268149, 3734.738568300247, 3761.3793724035227, 46965.0, 48010.75994620004, 48356.75821620869, 48561.5143848557, 49122.0, 45655.0, 46529.5347046532, 46541.0, 46697.766511167225, 46774.0, 42337.78831105825, 42969.570304296554, 43331.78334108309, 43511.129777404276, 43856.0, 7814.765557033298, 8089.406610912034, 8116.107228204774, 8116.918830811853, 8383.119772424052, 30154.54768178523, 30235.69764302329, 30607.693923060484, 31131.53302700416, 31138.844305778326, 35837.46243806397, 36090.45864311985, 36995.0, 40968.59031409648, 41052.384214237405, 6843.931560684528, 6887.0, 6981.022656827947, 7098.929010709827, 7148.213696493278, 11309.547618095185, 11463.885361146615, 11660.18378713482, 11704.94147529257, 11938.880611193777, 10557.20820938448, 10722.356658600509, 10923.945380273048, 11167.49746261404, 11541.711457213301, 10632.946835265775, 10761.946190268998, 10799.298045627009, 11016.889831101586, 11077.224594278323, 8443.577821109044, 8565.143485651384, 10703.732406689895, 11325.433728313716, 11355.261907975955, 8732.78168045804, 8920.598573064099, 9021.684241051531, 9183.127602877716, 9506.0, 8898.822023559622, 9153.816923661623, 9374.390664606779, 9408.62498937997, 9536.141747242782]}, "summary": {"lowerIsBetter": false, "suite": 6025.148115353695, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6477.40316435665, "unit": "ms", "value": 6477.40316435665}, "dojo.html": {"lowerIsBetter": false, "filtered": 4653.738897021624, "unit": "ms", "value": 4653.738897021624}, "mootools.html": {"lowerIsBetter": false, "filtered": 3954.3754195968413, "unit": "ms", "value": 3954.3754195968413}, "ext.html": {"lowerIsBetter": false, "filtered": 17154.70482159996, "unit": "ms", "value": 17154.70482159996}, "prototype.html": {"lowerIsBetter": false, "filtered": 4220.883122779436, "unit": "ms", "value": 4220.883122779436}, "yui.html": {"lowerIsBetter": false, "filtered": 5542.359356928465, "unit": "ms", "value": 5542.359356928465}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1447431980, "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": "20151113072730", "branch": "Mozilla-Inbound-Non-PGO", "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 161.0, 163.0, 162.0, 161.0, 163.0, 162.0, 163.0, 162.0], "ai-astar": [112.0, 114.0, 105.0, 111.0, 112.0, 112.0, 101.0, 112.0, 112.0, 110.0], "imaging-gaussian-blur": [110.0, 108.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "audio-beat-detection": [158.0, 138.0, 153.0, 166.0, 137.0, 160.0, 164.0, 139.0, 165.0, 132.0], "json-stringify-tinderbox": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0], "stanford-crypto-pbkdf2": [133.0, 137.0, 150.0, 145.0, 151.0, 133.0, 145.0, 143.0, 157.0, 133.0], "json-parse-financial": [71.0, 70.0, 70.0, 69.0, 69.0, 72.0, 70.0, 78.0, 70.0, 68.0], "stanford-crypto-sha256-iterative": [68.0, 69.0, 73.0, 68.0, 68.0, 71.0, 69.0, 69.0, 67.0, 70.0], "audio-fft": [72.0, 73.0, 91.0, 92.0, 73.0, 72.0, 72.0, 106.0, 90.0, 72.0], "imaging-darkroom": [147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 146.0, 148.0, 146.0], "stanford-crypto-ccm": [127.0, 119.0, 127.0, 120.0, 125.0, 119.0, 125.0, 129.0, 128.0, 131.0], "audio-oscillator": [92.0, 92.0, 128.0, 92.0, 92.0, 92.0, 125.0, 91.0, 92.0, 127.0], "stanford-crypto-aes": [82.0, 83.0, 83.0, 83.0, 81.0, 81.0, 83.0, 91.0, 84.0, 84.0], "imaging-desaturate": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1515.9, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.3, "unit": "ms", "value": 81.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 142.7, "unit": "ms", "value": 142.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 151.2, "unit": "ms", "value": 151.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 125.0, "unit": "ms", "value": 125.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 70.7, "unit": "ms", "value": 70.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.3, "unit": "ms", "value": 102.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 110.1, "unit": "ms", "value": 110.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.9, "unit": "ms", "value": 161.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 69.2, "unit": "ms", "value": 69.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.3, "unit": "ms", "value": 66.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 83.5, "unit": "ms", "value": 83.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.7, "unit": "ms", "value": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1447431980, "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": "20151113072730", "branch": "Mozilla-Inbound-Non-PGO", "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.71779141104295], "Encrypt": [280.1120448179272], "NavierStokes": [4822.115384615385], "Decrypt": [5045.226130653266], "Splay": [621.1180124223603], "Richards": [171.02787754403968], "RegExp": [26736.842105263157], "Earley": [827.2727272727273], "Boyer": [11767.441860465116], "RayTrace": [2006.0120240480962]}, "summary": {"lowerIsBetter": false, "suite": 19650.269386657703, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.87148800000006, "unit": "score", "value": 344.87148800000006}, "Encrypt": {"lowerIsBetter": false, "filtered": 950.2661699999999, "unit": "score", "value": 950.2661699999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.75898306772911, "unit": "score", "value": 52.75898306772911}, "Splay": {"lowerIsBetter": false, "filtered": 131.20050999999998, "unit": "score", "value": 131.20050999999998}, "RegExp": {"lowerIsBetter": false, "filtered": 34.07227362204725, "unit": "score", "value": 34.07227362204725}, "Richards": {"lowerIsBetter": false, "filtered": 206.41079400000007, "unit": "score", "value": 206.41079400000007}, "Earley": {"lowerIsBetter": false, "filtered": 805.6146153846153, "unit": "score", "value": 805.6146153846153}, "Boyer": {"lowerIsBetter": false, "filtered": 56.63618379446645, "unit": "score", "value": 56.63618379446645}, "RayTrace": {"lowerIsBetter": false, "filtered": 368.8856253746253, "unit": "score", "value": 368.8856253746253}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1447431980, "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": "20151113072730", "branch": "Mozilla-Inbound-Non-PGO", "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f"}}] 08:46:38 INFO - RETURN: dromaeo_css: 6025.15 08:46:38 INFO - RETURN: kraken: 1515.90 08:46:38 INFO - RETURN: v8_7: 19650.27 08:46:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19650.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1515.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "6025.15"}}} 08:46:38 INFO - Return code: 0 08:46:38 INFO - # TBPL SUCCESS # 08:46:38 INFO - Running post-action listener: _resource_record_post_action 08:46:38 INFO - Running post-run listener: _resource_record_post_run 08:46:39 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503345152; Read time: 168; Write time: 371284 08:46:39 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 131563520; Read time: 0; Write time: 120104 08:46:39 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 274096128; Read time: 0; Write time: 157024 08:46:39 INFO - Running post-run listener: _upload_blobber_files 08:46:39 INFO - Blob upload gear active. 08:46:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:46:39 INFO - Copying logs to upload dir... 08:46:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.176166 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-13 08:46:39.266114) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:46:39.270216) ========= 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=928fd09416829678a2f67a56000001ac-1447431933.625129-473351241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010074 build_url: 'https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/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-13 08:46:39.322042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:46:39.322411) ========= 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=928fd09416829678a2f67a56000001ac-1447431933.625129-473351241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:46:39.372845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 08:46:39.373155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 08:46:39.373548) ========= ========= Total master_lag: 0.23 =========