builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1447295628.8 results: success (0) buildid: 20151111171348 builduid: 05d2751f851f44acbc28234846d9b837 revision: 9f7af27bf22fddfd062df2b756187578e7facf8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.805402) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.806053) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.806366) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006694 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.829129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.829446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.858646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.859026) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.909172) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.909471) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.909833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:48.910129) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-11 18:33:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.1M=0s 2015-11-11 18:33:49 (95.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110897 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.032662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.032978) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020896 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.083056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.083447) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9f7af27bf22fddfd062df2b756187578e7facf8a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9f7af27bf22fddfd062df2b756187578e7facf8a --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=cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-11 18:33:49,625 truncating revision to first 12 chars 2015-11-11 18:33:49,625 Setting DEBUG logging. 2015-11-11 18:33:49,625 attempt 1/10 2015-11-11 18:33:49,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/9f7af27bf22f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 18:33:49,877 unpacking tar archive at: b2g-inbound-9f7af27bf22f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.623103) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.623422) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.630392) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.630659) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 18:33:49.631098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-11 18:33:49.631425) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:33:50 INFO - MultiFileLogger online at 20151111 18:33:50 in /builds/slave/test 18:33:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 18:33:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:33:50 INFO - {'append_to_log': False, 18:33:50 INFO - 'base_work_dir': '/builds/slave/test', 18:33:50 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 18:33:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:33:50 INFO - 'branch': 'B2G-Inbound-Non-PGO', 18:33:50 INFO - 'buildbot_json_path': 'buildprops.json', 18:33:50 INFO - 'config_files': ('talos/linux_config.py',), 18:33:50 INFO - 'default_actions': ('clobber', 18:33:50 INFO - 'read-buildbot-config', 18:33:50 INFO - 'download-and-extract', 18:33:50 INFO - 'populate-webroot', 18:33:50 INFO - 'create-virtualenv', 18:33:50 INFO - 'install', 18:33:50 INFO - 'run-tests'), 18:33:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:33:50 INFO - 'download_minidump_stackwalk': True, 18:33:50 INFO - 'download_symbols': 'ondemand', 18:33:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:33:50 INFO - 'tooltool.py': '/tools/tooltool.py', 18:33:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:33:50 INFO - '/tools/misc-python/virtualenv.py')}, 18:33:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:33:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:33:50 INFO - 'installer_path': 'installer.exe', 18:33:50 INFO - 'log_level': 'info', 18:33:50 INFO - 'log_name': 'talos', 18:33:50 INFO - 'log_to_console': True, 18:33:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:33:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:33:50 INFO - 'opt_config_files': (), 18:33:50 INFO - 'pip_index': False, 18:33:50 INFO - 'sps_profile': False, 18:33:50 INFO - 'sps_profile_interval': 0, 18:33:50 INFO - 'suite': 'dromaeojs', 18:33:50 INFO - 'system_bits': '64', 18:33:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:33:50 INFO - 'title': 'talos-linux64-ix-005', 18:33:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:33:50 INFO - 'use_talos_json': True, 18:33:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:33:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:33:50 INFO - 'work_dir': 'build'} 18:33:50 INFO - ##### 18:33:50 INFO - ##### Running clobber step. 18:33:50 INFO - ##### 18:33:50 INFO - Running pre-action listener: _resource_record_pre_action 18:33:50 INFO - Running main action method: clobber 18:33:50 INFO - rmtree: /builds/slave/test/build 18:33:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:33:50 INFO - Running post-action listener: _resource_record_post_action 18:33:50 INFO - ##### 18:33:50 INFO - ##### Running read-buildbot-config step. 18:33:50 INFO - ##### 18:33:50 INFO - Running pre-action listener: _resource_record_pre_action 18:33:50 INFO - Running main action method: read_buildbot_config 18:33:50 INFO - Using buildbot properties: 18:33:50 INFO - { 18:33:50 INFO - "properties": { 18:33:50 INFO - "buildnumber": 186, 18:33:50 INFO - "product": "firefox", 18:33:50 INFO - "script_repo_revision": "production", 18:33:50 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 18:33:50 INFO - "repository": "", 18:33:50 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 18:33:50 INFO - "buildid": "20151111171348", 18:33:50 INFO - "slavename": "talos-linux64-ix-005", 18:33:50 INFO - "pgo_build": "False", 18:33:50 INFO - "basedir": "/builds/slave/test", 18:33:50 INFO - "project": "", 18:33:50 INFO - "platform": "ubuntu64_hw", 18:33:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:33:50 INFO - "slavebuilddir": "test", 18:33:50 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 18:33:50 INFO - "branch": "b2g-inbound", 18:33:50 INFO - "repo_path": "integration/b2g-inbound", 18:33:50 INFO - "stage_platform": "linux64", 18:33:50 INFO - "builduid": "05d2751f851f44acbc28234846d9b837", 18:33:50 INFO - "revision": "9f7af27bf22fddfd062df2b756187578e7facf8a" 18:33:50 INFO - }, 18:33:50 INFO - "sourcestamp": { 18:33:50 INFO - "repository": "", 18:33:50 INFO - "hasPatch": false, 18:33:50 INFO - "project": "", 18:33:50 INFO - "branch": "b2g-inbound-linux64-talos", 18:33:50 INFO - "changes": [ 18:33:50 INFO - { 18:33:50 INFO - "category": null, 18:33:50 INFO - "files": [ 18:33:50 INFO - { 18:33:50 INFO - "url": null, 18:33:50 INFO - "name": "https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:33:50 INFO - } 18:33:50 INFO - ], 18:33:50 INFO - "repository": "", 18:33:50 INFO - "rev": "9f7af27bf22fddfd062df2b756187578e7facf8a", 18:33:50 INFO - "who": "kwierso@gmail.com", 18:33:50 INFO - "when": 1447295587, 18:33:50 INFO - "number": 6651645, 18:33:50 INFO - "comments": "Merge m-c to b2ginbound, a=merge", 18:33:50 INFO - "project": "", 18:33:50 INFO - "at": "Wed 11 Nov 2015 18:33:07", 18:33:50 INFO - "branch": "b2g-inbound-linux64-talos", 18:33:50 INFO - "revlink": "", 18:33:50 INFO - "properties": [ 18:33:50 INFO - [ 18:33:50 INFO - "buildid", 18:33:50 INFO - "20151111171348", 18:33:50 INFO - "Change" 18:33:50 INFO - ], 18:33:50 INFO - [ 18:33:50 INFO - "builduid", 18:33:50 INFO - "05d2751f851f44acbc28234846d9b837", 18:33:50 INFO - "Change" 18:33:50 INFO - ], 18:33:50 INFO - [ 18:33:50 INFO - "pgo_build", 18:33:50 INFO - "False", 18:33:50 INFO - "Change" 18:33:50 INFO - ] 18:33:50 INFO - ], 18:33:50 INFO - "revision": "9f7af27bf22fddfd062df2b756187578e7facf8a" 18:33:50 INFO - } 18:33:50 INFO - ], 18:33:50 INFO - "revision": "9f7af27bf22fddfd062df2b756187578e7facf8a" 18:33:50 INFO - } 18:33:50 INFO - } 18:33:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:33:50 INFO - Running post-action listener: _resource_record_post_action 18:33:50 INFO - ##### 18:33:50 INFO - ##### Running download-and-extract step. 18:33:50 INFO - ##### 18:33:50 INFO - Running pre-action listener: _resource_record_pre_action 18:33:50 INFO - Running main action method: download_and_extract 18:33:50 INFO - mkdir: /builds/slave/test/build/tests 18:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:50 INFO - https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:33:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/test_packages.json 18:33:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/test_packages.json 18:33:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:33:51 INFO - Downloaded 1302 bytes. 18:33:51 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:33:51 INFO - Using the following test package requirements: 18:33:51 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:33:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:33:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:51 INFO - u'jsshell-linux-x86_64.zip'], 18:33:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:33:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:33:51 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:33:51 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:33:51 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:33:51 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:33:51 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:33:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:33: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')]} 18:33:51 INFO - https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:33:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:33:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:33:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:33:53 INFO - Downloaded 21251435 bytes. 18:33:53 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 18:33:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:33:53 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 18:33:54 INFO - Return code: 0 18:33:54 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 18:33:54 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')]} 18:33:54 INFO - https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:33:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:33:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:33:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:33:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:33:55 INFO - Downloaded 21251435 bytes. 18:33:55 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 18:33:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:33:55 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 18:33:57 INFO - Return code: 0 18:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:57 INFO - https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:33:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:33:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:33:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:33:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:33:57 INFO - Downloaded 11131693 bytes. 18:33:57 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 18:33:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:33:57 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 18:33:58 INFO - Return code: 0 18:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:58 INFO - https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:33:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:33:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:33:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:33:59 INFO - Downloaded 55636144 bytes. 18:33:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:33:59 INFO - mkdir: /builds/slave/test/properties 18:33:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:59 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:59 INFO - Contents: 18:33:59 INFO - build_url:https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:33:59 INFO - Running post-action listener: _resource_record_post_action 18:33:59 INFO - Running post-action listener: set_extra_try_arguments 18:33:59 INFO - ##### 18:33:59 INFO - ##### Running populate-webroot step. 18:33:59 INFO - ##### 18:33:59 INFO - Running pre-action listener: _resource_record_pre_action 18:33:59 INFO - Running main action method: populate_webroot 18:33:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:33:59 INFO - '../fennec_ids.txt'], 18:33:59 INFO - 'tests': ['tcheck2']}, 18:33:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:59 INFO - '--tppagecycles', 18:33:59 INFO - '7'], 18:33:59 INFO - 'tests': ['tsvgm']}}, 18:33:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:33:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:33:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:33:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:33:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:59 INFO - 'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:59 INFO - 'tests': ['damp', 'tps']}, 18:33:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:59 INFO - 'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['damp', 'tps']}, 18:33:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:33:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:59 INFO - 'other': {'tests': ['a11yr', 18:33:59 INFO - 'ts_paint', 18:33:59 INFO - 'tpaint', 18:33:59 INFO - 'sessionrestore', 18:33:59 INFO - 'sessionrestore_no_auto_restore']}, 18:33:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['a11yr', 18:33:59 INFO - 'ts_paint', 18:33:59 INFO - 'tpaint', 18:33:59 INFO - 'sessionrestore', 18:33:59 INFO - 'sessionrestore_no_auto_restore']}, 18:33:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['a11yr', 18:33:59 INFO - 'ts_paint', 18:33:59 INFO - 'tpaint', 18:33:59 INFO - 'sessionrestore', 18:33:59 INFO - 'sessionrestore_no_auto_restore']}, 18:33:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['a11yr', 18:33:59 INFO - 'ts_paint', 18:33:59 INFO - 'tpaint', 18:33:59 INFO - 'sessionrestore', 18:33:59 INFO - 'sessionrestore_no_auto_restore']}, 18:33:59 INFO - 'other_l64': {'tests': ['a11yr', 18:33:59 INFO - 'ts_paint', 18:33:59 INFO - 'tpaint', 18:33:59 INFO - 'sessionrestore', 18:33:59 INFO - 'sessionrestore_no_auto_restore']}, 18:33:59 INFO - 'other_nol64': {'tests': ['a11yr', 18:33:59 INFO - 'ts_paint', 18:33:59 INFO - 'tpaint', 18:33:59 INFO - 'sessionrestore', 18:33:59 INFO - 'sessionrestore_no_auto_restore']}, 18:33:59 INFO - 'svgr': {'tests': ['tsvgx', 18:33:59 INFO - 'tsvgr_opacity', 18:33:59 INFO - 'tart', 18:33:59 INFO - 'tscrollx', 18:33:59 INFO - 'cart']}, 18:33:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['tsvgx', 18:33:59 INFO - 'tsvgr_opacity', 18:33:59 INFO - 'tart', 18:33:59 INFO - 'tscrollx', 18:33:59 INFO - 'cart']}, 18:33:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:59 INFO - 'tests': ['tp5o']}, 18:33:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:59 INFO - 'talos_options': ['--e10s'], 18:33:59 INFO - 'tests': ['tp5o']}, 18:33:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:59 INFO - 'talos_options': ['--xperf_path', 18:33:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:59 INFO - 'tests': ['tp5n']}, 18:33:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:59 INFO - 'talos_options': ['--e10s', 18:33:59 INFO - '--xperf_path', 18:33:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:59 INFO - 'tests': ['tp5n']}}, 18:33:59 INFO - 'talos.zip': {'path': '', 18:33:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:59 INFO - Running post-action listener: _resource_record_post_action 18:33:59 INFO - ##### 18:33:59 INFO - ##### Running create-virtualenv step. 18:33:59 INFO - ##### 18:33:59 INFO - Running pre-action listener: _resource_record_pre_action 18:33:59 INFO - Running main action method: create_virtualenv 18:33:59 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:59 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 18:33:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:59 INFO - Using real prefix '/usr' 18:33:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:34:00 INFO - Installing distribute.............................................................................................................................................................................................done. 18:34:02 INFO - Installing pip.................done. 18:34:02 INFO - Return code: 0 18:34:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:34: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')]} 18:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabb5323c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11659a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4ac0>, '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 0x11f59a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5e50>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', '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 18:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:34:02 INFO - Using env: {'DISPLAY': ':0', 18:34:02 INFO - 'HOME': '/home/cltbld', 18:34:02 INFO - 'LANG': 'en_US.UTF-8', 18:34:02 INFO - 'LANGUAGE': 'en_US:en', 18:34:02 INFO - 'LOGNAME': 'cltbld', 18:34:02 INFO - 'MAIL': '/var/mail/cltbld', 18:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:02 INFO - 'MOZ_NO_REMOTE': '1', 18:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:02 INFO - 'NO_EM_RESTART': '1', 18:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:02 INFO - 'PWD': '/builds/slave/test', 18:34:02 INFO - 'SHELL': '/bin/bash', 18:34:02 INFO - 'SHLVL': '1', 18:34:02 INFO - 'TERM': 'linux', 18:34:02 INFO - 'TMOUT': '86400', 18:34:02 INFO - 'USER': 'cltbld', 18:34:02 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', 18:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:02 INFO - '_': '/tools/buildbot/bin/python'} 18:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:02 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 18:34:02 INFO - Cleaning up... 18:34:02 INFO - Return code: 0 18:34:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:34: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')]} 18:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fabb5323c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11659a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4ac0>, '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 0x11f59a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5e50>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', '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 18:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:34:02 INFO - Using env: {'DISPLAY': ':0', 18:34:02 INFO - 'HOME': '/home/cltbld', 18:34:02 INFO - 'LANG': 'en_US.UTF-8', 18:34:02 INFO - 'LANGUAGE': 'en_US:en', 18:34:02 INFO - 'LOGNAME': 'cltbld', 18:34:02 INFO - 'MAIL': '/var/mail/cltbld', 18:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:02 INFO - 'MOZ_NO_REMOTE': '1', 18:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:02 INFO - 'NO_EM_RESTART': '1', 18:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:02 INFO - 'PWD': '/builds/slave/test', 18:34:02 INFO - 'SHELL': '/bin/bash', 18:34:02 INFO - 'SHLVL': '1', 18:34:02 INFO - 'TERM': 'linux', 18:34:02 INFO - 'TMOUT': '86400', 18:34:02 INFO - 'USER': 'cltbld', 18:34:02 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', 18:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:02 INFO - '_': '/tools/buildbot/bin/python'} 18:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:02 INFO - Downloading/unpacking psutil>=0.7.1 18:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:34:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:34:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:34:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:34:04 INFO - Installing collected packages: psutil 18:34:04 INFO - Running setup.py install for psutil 18:34:04 INFO - building 'psutil._psutil_linux' extension 18:34:04 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 18:34:04 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 18:34:04 INFO - building 'psutil._psutil_posix' extension 18:34:04 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 18:34:04 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 18:34:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:34:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:34:04 INFO - Successfully installed psutil 18:34:04 INFO - Cleaning up... 18:34:04 INFO - Return code: 0 18:34:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:34: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')]} 18:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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', '--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 0x7fabb5323c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11659a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4ac0>, '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 0x11f59a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5e50>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', '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 18:34:05 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 18:34:05 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 18:34:05 INFO - Using env: {'DISPLAY': ':0', 18:34:05 INFO - 'HOME': '/home/cltbld', 18:34:05 INFO - 'LANG': 'en_US.UTF-8', 18:34:05 INFO - 'LANGUAGE': 'en_US:en', 18:34:05 INFO - 'LOGNAME': 'cltbld', 18:34:05 INFO - 'MAIL': '/var/mail/cltbld', 18:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:05 INFO - 'MOZ_NO_REMOTE': '1', 18:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:05 INFO - 'NO_EM_RESTART': '1', 18:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:05 INFO - 'PWD': '/builds/slave/test', 18:34:05 INFO - 'SHELL': '/bin/bash', 18:34:05 INFO - 'SHLVL': '1', 18:34:05 INFO - 'TERM': 'linux', 18:34:05 INFO - 'TMOUT': '86400', 18:34:05 INFO - 'USER': 'cltbld', 18:34:05 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', 18:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:05 INFO - '_': '/tools/buildbot/bin/python'} 18:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:34:05 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 18:34:05 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 18:34:05 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 18:34:05 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 18:34:05 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 18:34:05 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 18:34:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:34:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:34:06 INFO - Installing collected packages: mozsystemmonitor 18:34:07 INFO - Running setup.py install for mozsystemmonitor 18:34:07 INFO - Successfully installed mozsystemmonitor 18:34:07 INFO - Cleaning up... 18:34:07 INFO - Return code: 0 18:34:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fabb5323c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11659a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4ac0>, '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 0x11f59a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5e50>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', '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 18:34:07 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 18:34:07 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 18:34:07 INFO - Using env: {'DISPLAY': ':0', 18:34:07 INFO - 'HOME': '/home/cltbld', 18:34:07 INFO - 'LANG': 'en_US.UTF-8', 18:34:07 INFO - 'LANGUAGE': 'en_US:en', 18:34:07 INFO - 'LOGNAME': 'cltbld', 18:34:07 INFO - 'MAIL': '/var/mail/cltbld', 18:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:07 INFO - 'MOZ_NO_REMOTE': '1', 18:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:07 INFO - 'NO_EM_RESTART': '1', 18:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:07 INFO - 'PWD': '/builds/slave/test', 18:34:07 INFO - 'SHELL': '/bin/bash', 18:34:07 INFO - 'SHLVL': '1', 18:34:07 INFO - 'TERM': 'linux', 18:34:07 INFO - 'TMOUT': '86400', 18:34:07 INFO - 'USER': 'cltbld', 18:34:07 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', 18:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:07 INFO - '_': '/tools/buildbot/bin/python'} 18:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:07 INFO - Downloading/unpacking blobuploader==1.2.4 18:34:07 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 18:34:07 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 18:34:07 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 18:34:07 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 18:34:07 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 18:34:07 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 18:34:08 INFO - Downloading blobuploader-1.2.4.tar.gz 18:34:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:34:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:34:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:09 INFO - Downloading docopt-0.6.1.tar.gz 18:34:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:34:09 INFO - Installing collected packages: blobuploader, requests, docopt 18:34:09 INFO - Running setup.py install for blobuploader 18:34:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:34:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:34:09 INFO - Running setup.py install for requests 18:34:10 INFO - Running setup.py install for docopt 18:34:10 INFO - Successfully installed blobuploader requests docopt 18:34:10 INFO - Cleaning up... 18:34:10 INFO - Return code: 0 18:34:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:10 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 0x7fabb5323c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11659a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4ac0>, '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 0x11f59a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5e50>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', '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 18:34:10 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 18:34:10 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 18:34:10 INFO - Using env: {'DISPLAY': ':0', 18:34:10 INFO - 'HOME': '/home/cltbld', 18:34:10 INFO - 'LANG': 'en_US.UTF-8', 18:34:10 INFO - 'LANGUAGE': 'en_US:en', 18:34:10 INFO - 'LOGNAME': 'cltbld', 18:34:10 INFO - 'MAIL': '/var/mail/cltbld', 18:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:10 INFO - 'MOZ_NO_REMOTE': '1', 18:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:10 INFO - 'NO_EM_RESTART': '1', 18:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:10 INFO - 'PWD': '/builds/slave/test', 18:34:10 INFO - 'SHELL': '/bin/bash', 18:34:10 INFO - 'SHLVL': '1', 18:34:10 INFO - 'TERM': 'linux', 18:34:10 INFO - 'TMOUT': '86400', 18:34:10 INFO - 'USER': 'cltbld', 18:34:10 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', 18:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:10 INFO - '_': '/tools/buildbot/bin/python'} 18:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:34:10 INFO - Running setup.py (path:/tmp/pip-kCGwes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:34:10 INFO - Running setup.py (path:/tmp/pip-2jWej1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:34:10 INFO - Running setup.py (path:/tmp/pip-4pdmAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:34:10 INFO - Running setup.py (path:/tmp/pip-0SJIrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:34:10 INFO - Running setup.py (path:/tmp/pip-MVLWcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:34:10 INFO - Running setup.py (path:/tmp/pip-C4JUP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:34:10 INFO - Running setup.py (path:/tmp/pip-VJsRds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:34:10 INFO - Running setup.py (path:/tmp/pip-h0dT27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:34:11 INFO - Running setup.py (path:/tmp/pip-t7_DX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:34:11 INFO - Running setup.py (path:/tmp/pip-8UbUYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:34:11 INFO - Running setup.py (path:/tmp/pip-uIpZ2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:34:11 INFO - Running setup.py (path:/tmp/pip-f0NSZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:34:11 INFO - Running setup.py (path:/tmp/pip-Hy9ZS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:34:11 INFO - Running setup.py (path:/tmp/pip-FlB3eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:11 INFO - Running setup.py (path:/tmp/pip-n8PH7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:34:11 INFO - Running setup.py (path:/tmp/pip-6Lv_4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:34:11 INFO - Running setup.py (path:/tmp/pip-WBZwCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:34:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:34:11 INFO - Running setup.py install for manifestparser 18:34:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:34:11 INFO - Running setup.py install for mozcrash 18:34:11 INFO - Running setup.py install for mozdebug 18:34:11 INFO - Running setup.py install for mozdevice 18:34:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Running setup.py install for mozfile 18:34:12 INFO - Running setup.py install for mozhttpd 18:34:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Running setup.py install for mozinfo 18:34:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Running setup.py install for mozInstall 18:34:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Running setup.py install for mozleak 18:34:12 INFO - Running setup.py install for mozlog 18:34:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Running setup.py install for moznetwork 18:34:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:34:12 INFO - Running setup.py install for mozprocess 18:34:12 INFO - Running setup.py install for mozprofile 18:34:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:34:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:34:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:34:13 INFO - Running setup.py install for mozrunner 18:34:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:34:13 INFO - Running setup.py install for mozscreenshot 18:34:13 INFO - Running setup.py install for moztest 18:34:13 INFO - Running setup.py install for mozversion 18:34:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:34:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:34:13 INFO - Cleaning up... 18:34:13 INFO - Return code: 0 18:34:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fabb5323c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11659a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4ac0>, '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 0x11f59a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5e50>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', '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 18:34:13 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 18:34:13 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 18:34:13 INFO - Using env: {'DISPLAY': ':0', 18:34:13 INFO - 'HOME': '/home/cltbld', 18:34:13 INFO - 'LANG': 'en_US.UTF-8', 18:34:13 INFO - 'LANGUAGE': 'en_US:en', 18:34:13 INFO - 'LOGNAME': 'cltbld', 18:34:13 INFO - 'MAIL': '/var/mail/cltbld', 18:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:13 INFO - 'MOZ_NO_REMOTE': '1', 18:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:13 INFO - 'NO_EM_RESTART': '1', 18:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:13 INFO - 'PWD': '/builds/slave/test', 18:34:13 INFO - 'SHELL': '/bin/bash', 18:34:13 INFO - 'SHLVL': '1', 18:34:13 INFO - 'TERM': 'linux', 18:34:13 INFO - 'TMOUT': '86400', 18:34:13 INFO - 'USER': 'cltbld', 18:34:13 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', 18:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:13 INFO - '_': '/tools/buildbot/bin/python'} 18:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:34:13 INFO - Running setup.py (path:/tmp/pip-hyysml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:34:13 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)) 18:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:34:13 INFO - Running setup.py (path:/tmp/pip-l2IPZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:34:13 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)) 18:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:34:13 INFO - Running setup.py (path:/tmp/pip-pWLBma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:34:13 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)) 18:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:34:13 INFO - Running setup.py (path:/tmp/pip-hdGJY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:34:13 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)) 18:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:34:13 INFO - Running setup.py (path:/tmp/pip-TE6V_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:34:14 INFO - Running setup.py (path:/tmp/pip-3uE4EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:34:14 INFO - Running setup.py (path:/tmp/pip-nUcOpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:34:14 INFO - Running setup.py (path:/tmp/pip-g2YjDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:34:14 INFO - Running setup.py (path:/tmp/pip-ptdu6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:34:14 INFO - Running setup.py (path:/tmp/pip-_B18Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:34:14 INFO - Running setup.py (path:/tmp/pip-WFkR7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:34:14 INFO - Running setup.py (path:/tmp/pip-3EZvZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:34:14 INFO - Running setup.py (path:/tmp/pip-76rLTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:34:14 INFO - Running setup.py (path:/tmp/pip-7oed3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:14 INFO - Running setup.py (path:/tmp/pip-_JDQrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:34:14 INFO - Running setup.py (path:/tmp/pip-JUkdWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:34:14 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)) 18:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:34:14 INFO - Running setup.py (path:/tmp/pip-yfY77K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:16 INFO - Downloading blessings-1.5.1.tar.gz 18:34:16 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 18:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:34:16 INFO - Installing collected packages: blessings 18:34:16 INFO - Running setup.py install for blessings 18:34:16 INFO - Successfully installed blessings 18:34:16 INFO - Cleaning up... 18:34:16 INFO - Return code: 0 18:34:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:34:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:17 INFO - Reading from file tmpfile_stdout 18:34:17 INFO - Current package versions: 18:34:17 INFO - argparse == 1.2.1 18:34:17 INFO - blessings == 1.5.1 18:34:17 INFO - blobuploader == 1.2.4 18:34:17 INFO - docopt == 0.6.1 18:34:17 INFO - manifestparser == 1.1 18:34:17 INFO - mozInstall == 1.12 18:34:17 INFO - mozcrash == 0.16 18:34:17 INFO - mozdebug == 0.1 18:34:17 INFO - mozdevice == 0.47 18:34:17 INFO - mozfile == 1.2 18:34:17 INFO - mozhttpd == 0.7 18:34:17 INFO - mozinfo == 0.9 18:34:17 INFO - mozleak == 0.1 18:34:17 INFO - mozlog == 3.0 18:34:17 INFO - moznetwork == 0.27 18:34:17 INFO - mozprocess == 0.22 18:34:17 INFO - mozprofile == 0.27 18:34:17 INFO - mozrunner == 6.11 18:34:17 INFO - mozscreenshot == 0.1 18:34:17 INFO - mozsystemmonitor == 0.0 18:34:17 INFO - moztest == 0.7 18:34:17 INFO - mozversion == 1.4 18:34:17 INFO - psutil == 3.1.1 18:34:17 INFO - requests == 1.2.3 18:34:17 INFO - wsgiref == 0.1.2 18:34:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34:17 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')]} 18:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:17 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')]} 18:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:17 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 0x7fabb5323c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11659a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4ac0>, '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 0x11f59a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5e50>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', '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 18:34:17 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 18:34:17 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 18:34:17 INFO - Using env: {'DISPLAY': ':0', 18:34:17 INFO - 'HOME': '/home/cltbld', 18:34:17 INFO - 'LANG': 'en_US.UTF-8', 18:34:17 INFO - 'LANGUAGE': 'en_US:en', 18:34:17 INFO - 'LOGNAME': 'cltbld', 18:34:17 INFO - 'MAIL': '/var/mail/cltbld', 18:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:17 INFO - 'MOZ_NO_REMOTE': '1', 18:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:17 INFO - 'NO_EM_RESTART': '1', 18:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:17 INFO - 'PWD': '/builds/slave/test', 18:34:17 INFO - 'SHELL': '/bin/bash', 18:34:17 INFO - 'SHLVL': '1', 18:34:17 INFO - 'TERM': 'linux', 18:34:17 INFO - 'TMOUT': '86400', 18:34:17 INFO - 'USER': 'cltbld', 18:34:17 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', 18:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:17 INFO - '_': '/tools/buildbot/bin/python'} 18:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 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)) 18:34:17 INFO - Cleaning up... 18:34:17 INFO - Return code: 0 18:34:17 INFO - Running post-action listener: _resource_record_post_action 18:34:17 INFO - Running post-action listener: _start_resource_monitoring 18:34:17 INFO - Starting resource monitoring. 18:34:17 INFO - ##### 18:34:17 INFO - ##### Running install step. 18:34:17 INFO - ##### 18:34:17 INFO - Running pre-action listener: _resource_record_pre_action 18:34:17 INFO - Running main action method: install 18:34:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:17 INFO - Reading from file tmpfile_stdout 18:34:17 INFO - Detecting whether we're running mozinstall >=1.0... 18:34:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:34:17 INFO - Reading from file tmpfile_stdout 18:34:17 INFO - Output received: 18:34:17 INFO - Usage: mozinstall [options] installer 18:34:17 INFO - Options: 18:34:17 INFO - -h, --help show this help message and exit 18:34:17 INFO - -d DEST, --destination=DEST 18:34:17 INFO - Directory to install application into. [default: 18:34:17 INFO - "/builds/slave/test"] 18:34:17 INFO - --app=APP Application being installed. [default: firefox] 18:34:17 INFO - mkdir: /builds/slave/test/build/application 18:34:17 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'] 18:34:17 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 18:34:31 INFO - Reading from file tmpfile_stdout 18:34:31 INFO - Output received: 18:34:31 INFO - /builds/slave/test/build/application/firefox/firefox 18:34:31 INFO - Running post-action listener: _resource_record_post_action 18:34:31 INFO - ##### 18:34:31 INFO - ##### Running run-tests step. 18:34:31 INFO - ##### 18:34:31 INFO - Running pre-action listener: _resource_record_pre_action 18:34:31 INFO - Running main action method: run_tests 18:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:34:31 INFO - Python 2.7.3 18:34:31 INFO - Return code: 0 18:34:31 INFO - grabbing minidump binary from tooltool 18:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:31 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 0x11f4ac0>, '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 0x11f59a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:34:31 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 18:34:31 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 18:34:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:34:31 INFO - Return code: 0 18:34:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:34:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:34:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:34:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:34:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] in /builds/slave/test/build 18:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost 18:34:31 INFO - Using env: {'DISPLAY': ':0', 18:34:31 INFO - 'HOME': '/home/cltbld', 18:34:31 INFO - 'LANG': 'en_US.UTF-8', 18:34:31 INFO - 'LANGUAGE': 'en_US:en', 18:34:31 INFO - 'LOGNAME': 'cltbld', 18:34:31 INFO - 'MAIL': '/var/mail/cltbld', 18:34:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:34:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:31 INFO - 'MOZ_NO_REMOTE': '1', 18:34:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:31 INFO - 'NO_EM_RESTART': '1', 18:34:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:31 INFO - 'PWD': '/builds/slave/test', 18:34:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:34:31 INFO - 'SHELL': '/bin/bash', 18:34:31 INFO - 'SHLVL': '1', 18:34:31 INFO - 'TERM': 'linux', 18:34:31 INFO - 'TMOUT': '86400', 18:34:31 INFO - 'USER': 'cltbld', 18:34:31 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086', 18:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:31 INFO - '_': '/tools/buildbot/bin/python'} 18:34:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] with output_timeout 3600 18:34:31 INFO - mozversion INFO | application_buildid: 20151111171348 18:34:31 INFO - mozversion INFO | application_changeset: 9f7af27bf22fddfd062df2b756187578e7facf8a 18:34:31 INFO - mozversion INFO | application_display_name: Nightly 18:34:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:34:31 INFO - mozversion INFO | application_name: Firefox 18:34:31 INFO - mozversion INFO | application_remotingname: firefox 18:34:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 18:34:31 INFO - mozversion INFO | application_vendor: Mozilla 18:34:31 INFO - mozversion INFO | application_version: 45.0a1 18:34:31 INFO - mozversion INFO | platform_buildid: 20151111171348 18:34:31 INFO - mozversion INFO | platform_changeset: 9f7af27bf22fddfd062df2b756187578e7facf8a 18:34:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 18:34:31 INFO - mozversion INFO | platform_version: 45.0a1 18:34:31 INFO - 2015-11-11 18:34:31,883 DEBUG : using testdate: 1447295671 18:34:31 INFO - 2015-11-11 18:34:31,883 DEBUG : actual date: 1447295671 18:34:31 INFO - 2015-11-11 18:34:31,891 INFO : starting webserver on 'localhost:52956' 18:34:31 INFO - 2015-11-11 18:34:31,892 INFO : Starting test suite talos-linux64-ix-005 18:34:31 INFO - 2015-11-11 18:34:31,892 INFO : Starting test dromaeo_css 18:34:31 INFO - 2015-11-11 18:34:31,892 DEBUG : operating with platform_type : linux_ 18:34:31 INFO - 2015-11-11 18:34:31,893 INFO : Initialising browser for dromaeo_css test... 18:34:31 INFO - 2015-11-11 18:34:31,905 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRieK_9/profile http://localhost:52956/getInfo.html 18:34:35 INFO - 2015-11-11 18:34:35,755 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:34:35 INFO - 2015-11-11 18:34:35,755 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:34:35 INFO - 2015-11-11 18:34:35,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:34:35 INFO - 2015-11-11 18:34:35,756 DEBUG : BROWSER_OUTPUT: __metrics 18:34:35 INFO - 2015-11-11 18:34:35,852 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:34:37 INFO - 2015-11-11 18:34:37,274 INFO : Browser initialized. 18:34:37 INFO - 2015-11-11 18:34:37,275 INFO : Running cycle 1/1 for dromaeo_css test... 18:34:37 INFO - 2015-11-11 18:34:37,275 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRieK_9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:34:49 INFO - 2015-11-11 18:34:49,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 140169216 18:34:49 INFO - 2015-11-11 18:34:49,153 DEBUG : BROWSER_OUTPUT: 18:35:40 INFO - 2015-11-11 18:35:40,527 DEBUG : BROWSER_OUTPUT: 1447295740521 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] 18:37:52 INFO - 2015-11-11 18:37:52,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52956/tests/dromaeo/cssquery-ext.html) 18:37:53 INFO - 2015-11-11 18:37:53,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 236212224 18:37:53 INFO - 2015-11-11 18:37:53,509 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-11 18:40:55,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/dromaeo/cssquery-ext.html (next: http://localhost:52956/tests/dromaeo/cssquery-jquery.html) 18:40:56 INFO - 2015-11-11 18:40:56,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 214790144 18:40:56 INFO - 2015-11-11 18:40:56,520 DEBUG : BROWSER_OUTPUT: 18:43:58 INFO - 2015-11-11 18:43:58,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52956/tests/dromaeo/cssquery-mootools.html) 18:43:59 INFO - 2015-11-11 18:43:59,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 212115456 18:43:59 INFO - 2015-11-11 18:43:59,103 DEBUG : BROWSER_OUTPUT: 18:47:01 INFO - 2015-11-11 18:47:01,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52956/tests/dromaeo/cssquery-prototype.html) 18:47:01 INFO - 2015-11-11 18:47:01,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 198430720 18:47:01 INFO - 2015-11-11 18:47:01,578 DEBUG : BROWSER_OUTPUT: 18:50:04 INFO - 2015-11-11 18:50:04,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52956/tests/dromaeo/cssquery-yui.html) 18:50:04 INFO - 2015-11-11 18:50:04,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 200167424 18:50:04 INFO - 2015-11-11 18:50:04,953 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/dromaeo/cssquery-yui.html (next: http://localhost:52956/tests/dromaeo/cssquery-dojo.html) 18:53:07 INFO - 2015-11-11 18:53:07,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 248598528 18:53:07 INFO - 2015-11-11 18:53:07,766 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,766 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:53:07 INFO - 2015-11-11 18:53:07,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:53:07 INFO - 2015-11-11 18:53:07,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:53:07 INFO - 2015-11-11 18:53:07,767 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:53:07 INFO - 2015-11-11 18:53:07,767 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2666.400059986503;2741.410596721704;2745.0392362673056;2749.3951330707237;2770.376665250319;4550.544945505448;4695.272232803913;4784.8803779905475;4799.856004319871;4822.6624136310475;4724.196886529289;4769.90460190796;4811.975940120304;4879.682820616657;4890.68210566313;4416.492103408101;4417.801198946039;4450.354698568705;4454.376387305763;4485.327200919855;4469.620082293009;4515.983903621675;4523.819047238107;4526.592606665399;4559.566841150086;4277.12318974611;4298.591633794785;4358.65130789536;4388.868333949987;4407.118576284756;4401.757903315316;4437.0460351024685;4440.333949907507;4441.64466842655;4478.596926276618;4201.054762678404;4419.53594872537;4435.024294655171;4449.822007119744;4474.351219073249;4598.448186217642;4645.070985802819;4691.695039822401;4696.154692155411;4727.716337019755;5154.252633368141;5182.507661772163;5189.455107213764;5190.766415511311;5237.109691352479;4895.804167833282;4997.225430058346;5190.844274671728;5208.5572726318305;5212.58299336056;4657.324687920266;4696.7416792076765;4709;4738.952610473885;4758.738269395148;5195.896082078338;5311.3891902431715;5312.335958005249;5315.946840531623;5316.0696878046965;4833.32333473314;4954.810845397079;5108.2848401223855;5110.616703747234;5125.513076257749;5066.240063990431;5095.031943930641;5152.252923326097;5155.690658560498;5172.482751724798;5046.545810877039;5049.2173713074535;5053.9241911371355;5092.516210959953;5097.413797413271;4858.44127925286;4976.800927962913;5014.122528557488;5015.272785446163;5016.372953380827;4138.048248902709;4193.993441574061;4216.746995180238;4227.534971153171;4229.217594744982;3747.1006958329804;3756.380197267475;3758.248350329945;3765.2093060457064;3782.5650050244026;4202.726822756572;4384.539623339503;4384.6273066789045;4388.253996820548;4424.845130420485;4979.701217926863;5036.84889453317;5066.544011039025;5088.414832294334;5101.20931255656;4286.142771445723;4295.312749959991;4298.312270036841;4317.589828966243;4329.783510824446;4343.131373725268;4455.198064348384;4455.799489023002;4461.152381047591;4512.661550383735;4703.176944034849;4724.267738500538;4739.691920025256;4802.7838747255755;4824.396950381202;5063;5127.4872512748425;5128.230765385073;5135.178371460698;5178.559822415137;4684.601808846286;4816.662833601615;4819.783109760139;4822.493638168082;4861.4895435978715;5005.449400566008;5018.749062546931;5028.195488721787;5029.29589857413;5029.723365214948;4992;5080.415752188398;5086.491350864884;5103.515166059218;5121.513456221653;4973.975130124326;5005.599552035756;5008.248762685626;5012.8496145115705;5058.038972595195;4806.351142595705;5009.649324547247;5020.447750747342;5023.171176755941;5028.170351891897;4812.037592481588;4826.107170173529;4834.395700537433;4884;4928.236123400879;4946.307516947558;4961.6030717543235;4962.057209130254;4965.379327584052;5003.849884503471;4632.166210082218;4824.517548245288;4824.614030877591;4832.975835120802;4869.293952376956 18:53:07 INFO - 2015-11-11 18:53:07,768 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.4132059880468;574.0585439878603;583.0729140666341;589.9852254122907;595.3926994465643;28258.152255432346;28721;29025.27436814078;36568.81715591425;37155.25689486209;40179.59820401795;40740.18519629606;40782.7960860196;40813.38779918304;40988;7729.381649468043;7880.881786773203;7881.763547093597;7887.605619718991;7889.132195458495;7203.351698347148;7394.630268486581;10058.49707514625;10321.277510574262;10339.534720937538;10338.431386273753;10342.32774869631;10433.217508686841;10459.477026148701;10460.947695261513;7189.712411503534;7418.629068546551;10077.44574048427;10178;10182.13451856593;10313.690589282258;10627.36235825853;10642.946785266024;10643.78712425755;10652.946735266352;36456.270874582624;36921.81539092314;37496.25007499862;37497;37784.811075944446;2795.664520257562;3318.1372843060976;3327.633960264369;3672.816359182057;3707.0917625181733;27982.460964646936;28562.857185714147;28634.14097577076;28651;28772.4097991543;2657.388800575859;2687.3013016615623;2698.136596289188;2707.44497378037;2741.753242208211;231797;232017.9999999983;232458;232748;233836;44821.10357792826;45660.315095273596;54241;54265.72867135718;54660.453395465534;48464.7576762114;48479.515204848205;48642.75678621655;48695;48869.266960995614;13490.865091349157;13632.727345453035;13667.384967676478;13672.863271367358;13677.658058548615;10503.159747220205;10569.524371403306;10574.682759517227;10577.894221057692;10580.470976451146;17764.20061097228;18109.63780724378;18189.54526136857;18200.45398638043;18246.635067298845;7562.848743025109;7827.726029588937;7882.290593846581;7899.436394116255;7901.525908445512;848.702953966107;882.9514376709215;918.5407296351824;978.5645387802502;1007.3150257824603;25463;26078.739212608012;26320;26472.60291095635;26665.86667066652;994.1599348550463;994.4381424495137;997.8553109799038;1008.6973907827622;1039.101177481473;12508.937455312665;12781.936090319676;12804.61586152417;12841.422136003715;12883.35583220854;260148;264803;265000;265104;267679;44635;45154;45188.77405612951;45189;45249.54750452453;1193.9283642981275;1205.4033253539553;1219.2501611508858;1233.1244816180433;1247.7941139712027;24074.25920742195;25063.35821007398;25401.364965876;25532.61701074448;25574.872125639253;39069;39206.411903820896;39214.411783822696;39247;39384;243485;244598;245081;245259;245378;23642;24030.158944436862;27627.72372276332;27778.86110569434;28316.15051548457;33029.66970330266;33062.66937330596;33069.83465082659;33442.665573343955;33709;30893.38213235678;31044.68955310418;31128.377432450772;31739.365212695157;31993.520097198096;27351.58972615452;31031;31227.84386078055;31483.527747083353;31695;29294.41411171722;32102.35795284128;32490.51264230991;32613.510797337585;32724.181895452803;25479.36301592475;27046;27193.72806271991;28886.42227155403;29338.266543336587;22691.319260422213;22698;22742.886285568467;23106.884465577565;23116.19093331725 18:53:07 INFO - 2015-11-11 18:53:07,768 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.790755777639;337.4729349692641;337.5325174633134;337.6201773005369;339.9949000764989;12459.68850778731;12823.166494177894;15594.298256578453;16202.513924582267;16990.06554639496;12796.232226066442;15324.846751532481;16065.277062532185;16096.517104486855;16165.43420980266;5057.443681195065;5204.193350030751;5208.505192006773;5212.21816727492;5212.869678258036;3623.8188090595495;3752.9061773455746;5148.897022059557;5202.323697919265;5205.193195054753;5657.490825825675;5823.417658234164;5870.295564532241;5870.76516939324;5874.412558744134;5402.270693456372;5411.21537377082;5461.781528738846;5799.159121927318;5815.651060936336;5043.117454445494;5158.509941555584;5162.586993040548;5165.509276618753;5168.147255702805;18873.716894246598;19386.515337116543;19617.9019104905;19664.311749088713;19710.70433943492;1868.019289872814;1877.511846919797;1886.6038131992298;1910.8949007804565;1969.4977780665981;12404;12439.37803109841;12738.426770795337;12783.488660453571;12811.551595694105;1684.9915750421292;1699.8725095617879;1711.5617133456278;1763.8236176382388;1770.0707128757376;53387.46612533864;53655.73172134154;54719.17921231185;54964;55660;9189.81620367589;9347.90652093484;9534.809303813885;9549.379290346105;9616.90383096174;11996.880031199576;12067.974222191036;12069.818952715716;12085.15403921717;12117.697057573454;7062.435005199572;7067.505274630829;7080;7084.92915070853;7087.3267039631155;6791;6831.9658401707675;6838.794836154923;6891.793246202622;6894.413974812097;5684.090545512699;5695.60130790849;5697.487226149667;5712.542996560265;5798.449147330997;1540.2914659256867;1627.78838750964;1666.7083260429376;1682.7896512935883;1710.9144542772813;370.2908929400222;371.59867343269207;392.2527584950673;974.7270764186039;1010.722051435861;9256.472682007394;9299.814003719888;9516.23870090391;9541.141297283279;9707.66023189199;364.2951088170325;399.21354930786305;401.3498133024519;402.1895879802201;407.14093263214596;5195.532402083831;5313.601479888946;5351.732413379315;5415.4855288748295;5426.294581704353;454585;464406;476387;480143;483903;65061.67469162624;68000.65999670069;68314.31685683079;69772.30227697658;70334.64832675907;495.35603715170134;503.95464408203435;504.33679711179684;507.95361555196416;510.39773067779635;9985.450800205768;10044;10058.04448577384;10144.137748291478;10228.386296822215;32146;32440.83779581087;32478.350432990734;32851;33612.831935840164;38997;40068;41591.792041039604;41791.58208417877;41792;5906.438888305604;5964.671943043;6123.908141377794;6135.202423684892;6137.048757442603;10966.287191332538;11007.339559626447;11021.063209627271;11026.062784663394;11184.328940263611;8323.542205178532;9347.298952578447;9553.331266811256;9578.856317155109;9594;8996.55017249148;9210.263178945803;9224.861627075734;9268.72193834186;9498.572564234764;9175.816483670424;9487.146156845916;9594.952025239829;9645.469499177332;9697.563609637724;6220;6221.782237621662;6272.560920735505;6293.307736149111;6427.357264273535;10224.437655928996;10332.535035923553;10509.737256568647;10607.787844242917;10619.36283822973 18:53:07 INFO - 2015-11-11 18:53:07,769 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1220.4385982448073;1624.2609612626256;1672.4313733330669;1679.4877562343481;1713.1348668922192;6142.723577439015;6716.865662686743;6834.214065382483;6843.213030501493;6859.759908403201;6851.143607049119;6997.1253593300835;7022.613756243404;7050.823729406768;7057.505974581782;1731.2642127095996;1760.0231871311416;2023.4132101690566;2045.4477291131386;2071.4924843413387;2054.9897250513727;2065.834733221339;2067.3591186732087;2068.7724350321528;2074.4917495213695;1970.8620396572246;2003.7695664998566;2047.109507364294;2048.9180432782673;2050.8256798172174;1976.762788465379;1987.3044434447972;1996.341207401554;2005.0175414047085;2062.278202629068;2035.6437623415843;2060.5981833542464;2063.9174433022663;2065.4113577630455;2067.131804642054;7063.964680176618;7100.325469080429;7130.358267755875;7131.500794944356;7134;4225.852095176654;4288.013756835945;4309.41822853917;4330.372096046056;4334.436523251957;2325.3489023073566;2595.5198288316724;2706.905258315969;2732.467168902045;2754.1599812057316;787.9763607091796;826.3224156191925;856.6402111113347;862.0689655172399;872.8690696395528;9393.718188454357;9413.811723765486;9431.198348140417;9460.763480912963;9475.620975160986;3964.583718709494;3989.5611482736876;4057.350823868167;4058.046359105667;4069.1658210066867;8051.074126475413;8091.919080809116;8092.473989190684;8105.918940810634;8106.310963568045;4337.50118736343;4358.65130789536;4359.258925982591;4362.192994296065;4367.323064924942;3912.8630497932436;3958;3961.801909904493;3962.7226094173707;3966.5240171179066;3439.0542600784984;3450.46517789743;3450.5686789151355;3480.617132115465;3483.547138871981;1050.2333296693305;1062.6015244283394;1064.3135177810268;1064.9254552181274;1070.3363914373138;1189.5717541684987;1191.463841271414;1193.5643490126215;1197.5748609243767;1212.3029258176584;6727.29363416844;6772.69522871472;6778;6806.965965170142;6836.5214434989075;388.45034276499;389.37505303987257;389.9259140763303;390.0813584009673;390.8573370719667;5188.040212560688;5238.97380513095;5250.159974404077;5251.868703282372;5256.9737151314;7826.960865195638;8021.91704119948;8325.167483251626;8401.915980840113;8492.320614350838;7172.784816455411;7244.492885497964;7250.006248281659;7303.087114110736;7320.414366850639;6605.735770569219;6634.635095069818;6771.864562708718;6785.457163426914;6795.966020169867;6493.155889734304;6555.344465553407;6568.113304703804;6571.57284776488;6604.669766511752;6672.933270667425;7260.346568808833;7326.853462930818;7415.03604531429;7450.925490745023;7323.2676732326345;7461.776146715607;7476.177620461854;7848.7645370638975;7862.095858976291;6501.934980650133;6544.705488253136;6551.377619126175;6600.8349791255605;6603.372679595431;6890.841299432771;6890.965545172443;6903.1716194057035;6904.240533541206;6918.5502942308585;6421.614703117828;6463.353664633499;6543;6551.672416379257;6642.4686025118845;6240.937590624036;6254.906176407267;6333.334999825136;6358.046293056079;6473.287938326686;6425.261094973951;6572.474202063728;6586.934130658824;6607.702653380513;6628.171478565179;6037.728302226323;6066.423689749467;6071.605345652519;6088.299845517822;6105.755769769159;5696.800611978727;6050.90923636137;6159;6183.165272688129;6199 18:53:07 INFO - 2015-11-11 18:53:07,773 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.6625113621608;309.1899224033033;309.35036423510616;311.16141997317237;312.1447234577259;5212.973935130324;5214.530692237698;5302.840914772553;5303.946960530394;5317.441668624797;5135.8202462913805;5197.766100525476;5204.089284375238;5210.583153347732;5219.45195754446;3882.495275614166;3933.449317095609;4044.4539987101657;4044.65620422263;4049.9392509112386;3941.625545573166;3965.20695860829;3972.9801350993203;3974.2051589682032;3978.2043591281713;3893.610638936098;3928.508936382952;3942.56631770505;3942.743721658083;3950.980245098785;3834.424836274567;3895.18201177753;3898.727089103764;3935.114599215168;3957.3668213085766;3426.468897320919;3434.1242983039415;3440;3440.0023993041987;3446.0006598086525;4940.2342636891335;4941.777620007072;4958.281049247875;4960.627952903511;4961.355023846877;4493.752843593601;4497.550244975509;4501.077279157765;4504.369388285642;4506.662000349987;5353.330833645794;5456.399796022434;5476.780928762844;5480.123180291134;5495.917561236584;3771.415430608233;3777.6033516480647;3778.149916268845;3778.3199024175638;3778.6221377861993;5662.433756624305;5715.31416230055;5755.683437410982;5761.337446193699;5762.135679648044;3941.1329507508303;3943.171933893857;3945.2109578084496;3945.881623551298;3946.3291240489184;3777.8866634001024;3792.715546333981;3990.10222699896;3994.08136128692;3998.520177578651;4116.5060192777055;4381.342798580238;4428.712133711363;4464.821407143678;4529.750863702462;5353.277307563507;5414.052540805344;5418.566514678816;5431.049566325877;5435.157550579666;1412.773956167029;1426.3581388375273;1427.4932398998415;1427.5003748687875;1427.6216802547333;956.4548207521646;962.153305091529;962.1965658675085;981.0777868803302;983.306768728045;4744.667873248908;4760.285957106462;4768.356271903249;4776.92519183188;4780.856574302777;5658.547316214693;5664;5666.036773748473;5670.432956704379;5675;4788.353572267769;4809.182438985381;4809.302651115569;4809.519048095232;4812.5668689818085;2949.646042474874;3057.969420305813;3089.4130115278026;3124.3595063012026;3130.0922732407803;4582.679212455163;5277;5327.121025030827;5328.094223981932;5334.839954801362;5734;5814.098814683731;5817.650940943557;5818.2436283282905;5823.5923485355615;5300.09898317287;5306.336707911511;5316.813911513079;5317.920231196613;5320.494553017457;5635.971820140873;5642.294713160855;5643.83068507929;5686.601937864475;5721.828345149652;5376.166694162411;5583;5593.105103183471;5601.6358936668985;5613.186088017296;5212.921806172834;5233.188855727369;5235.424103348705;5238.3975842777045;5322;3886.630770076951;3886.825092870884;3889.1055057337535;3889.474920885644;3897.5322961244833;5644.379118297066;5647.29408823897;5647.519960803378;5647.7176141193595;5655.830325090254;5314.893702125859;5438.347398312228;5443.7278136092245;5449.128139497661;5456.48163424474;5509.256250406304;5512.2558454608115;5524.06090964545;5524.14375771756;5527.861803454945;5410.97294513525;5413.675179489243;5419.132938729942;5424.159255315432;5425.647332923348;5420.674759514442;5542.63972841764;5548.140038294071;5553.361363443094;5555.30558680165;5393.730313484231;5407.567394608343;5407.83776486706;5409.404965453718;5411.350637923474 18:53:07 INFO - 2015-11-11 18:53:07,773 DEBUG : BROWSER_OUTPUT: |5;yui.html;634.3561285295428;653.4902775834851;675.1088563096714;688.7486067585331;726.6003697966119;11495.482703278352;11778.705532361695;11838.822417663741;11845.052395808336;11853.288802671836;12619.43212555435;12803.295818729966;12808.167469114502;12820;12830.550930717427;609.7652403824516;782.7260458839403;796.044746304434;796.1560745609672;796.410656114474;609.2110716621963;778.9337906277973;793.1434051224693;793.2147174297432;793.7658390774735;823.8640624296984;834.9123342049088;835.0355339582792;835.7367429259764;836.564986207172;627.673609722946;632.6868200240864;804.2922228438995;821.0147822612859;825.1954344514081;595.4700316718124;596.3946594206883;598.6019297167378;598.9011813050842;599.4754589733983;10899.29154604948;11058.557657693682;11126;11155.888441115567;11201;8636.784080397978;8793.516356600385;8872.37893347466;9040.050794666531;9773.755656108584;8054.637541310596;8257.504549727035;8436.746897593082;8588.055313915464;8626.094260102662;2645.5105805426056;2667.6265322854815;2679.303381120903;2679.9866000670067;2752.876120574579;38854.41718374227;39094.21811563753;39198.41202381966;39494.80252598719;39621.40567891484;6208.596441231396;6345.36546345371;6355.237371515355;6450.645214513247;6585.341465853377;10736.73158171052;10743.14054875608;10743.78512429747;10776.245662803529;10800.621978230723;5248.177097513514;5318.867028324323;5336.066188417011;5356.330458692663;5417.83746487606;3391.69474747269;3447.0348302475345;3452.913677158091;3468.514407982884;3532.6997205237844;2267.4671452208718;2295.3687735872436;2298.1956315289517;2304.0438218139284;2310.8844557772045;403.89296836338394;404.6762589928046;405.27253579824287;407.8103681787924;409.34300447781476;398.40438544375763;399.54451924805744;410.2021568050114;421.4857873394454;422.72945314998424;6935.791926242221;7374.1151061872915;7420.269029657054;7492;7542.396608271325;425.68073944541595;437.8949052227442;444.09626410255623;464.73277865226953;473.7134033909504;3447.1382154461385;3465.151037995707;3499.3876071687864;3522.471629255581;3562.5546806649168;53560;53560.46439535633;53789.731051345276;54408;54959.72520137374;47770;48583.51416485861;48731.512684872694;48879.26681099786;49064.26403603949;42598.57401426008;43014.139717206104;44271.77864110723;44348.55651443509;45202.773986130516;7200.8919866201;7341.853162936818;7415.851682966419;7839.412044096602;7966.84066318682;30571.847140765043;30633.387332253675;30774.692253077184;31071.84464077665;31586.368272634878;38705.4194187093;39461;42866.56408001763;43050.35424468573;43175.784121079196;6930.13373328334;7053.188883278283;7116.395106416013;7189.1013623297085;7230.855382892418;10106.797864042532;10446.320989135682;10539;10593.417362045162;10661.147108231478;9280.814383712153;9337.953310233406;9870.654527091518;10047.14599259042;10067.74830629211;9766.511674416393;9906.801863962824;9946.502674866373;9946.850797238192;10036.849447258443;9607.13535781783;9654.372465789702;9750.609975600897;9832.655857044969;9870.259730520384;8031.196880311922;8198.057223419382;8263.504189748634;8267.710630127916;8282.751517454486;7695.192004839635;7741.574213418091;7891.368690504631;8136.877946830684;8187.631556579849 18:53:07 INFO - 2015-11-11 18:53:07,773 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:53:07 INFO - 2015-11-11 18:53:07,773 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:53:07 INFO - 2015-11-11 18:53:07,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,917 18:53:07 INFO - 2015-11-11 18:53:07,773 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:53:07 INFO - 2015-11-11 18:53:07,774 DEBUG : BROWSER_OUTPUT: __startTimestamp1447296787760__endTimestamp 18:53:07 INFO - 2015-11-11 18:53:07,774 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:53:07 INFO - 2015-11-11 18:53:07,774 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:53:07 INFO - 2015-11-11 18:53:07,774 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,774 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4700.40 Median:4822.49 stddev:491.97 (10.2%) stddev-sans-first:466.89 18:53:07 INFO - 2015-11-11 18:53:07,774 DEBUG : BROWSER_OUTPUT: Values: 2666.4 2741.4 2745.0 2749.4 2770.4 4550.5 4695.3 4784.9 4799.9 4822.7 4724.2 4769.9 4812.0 4879.7 4890.7 4416.5 4417.8 4450.4 4454.4 4485.3 4469.6 4516.0 4523.8 4526.6 4559.6 4277.1 4298.6 4358.7 4388.9 4407.1 4401.8 4437.0 4440.3 4441.6 4478.6 4201.1 4419.5 4435.0 4449.8 4474.4 4598.4 4645.1 4691.7 4696.2 4727.7 5154.3 5182.5 5189.5 5190.8 5237.1 4895.8 4997.2 5190.8 5208.6 5212.6 4657.3 4696.7 4709.0 4739.0 4758.7 5195.9 5311.4 5312.3 5315.9 5316.1 4833.3 4954.8 5108.3 5110.6 5125.5 5066.2 5095.0 5152.3 5155.7 5172.5 5046.5 5049.2 5053.9 5092.5 5097.4 4858.4 4976.8 5014.1 5015.3 5016.4 4138.0 4194.0 4216.7 4227.5 4229.2 3747.1 3756.4 3758.2 3765.2 3782.6 4202.7 4384.5 4384.6 4388.3 4424.8 4979.7 5036.8 5066.5 5088.4 5101.2 4286.1 4295.3 4298.3 4317.6 4329.8 4343.1 4455.2 4455.8 4461.2 4512.7 4703.2 4724.3 4739.7 4802.8 4824.4 5063.0 5127.5 5128.2 5135.2 5178.6 4684.6 4816.7 4819.8 4822.5 4861.5 5005.4 5018.7 5028.2 5029.3 5029.7 4992.0 5080.4 5086.5 5103.5 5121.5 4974.0 5005.6 5008.2 5012.8 5058.0 4806.4 5009.6 5020.4 5023.2 5028.2 4812.0 4826.1 4834.4 4884.0 4928.2 4946.3 4961.6 4962.1 4965.4 5003.8 4632.2 4824.5 4824.6 4833.0 4869.3 18:53:07 INFO - 2015-11-11 18:53:07,775 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,775 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39961.49 Median:28439.50 stddev:64423.73 (226.5%) stddev-sans-first:64536.51 18:53:07 INFO - 2015-11-11 18:53:07,775 DEBUG : BROWSER_OUTPUT: Values: 554.4 574.1 583.1 590.0 595.4 28258.2 28721.0 29025.3 36568.8 37155.3 40179.6 40740.2 40782.8 40813.4 40988.0 7729.4 7880.9 7881.8 7887.6 7889.1 7203.4 7394.6 10058.5 10321.3 10339.5 10338.4 10342.3 10433.2 10459.5 10460.9 7189.7 7418.6 10077.4 10178.0 10182.1 10313.7 10627.4 10642.9 10643.8 10652.9 36456.3 36921.8 37496.3 37497.0 37784.8 2795.7 3318.1 3327.6 3672.8 3707.1 27982.5 28562.9 28634.1 28651.0 28772.4 2657.4 2687.3 2698.1 2707.4 2741.8 231797.0 232018.0 232458.0 232748.0 233836.0 44821.1 45660.3 54241.0 54265.7 54660.5 48464.8 48479.5 48642.8 48695.0 48869.3 13490.9 13632.7 13667.4 13672.9 13677.7 10503.2 10569.5 10574.7 10577.9 10580.5 17764.2 18109.6 18189.5 18200.5 18246.6 7562.8 7827.7 7882.3 7899.4 7901.5 848.7 883.0 918.5 978.6 1007.3 25463.0 26078.7 26320.0 26472.6 26665.9 994.2 994.4 997.9 1008.7 1039.1 12508.9 12781.9 12804.6 12841.4 12883.4 260148.0 264803.0 265000.0 265104.0 267679.0 44635.0 45154.0 45188.8 45189.0 45249.5 1193.9 1205.4 1219.3 1233.1 1247.8 24074.3 25063.4 25401.4 25532.6 25574.9 39069.0 39206.4 39214.4 39247.0 39384.0 243485.0 244598.0 245081.0 245259.0 245378.0 23642.0 24030.2 27627.7 27778.9 28316.2 33029.7 33062.7 33069.8 33442.7 33709.0 30893.4 31044.7 31128.4 31739.4 31993.5 27351.6 31031.0 31227.8 31483.5 31695.0 29294.4 32102.4 32490.5 32613.5 32724.2 25479.4 27046.0 27193.7 28886.4 29338.3 22691.3 22698.0 22742.9 23106.9 23116.2 18:53:07 INFO - 2015-11-11 18:53:07,775 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,775 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24771.53 Median:509.18 stddev:77203.08 (15162.4%) stddev-sans-first:77397.85 18:53:07 INFO - 2015-11-11 18:53:07,775 DEBUG : BROWSER_OUTPUT: Values: 334.8 337.5 337.5 337.6 340.0 12459.7 12823.2 15594.3 16202.5 16990.1 12796.2 15324.8 16065.3 16096.5 16165.4 5057.4 5204.2 5208.5 5212.2 5212.9 3623.8 3752.9 5148.9 5202.3 5205.2 5657.5 5823.4 5870.3 5870.8 5874.4 5402.3 5411.2 5461.8 5799.2 5815.7 5043.1 5158.5 5162.6 5165.5 5168.1 18873.7 19386.5 19617.9 19664.3 19710.7 1868.0 1877.5 1886.6 1910.9 1969.5 12404.0 12439.4 12738.4 12783.5 12811.6 1685.0 1699.9 1711.6 1763.8 1770.1 53387.5 53655.7 54719.2 54964.0 55660.0 9189.8 9347.9 9534.8 9549.4 9616.9 11996.9 12068.0 12069.8 12085.2 12117.7 7062.4 7067.5 7080.0 7084.9 7087.3 6791.0 6832.0 6838.8 6891.8 6894.4 5684.1 5695.6 5697.5 5712.5 5798.4 1540.3 1627.8 1666.7 1682.8 1710.9 370.3 371.6 392.3 974.7 1010.7 9256.5 9299.8 9516.2 9541.1 9707.7 364.3 399.2 401.3 402.2 407.1 5195.5 5313.6 5351.7 5415.5 5426.3 454585.0 464406.0 476387.0 480143.0 483903.0 65061.7 68000.7 68314.3 69772.3 70334.6 495.4 504.0 504.3 508.0 510.4 9985.5 10044.0 10058.0 10144.1 10228.4 32146.0 32440.8 32478.4 32851.0 33612.8 38997.0 40068.0 41591.8 41791.6 41792.0 5906.4 5964.7 6123.9 6135.2 6137.0 10966.3 11007.3 11021.1 11026.1 11184.3 8323.5 9347.3 9553.3 9578.9 9594.0 8996.6 9210.3 9224.9 9268.7 9498.6 9175.8 9487.1 9595.0 9645.5 9697.6 6220.0 6221.8 6272.6 6293.3 6427.4 10224.4 10332.5 10509.7 10607.8 10619.4 18:53:07 INFO - 2015-11-11 18:53:07,775 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,776 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4910.78 Median:6219.97 stddev:2517.65 (40.5%) stddev-sans-first:2509.43 18:53:07 INFO - 2015-11-11 18:53:07,776 DEBUG : BROWSER_OUTPUT: Values: 1220.4 1624.3 1672.4 1679.5 1713.1 6142.7 6716.9 6834.2 6843.2 6859.8 6851.1 6997.1 7022.6 7050.8 7057.5 1731.3 1760.0 2023.4 2045.4 2071.5 2055.0 2065.8 2067.4 2068.8 2074.5 1970.9 2003.8 2047.1 2048.9 2050.8 1976.8 1987.3 1996.3 2005.0 2062.3 2035.6 2060.6 2063.9 2065.4 2067.1 7064.0 7100.3 7130.4 7131.5 7134.0 4225.9 4288.0 4309.4 4330.4 4334.4 2325.3 2595.5 2706.9 2732.5 2754.2 788.0 826.3 856.6 862.1 872.9 9393.7 9413.8 9431.2 9460.8 9475.6 3964.6 3989.6 4057.4 4058.0 4069.2 8051.1 8091.9 8092.5 8105.9 8106.3 4337.5 4358.7 4359.3 4362.2 4367.3 3912.9 3958.0 3961.8 3962.7 3966.5 3439.1 3450.5 3450.6 3480.6 3483.5 1050.2 1062.6 1064.3 1064.9 1070.3 1189.6 1191.5 1193.6 1197.6 1212.3 6727.3 6772.7 6778.0 6807.0 6836.5 388.5 389.4 389.9 390.1 390.9 5188.0 5239.0 5250.2 5251.9 5257.0 7827.0 8021.9 8325.2 8401.9 8492.3 7172.8 7244.5 7250.0 7303.1 7320.4 6605.7 6634.6 6771.9 6785.5 6796.0 6493.2 6555.3 6568.1 6571.6 6604.7 6672.9 7260.3 7326.9 7415.0 7450.9 7323.3 7461.8 7476.2 7848.8 7862.1 6501.9 6544.7 6551.4 6600.8 6603.4 6890.8 6891.0 6903.2 6904.2 6918.6 6421.6 6463.4 6543.0 6551.7 6642.5 6240.9 6254.9 6333.3 6358.0 6473.3 6425.3 6572.5 6586.9 6607.7 6628.2 6037.7 6066.4 6071.6 6088.3 6105.8 5696.8 6050.9 6159.0 6183.2 6199.0 18:53:07 INFO - 2015-11-11 18:53:07,776 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,776 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4509.65 Median:5212.95 stddev:1330.98 (25.5%) stddev-sans-first:1296.64 18:53:07 INFO - 2015-11-11 18:53:07,777 DEBUG : BROWSER_OUTPUT: Values: 298.7 309.2 309.4 311.2 312.1 5213.0 5214.5 5302.8 5303.9 5317.4 5135.8 5197.8 5204.1 5210.6 5219.5 3882.5 3933.4 4044.5 4044.7 4049.9 3941.6 3965.2 3973.0 3974.2 3978.2 3893.6 3928.5 3942.6 3942.7 3951.0 3834.4 3895.2 3898.7 3935.1 3957.4 3426.5 3434.1 3440.0 3440.0 3446.0 4940.2 4941.8 4958.3 4960.6 4961.4 4493.8 4497.6 4501.1 4504.4 4506.7 5353.3 5456.4 5476.8 5480.1 5495.9 3771.4 3777.6 3778.1 3778.3 3778.6 5662.4 5715.3 5755.7 5761.3 5762.1 3941.1 3943.2 3945.2 3945.9 3946.3 3777.9 3792.7 3990.1 3994.1 3998.5 4116.5 4381.3 4428.7 4464.8 4529.8 5353.3 5414.1 5418.6 5431.0 5435.2 1412.8 1426.4 1427.5 1427.5 1427.6 956.5 962.2 962.2 981.1 983.3 4744.7 4760.3 4768.4 4776.9 4780.9 5658.5 5664.0 5666.0 5670.4 5675.0 4788.4 4809.2 4809.3 4809.5 4812.6 2949.6 3058.0 3089.4 3124.4 3130.1 4582.7 5277.0 5327.1 5328.1 5334.8 5734.0 5814.1 5817.7 5818.2 5823.6 5300.1 5306.3 5316.8 5317.9 5320.5 5636.0 5642.3 5643.8 5686.6 5721.8 5376.2 5583.0 5593.1 5601.6 5613.2 5212.9 5233.2 5235.4 5238.4 5322.0 3886.6 3886.8 3889.1 3889.5 3897.5 5644.4 5647.3 5647.5 5647.7 5655.8 5314.9 5438.3 5443.7 5449.1 5456.5 5509.3 5512.3 5524.1 5524.1 5527.9 5411.0 5413.7 5419.1 5424.2 5425.6 5420.7 5542.6 5548.1 5553.4 5555.3 5393.7 5407.6 5407.8 5409.4 5411.4 18:53:07 INFO - 2015-11-11 18:53:07,777 DEBUG : BROWSER_OUTPUT: 18:53:07 INFO - 2015-11-11 18:53:07,777 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11924.26 Median:5346.20 stddev:14765.04 (276.2%) stddev-sans-first:14782.12 18:53:07 INFO - 2015-11-11 18:53:07,778 DEBUG : BROWSER_OUTPUT: Values: 634.4 653.5 675.1 688.7 726.6 11495.5 11778.7 11838.8 11845.1 11853.3 12619.4 12803.3 12808.2 12820.0 12830.6 609.8 782.7 796.0 796.2 796.4 609.2 778.9 793.1 793.2 793.8 823.9 834.9 835.0 835.7 836.6 627.7 632.7 804.3 821.0 825.2 595.5 596.4 598.6 598.9 599.5 10899.3 11058.6 11126.0 11155.9 11201.0 8636.8 8793.5 8872.4 9040.1 9773.8 8054.6 8257.5 8436.7 8588.1 8626.1 2645.5 2667.6 2679.3 2680.0 2752.9 38854.4 39094.2 39198.4 39494.8 39621.4 6208.6 6345.4 6355.2 6450.6 6585.3 10736.7 10743.1 10743.8 10776.2 10800.6 5248.2 5318.9 5336.1 5356.3 5417.8 3391.7 3447.0 3452.9 3468.5 3532.7 2267.5 2295.4 2298.2 2304.0 2310.9 403.9 404.7 405.3 407.8 409.3 398.4 399.5 410.2 421.5 422.7 6935.8 7374.1 7420.3 7492.0 7542.4 425.7 437.9 444.1 464.7 473.7 3447.1 3465.2 3499.4 3522.5 3562.6 53560.0 53560.5 53789.7 54408.0 54959.7 47770.0 48583.5 48731.5 48879.3 49064.3 42598.6 43014.1 44271.8 44348.6 45202.8 7200.9 7341.9 7415.9 7839.4 7966.8 30571.8 30633.4 30774.7 31071.8 31586.4 38705.4 39461.0 42866.6 43050.4 43175.8 6930.1 7053.2 7116.4 7189.1 7230.9 10106.8 10446.3 10539.0 10593.4 10661.1 9280.8 9338.0 9870.7 10047.1 10067.7 9766.5 9906.8 9946.5 9946.9 10036.8 9607.1 9654.4 9750.6 9832.7 9870.3 8031.2 8198.1 8263.5 8267.7 8282.8 7695.2 7741.6 7891.4 8136.9 8187.6 18:53:07 INFO - 2015-11-11 18:53:07,778 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:53:07 INFO - 2015-11-11 18:53:07,778 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-11 18:53:08,435 INFO : Browser exited with error code: 0 18:53:08 INFO - 2015-11-11 18:53:08,461 INFO : Completed test dromaeo_css (00:18:36) 18:53:08 INFO - 2015-11-11 18:53:08,461 INFO : Starting test kraken 18:53:08 INFO - 2015-11-11 18:53:08,461 DEBUG : operating with platform_type : linux_ 18:53:08 INFO - 2015-11-11 18:53:08,461 INFO : Initialising browser for kraken test... 18:53:08 INFO - 2015-11-11 18:53:08,468 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgFkQnj/profile http://localhost:52956/getInfo.html 18:53:12 INFO - 2015-11-11 18:53:12,083 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:53:12 INFO - 2015-11-11 18:53:12,083 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:53:12 INFO - 2015-11-11 18:53:12,083 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:53:12 INFO - 2015-11-11 18:53:12,083 DEBUG : BROWSER_OUTPUT: __metrics 18:53:12 INFO - 2015-11-11 18:53:12,164 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:53:13 INFO - 2015-11-11 18:53:13,388 INFO : Browser initialized. 18:53:13 INFO - 2015-11-11 18:53:13,389 INFO : Running cycle 1/1 for kraken test... 18:53:13 INFO - 2015-11-11 18:53:13,389 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgFkQnj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:53:25 INFO - 2015-11-11 18:53:25,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 139292672 18:53:25 INFO - 2015-11-11 18:53:25,282 DEBUG : BROWSER_OUTPUT: 18:53:27 INFO - 2015-11-11 18:53:27,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52956/tests/kraken/driver.html?testName=audio-beat-detection) 18:53:28 INFO - 2015-11-11 18:53:28,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 176386048 18:53:28 INFO - 2015-11-11 18:53:28,472 DEBUG : BROWSER_OUTPUT: 18:53:31 INFO - 2015-11-11 18:53:31,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52956/tests/kraken/driver.html?testName=audio-dft) 18:53:31 INFO - 2015-11-11 18:53:31,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 167391232 18:53:31 INFO - 2015-11-11 18:53:31,737 DEBUG : BROWSER_OUTPUT: 18:53:34 INFO - 2015-11-11 18:53:34,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52956/tests/kraken/driver.html?testName=audio-fft) 18:53:35 INFO - 2015-11-11 18:53:35,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 149606400 18:53:35 INFO - 2015-11-11 18:53:35,340 DEBUG : BROWSER_OUTPUT: 18:53:37 INFO - 2015-11-11 18:53:37,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52956/tests/kraken/driver.html?testName=audio-oscillator) 18:53:37 INFO - 2015-11-11 18:53:37,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 152608768 18:53:37 INFO - 2015-11-11 18:53:37,977 DEBUG : BROWSER_OUTPUT: 18:53:40 INFO - 2015-11-11 18:53:40,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52956/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:53:40 INFO - 2015-11-11 18:53:40,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 155697152 18:53:40 INFO - 2015-11-11 18:53:40,782 DEBUG : BROWSER_OUTPUT: 18:53:43 INFO - 2015-11-11 18:53:43,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52956/tests/kraken/driver.html?testName=imaging-darkroom) 18:53:44 INFO - 2015-11-11 18:53:44,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 156467200 18:53:44 INFO - 2015-11-11 18:53:44,327 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-11 18:53:47,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52956/tests/kraken/driver.html?testName=imaging-desaturate) 18:53:48 INFO - 2015-11-11 18:53:48,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 157335552 18:53:48 INFO - 2015-11-11 18:53:48,314 DEBUG : BROWSER_OUTPUT: 18:53:51 INFO - 2015-11-11 18:53:51,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52956/tests/kraken/driver.html?testName=json-parse-financial) 18:53:51 INFO - 2015-11-11 18:53:51,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 155529216 18:53:51 INFO - 2015-11-11 18:53:51,764 DEBUG : BROWSER_OUTPUT: 18:53:53 INFO - 2015-11-11 18:53:53,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52956/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:53:54 INFO - 2015-11-11 18:53:54,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 164843520 18:53:54 INFO - 2015-11-11 18:53:54,100 DEBUG : BROWSER_OUTPUT: 18:53:55 INFO - 2015-11-11 18:53:55,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52956/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:53:56 INFO - 2015-11-11 18:53:56,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 164945920 18:53:56 INFO - 2015-11-11 18:53:56,563 DEBUG : BROWSER_OUTPUT: 18:53:58 INFO - 2015-11-11 18:53:58,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52956/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:53:59 INFO - 2015-11-11 18:53:59,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 175595520 18:53:59 INFO - 2015-11-11 18:53:59,260 DEBUG : BROWSER_OUTPUT: 18:54:01 INFO - 2015-11-11 18:54:01,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:54:02 INFO - 2015-11-11 18:54:02,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 180961280 18:54:02 INFO - 2015-11-11 18:54:02,379 DEBUG : BROWSER_OUTPUT: 18:54:04 INFO - 2015-11-11 18:54:04,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:54:05 INFO - 2015-11-11 18:54:05,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 178294784 18:54:05 INFO - 2015-11-11 18:54:05,566 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52956/tests/kraken/driver.html?testName=ai-astar) 18:54:07 INFO - 2015-11-11 18:54:07,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 237088768 18:54:07 INFO - 2015-11-11 18:54:07,570 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,571 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:54:07 INFO - 2015-11-11 18:54:07,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:54:07 INFO - 2015-11-11 18:54:07,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:54:07 INFO - 2015-11-11 18:54:07,572 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:54:07 INFO - 2015-11-11 18:54:07,572 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;105;112;112;113;102;111;105;113 18:54:07 INFO - 2015-11-11 18:54:07,572 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;135;155;165;129;152;155;128;166;129 18:54:07 INFO - 2015-11-11 18:54:07,572 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;174;160;163;161;162;161;163;163;163 18:54:07 INFO - 2015-11-11 18:54:07,572 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;81;93;72;71;73;87;94;73 18:54:07 INFO - 2015-11-11 18:54:07,573 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;129;91;92;98;126;91;92;127 18:54:07 INFO - 2015-11-11 18:54:07,573 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;109;110;110;110;109 18:54:07 INFO - 2015-11-11 18:54:07,573 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;146;145;146;147;146;147;146;147 18:54:07 INFO - 2015-11-11 18:54:07,573 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;95 18:54:07 INFO - 2015-11-11 18:54:07,573 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;73;71;72;72;71;80;69;70 18:54:07 INFO - 2015-11-11 18:54:07,573 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;67;67;66;77;66;67;67;67 18:54:07 INFO - 2015-11-11 18:54:07,573 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;91;84;83;83;82;87;83;83;83 18:54:07 INFO - 2015-11-11 18:54:07,573 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;118;115;116;130;120;128;128;124;120 18:54:07 INFO - 2015-11-11 18:54:07,574 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;144;144;144;145;145;144;144;144;133 18:54:07 INFO - 2015-11-11 18:54:07,574 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;68;72;71;67;70;67;68 18:54:07 INFO - 2015-11-11 18:54:07,574 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:54:07 INFO - 2015-11-11 18:54:07,574 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:54:07 INFO - 2015-11-11 18:54:07,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 18:54:07 INFO - 2015-11-11 18:54:07,574 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:54:07 INFO - 2015-11-11 18:54:07,574 DEBUG : BROWSER_OUTPUT: __startTimestamp1447296847570__endTimestamp 18:54:07 INFO - 2015-11-11 18:54:07,575 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,582 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:54:07 INFO - 2015-11-11 18:54:07,582 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:54:07 INFO - 2015-11-11 18:54:07,582 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,582 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:4.23 (3.8%) stddev-sans-first:4.42 18:54:07 INFO - 2015-11-11 18:54:07,582 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 105.0 112.0 112.0 113.0 102.0 111.0 105.0 113.0 18:54:07 INFO - 2015-11-11 18:54:07,582 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.60 Median:153.50 stddev:14.96 (9.7%) stddev-sans-first:15.74 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: Values: 152.0 135.0 155.0 165.0 129.0 152.0 155.0 128.0 166.0 129.0 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:3.92 (2.4%) stddev-sans-first:4.15 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: Values: 163.0 174.0 160.0 163.0 161.0 162.0 161.0 163.0 163.0 163.0 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.70 Median:77.00 stddev:9.35 (12.1%) stddev-sans-first:9.49 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 81.0 93.0 72.0 71.0 73.0 87.0 94.0 73.0 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.10 Median:92.00 stddev:16.86 (18.3%) stddev-sans-first:17.39 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 129.0 91.0 92.0 98.0 126.0 91.0 92.0 127.0 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,583 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 145.0 146.0 147.0 146.0 147.0 146.0 147.0 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.00 stddev:3.00 (4.2%) stddev-sans-first:3.15 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 73.0 71.0 72.0 72.0 71.0 80.0 69.0 70.0 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:3.30 (4.9%) stddev-sans-first:3.49 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 67.0 67.0 66.0 77.0 66.0 67.0 67.0 67.0 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.00 stddev:2.81 (3.4%) stddev-sans-first:2.87 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: Values: 82.0 91.0 84.0 83.0 83.0 82.0 87.0 83.0 83.0 83.0 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:126.00 stddev:5.58 (4.4%) stddev-sans-first:5.58 18:54:07 INFO - 2015-11-11 18:54:07,584 DEBUG : BROWSER_OUTPUT: Values: 128.0 118.0 115.0 116.0 130.0 120.0 128.0 128.0 124.0 120.0 18:54:07 INFO - 2015-11-11 18:54:07,585 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,585 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:144.00 stddev:3.78 (2.6%) stddev-sans-first:3.77 18:54:07 INFO - 2015-11-11 18:54:07,585 DEBUG : BROWSER_OUTPUT: Values: 147.0 144.0 144.0 144.0 145.0 145.0 144.0 144.0 144.0 133.0 18:54:07 INFO - 2015-11-11 18:54:07,585 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-11 18:54:07,585 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.66 (2.4%) stddev-sans-first:1.73 18:54:07 INFO - 2015-11-11 18:54:07,585 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 68.0 72.0 71.0 67.0 70.0 67.0 68.0 18:54:07 INFO - 2015-11-11 18:54:07,585 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:54:07 INFO - 2015-11-11 18:54:07,585 DEBUG : BROWSER_OUTPUT: 18:54:08 INFO - 2015-11-11 18:54:08,495 INFO : Browser exited with error code: 0 18:54:08 INFO - 2015-11-11 18:54:08,543 INFO : Completed test kraken (00:01:00) 18:54:08 INFO - 2015-11-11 18:54:08,543 INFO : Starting test v8_7 18:54:08 INFO - 2015-11-11 18:54:08,543 DEBUG : operating with platform_type : linux_ 18:54:08 INFO - 2015-11-11 18:54:08,543 INFO : Initialising browser for v8_7 test... 18:54:08 INFO - 2015-11-11 18:54:08,549 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnOAtuB/profile http://localhost:52956/getInfo.html 18:54:12 INFO - 2015-11-11 18:54:12,184 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:54:12 INFO - 2015-11-11 18:54:12,184 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:54:12 INFO - 2015-11-11 18:54:12,184 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:54:12 INFO - 2015-11-11 18:54:12,184 DEBUG : BROWSER_OUTPUT: __metrics 18:54:12 INFO - 2015-11-11 18:54:12,265 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:54:13 INFO - 2015-11-11 18:54:13,419 INFO : Browser initialized. 18:54:13 INFO - 2015-11-11 18:54:13,420 INFO : Running cycle 1/1 for v8_7 test... 18:54:13 INFO - 2015-11-11 18:54:13,420 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnOAtuB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:54:25 INFO - 2015-11-11 18:54:25,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 139878400 18:54:25 INFO - 2015-11-11 18:54:25,301 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52956/tests/v8_7/run.html (next: http://localhost:52956/tests/v8_7/run.html) 18:54:46 INFO - 2015-11-11 18:54:46,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 442986496 18:54:46 INFO - 2015-11-11 18:54:46,971 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,971 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:54:46 INFO - 2015-11-11 18:54:46,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:54:46 INFO - 2015-11-11 18:54:46,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |0;Richards;170.2127659574468 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.8649270913277 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |5;Earley;812.3476848090983 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |6;Boyer;11823.529411764706 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |7;RegExp;26947.36842105263 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |8;Splay;617.283950617284 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: __startTimestamp1447296886970__endTimestamp 18:54:46 INFO - 2015-11-11 18:54:46,972 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.21 Median:170.21 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: Values: 170.2 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.86 Median:191.86 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: Values: 191.9 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: Values: 279.4 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,974 DEBUG : BROWSER_OUTPUT: Values: 5030.2 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: Values: 1986.1 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:812.35 Median:812.35 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: Values: 812.3 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11823.53 Median:11823.53 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: Values: 11823.5 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26947.37 Median:26947.37 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: Values: 26947.4 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.28 Median:617.28 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: Values: 617.3 18:54:46 INFO - 2015-11-11 18:54:46,975 DEBUG : BROWSER_OUTPUT: 18:54:46 INFO - 2015-11-11 18:54:46,976 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 18:54:46 INFO - 2015-11-11 18:54:46,976 DEBUG : BROWSER_OUTPUT: Values: 4817.3 18:54:46 INFO - 2015-11-11 18:54:46,976 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:54:46 INFO - 2015-11-11 18:54:46,976 DEBUG : BROWSER_OUTPUT: 18:54:47 INFO - 2015-11-11 18:54:47,871 INFO : Browser exited with error code: 0 18:54:47 INFO - 2015-11-11 18:54:47,888 INFO : Completed test v8_7 (00:00:39) 18:54:47 INFO - 2015-11-11 18:54:47,978 INFO : Completed test suite (00:20:16) 18:54:47 INFO - 2015-11-11 18:54:47,978 DEBUG : Working with test: dromaeo_css 18:54:47 INFO - 2015-11-11 18:54:47,978 DEBUG : Generating results file: dromaeo_css 18:54:47 INFO - 2015-11-11 18:54:47,979 DEBUG : Working with test: kraken 18:54:47 INFO - 2015-11-11 18:54:47,979 DEBUG : Generating results file: kraken 18:54:47 INFO - 2015-11-11 18:54:47,980 INFO : javascript benchmark 18:54:47 INFO - 2015-11-11 18:54:47,980 DEBUG : Working with test: v8_7 18:54:47 INFO - 2015-11-11 18:54:47,980 DEBUG : Generating results file: v8_7 18:54:47 INFO - 2015-11-11 18:54:47,980 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:54:48 INFO - 2015-11-11 18:54:48,034 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 18:54:48 INFO - 2015-11-11 18:54:48,035 DEBUG : process_Request line: dromaeo_css 6012.65 graph.html#tests=[[72,203,35]] 18:54:48 INFO - 2015-11-11 18:54:48,035 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:54:48 INFO - 2015-11-11 18:54:48,063 DEBUG : process_Request line: kraken 1511.80 graph.html#tests=[[232,203,35]] 18:54:48 INFO - 2015-11-11 18:54:48,063 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:54:48 INFO - 2015-11-11 18:54:48,094 DEBUG : process_Request line: v8_7 19714.40 graph.html#tests=[[230,203,35]] 18:54:48 INFO - 2015-11-11 18:54:48,095 INFO : javascript benchmark 18:54:48 INFO - 2015-11-11 18:54:48,099 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [334.790755777639, 337.4729349692641, 337.5325174633134, 337.6201773005369, 339.9949000764989, 12459.68850778731, 12823.166494177894, 15594.298256578453, 16202.513924582267, 16990.06554639496, 12796.232226066442, 15324.846751532481, 16065.277062532185, 16096.517104486855, 16165.43420980266, 5057.443681195065, 5204.193350030751, 5208.505192006773, 5212.21816727492, 5212.869678258036, 3623.8188090595495, 3752.9061773455746, 5148.897022059557, 5202.323697919265, 5205.193195054753, 5657.490825825675, 5823.417658234164, 5870.295564532241, 5870.76516939324, 5874.412558744134, 5402.270693456372, 5411.21537377082, 5461.781528738846, 5799.159121927318, 5815.651060936336, 5043.117454445494, 5158.509941555584, 5162.586993040548, 5165.509276618753, 5168.147255702805, 18873.716894246598, 19386.515337116543, 19617.9019104905, 19664.311749088713, 19710.70433943492, 1868.019289872814, 1877.511846919797, 1886.6038131992298, 1910.8949007804565, 1969.4977780665981, 12404.0, 12439.37803109841, 12738.426770795337, 12783.488660453571, 12811.551595694105, 1684.9915750421292, 1699.8725095617879, 1711.5617133456278, 1763.8236176382388, 1770.0707128757376, 53387.46612533864, 53655.73172134154, 54719.17921231185, 54964.0, 55660.0, 9189.81620367589, 9347.90652093484, 9534.809303813885, 9549.379290346105, 9616.90383096174, 11996.880031199576, 12067.974222191036, 12069.818952715716, 12085.15403921717, 12117.697057573454, 7062.435005199572, 7067.505274630829, 7080.0, 7084.92915070853, 7087.3267039631155, 6791.0, 6831.9658401707675, 6838.794836154923, 6891.793246202622, 6894.413974812097, 5684.090545512699, 5695.60130790849, 5697.487226149667, 5712.542996560265, 5798.449147330997, 1540.2914659256867, 1627.78838750964, 1666.7083260429376, 1682.7896512935883, 1710.9144542772813, 370.2908929400222, 371.59867343269207, 392.2527584950673, 974.7270764186039, 1010.722051435861, 9256.472682007394, 9299.814003719888, 9516.23870090391, 9541.141297283279, 9707.66023189199, 364.2951088170325, 399.21354930786305, 401.3498133024519, 402.1895879802201, 407.14093263214596, 5195.532402083831, 5313.601479888946, 5351.732413379315, 5415.4855288748295, 5426.294581704353, 454585.0, 464406.0, 476387.0, 480143.0, 483903.0, 65061.67469162624, 68000.65999670069, 68314.31685683079, 69772.30227697658, 70334.64832675907, 495.35603715170134, 503.95464408203435, 504.33679711179684, 507.95361555196416, 510.39773067779635, 9985.450800205768, 10044.0, 10058.04448577384, 10144.137748291478, 10228.386296822215, 32146.0, 32440.83779581087, 32478.350432990734, 32851.0, 33612.831935840164, 38997.0, 40068.0, 41591.792041039604, 41791.58208417877, 41792.0, 5906.438888305604, 5964.671943043, 6123.908141377794, 6135.202423684892, 6137.048757442603, 10966.287191332538, 11007.339559626447, 11021.063209627271, 11026.062784663394, 11184.328940263611, 8323.542205178532, 9347.298952578447, 9553.331266811256, 9578.856317155109, 9594.0, 8996.55017249148, 9210.263178945803, 9224.861627075734, 9268.72193834186, 9498.572564234764, 9175.816483670424, 9487.146156845916, 9594.952025239829, 9645.469499177332, 9697.563609637724, 6220.0, 6221.782237621662, 6272.560920735505, 6293.307736149111, 6427.357264273535, 10224.437655928996, 10332.535035923553, 10509.737256568647, 10607.787844242917, 10619.36283822973], "dojo.html": [2666.400059986503, 2741.410596721704, 2745.0392362673056, 2749.3951330707237, 2770.376665250319, 4550.544945505448, 4695.272232803913, 4784.8803779905475, 4799.856004319871, 4822.6624136310475, 4724.196886529289, 4769.90460190796, 4811.975940120304, 4879.682820616657, 4890.68210566313, 4416.492103408101, 4417.801198946039, 4450.354698568705, 4454.376387305763, 4485.327200919855, 4469.620082293009, 4515.983903621675, 4523.819047238107, 4526.592606665399, 4559.566841150086, 4277.12318974611, 4298.591633794785, 4358.65130789536, 4388.868333949987, 4407.118576284756, 4401.757903315316, 4437.0460351024685, 4440.333949907507, 4441.64466842655, 4478.596926276618, 4201.054762678404, 4419.53594872537, 4435.024294655171, 4449.822007119744, 4474.351219073249, 4598.448186217642, 4645.070985802819, 4691.695039822401, 4696.154692155411, 4727.716337019755, 5154.252633368141, 5182.507661772163, 5189.455107213764, 5190.766415511311, 5237.109691352479, 4895.804167833282, 4997.225430058346, 5190.844274671728, 5208.5572726318305, 5212.58299336056, 4657.324687920266, 4696.7416792076765, 4709.0, 4738.952610473885, 4758.738269395148, 5195.896082078338, 5311.3891902431715, 5312.335958005249, 5315.946840531623, 5316.0696878046965, 4833.32333473314, 4954.810845397079, 5108.2848401223855, 5110.616703747234, 5125.513076257749, 5066.240063990431, 5095.031943930641, 5152.252923326097, 5155.690658560498, 5172.482751724798, 5046.545810877039, 5049.2173713074535, 5053.9241911371355, 5092.516210959953, 5097.413797413271, 4858.44127925286, 4976.800927962913, 5014.122528557488, 5015.272785446163, 5016.372953380827, 4138.048248902709, 4193.993441574061, 4216.746995180238, 4227.534971153171, 4229.217594744982, 3747.1006958329804, 3756.380197267475, 3758.248350329945, 3765.2093060457064, 3782.5650050244026, 4202.726822756572, 4384.539623339503, 4384.6273066789045, 4388.253996820548, 4424.845130420485, 4979.701217926863, 5036.84889453317, 5066.544011039025, 5088.414832294334, 5101.20931255656, 4286.142771445723, 4295.312749959991, 4298.312270036841, 4317.589828966243, 4329.783510824446, 4343.131373725268, 4455.198064348384, 4455.799489023002, 4461.152381047591, 4512.661550383735, 4703.176944034849, 4724.267738500538, 4739.691920025256, 4802.7838747255755, 4824.396950381202, 5063.0, 5127.4872512748425, 5128.230765385073, 5135.178371460698, 5178.559822415137, 4684.601808846286, 4816.662833601615, 4819.783109760139, 4822.493638168082, 4861.4895435978715, 5005.449400566008, 5018.749062546931, 5028.195488721787, 5029.29589857413, 5029.723365214948, 4992.0, 5080.415752188398, 5086.491350864884, 5103.515166059218, 5121.513456221653, 4973.975130124326, 5005.599552035756, 5008.248762685626, 5012.8496145115705, 5058.038972595195, 4806.351142595705, 5009.649324547247, 5020.447750747342, 5023.171176755941, 5028.170351891897, 4812.037592481588, 4826.107170173529, 4834.395700537433, 4884.0, 4928.236123400879, 4946.307516947558, 4961.6030717543235, 4962.057209130254, 4965.379327584052, 5003.849884503471, 4632.166210082218, 4824.517548245288, 4824.614030877591, 4832.975835120802, 4869.293952376956], "mootools.html": [1220.4385982448073, 1624.2609612626256, 1672.4313733330669, 1679.4877562343481, 1713.1348668922192, 6142.723577439015, 6716.865662686743, 6834.214065382483, 6843.213030501493, 6859.759908403201, 6851.143607049119, 6997.1253593300835, 7022.613756243404, 7050.823729406768, 7057.505974581782, 1731.2642127095996, 1760.0231871311416, 2023.4132101690566, 2045.4477291131386, 2071.4924843413387, 2054.9897250513727, 2065.834733221339, 2067.3591186732087, 2068.7724350321528, 2074.4917495213695, 1970.8620396572246, 2003.7695664998566, 2047.109507364294, 2048.9180432782673, 2050.8256798172174, 1976.762788465379, 1987.3044434447972, 1996.341207401554, 2005.0175414047085, 2062.278202629068, 2035.6437623415843, 2060.5981833542464, 2063.9174433022663, 2065.4113577630455, 2067.131804642054, 7063.964680176618, 7100.325469080429, 7130.358267755875, 7131.500794944356, 7134.0, 4225.852095176654, 4288.013756835945, 4309.41822853917, 4330.372096046056, 4334.436523251957, 2325.3489023073566, 2595.5198288316724, 2706.905258315969, 2732.467168902045, 2754.1599812057316, 787.9763607091796, 826.3224156191925, 856.6402111113347, 862.0689655172399, 872.8690696395528, 9393.718188454357, 9413.811723765486, 9431.198348140417, 9460.763480912963, 9475.620975160986, 3964.583718709494, 3989.5611482736876, 4057.350823868167, 4058.046359105667, 4069.1658210066867, 8051.074126475413, 8091.919080809116, 8092.473989190684, 8105.918940810634, 8106.310963568045, 4337.50118736343, 4358.65130789536, 4359.258925982591, 4362.192994296065, 4367.323064924942, 3912.8630497932436, 3958.0, 3961.801909904493, 3962.7226094173707, 3966.5240171179066, 3439.0542600784984, 3450.46517789743, 3450.5686789151355, 3480.617132115465, 3483.547138871981, 1050.2333296693305, 1062.6015244283394, 1064.3135177810268, 1064.9254552181274, 1070.3363914373138, 1189.5717541684987, 1191.463841271414, 1193.5643490126215, 1197.5748609243767, 1212.3029258176584, 6727.29363416844, 6772.69522871472, 6778.0, 6806.965965170142, 6836.5214434989075, 388.45034276499, 389.37505303987257, 389.9259140763303, 390.0813584009673, 390.8573370719667, 5188.040212560688, 5238.97380513095, 5250.159974404077, 5251.868703282372, 5256.9737151314, 7826.960865195638, 8021.91704119948, 8325.167483251626, 8401.915980840113, 8492.320614350838, 7172.784816455411, 7244.492885497964, 7250.006248281659, 7303.087114110736, 7320.414366850639, 6605.735770569219, 6634.635095069818, 6771.864562708718, 6785.457163426914, 6795.966020169867, 6493.155889734304, 6555.344465553407, 6568.113304703804, 6571.57284776488, 6604.669766511752, 6672.933270667425, 7260.346568808833, 7326.853462930818, 7415.03604531429, 7450.925490745023, 7323.2676732326345, 7461.776146715607, 7476.177620461854, 7848.7645370638975, 7862.095858976291, 6501.934980650133, 6544.705488253136, 6551.377619126175, 6600.8349791255605, 6603.372679595431, 6890.841299432771, 6890.965545172443, 6903.1716194057035, 6904.240533541206, 6918.5502942308585, 6421.614703117828, 6463.353664633499, 6543.0, 6551.672416379257, 6642.4686025118845, 6240.937590624036, 6254.906176407267, 6333.334999825136, 6358.046293056079, 6473.287938326686, 6425.261094973951, 6572.474202063728, 6586.934130658824, 6607.702653380513, 6628.171478565179, 6037.728302226323, 6066.423689749467, 6071.605345652519, 6088.299845517822, 6105.755769769159, 5696.800611978727, 6050.90923636137, 6159.0, 6183.165272688129, 6199.0], "ext.html": [554.4132059880468, 574.0585439878603, 583.0729140666341, 589.9852254122907, 595.3926994465643, 28258.152255432346, 28721.0, 29025.27436814078, 36568.81715591425, 37155.25689486209, 40179.59820401795, 40740.18519629606, 40782.7960860196, 40813.38779918304, 40988.0, 7729.381649468043, 7880.881786773203, 7881.763547093597, 7887.605619718991, 7889.132195458495, 7203.351698347148, 7394.630268486581, 10058.49707514625, 10321.277510574262, 10339.534720937538, 10338.431386273753, 10342.32774869631, 10433.217508686841, 10459.477026148701, 10460.947695261513, 7189.712411503534, 7418.629068546551, 10077.44574048427, 10178.0, 10182.13451856593, 10313.690589282258, 10627.36235825853, 10642.946785266024, 10643.78712425755, 10652.946735266352, 36456.270874582624, 36921.81539092314, 37496.25007499862, 37497.0, 37784.811075944446, 2795.664520257562, 3318.1372843060976, 3327.633960264369, 3672.816359182057, 3707.0917625181733, 27982.460964646936, 28562.857185714147, 28634.14097577076, 28651.0, 28772.4097991543, 2657.388800575859, 2687.3013016615623, 2698.136596289188, 2707.44497378037, 2741.753242208211, 231797.0, 232017.9999999983, 232458.0, 232748.0, 233836.0, 44821.10357792826, 45660.315095273596, 54241.0, 54265.72867135718, 54660.453395465534, 48464.7576762114, 48479.515204848205, 48642.75678621655, 48695.0, 48869.266960995614, 13490.865091349157, 13632.727345453035, 13667.384967676478, 13672.863271367358, 13677.658058548615, 10503.159747220205, 10569.524371403306, 10574.682759517227, 10577.894221057692, 10580.470976451146, 17764.20061097228, 18109.63780724378, 18189.54526136857, 18200.45398638043, 18246.635067298845, 7562.848743025109, 7827.726029588937, 7882.290593846581, 7899.436394116255, 7901.525908445512, 848.702953966107, 882.9514376709215, 918.5407296351824, 978.5645387802502, 1007.3150257824603, 25463.0, 26078.739212608012, 26320.0, 26472.60291095635, 26665.86667066652, 994.1599348550463, 994.4381424495137, 997.8553109799038, 1008.6973907827622, 1039.101177481473, 12508.937455312665, 12781.936090319676, 12804.61586152417, 12841.422136003715, 12883.35583220854, 260148.0, 264803.0, 265000.0, 265104.0, 267679.0, 44635.0, 45154.0, 45188.77405612951, 45189.0, 45249.54750452453, 1193.9283642981275, 1205.4033253539553, 1219.2501611508858, 1233.1244816180433, 1247.7941139712027, 24074.25920742195, 25063.35821007398, 25401.364965876, 25532.61701074448, 25574.872125639253, 39069.0, 39206.411903820896, 39214.411783822696, 39247.0, 39384.0, 243485.0, 244598.0, 245081.0, 245259.0, 245378.0, 23642.0, 24030.158944436862, 27627.72372276332, 27778.86110569434, 28316.15051548457, 33029.66970330266, 33062.66937330596, 33069.83465082659, 33442.665573343955, 33709.0, 30893.38213235678, 31044.68955310418, 31128.377432450772, 31739.365212695157, 31993.520097198096, 27351.58972615452, 31031.0, 31227.84386078055, 31483.527747083353, 31695.0, 29294.41411171722, 32102.35795284128, 32490.51264230991, 32613.510797337585, 32724.181895452803, 25479.36301592475, 27046.0, 27193.72806271991, 28886.42227155403, 29338.266543336587, 22691.319260422213, 22698.0, 22742.886285568467, 23106.884465577565, 23116.19093331725], "prototype.html": [298.6625113621608, 309.1899224033033, 309.35036423510616, 311.16141997317237, 312.1447234577259, 5212.973935130324, 5214.530692237698, 5302.840914772553, 5303.946960530394, 5317.441668624797, 5135.8202462913805, 5197.766100525476, 5204.089284375238, 5210.583153347732, 5219.45195754446, 3882.495275614166, 3933.449317095609, 4044.4539987101657, 4044.65620422263, 4049.9392509112386, 3941.625545573166, 3965.20695860829, 3972.9801350993203, 3974.2051589682032, 3978.2043591281713, 3893.610638936098, 3928.508936382952, 3942.56631770505, 3942.743721658083, 3950.980245098785, 3834.424836274567, 3895.18201177753, 3898.727089103764, 3935.114599215168, 3957.3668213085766, 3426.468897320919, 3434.1242983039415, 3440.0, 3440.0023993041987, 3446.0006598086525, 4940.2342636891335, 4941.777620007072, 4958.281049247875, 4960.627952903511, 4961.355023846877, 4493.752843593601, 4497.550244975509, 4501.077279157765, 4504.369388285642, 4506.662000349987, 5353.330833645794, 5456.399796022434, 5476.780928762844, 5480.123180291134, 5495.917561236584, 3771.415430608233, 3777.6033516480647, 3778.149916268845, 3778.3199024175638, 3778.6221377861993, 5662.433756624305, 5715.31416230055, 5755.683437410982, 5761.337446193699, 5762.135679648044, 3941.1329507508303, 3943.171933893857, 3945.2109578084496, 3945.881623551298, 3946.3291240489184, 3777.8866634001024, 3792.715546333981, 3990.10222699896, 3994.08136128692, 3998.520177578651, 4116.5060192777055, 4381.342798580238, 4428.712133711363, 4464.821407143678, 4529.750863702462, 5353.277307563507, 5414.052540805344, 5418.566514678816, 5431.049566325877, 5435.157550579666, 1412.773956167029, 1426.3581388375273, 1427.4932398998415, 1427.5003748687875, 1427.6216802547333, 956.4548207521646, 962.153305091529, 962.1965658675085, 981.0777868803302, 983.306768728045, 4744.667873248908, 4760.285957106462, 4768.356271903249, 4776.92519183188, 4780.856574302777, 5658.547316214693, 5664.0, 5666.036773748473, 5670.432956704379, 5675.0, 4788.353572267769, 4809.182438985381, 4809.302651115569, 4809.519048095232, 4812.5668689818085, 2949.646042474874, 3057.969420305813, 3089.4130115278026, 3124.3595063012026, 3130.0922732407803, 4582.679212455163, 5277.0, 5327.121025030827, 5328.094223981932, 5334.839954801362, 5734.0, 5814.098814683731, 5817.650940943557, 5818.2436283282905, 5823.5923485355615, 5300.09898317287, 5306.336707911511, 5316.813911513079, 5317.920231196613, 5320.494553017457, 5635.971820140873, 5642.294713160855, 5643.83068507929, 5686.601937864475, 5721.828345149652, 5376.166694162411, 5583.0, 5593.105103183471, 5601.6358936668985, 5613.186088017296, 5212.921806172834, 5233.188855727369, 5235.424103348705, 5238.3975842777045, 5322.0, 3886.630770076951, 3886.825092870884, 3889.1055057337535, 3889.474920885644, 3897.5322961244833, 5644.379118297066, 5647.29408823897, 5647.519960803378, 5647.7176141193595, 5655.830325090254, 5314.893702125859, 5438.347398312228, 5443.7278136092245, 5449.128139497661, 5456.48163424474, 5509.256250406304, 5512.2558454608115, 5524.06090964545, 5524.14375771756, 5527.861803454945, 5410.97294513525, 5413.675179489243, 5419.132938729942, 5424.159255315432, 5425.647332923348, 5420.674759514442, 5542.63972841764, 5548.140038294071, 5553.361363443094, 5555.30558680165, 5393.730313484231, 5407.567394608343, 5407.83776486706, 5409.404965453718, 5411.350637923474], "yui.html": [634.3561285295428, 653.4902775834851, 675.1088563096714, 688.7486067585331, 726.6003697966119, 11495.482703278352, 11778.705532361695, 11838.822417663741, 11845.052395808336, 11853.288802671836, 12619.43212555435, 12803.295818729966, 12808.167469114502, 12820.0, 12830.550930717427, 609.7652403824516, 782.7260458839403, 796.044746304434, 796.1560745609672, 796.410656114474, 609.2110716621963, 778.9337906277973, 793.1434051224693, 793.2147174297432, 793.7658390774735, 823.8640624296984, 834.9123342049088, 835.0355339582792, 835.7367429259764, 836.564986207172, 627.673609722946, 632.6868200240864, 804.2922228438995, 821.0147822612859, 825.1954344514081, 595.4700316718124, 596.3946594206883, 598.6019297167378, 598.9011813050842, 599.4754589733983, 10899.29154604948, 11058.557657693682, 11126.0, 11155.888441115567, 11201.0, 8636.784080397978, 8793.516356600385, 8872.37893347466, 9040.050794666531, 9773.755656108584, 8054.637541310596, 8257.504549727035, 8436.746897593082, 8588.055313915464, 8626.094260102662, 2645.5105805426056, 2667.6265322854815, 2679.303381120903, 2679.9866000670067, 2752.876120574579, 38854.41718374227, 39094.21811563753, 39198.41202381966, 39494.80252598719, 39621.40567891484, 6208.596441231396, 6345.36546345371, 6355.237371515355, 6450.645214513247, 6585.341465853377, 10736.73158171052, 10743.14054875608, 10743.78512429747, 10776.245662803529, 10800.621978230723, 5248.177097513514, 5318.867028324323, 5336.066188417011, 5356.330458692663, 5417.83746487606, 3391.69474747269, 3447.0348302475345, 3452.913677158091, 3468.514407982884, 3532.6997205237844, 2267.4671452208718, 2295.3687735872436, 2298.1956315289517, 2304.0438218139284, 2310.8844557772045, 403.89296836338394, 404.6762589928046, 405.27253579824287, 407.8103681787924, 409.34300447781476, 398.40438544375763, 399.54451924805744, 410.2021568050114, 421.4857873394454, 422.72945314998424, 6935.791926242221, 7374.1151061872915, 7420.269029657054, 7492.0, 7542.396608271325, 425.68073944541595, 437.8949052227442, 444.09626410255623, 464.73277865226953, 473.7134033909504, 3447.1382154461385, 3465.151037995707, 3499.3876071687864, 3522.471629255581, 3562.5546806649168, 53560.0, 53560.46439535633, 53789.731051345276, 54408.0, 54959.72520137374, 47770.0, 48583.51416485861, 48731.512684872694, 48879.26681099786, 49064.26403603949, 42598.57401426008, 43014.139717206104, 44271.77864110723, 44348.55651443509, 45202.773986130516, 7200.8919866201, 7341.853162936818, 7415.851682966419, 7839.412044096602, 7966.84066318682, 30571.847140765043, 30633.387332253675, 30774.692253077184, 31071.84464077665, 31586.368272634878, 38705.4194187093, 39461.0, 42866.56408001763, 43050.35424468573, 43175.784121079196, 6930.13373328334, 7053.188883278283, 7116.395106416013, 7189.1013623297085, 7230.855382892418, 10106.797864042532, 10446.320989135682, 10539.0, 10593.417362045162, 10661.147108231478, 9280.814383712153, 9337.953310233406, 9870.654527091518, 10047.14599259042, 10067.74830629211, 9766.511674416393, 9906.801863962824, 9946.502674866373, 9946.850797238192, 10036.849447258443, 9607.13535781783, 9654.372465789702, 9750.609975600897, 9832.655857044969, 9870.259730520384, 8031.196880311922, 8198.057223419382, 8263.504189748634, 8267.710630127916, 8282.751517454486, 7695.192004839635, 7741.574213418091, 7891.368690504631, 8136.877946830684, 8187.631556579849]}, "summary": {"lowerIsBetter": false, "suite": 6012.647958967784, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7186.721098744177, "unit": "ms", "value": 7186.721098744177}, "dojo.html": {"lowerIsBetter": false, "filtered": 4669.898626186756, "unit": "ms", "value": 4669.898626186756}, "mootools.html": {"lowerIsBetter": false, "filtered": 3966.8067097321136, "unit": "ms", "value": 3966.8067097321136}, "ext.html": {"lowerIsBetter": false, "filtered": 16729.261199340843, "unit": "ms", "value": 16729.261199340843}, "prototype.html": {"lowerIsBetter": false, "filtered": 4089.4843856027987, "unit": "ms", "value": 4089.4843856027987}, "yui.html": {"lowerIsBetter": false, "filtered": 5187.100467870116, "unit": "ms", "value": 5187.100467870116}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-005"}, "testrun": {"date": 1447295671, "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": "20151111171348", "branch": "B2G-Inbound-Non-PGO", "revision": "9f7af27bf22fddfd062df2b756187578e7facf8a"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 174.0, 160.0, 163.0, 161.0, 162.0, 161.0, 163.0, 163.0, 163.0], "ai-astar": [112.0, 114.0, 105.0, 112.0, 112.0, 113.0, 102.0, 111.0, 105.0, 113.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "audio-beat-detection": [152.0, 135.0, 155.0, 165.0, 129.0, 152.0, 155.0, 128.0, 166.0, 129.0], "json-stringify-tinderbox": [67.0, 66.0, 67.0, 67.0, 66.0, 77.0, 66.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [147.0, 144.0, 144.0, 144.0, 145.0, 145.0, 144.0, 144.0, 144.0, 133.0], "json-parse-financial": [71.0, 72.0, 73.0, 71.0, 72.0, 72.0, 71.0, 80.0, 69.0, 70.0], "stanford-crypto-sha256-iterative": [70.0, 69.0, 69.0, 68.0, 72.0, 71.0, 67.0, 70.0, 67.0, 68.0], "audio-fft": [71.0, 72.0, 81.0, 93.0, 72.0, 71.0, 73.0, 87.0, 94.0, 73.0], "imaging-darkroom": [145.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "stanford-crypto-ccm": [128.0, 118.0, 115.0, 116.0, 130.0, 120.0, 128.0, 128.0, 124.0, 120.0], "audio-oscillator": [92.0, 93.0, 129.0, 91.0, 92.0, 98.0, 126.0, 91.0, 92.0, 127.0], "stanford-crypto-aes": [82.0, 91.0, 84.0, 83.0, 83.0, 82.0, 87.0, 83.0, 83.0, 83.0], "imaging-desaturate": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1511.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.7, "unit": "ms", "value": 78.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 143.4, "unit": "ms", "value": 143.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 146.6, "unit": "ms", "value": 146.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.7, "unit": "ms", "value": 122.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.2, "unit": "ms", "value": 146.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.1, "unit": "ms", "value": 72.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.1, "unit": "ms", "value": 103.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.9, "unit": "ms", "value": 109.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.3, "unit": "ms", "value": 163.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 69.1, "unit": "ms", "value": 69.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.7, "unit": "ms", "value": 67.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.1, "unit": "ms", "value": 84.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.2, "unit": "ms", "value": 95.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-005"}, "testrun": {"date": 1447295671, "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": "20151111171348", "branch": "B2G-Inbound-Non-PGO", "revision": "9f7af27bf22fddfd062df2b756187578e7facf8a"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.8649270913277], "Encrypt": [279.4076557697681], "NavierStokes": [4817.307692307692], "Decrypt": [5030.150753768844], "Splay": [617.283950617284], "Richards": [170.2127659574468], "RegExp": [26947.36842105263], "Earley": [812.3476848090983], "Boyer": [11823.529411764706], "RayTrace": [1986.111111111111]}, "summary": {"lowerIsBetter": false, "suite": 19714.39785887906, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.60701600000004, "unit": "score", "value": 344.60701600000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 952.6617989999997, "unit": "score", "value": 952.6617989999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.055888223553, "unit": "score", "value": 308.055888223553}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 132.01541999999998, "unit": "score", "value": 132.01541999999998}, "RegExp": {"lowerIsBetter": false, "filtered": 33.80608398437501, "unit": "score", "value": 33.80608398437501}, "Richards": {"lowerIsBetter": false, "filtered": 207.39925000000005, "unit": "score", "value": 207.39925000000005}, "Earley": {"lowerIsBetter": false, "filtered": 820.4159530000002, "unit": "score", "value": 820.4159530000002}, "Boyer": {"lowerIsBetter": false, "filtered": 56.36751741293535, "unit": "score", "value": 56.36751741293535}, "RayTrace": {"lowerIsBetter": false, "filtered": 372.5818741258742, "unit": "score", "value": 372.5818741258742}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-005"}, "testrun": {"date": 1447295671, "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": "20151111171348", "branch": "B2G-Inbound-Non-PGO", "revision": "9f7af27bf22fddfd062df2b756187578e7facf8a"}}] 18:54:48 INFO - RETURN: dromaeo_css: 6012.65 18:54:48 INFO - RETURN: kraken: 1511.80 18:54:48 INFO - RETURN: v8_7: 19714.40 18:54:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19714.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1511.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6012.65"}}} 18:54:48 INFO - Return code: 0 18:54:48 INFO - # TBPL SUCCESS # 18:54:48 INFO - Running post-action listener: _resource_record_post_action 18:54:48 INFO - Running post-run listener: _resource_record_post_run 18:54:49 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 509394944; Read time: 0; Write time: 379448 18:54:49 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 228474880; Read time: 0; Write time: 227456 18:54:49 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 279801856; Read time: 0; Write time: 133212 18:54:49 INFO - Running post-run listener: _upload_blobber_files 18:54:49 INFO - Blob upload gear active. 18:54:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:54:49 INFO - Copying logs to upload dir... 18:54:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1259.156318 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-11 18:54:48.801814) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:54:48.805633) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009983 build_url: 'https://queue.taskcluster.net/v1/task/TFXM2_QVTwCqnVu-qCP0-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:54:48.857681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:54:48.858026) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447294046.789332-1257974086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:54:48.908306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 18:54:48.908627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 18:54:48.908932) ========= ========= Total master_lag: 0.22 =========