builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1447727907.52 results: success (0) buildid: 20151116172211 builduid: 8a8a59ef1ef14da7b59629fef4b24f89 revision: a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.520279) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.520737) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.521043) ========= 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=7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004077 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.536493) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.536804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.545761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.546253) ========= 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=7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003966 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.593641) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.593973) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.594338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.594609) ========= 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=7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 18:38:28-- 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% 43.7M=0s 2015-11-16 18:38:28 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.800279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.800609) ========= 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=7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018947 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:27.849587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 18:38:27.849941) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb --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=7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 18:38:28,405 truncating revision to first 12 chars 2015-11-16 18:38:28,405 Setting DEBUG logging. 2015-11-16 18:38:28,405 attempt 1/10 2015-11-16 18:38:28,405 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a2f83cbe53ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 18:38:29,446 unpacking tar archive at: mozilla-central-a2f83cbe53ac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323281 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 18:38:29.185786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:29.186112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:29.195898) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:29.196201) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:38:29.196607) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-16 18:38:29.196898) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:38:29 INFO - MultiFileLogger online at 20151116 18:38:29 in /builds/slave/test 18:38:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:38:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:38:29 INFO - {'append_to_log': False, 18:38:29 INFO - 'base_work_dir': '/builds/slave/test', 18:38:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:38:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:38:29 INFO - 'branch': 'Firefox-Non-PGO', 18:38:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:38:29 INFO - 'config_files': ('talos/linux_config.py',), 18:38:29 INFO - 'default_actions': ('clobber', 18:38:29 INFO - 'read-buildbot-config', 18:38:29 INFO - 'download-and-extract', 18:38:29 INFO - 'populate-webroot', 18:38:29 INFO - 'create-virtualenv', 18:38:29 INFO - 'install', 18:38:29 INFO - 'run-tests'), 18:38:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:38:29 INFO - 'download_minidump_stackwalk': True, 18:38:29 INFO - 'download_symbols': 'ondemand', 18:38:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:38:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:38:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:38:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:38:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:38:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:38:29 INFO - 'installer_path': 'installer.exe', 18:38:29 INFO - 'log_level': 'info', 18:38:29 INFO - 'log_name': 'talos', 18:38:29 INFO - 'log_to_console': True, 18:38:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:38:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:38:29 INFO - 'opt_config_files': (), 18:38:29 INFO - 'pip_index': False, 18:38:29 INFO - 'sps_profile': False, 18:38:29 INFO - 'sps_profile_interval': 0, 18:38:29 INFO - 'suite': 'dromaeojs', 18:38:29 INFO - 'system_bits': '64', 18:38:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:38:29 INFO - 'title': 'talos-linux64-ix-008', 18:38:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:38:29 INFO - 'use_talos_json': True, 18:38:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:38:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:38:29 INFO - 'work_dir': 'build'} 18:38:29 INFO - ##### 18:38:29 INFO - ##### Running clobber step. 18:38:29 INFO - ##### 18:38:29 INFO - Running pre-action listener: _resource_record_pre_action 18:38:29 INFO - Running main action method: clobber 18:38:29 INFO - rmtree: /builds/slave/test/build 18:38:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:38:30 INFO - Running post-action listener: _resource_record_post_action 18:38:30 INFO - ##### 18:38:30 INFO - ##### Running read-buildbot-config step. 18:38:30 INFO - ##### 18:38:30 INFO - Running pre-action listener: _resource_record_pre_action 18:38:30 INFO - Running main action method: read_buildbot_config 18:38:30 INFO - Using buildbot properties: 18:38:30 INFO - { 18:38:30 INFO - "properties": { 18:38:30 INFO - "buildnumber": 350, 18:38:30 INFO - "product": "firefox", 18:38:30 INFO - "script_repo_revision": "production", 18:38:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:38:30 INFO - "repository": "", 18:38:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:38:30 INFO - "buildid": "20151116172211", 18:38:30 INFO - "slavename": "talos-linux64-ix-008", 18:38:30 INFO - "pgo_build": "False", 18:38:30 INFO - "basedir": "/builds/slave/test", 18:38:30 INFO - "project": "", 18:38:30 INFO - "platform": "ubuntu64_hw", 18:38:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:38:30 INFO - "slavebuilddir": "test", 18:38:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:38:30 INFO - "branch": "mozilla-central", 18:38:30 INFO - "repo_path": "mozilla-central", 18:38:30 INFO - "stage_platform": "linux64", 18:38:30 INFO - "builduid": "8a8a59ef1ef14da7b59629fef4b24f89", 18:38:30 INFO - "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb" 18:38:30 INFO - }, 18:38:30 INFO - "sourcestamp": { 18:38:30 INFO - "repository": "", 18:38:30 INFO - "hasPatch": false, 18:38:30 INFO - "project": "", 18:38:30 INFO - "branch": "mozilla-central-linux64-talos", 18:38:30 INFO - "changes": [ 18:38:30 INFO - { 18:38:30 INFO - "category": null, 18:38:30 INFO - "files": [ 18:38:30 INFO - { 18:38:30 INFO - "url": null, 18:38:30 INFO - "name": "https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:38:30 INFO - } 18:38:30 INFO - ], 18:38:30 INFO - "repository": "", 18:38:30 INFO - "rev": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb", 18:38:30 INFO - "who": "kwierso@gmail.com", 18:38:30 INFO - "when": 1447727625, 18:38:30 INFO - "number": 6669605, 18:38:30 INFO - "comments": "Merge inbound to m-c a=merge", 18:38:30 INFO - "project": "", 18:38:30 INFO - "at": "Mon 16 Nov 2015 18:33:45", 18:38:30 INFO - "branch": "mozilla-central-linux64-talos", 18:38:30 INFO - "revlink": "", 18:38:30 INFO - "properties": [ 18:38:30 INFO - [ 18:38:30 INFO - "buildid", 18:38:30 INFO - "20151116172211", 18:38:30 INFO - "Change" 18:38:30 INFO - ], 18:38:30 INFO - [ 18:38:30 INFO - "builduid", 18:38:30 INFO - "8a8a59ef1ef14da7b59629fef4b24f89", 18:38:30 INFO - "Change" 18:38:30 INFO - ], 18:38:30 INFO - [ 18:38:30 INFO - "pgo_build", 18:38:30 INFO - "False", 18:38:30 INFO - "Change" 18:38:30 INFO - ] 18:38:30 INFO - ], 18:38:30 INFO - "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb" 18:38:30 INFO - } 18:38:30 INFO - ], 18:38:30 INFO - "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb" 18:38:30 INFO - } 18:38:30 INFO - } 18:38:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:38:30 INFO - Running post-action listener: _resource_record_post_action 18:38:30 INFO - ##### 18:38:30 INFO - ##### Running download-and-extract step. 18:38:30 INFO - ##### 18:38:30 INFO - Running pre-action listener: _resource_record_pre_action 18:38:30 INFO - Running main action method: download_and_extract 18:38:30 INFO - mkdir: /builds/slave/test/build/tests 18:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:30 INFO - https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:38:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/test_packages.json 18:38:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/test_packages.json 18:38:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:38:30 INFO - Downloaded 1302 bytes. 18:38:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:38:30 INFO - Using the following test package requirements: 18:38:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:38:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:38:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:30 INFO - u'jsshell-linux-x86_64.zip'], 18:38:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:38:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:38:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:38:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:38:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:38:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:38:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:38:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:30 INFO - https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:38:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/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:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/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:38:31 INFO - Downloaded 21278087 bytes. 18:38:31 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:38:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:31 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:38:32 INFO - Return code: 0 18:38:32 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:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:32 INFO - https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:38:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/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:38:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/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:38:34 INFO - Downloaded 21278087 bytes. 18:38:34 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:38:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:34 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:38:36 INFO - Return code: 0 18:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:36 INFO - https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:38:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/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:38:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/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:38:37 INFO - Downloaded 11131693 bytes. 18:38:37 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:38:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:37 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:38:37 INFO - Return code: 0 18:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:37 INFO - https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/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:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvKkBnz-RzeaBufjHaluBw/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:38:39 INFO - Downloaded 55614725 bytes. 18:38:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:39 INFO - mkdir: /builds/slave/test/properties 18:38:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:38:39 INFO - Writing to file /builds/slave/test/properties/build_url 18:38:39 INFO - Contents: 18:38:39 INFO - build_url:https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:39 INFO - Running post-action listener: _resource_record_post_action 18:38:39 INFO - Running post-action listener: set_extra_try_arguments 18:38:39 INFO - ##### 18:38:39 INFO - ##### Running populate-webroot step. 18:38:39 INFO - ##### 18:38:39 INFO - Running pre-action listener: _resource_record_pre_action 18:38:39 INFO - Running main action method: populate_webroot 18:38:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:38:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:38:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:38:39 INFO - '../fennec_ids.txt'], 18:38:39 INFO - 'tests': ['tcheck2']}, 18:38:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:38:39 INFO - '--tppagecycles', 18:38:39 INFO - '7'], 18:38:39 INFO - 'tests': ['tsvgm']}}, 18:38:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:38:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:38:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:38:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:38:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:39 INFO - 'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:39 INFO - 'tests': ['damp', 'tps']}, 18:38:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:39 INFO - 'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['damp', 'tps']}, 18:38:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:38:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:38:39 INFO - 'other': {'tests': ['a11yr', 18:38:39 INFO - 'ts_paint', 18:38:39 INFO - 'tpaint', 18:38:39 INFO - 'sessionrestore', 18:38:39 INFO - 'sessionrestore_no_auto_restore']}, 18:38:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['a11yr', 18:38:39 INFO - 'ts_paint', 18:38:39 INFO - 'tpaint', 18:38:39 INFO - 'sessionrestore', 18:38:39 INFO - 'sessionrestore_no_auto_restore']}, 18:38:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['a11yr', 18:38:39 INFO - 'ts_paint', 18:38:39 INFO - 'tpaint', 18:38:39 INFO - 'sessionrestore', 18:38:39 INFO - 'sessionrestore_no_auto_restore']}, 18:38:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['a11yr', 18:38:39 INFO - 'ts_paint', 18:38:39 INFO - 'tpaint', 18:38:39 INFO - 'sessionrestore', 18:38:39 INFO - 'sessionrestore_no_auto_restore']}, 18:38:39 INFO - 'other_l64': {'tests': ['a11yr', 18:38:39 INFO - 'ts_paint', 18:38:39 INFO - 'tpaint', 18:38:39 INFO - 'sessionrestore', 18:38:39 INFO - 'sessionrestore_no_auto_restore']}, 18:38:39 INFO - 'other_nol64': {'tests': ['a11yr', 18:38:39 INFO - 'ts_paint', 18:38:39 INFO - 'tpaint', 18:38:39 INFO - 'sessionrestore', 18:38:39 INFO - 'sessionrestore_no_auto_restore']}, 18:38:39 INFO - 'svgr': {'tests': ['tsvgx', 18:38:39 INFO - 'tsvgr_opacity', 18:38:39 INFO - 'tart', 18:38:39 INFO - 'tscrollx', 18:38:39 INFO - 'cart']}, 18:38:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['tsvgx', 18:38:39 INFO - 'tsvgr_opacity', 18:38:39 INFO - 'tart', 18:38:39 INFO - 'tscrollx', 18:38:39 INFO - 'cart']}, 18:38:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:39 INFO - 'tests': ['tp5o']}, 18:38:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:39 INFO - 'talos_options': ['--e10s'], 18:38:39 INFO - 'tests': ['tp5o']}, 18:38:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:39 INFO - 'talos_options': ['--xperf_path', 18:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:39 INFO - 'tests': ['tp5n']}, 18:38:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:39 INFO - 'talos_options': ['--e10s', 18:38:39 INFO - '--xperf_path', 18:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:39 INFO - 'tests': ['tp5n']}}, 18:38:39 INFO - 'talos.zip': {'path': '', 18:38:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:38:39 INFO - Running post-action listener: _resource_record_post_action 18:38:39 INFO - ##### 18:38:39 INFO - ##### Running create-virtualenv step. 18:38:39 INFO - ##### 18:38:39 INFO - Running pre-action listener: _resource_record_pre_action 18:38:39 INFO - Running main action method: create_virtualenv 18:38:39 INFO - Creating virtualenv /builds/slave/test/build/venv 18:38:39 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:38:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:38:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:38:39 INFO - Using real prefix '/usr' 18:38:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:38:40 INFO - Installing distribute.............................................................................................................................................................................................done. 18:38:41 INFO - Installing pip.................done. 18:38:41 INFO - Return code: 0 18:38:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f4a5a5b1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254bac0>, '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 0x254c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254ce50>, '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': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', '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:38:41 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:38:41 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:38:41 INFO - Using env: {'DISPLAY': ':0', 18:38:41 INFO - 'HOME': '/home/cltbld', 18:38:41 INFO - 'LANG': 'en_US.UTF-8', 18:38:41 INFO - 'LANGUAGE': 'en_US:en', 18:38:41 INFO - 'LOGNAME': 'cltbld', 18:38:41 INFO - 'MAIL': '/var/mail/cltbld', 18:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:41 INFO - 'MOZ_NO_REMOTE': '1', 18:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:41 INFO - 'NO_EM_RESTART': '1', 18:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:41 INFO - 'PWD': '/builds/slave/test', 18:38:41 INFO - 'SHELL': '/bin/bash', 18:38:41 INFO - 'SHLVL': '1', 18:38:41 INFO - 'TERM': 'linux', 18:38:41 INFO - 'TMOUT': '86400', 18:38:41 INFO - 'USER': 'cltbld', 18:38:41 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', 18:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:41 INFO - '_': '/tools/buildbot/bin/python'} 18:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:42 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:38:42 INFO - Cleaning up... 18:38:42 INFO - Return code: 0 18:38:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:42 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 0x7f4a5a5b1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254bac0>, '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 0x254c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254ce50>, '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': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', '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:38:42 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:38:42 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:38:42 INFO - Using env: {'DISPLAY': ':0', 18:38:42 INFO - 'HOME': '/home/cltbld', 18:38:42 INFO - 'LANG': 'en_US.UTF-8', 18:38:42 INFO - 'LANGUAGE': 'en_US:en', 18:38:42 INFO - 'LOGNAME': 'cltbld', 18:38:42 INFO - 'MAIL': '/var/mail/cltbld', 18:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:42 INFO - 'MOZ_NO_REMOTE': '1', 18:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:42 INFO - 'NO_EM_RESTART': '1', 18:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:42 INFO - 'PWD': '/builds/slave/test', 18:38:42 INFO - 'SHELL': '/bin/bash', 18:38:42 INFO - 'SHLVL': '1', 18:38:42 INFO - 'TERM': 'linux', 18:38:42 INFO - 'TMOUT': '86400', 18:38:42 INFO - 'USER': 'cltbld', 18:38:42 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', 18:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:42 INFO - '_': '/tools/buildbot/bin/python'} 18:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:42 INFO - Downloading/unpacking psutil>=0.7.1 18:38:42 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:38:42 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:38:42 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:38:42 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:38:42 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:38:42 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:38:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:38:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:44 INFO - Installing collected packages: psutil 18:38:44 INFO - Running setup.py install for psutil 18:38:44 INFO - building 'psutil._psutil_linux' extension 18:38:44 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:38:44 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:38:44 INFO - building 'psutil._psutil_posix' extension 18:38:44 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:38:44 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:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:44 INFO - Successfully installed psutil 18:38:44 INFO - Cleaning up... 18:38:44 INFO - Return code: 0 18:38:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:44 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 0x7f4a5a5b1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254bac0>, '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 0x254c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254ce50>, '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': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', '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:38:44 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:38:44 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:38:44 INFO - Using env: {'DISPLAY': ':0', 18:38:44 INFO - 'HOME': '/home/cltbld', 18:38:44 INFO - 'LANG': 'en_US.UTF-8', 18:38:44 INFO - 'LANGUAGE': 'en_US:en', 18:38:44 INFO - 'LOGNAME': 'cltbld', 18:38:44 INFO - 'MAIL': '/var/mail/cltbld', 18:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:44 INFO - 'MOZ_NO_REMOTE': '1', 18:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:44 INFO - 'NO_EM_RESTART': '1', 18:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:44 INFO - 'PWD': '/builds/slave/test', 18:38:44 INFO - 'SHELL': '/bin/bash', 18:38:44 INFO - 'SHLVL': '1', 18:38:44 INFO - 'TERM': 'linux', 18:38:44 INFO - 'TMOUT': '86400', 18:38:44 INFO - 'USER': 'cltbld', 18:38:44 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', 18:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:44 INFO - '_': '/tools/buildbot/bin/python'} 18:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:38:44 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:38:44 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:38:44 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:38:44 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:38:44 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:38:44 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:38:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:38:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:46 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:38:46 INFO - Installing collected packages: mozsystemmonitor 18:38:46 INFO - Running setup.py install for mozsystemmonitor 18:38:46 INFO - Successfully installed mozsystemmonitor 18:38:46 INFO - Cleaning up... 18:38:46 INFO - Return code: 0 18:38:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:38:46 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:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:46 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:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:46 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 0x7f4a5a5b1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254bac0>, '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 0x254c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254ce50>, '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': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', '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:38:46 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:38:46 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:38:46 INFO - Using env: {'DISPLAY': ':0', 18:38:46 INFO - 'HOME': '/home/cltbld', 18:38:46 INFO - 'LANG': 'en_US.UTF-8', 18:38:46 INFO - 'LANGUAGE': 'en_US:en', 18:38:46 INFO - 'LOGNAME': 'cltbld', 18:38:46 INFO - 'MAIL': '/var/mail/cltbld', 18:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:46 INFO - 'MOZ_NO_REMOTE': '1', 18:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:46 INFO - 'NO_EM_RESTART': '1', 18:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:46 INFO - 'PWD': '/builds/slave/test', 18:38:46 INFO - 'SHELL': '/bin/bash', 18:38:46 INFO - 'SHLVL': '1', 18:38:46 INFO - 'TERM': 'linux', 18:38:46 INFO - 'TMOUT': '86400', 18:38:46 INFO - 'USER': 'cltbld', 18:38:46 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', 18:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:46 INFO - '_': '/tools/buildbot/bin/python'} 18:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:46 INFO - Downloading/unpacking blobuploader==1.2.4 18:38:46 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:38:46 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:38:46 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:38:46 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:38:46 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:38:46 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:38:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38:48 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:38:48 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:38:48 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:38:48 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:38:48 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:38:48 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:38:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:38:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38:49 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:38:49 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:38:49 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:38:49 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:38:49 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:38:49 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:38:49 INFO - Downloading docopt-0.6.1.tar.gz 18:38:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:49 INFO - Running setup.py install for blobuploader 18:38:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:38:49 INFO - Running setup.py install for requests 18:38:50 INFO - Running setup.py install for docopt 18:38:50 INFO - Successfully installed blobuploader requests docopt 18:38:50 INFO - Cleaning up... 18:38:50 INFO - Return code: 0 18:38:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38: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:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38: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:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:50 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 0x7f4a5a5b1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254bac0>, '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 0x254c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254ce50>, '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': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', '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:38:50 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:38:50 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:38:50 INFO - Using env: {'DISPLAY': ':0', 18:38:50 INFO - 'HOME': '/home/cltbld', 18:38:50 INFO - 'LANG': 'en_US.UTF-8', 18:38:50 INFO - 'LANGUAGE': 'en_US:en', 18:38:50 INFO - 'LOGNAME': 'cltbld', 18:38:50 INFO - 'MAIL': '/var/mail/cltbld', 18:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:50 INFO - 'MOZ_NO_REMOTE': '1', 18:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:50 INFO - 'NO_EM_RESTART': '1', 18:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:50 INFO - 'PWD': '/builds/slave/test', 18:38:50 INFO - 'SHELL': '/bin/bash', 18:38:50 INFO - 'SHLVL': '1', 18:38:50 INFO - 'TERM': 'linux', 18:38:50 INFO - 'TMOUT': '86400', 18:38:50 INFO - 'USER': 'cltbld', 18:38:50 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', 18:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:50 INFO - '_': '/tools/buildbot/bin/python'} 18:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:50 INFO - Running setup.py (path:/tmp/pip-2bZkWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:50 INFO - Running setup.py (path:/tmp/pip-_TdMaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:50 INFO - Running setup.py (path:/tmp/pip-zU9L1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:50 INFO - Running setup.py (path:/tmp/pip-6J_mxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:50 INFO - Running setup.py (path:/tmp/pip-yNROhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:50 INFO - Running setup.py (path:/tmp/pip-qq249D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:50 INFO - Running setup.py (path:/tmp/pip-WOYc8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:50 INFO - Running setup.py (path:/tmp/pip-YJDIJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:50 INFO - Running setup.py (path:/tmp/pip-NpjHVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:51 INFO - Running setup.py (path:/tmp/pip-hWk_i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:51 INFO - Running setup.py (path:/tmp/pip-Wli6Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:51 INFO - Running setup.py (path:/tmp/pip-h0Vism-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:51 INFO - Running setup.py (path:/tmp/pip-4tF8ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:51 INFO - Running setup.py (path:/tmp/pip-9p2ZTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:51 INFO - Running setup.py (path:/tmp/pip-WfUxUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:51 INFO - Running setup.py (path:/tmp/pip-hZa6xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:51 INFO - Running setup.py (path:/tmp/pip-1S7m0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:51 INFO - Running setup.py install for manifestparser 18:38:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:38:51 INFO - Running setup.py install for mozcrash 18:38:51 INFO - Running setup.py install for mozdebug 18:38:51 INFO - Running setup.py install for mozdevice 18:38:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:38:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Running setup.py install for mozfile 18:38:52 INFO - Running setup.py install for mozhttpd 18:38:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Running setup.py install for mozinfo 18:38:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Running setup.py install for mozInstall 18:38:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Running setup.py install for mozleak 18:38:52 INFO - Running setup.py install for mozlog 18:38:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Running setup.py install for moznetwork 18:38:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Running setup.py install for mozprocess 18:38:52 INFO - Running setup.py install for mozprofile 18:38:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:38:52 INFO - Running setup.py install for mozrunner 18:38:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:38:53 INFO - Running setup.py install for mozscreenshot 18:38:53 INFO - Running setup.py install for moztest 18:38:53 INFO - Running setup.py install for mozversion 18:38:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:38:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:53 INFO - Cleaning up... 18:38:53 INFO - Return code: 0 18:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4a5a5b1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254bac0>, '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 0x254c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254ce50>, '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': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', '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:38:53 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:38:53 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:38:53 INFO - Using env: {'DISPLAY': ':0', 18:38:53 INFO - 'HOME': '/home/cltbld', 18:38:53 INFO - 'LANG': 'en_US.UTF-8', 18:38:53 INFO - 'LANGUAGE': 'en_US:en', 18:38:53 INFO - 'LOGNAME': 'cltbld', 18:38:53 INFO - 'MAIL': '/var/mail/cltbld', 18:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:53 INFO - 'MOZ_NO_REMOTE': '1', 18:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:53 INFO - 'NO_EM_RESTART': '1', 18:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:53 INFO - 'PWD': '/builds/slave/test', 18:38:53 INFO - 'SHELL': '/bin/bash', 18:38:53 INFO - 'SHLVL': '1', 18:38:53 INFO - 'TERM': 'linux', 18:38:53 INFO - 'TMOUT': '86400', 18:38:53 INFO - 'USER': 'cltbld', 18:38:53 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', 18:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:53 INFO - '_': '/tools/buildbot/bin/python'} 18:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:53 INFO - Running setup.py (path:/tmp/pip-3wA8Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:53 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:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:53 INFO - Running setup.py (path:/tmp/pip-u6Hq6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:53 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:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:53 INFO - Running setup.py (path:/tmp/pip-U4o1WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:53 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:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:53 INFO - Running setup.py (path:/tmp/pip-R0uG5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:53 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:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:53 INFO - Running setup.py (path:/tmp/pip-CS3lk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:53 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:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:53 INFO - Running setup.py (path:/tmp/pip-67GsSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:54 INFO - Running setup.py (path:/tmp/pip-PaStqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:54 INFO - Running setup.py (path:/tmp/pip-4Ifan4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:54 INFO - Running setup.py (path:/tmp/pip-XcxUN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:54 INFO - Running setup.py (path:/tmp/pip-tcmGQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:54 INFO - Running setup.py (path:/tmp/pip-O_osXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:54 INFO - Running setup.py (path:/tmp/pip-IgRJbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:54 INFO - Running setup.py (path:/tmp/pip-4REZTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:54 INFO - Running setup.py (path:/tmp/pip-WxPA9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:54 INFO - Running setup.py (path:/tmp/pip-toUaqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:54 INFO - Running setup.py (path:/tmp/pip-gAw_P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:54 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:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:54 INFO - Running setup.py (path:/tmp/pip-ramnrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:54 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:38:54 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:38:54 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:38:54 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:38:54 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:38:54 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:38:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:56 INFO - Downloading blessings-1.5.1.tar.gz 18:38:56 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:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:38:56 INFO - Installing collected packages: blessings 18:38:56 INFO - Running setup.py install for blessings 18:38:56 INFO - Successfully installed blessings 18:38:56 INFO - Cleaning up... 18:38:56 INFO - Return code: 0 18:38:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:38:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:56 INFO - Reading from file tmpfile_stdout 18:38:56 INFO - Current package versions: 18:38:56 INFO - argparse == 1.2.1 18:38:56 INFO - blessings == 1.5.1 18:38:56 INFO - blobuploader == 1.2.4 18:38:56 INFO - docopt == 0.6.1 18:38:56 INFO - manifestparser == 1.1 18:38:56 INFO - mozInstall == 1.12 18:38:56 INFO - mozcrash == 0.16 18:38:56 INFO - mozdebug == 0.1 18:38:56 INFO - mozdevice == 0.47 18:38:56 INFO - mozfile == 1.2 18:38:56 INFO - mozhttpd == 0.7 18:38:56 INFO - mozinfo == 0.9 18:38:56 INFO - mozleak == 0.1 18:38:56 INFO - mozlog == 3.0 18:38:56 INFO - moznetwork == 0.27 18:38:56 INFO - mozprocess == 0.22 18:38:56 INFO - mozprofile == 0.27 18:38:56 INFO - mozrunner == 6.11 18:38:56 INFO - mozscreenshot == 0.1 18:38:56 INFO - mozsystemmonitor == 0.0 18:38:56 INFO - moztest == 0.7 18:38:56 INFO - mozversion == 1.4 18:38:56 INFO - psutil == 3.1.1 18:38:56 INFO - requests == 1.2.3 18:38:56 INFO - wsgiref == 0.1.2 18:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4a5a5b1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254bac0>, '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 0x254c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254ce50>, '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': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', '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:38:56 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:38:56 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:38:56 INFO - Using env: {'DISPLAY': ':0', 18:38:56 INFO - 'HOME': '/home/cltbld', 18:38:56 INFO - 'LANG': 'en_US.UTF-8', 18:38:56 INFO - 'LANGUAGE': 'en_US:en', 18:38:56 INFO - 'LOGNAME': 'cltbld', 18:38:56 INFO - 'MAIL': '/var/mail/cltbld', 18:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:56 INFO - 'MOZ_NO_REMOTE': '1', 18:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:56 INFO - 'NO_EM_RESTART': '1', 18:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:56 INFO - 'PWD': '/builds/slave/test', 18:38:56 INFO - 'SHELL': '/bin/bash', 18:38:56 INFO - 'SHLVL': '1', 18:38:56 INFO - 'TERM': 'linux', 18:38:56 INFO - 'TMOUT': '86400', 18:38:56 INFO - 'USER': 'cltbld', 18:38:56 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', 18:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:56 INFO - '_': '/tools/buildbot/bin/python'} 18:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:57 INFO - Cleaning up... 18:38:57 INFO - Return code: 0 18:38:57 INFO - Running post-action listener: _resource_record_post_action 18:38:57 INFO - Running post-action listener: _start_resource_monitoring 18:38:57 INFO - Starting resource monitoring. 18:38:57 INFO - ##### 18:38:57 INFO - ##### Running install step. 18:38:57 INFO - ##### 18:38:57 INFO - Running pre-action listener: _resource_record_pre_action 18:38:57 INFO - Running main action method: install 18:38:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:57 INFO - Reading from file tmpfile_stdout 18:38:57 INFO - Detecting whether we're running mozinstall >=1.0... 18:38:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:38:57 INFO - Reading from file tmpfile_stdout 18:38:57 INFO - Output received: 18:38:57 INFO - Usage: mozinstall [options] installer 18:38:57 INFO - Options: 18:38:57 INFO - -h, --help show this help message and exit 18:38:57 INFO - -d DEST, --destination=DEST 18:38:57 INFO - Directory to install application into. [default: 18:38:57 INFO - "/builds/slave/test"] 18:38:57 INFO - --app=APP Application being installed. [default: firefox] 18:38:57 INFO - mkdir: /builds/slave/test/build/application 18:38:57 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:38:57 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:39:11 INFO - Reading from file tmpfile_stdout 18:39:11 INFO - Output received: 18:39:11 INFO - /builds/slave/test/build/application/firefox/firefox 18:39:11 INFO - Running post-action listener: _resource_record_post_action 18:39:11 INFO - ##### 18:39:11 INFO - ##### Running run-tests step. 18:39:11 INFO - ##### 18:39:11 INFO - Running pre-action listener: _resource_record_pre_action 18:39:11 INFO - Running main action method: run_tests 18:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:39:11 INFO - Python 2.7.3 18:39:11 INFO - Return code: 0 18:39:11 INFO - grabbing minidump binary from tooltool 18:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:11 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 0x254bac0>, '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 0x254c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254ce50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:39:11 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:39:11 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:39:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:39:11 INFO - Return code: 0 18:39:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:39:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:39:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:39:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:39:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 18:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 18:39:11 INFO - Using env: {'DISPLAY': ':0', 18:39:11 INFO - 'HOME': '/home/cltbld', 18:39:11 INFO - 'LANG': 'en_US.UTF-8', 18:39:11 INFO - 'LANGUAGE': 'en_US:en', 18:39:11 INFO - 'LOGNAME': 'cltbld', 18:39:11 INFO - 'MAIL': '/var/mail/cltbld', 18:39:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:39:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:11 INFO - 'MOZ_NO_REMOTE': '1', 18:39:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:11 INFO - 'NO_EM_RESTART': '1', 18:39:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:11 INFO - 'PWD': '/builds/slave/test', 18:39:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:39:11 INFO - 'SHELL': '/bin/bash', 18:39:11 INFO - 'SHLVL': '1', 18:39:11 INFO - 'TERM': 'linux', 18:39:11 INFO - 'TMOUT': '86400', 18:39:11 INFO - 'USER': 'cltbld', 18:39:11 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763', 18:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:11 INFO - '_': '/tools/buildbot/bin/python'} 18:39:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 18:39:11 INFO - mozversion INFO | application_buildid: 20151116172211 18:39:11 INFO - mozversion INFO | application_changeset: a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb 18:39:11 INFO - mozversion INFO | application_display_name: Nightly 18:39:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:39:11 INFO - mozversion INFO | application_name: Firefox 18:39:11 INFO - mozversion INFO | application_remotingname: firefox 18:39:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:39:11 INFO - mozversion INFO | application_vendor: Mozilla 18:39:11 INFO - mozversion INFO | application_version: 45.0a1 18:39:11 INFO - mozversion INFO | platform_buildid: 20151116172211 18:39:11 INFO - mozversion INFO | platform_changeset: a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb 18:39:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:39:11 INFO - mozversion INFO | platform_version: 45.0a1 18:39:11 INFO - 2015-11-16 18:39:11,787 DEBUG : using testdate: 1447727951 18:39:11 INFO - 2015-11-16 18:39:11,787 DEBUG : actual date: 1447727951 18:39:11 INFO - 2015-11-16 18:39:11,796 INFO : starting webserver on 'localhost:39339' 18:39:11 INFO - 2015-11-16 18:39:11,796 INFO : Starting test suite talos-linux64-ix-008 18:39:11 INFO - 2015-11-16 18:39:11,797 INFO : Starting test dromaeo_css 18:39:11 INFO - 2015-11-16 18:39:11,797 DEBUG : operating with platform_type : linux_ 18:39:11 INFO - 2015-11-16 18:39:11,797 INFO : Initialising browser for dromaeo_css test... 18:39:11 INFO - 2015-11-16 18:39:11,813 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpByetPc/profile http://localhost:39339/getInfo.html 18:39:17 INFO - 2015-11-16 18:39:17,067 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:39:17 INFO - 2015-11-16 18:39:17,067 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:39:17 INFO - 2015-11-16 18:39:17,068 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:39:17 INFO - 2015-11-16 18:39:17,068 DEBUG : BROWSER_OUTPUT: __metrics 18:39:17 INFO - 2015-11-16 18:39:17,189 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:39:18 INFO - 2015-11-16 18:39:18,433 INFO : Browser initialized. 18:39:18 INFO - 2015-11-16 18:39:18,434 INFO : Running cycle 1/1 for dromaeo_css test... 18:39:18 INFO - 2015-11-16 18:39:18,434 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpByetPc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:39:30 INFO - 2015-11-16 18:39:30,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 141910016 18:39:30 INFO - 2015-11-16 18:39:30,370 DEBUG : BROWSER_OUTPUT: 18:40:21 INFO - 2015-11-16 18:40:21,553 DEBUG : BROWSER_OUTPUT: 1447728021549 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:42:33 INFO - 2015-11-16 18:42:33,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39339/tests/dromaeo/cssquery-ext.html) 18:42:34 INFO - 2015-11-16 18:42:34,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 224608256 18:42:34 INFO - 2015-11-16 18:42:34,369 DEBUG : BROWSER_OUTPUT: 18:45:36 INFO - 2015-11-16 18:45:36,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/dromaeo/cssquery-ext.html (next: http://localhost:39339/tests/dromaeo/cssquery-jquery.html) 18:45:37 INFO - 2015-11-16 18:45:37,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 223166464 18:45:37 INFO - 2015-11-16 18:45:37,359 DEBUG : BROWSER_OUTPUT: 18:48:39 INFO - 2015-11-16 18:48:39,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39339/tests/dromaeo/cssquery-mootools.html) 18:48:40 INFO - 2015-11-16 18:48:40,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 218927104 18:48:40 INFO - 2015-11-16 18:48:40,092 DEBUG : BROWSER_OUTPUT: 18:51:42 INFO - 2015-11-16 18:51:42,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39339/tests/dromaeo/cssquery-prototype.html) 18:51:42 INFO - 2015-11-16 18:51:42,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 203784192 18:51:42 INFO - 2015-11-16 18:51:42,663 DEBUG : BROWSER_OUTPUT: 18:54:45 INFO - 2015-11-16 18:54:45,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39339/tests/dromaeo/cssquery-yui.html) 18:54:45 INFO - 2015-11-16 18:54:45,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 205037568 18:54:45 INFO - 2015-11-16 18:54:45,915 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/dromaeo/cssquery-yui.html (next: http://localhost:39339/tests/dromaeo/cssquery-dojo.html) 18:57:48 INFO - 2015-11-16 18:57:48,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 250900480 18:57:48 INFO - 2015-11-16 18:57:48,731 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,731 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:57:48 INFO - 2015-11-16 18:57:48,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:57:48 INFO - 2015-11-16 18:57:48,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:57:48 INFO - 2015-11-16 18:57:48,732 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:57:48 INFO - 2015-11-16 18:57:48,735 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2621.750933661302;2732.3169207698074;2733.986330068349;2745.931351716207;2754.3389586499234;4493;4616.3767891334655;4671.439427268729;4763.73799441031;4806.0628177505405;4642.257238841786;4646.512116227798;4681.625469962403;4718.551737584932;4723.645726570512;4341.4790225172865;4343.435353404053;4367.4322338096;4379.824807007716;4384.408104905845;4222.282212023948;4444.511103778582;4466.084452687208;4490.191765482212;4492.707973981697;4277.636400905927;4327.4374331336885;4346.369776382407;4364.236258654754;4377.956220437787;4352.8476503322545;4369.344598310247;4375.278079116942;4383.583559561836;4411.911761764779;4126.958730412687;4273.038566322583;4339.826406943718;4363.410939523187;4411.183930972748;4538.909221815578;4643.698159619647;4647.024124933768;4657.743824089674;4694.929576056362;5115.514026167508;5119.360079990001;5119.667221630582;5124.897502049976;5129.281900533928;4814.951850481485;4935.629827762932;4937.728424936627;5122.974385128088;5126.641135120543;4598.632109431271;4655.4878963314;4657.04530571232;4671.462781780138;4708.03485285519;5138.820141295037;5158.148905430637;5224.2947202127225;5232.9738351308;5286.894262114736;4750.263709125091;4858.975705121452;4863.319135321058;5008.724520151427;5018.071656743514;4904.337914381585;5009.474005229471;5014.623903207274;5016.623753218523;5034.798608055637;5045.243213517928;5086;5086.338775959176;5087.135187018216;5136.486351364833;4831.251156070814;5038.2190760432195;5053.140966035783;5061.772220250097;5075.695458272516;4034;4137.668986481074;4138.275801734684;4150.709450338447;4151.4395556600075;3673.5959044505084;3676.283124790694;3687.520622319081;3717.9218026772473;3720.572134204547;4421.646268298528;4437.866863994085;4441.733495990251;4444.3333499974615;4478.373027776114;4812.735299558488;4925.310456536088;4931.161702510582;4963.6277279204205;5111.463296353903;4412;4423.668224883147;4429;4445.644348452116;4481.417415735934;4502.932456013163;4526.637868970474;4528.728276303433;4541.409616749867;4579.931301030487;4638.443386793607;4708.788104535372;4778.5699287064335;4783.6412269079265;4896.706197628154;5094.592432605456;5096.541311282002;5098.1588037973315;5107.821226257063;5128.051310507568;4861.295112208639;4865.56209941107;4866.853994380174;4869.780859861244;4902.411710594752;4696.084263568571;4816.566509014206;4820.25286080658;4830.3237546744185;5072.9746351268;5004.074246264453;5010.221371413096;5024.221245706921;5030.295758593873;5035.471275516018;4754.049190162051;4870.829520966891;4873.976464942401;4894.632902532253;4905.313256144072;4918;4948.035133149146;4960.801567937242;4969.329140566122;4990.451050384528;4608.147492713859;4737.620990320697;4816.614670826396;4850.854474365775;4895.902081958412;4791.544803243686;4878.268259761065;4887;4893.119238537098;4924.01519696055;4792.640551958687;4840.661153719206;4848.200046992207;4850.80596776125;4883.60931125502 18:57:48 INFO - 2015-11-16 18:57:48,735 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.2506041903848;570.9921987691722;571.8913406452772;575.7466714645553;584.5090124295593;28084.859575702118;35836.82081589592;36391.454128188096;36440.271194576126;36457.635423645756;39894.8005259974;40367.59632403675;40376.79811600945;40444.19111617766;40453.39319910196;7151.32062454066;7287.125544934589;7859;8020.67917283308;8022.237887400687;10252.94873525635;10502.68491945243;10520.421376824272;10533.84199237012;10553.577856885715;10104.141148002429;10192.745181370488;10225.028622280872;10226.642067527639;10237.539310731036;7308.123025236952;7505.437092218105;10149.594016239378;10256.846147307797;10540.262181647287;9903.504824758806;10009.549570269355;10033.698989030341;10043.096121349114;10051.798964020752;37721;38328.233435331415;38330;38403.231935361415;38410.231795363936;2757.696653368128;2915.3586211033753;3393.2704468539137;3497.422925217336;3625.111847597329;28216.858915705496;28710.71289287101;29217.561736573756;29345.85327073351;29497.852510737524;3016.276093737509;3040.285532899789;3046.2384403899027;3100.534919762031;3144.292534179814;228652.99999999834;228704;229389;230047;232529;49863.50136498661;51412.22881656778;54326.18510722342;55347.723261383435;55458.16812747812;51101;51126;51281.743591281804;51354.22968655473;51408.485915141115;14069.155850648995;14311.499097531745;14321.6419589509;14325.068870523382;14358.497452589108;10114.54484548197;10217.642382516726;10233.846492302622;10285.074343309137;10313.174946004301;18377.17302721381;18560.721589176173;18589.535261618566;18609;18622;6455.386738259858;6620.337966203341;6743.325667433315;6745.381108533917;6745.561538499982;774.6436639146056;844.2064459408136;890.5636238243214;905.9547022648841;973.1728031173446;25928.874998755695;26785.598216026774;26913.327166820596;26935;27019;895.1540793949786;943.9339246252833;1000.3797645459862;1051.3166441812882;1051.673981065872;12803;12805.807912881315;12981;13033.47866085346;13042.869571304165;268724;271296;272816;273735;273870;45436.54563454323;45842.770786146524;45850.31224531568;45905.31142032872;45914.770426147654;1152.5850693750244;1228.8709685483075;1231.599730087725;1239.0026029046703;1252.3300034481508;20341.288054918008;21330.57338853245;21747.782522174577;22132.88933555322;22704.65943010889;35269.64730352664;35919.64080359163;38004.809975949946;38275.80862095672;41247;223080;225167;226000;226212;226425;27692;27841;28011.918688944606;28663.140105796858;29116.56325155082;37111;37734.81132594319;38029;38060.80969595134;38168.427473588476;31193.220169495944;31987.360252794348;32312.35375292528;32652.346953061282;32841.343173136884;31496.685033149377;32414.189645259055;36038;36497.27005459929;36628.08429789277;32699.836500817342;32923.50614740733;32948.1762955928;33267.500987484724;33398.332033359686;36755;37899.242015160096;38895.805520972215;40471.79764101161;40890.79554602327;29150.416991660473;29470.705292947652;29475.705242947297;29938.25154371158;29960.400791984473 18:57:48 INFO - 2015-11-16 18:57:48,735 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.6619049283993;336.43478955354993;341.53892245468614;343.1164750766776;345.39038596876503;12640.683982900433;12959.676008099803;15196.924015379922;15293.388264469422;17709.468715938525;14853.405863765436;14892.106473611564;14991.47529836456;15019.849801502009;15047.172405517693;4381.737095774256;4500.324951257305;4888.973315603727;5025.623078269126;5056.772445239973;3507.964920350802;3637.5271214742047;5569.693666848321;5728.68492232927;5735.913961290584;5637.408072152406;5648;5666.348369937448;5676.091825307952;5695.74369153387;4191.517975432818;4283.057727299989;4287.528371879091;4293.076988447483;4300.1614685136565;3697.2605478904325;3709.7403181777286;3743.5882052974152;3748.381517049711;3748.850045998157;10986.395748233845;11190.776184476264;11194.832077518844;11195.160362972809;11208.831867521994;1706.2492503298508;1726.6287748134087;1731.8701097417745;1751.509577318353;1797.7752780902388;8724.607392667345;8997.775055623597;9014.504202268872;9028.187463128284;9183.448993060438;1598.1769388764797;1607.718649236379;1644.7944006999126;1677.6476939842526;1694.305334812721;52613.47386526124;53514.197287040726;53872.73063634696;54489.41075705747;54652.72673636646;6434.2600600930555;6529.477641788645;6552.705128269239;6583.144191255106;6600.273969863311;7392.4825262231125;7396.667149978264;7396.815079622945;7420.146683131401;7458.179600243969;5022.874428139326;5053.823116190989;5091.37076135633;5100.821471248562;5108.463611320833;5135.38375394955;5161.096808058574;5174.275601415805;5186.870328241824;5191.922121168185;2900.4054168895746;2933.1787099612143;2963.4517614241436;2966.7626589872757;2975.925601859971;1002.1031177096457;1008.969730908074;1027.4965267019106;1048.8321868501002;1071.5124618298655;384.1012031845495;392.30757712637217;394.9348357521034;402.3502044198657;420.05487652781244;9975.251856110675;10127.645532406477;10153.746156346151;10287.177025837915;10387.636432724817;403.9616236457532;411.3254263008668;415.40804353796324;418.49780263683704;436.07769567365426;5414.022287741726;5683.460071293221;5769.048107062287;5791.681457519792;5878.823635290948;314323;472995;478753;483716;493890;52966;64168;70503.64748176328;71558;73002;423.3586117032698;430.52212044630437;434.0710878719606;435.06461108616725;435.4687281516545;9266.53667316618;9478;9504.33469657145;9537.189338905993;9572.090651388386;30252.394952101276;30776.230594235323;31779.841100794347;32577.511337329484;33906;41730.374044389966;41787;41931.58068419277;42134.36798447964;43182.56817431786;5579.776808927598;5590.2453168821685;5655.660660360391;5694.658320500783;5700.800471983461;10109.443980581138;10192.184625229815;10209.285350025428;10427.113695335678;10452.059314661718;8939.463632182089;9018.639254430012;9021.368504204642;9160.31297652692;9436.245100392089;8743.956280218557;8766.298696104424;8883.600237989434;8979.865302020344;9080.636774528944;8683.175098365646;8719.564021799011;9215.677451289173;9353.11145441182;9382.202512786489;5532.778688852401;5538.224648549126;5606.719664016701;5607.943920560742;5621.747021383966;8963.910360896569;9016.233620142362;9021.097890210927;9081.636734530544;9389.85915211286 18:57:48 INFO - 2015-11-16 18:57:48,737 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1354.5529975108216;1552.2859484637067;1627.0237857285626;1637.1977730911856;1663.4094896311817;5805.245318108645;6038.094285857123;6529.347065293468;6714.060031595581;6722.487440325925;6886.862262754742;6904.551204171726;6921.757738479154;6926.896096558543;6947.131608548932;1689.9408520701777;1733.8959662420295;2005.3683089826695;2028.1887245102002;2031.0149577454922;2013.2953466286756;2063.8761674299517;2070.2029718558388;2070.5030792609814;2071.9482012949647;1941.9708704369446;1960.1081507913937;1965.2335589120255;1970.359633119242;1989.9403017909485;1974.6050789842018;2000.6798912173983;2004.6191223667602;2005.8395328373767;2005.8796472211714;1933.1204302042536;1986.4934441717414;1989.5523507210762;1990.6317331293612;1991.2234228650839;6890.965545172242;6898.758543450955;6937.202221744514;6940.201876784184;6986.056882320872;3984.2629113613784;4027.2750904837117;4038.414429907647;4052.8378864845668;4059.939100913489;2639.934001649955;2665.8400495970304;2736.179146256115;2750.4499100179846;2758.9862050689817;815.1196707555825;1645.9506214813575;1647.1681800690694;1722.5779683977505;1783.6432713457361;9164.679236226766;9169.770755731093;9201.67794127209;9223.44659320443;9243.6302547898;3539.7876127432437;3583;3607.6933460655614;3651.123730304708;3651.7808931464197;7415.555066696015;7425.331720145213;7444.664990075459;7450.403967682572;7450.888236676454;4002.4996875390575;4025.6175663311938;4028.576999415078;4034.072163402434;4035.3745169498775;3719.88840334785;3722.4974628424816;3725.0873535983856;3725.4970578972034;3726.049857286375;2722.0881004863195;2773.195773225742;3053.3435311408152;3056.43455960648;3105.5652208690803;902.1474706402518;906.1029580715176;909.490685216281;912.885889263842;927.3786563002805;903.6882275614902;928.9907100929039;930.7952250504878;961.5144352102144;1146.5986904583497;6456.483481321483;6503.479721622259;6520.282768895418;6527.738890444424;6531.0856480092825;555.552784995082;563.2846285217751;563.5322682173786;564.0833645326345;703.8979347994513;4691.906161876744;5256.316678831728;5257.868553286198;5259.21111833228;5264;8048.436609437284;8432.030316513557;8462.619182136696;8466.195711407407;8474.703385381483;7819.68721251155;7883.172266912006;7892.60536973149;7949.6025198739835;8004.119546849958;6287.559870809091;6359.713812878432;6420.807375778734;6424.196975378078;6429.935700643027;6323.525735569942;6382.521310901794;6425.967870160619;6427.517936154713;6441.71012304438;6961.965190174017;7224.783256502314;7261.564306141649;7298.96350518244;7389.519681220703;7421.369183619453;7433.070866141732;7588.317051465395;7621.466497345133;7630.847383052419;5836.708164591839;5842.970785146047;5884.9705751470965;5901.439363260483;5907.2911250650195;5687.857803554779;5846.386129456516;6299.811005669837;6316.652584107918;6327.557071004985;5598.86002849932;5737.053386191398;5766.596338256281;5845.561582881386;5877.0302900022725;5559.6664200148125;5600.299962504687;5838.678872662044;5939.227900372924;5954.404559544184;6148.262208535004;6180.47465965398;6188.257409110935;6189.102580125947;6209.59637623553;5713.571482138773;5777.45114214149;5819.039858423313;5826.592138550261;5845.240118784531;5810.506106980785;5856.560757943256;5857.853553661193;5859.296884373903;5861.443162899518 18:57:48 INFO - 2015-11-16 18:57:48,737 DEBUG : BROWSER_OUTPUT: |4;prototype.html;267.5999380925516;270.8889355364301;272.84311520875497;279.3895338684972;283.27199098317334;5266.894662106755;5322.840314790557;5366.651167674098;5383.057964856154;5383.757730902109;5037.5718063964605;5234.555062819665;5246.37043554773;5247.842564723064;5255.290535777669;3841.865534706286;3900.8244628991765;3930.2139572085553;3992.6406623403886;4009.578994205603;3988.4017397390335;4003;4004.5795191504762;4017.3973903914352;4019.31671615826;3798.810059497028;3972.9602703973023;3973.165635216608;3976.1252524444576;3977.6420122189143;3834.1564855731694;3899.1811719538646;3909.1009067914256;3914.588968158345;3940.9014774630577;3361.949570756416;3365.2764655599162;3368.8652453901814;3369.0566641340465;3369.22507823202;5061.519155680241;5064.265681476202;5079.1365467870555;5082.3138876251605;5093.719845408501;4502.459704835408;4508.1659892919915;4511.729296242203;4515.119551687422;4515.909681806378;5368.141097424394;5514.503694667499;5525.475079867406;5544.44955320549;5544.528715059225;3656.3601369760186;3656.542932133483;3661.450782382664;3661.6338366163172;3663.377225871608;5755.827325180209;5829.067349224146;5836;5837.941620583782;5839.299284085894;3834.309824231665;3835.846566137379;3838.6353296436796;3839.520059992445;3839.7504162229366;3738.336440284102;3879.301725689403;3885.048163200034;3891.7664940103687;3891.785951772623;4523.36672865799;4524.321351797191;4525.321201819754;4527.7736113194205;4534.7052441591195;5554.250176226238;5560.138178582326;5560.694161821139;5562.527185189223;5565.972170139124;1341.530464337474;1369.7808350663845;1370.6915943912738;1371.0882263294798;1371.5062577472102;887.729242581006;893.3433926064338;898.6989358564823;916.6058594804298;918.7243826851918;4927.605791536668;4940.456549779521;4940.629452791055;4947.035328111056;4948.90102197954;5750.4249575042995;5757;5768.826935191951;5769.596128271065;5772.191893134965;4934.605231581465;4936.284238785356;4940.777665005084;4943.060818444484;4943.604511639061;2969.4506516294555;3003.9849800751294;3052.420040192401;3053.801502902304;3080.969190308113;5458.317710286215;5481.835544933659;5503.174523821379;5513.531349835309;5515.503604675519;5935.080062590306;5936.5547583931375;5940.287165540163;5944.970275148597;5947.434993675594;5376.623636345418;5482.766377565016;5485.835424937259;5494.09347457665;5506.394296627368;5754.971225143848;5760.049591817303;5771.365149833431;5778.797742079007;5791.565632577658;5634.802781902614;5638.407967163389;5639.746211420578;5654.15187721845;5674.347450043298;5477.315335583052;5486.149646804752;5487.725613719218;5492.780288788404;5502.477264659851;3757.380032294641;3823.388257878726;3837.270918525471;3846.5576458707606;3856.1130939883424;5764.279465066867;5764.36591974874;5768.913466298093;5772.163036359789;5774.9133762994425;5568.832935011957;5580.944190558205;5583.246261754611;5583.720813959205;5585.525230355465;5386.111291636836;5565.916511252253;5571.554275658019;5571.582131340085;5577.9442205577425;5428.240046393587;5429.782808687608;5430.891382172414;5433.185022246695;5438.265834112344;5614.915776263278;5615.354234263112;5616.38219795814;5620.85947851307;5626.831195064155;5479.506844384025;5485.9725701371235;5486.423925487767;5487.6981766003255;5491.176323551499 18:57:48 INFO - 2015-11-16 18:57:48,738 DEBUG : BROWSER_OUTPUT: |5;yui.html;731.6159016516328;736.5065406177862;741.9703211871525;768.6041688530406;782.2881178127905;11183.217174797757;13540.322983850792;13545.322733863291;13604.863951360483;13650.590482285535;11880.702982425422;12031.759364812699;12034.69913252167;12035.638930832089;12045.096617753681;585.689584520205;593.3621357041177;745.7352639812842;749.7151082588622;761.584936209767;744.140517702055;745.4036770583539;751.4964973467789;751.6692655231681;751.7857410637969;786.8386980668978;791.7466410748563;793.5635400529685;793.5833687314149;794.0947320055142;611.016263815257;620.3331418724866;772.6947855597008;784.619459562112;788.1960400391569;573.3950682030456;578.1645522220393;578.7164289498157;578.7453520450988;579.1804596495953;11087.611933582286;11665.76668466626;11681.824772628332;11686.123540734394;11687.47406366707;8906.465612063297;9016.098390160996;9080.727578172666;9211.907880921171;9705.514724263758;8528.829423411496;8586.356023298278;8705.085965973609;8746.387752857303;9036.277097832224;2805.14443094856;2824.590434387023;2855.7429831315076;2895.406441679451;2899.5416821503777;38843.41734873979;39115.804420977714;39195.216095677926;39209.41185882242;39292.60707392918;7014.22843487216;7121.71513139479;7165.89251161233;7217.206107328189;7267.4549408794555;11028.22802403824;11126.276792008493;11126.833097503544;11167.162462815322;11172.553097876156;5276.419593844674;5717.599768016282;5741.024025915604;5821;5938.61399009063;3653.671169594696;3733.0667333166707;3761.9435708464393;3787.791671458096;3851.056491159684;2367.277980216016;2548.439343344461;2601.9479610408066;2606.973930260673;2609.138984135269;442.2570082261831;443.21993291806007;452.2921627652713;453.72776334199216;454.1915390604729;420.3106904676333;437.9408779814748;448.9797959091849;482.65249020705033;518.4478530365149;7189.6405179740805;7359.190489046201;7389.076365454318;7498.287662672037;7511.887321690179;456.0992040719619;463.6082510278809;499.8200647766801;549.9120140777457;556.4630131922714;3178.2213357727505;3248.7888287261253;3259.152620318687;3527.7883327000463;3540.4335306351377;44388.77805610951;48168.759156204695;48790.5120948786;48861.755691222024;48925.75537122291;43277.567224327984;44113.33829992553;44171.77914110473;44417.77791111088;45924.770376147906;41835;42347.57652423498;42422;42666.360004599956;42898.78550607227;7413.962930185315;7455.440841936768;7690.423218258541;7706.383489320729;7943.523388596703;29438.85280573669;30050.398992020473;30944.226394340323;31501.8424907874;31650.208744781565;36900.630993689716;36911;37528.81235593805;37693.62306376901;39823.20353592854;6541.280459149585;6692.230393504809;6739.865202696017;7099.621626755095;7203.963980180066;10607.840882386616;10630.202734795075;10755.731106722395;10773.353598784099;10880.401577913291;9647;9674.371165874196;9774.12032917041;9822.116009559173;10413.219008574539;10016.749581260527;10126.341787783771;10422.843657344994;10565.418901960466;10598.47007649599;9263.675771347971;9336.253099752139;9449.480278584744;9492.193163581172;9618.134367906921;8155.63299651529;8308.750737477885;8338.583070846555;8384.455010424303;8619.784505387415;6903.689333979883;7443.7766866991915;7500.662470188746;7666.156722760604;7709.8843517348405 18:57:48 INFO - 2015-11-16 18:57:48,738 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:57:48 INFO - 2015-11-16 18:57:48,738 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:57:48 INFO - 2015-11-16 18:57:48,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1169 18:57:48 INFO - 2015-11-16 18:57:48,738 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:57:48 INFO - 2015-11-16 18:57:48,738 DEBUG : BROWSER_OUTPUT: __startTimestamp1447729068730__endTimestamp 18:57:48 INFO - 2015-11-16 18:57:48,738 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,738 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:57:48 INFO - 2015-11-16 18:57:48,739 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:57:48 INFO - 2015-11-16 18:57:48,739 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,739 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4654.40 Median:4783.64 stddev:478.67 (10.0%) stddev-sans-first:452.80 18:57:48 INFO - 2015-11-16 18:57:48,739 DEBUG : BROWSER_OUTPUT: Values: 2621.8 2732.3 2734.0 2745.9 2754.3 4493.0 4616.4 4671.4 4763.7 4806.1 4642.3 4646.5 4681.6 4718.6 4723.6 4341.5 4343.4 4367.4 4379.8 4384.4 4222.3 4444.5 4466.1 4490.2 4492.7 4277.6 4327.4 4346.4 4364.2 4378.0 4352.8 4369.3 4375.3 4383.6 4411.9 4127.0 4273.0 4339.8 4363.4 4411.2 4538.9 4643.7 4647.0 4657.7 4694.9 5115.5 5119.4 5119.7 5124.9 5129.3 4815.0 4935.6 4937.7 5123.0 5126.6 4598.6 4655.5 4657.0 4671.5 4708.0 5138.8 5158.1 5224.3 5233.0 5286.9 4750.3 4859.0 4863.3 5008.7 5018.1 4904.3 5009.5 5014.6 5016.6 5034.8 5045.2 5086.0 5086.3 5087.1 5136.5 4831.3 5038.2 5053.1 5061.8 5075.7 4034.0 4137.7 4138.3 4150.7 4151.4 3673.6 3676.3 3687.5 3717.9 3720.6 4421.6 4437.9 4441.7 4444.3 4478.4 4812.7 4925.3 4931.2 4963.6 5111.5 4412.0 4423.7 4429.0 4445.6 4481.4 4502.9 4526.6 4528.7 4541.4 4579.9 4638.4 4708.8 4778.6 4783.6 4896.7 5094.6 5096.5 5098.2 5107.8 5128.1 4861.3 4865.6 4866.9 4869.8 4902.4 4696.1 4816.6 4820.3 4830.3 5073.0 5004.1 5010.2 5024.2 5030.3 5035.5 4754.0 4870.8 4874.0 4894.6 4905.3 4918.0 4948.0 4960.8 4969.3 4990.5 4608.1 4737.6 4816.6 4850.9 4895.9 4791.5 4878.3 4887.0 4893.1 4924.0 4792.6 4840.7 4848.2 4850.8 4883.6 18:57:48 INFO - 2015-11-16 18:57:48,739 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,739 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40572.26 Median:3073.39 stddev:63209.66 (2056.7%) stddev-sans-first:63315.58 18:57:48 INFO - 2015-11-16 18:57:48,740 DEBUG : BROWSER_OUTPUT: Values: 559.3 571.0 571.9 575.7 584.5 28084.9 35836.8 36391.5 36440.3 36457.6 39894.8 40367.6 40376.8 40444.2 40453.4 7151.3 7287.1 7859.0 8020.7 8022.2 10252.9 10502.7 10520.4 10533.8 10553.6 10104.1 10192.7 10225.0 10226.6 10237.5 7308.1 7505.4 10149.6 10256.8 10540.3 9903.5 10009.5 10033.7 10043.1 10051.8 37721.0 38328.2 38330.0 38403.2 38410.2 2757.7 2915.4 3393.3 3497.4 3625.1 28216.9 28710.7 29217.6 29345.9 29497.9 3016.3 3040.3 3046.2 3100.5 3144.3 228653.0 228704.0 229389.0 230047.0 232529.0 49863.5 51412.2 54326.2 55347.7 55458.2 51101.0 51126.0 51281.7 51354.2 51408.5 14069.2 14311.5 14321.6 14325.1 14358.5 10114.5 10217.6 10233.8 10285.1 10313.2 18377.2 18560.7 18589.5 18609.0 18622.0 6455.4 6620.3 6743.3 6745.4 6745.6 774.6 844.2 890.6 906.0 973.2 25928.9 26785.6 26913.3 26935.0 27019.0 895.2 943.9 1000.4 1051.3 1051.7 12803.0 12805.8 12981.0 13033.5 13042.9 268724.0 271296.0 272816.0 273735.0 273870.0 45436.5 45842.8 45850.3 45905.3 45914.8 1152.6 1228.9 1231.6 1239.0 1252.3 20341.3 21330.6 21747.8 22132.9 22704.7 35269.6 35919.6 38004.8 38275.8 41247.0 223080.0 225167.0 226000.0 226212.0 226425.0 27692.0 27841.0 28011.9 28663.1 29116.6 37111.0 37734.8 38029.0 38060.8 38168.4 31193.2 31987.4 32312.4 32652.3 32841.3 31496.7 32414.2 36038.0 36497.3 36628.1 32699.8 32923.5 32948.2 33267.5 33398.3 36755.0 37899.2 38895.8 40471.8 40890.8 29150.4 29470.7 29475.7 29938.3 29960.4 18:57:48 INFO - 2015-11-16 18:57:48,740 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,740 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23120.68 Median:481234.50 stddev:74461.52 (15.5%) stddev-sans-first:74650.73 18:57:48 INFO - 2015-11-16 18:57:48,740 DEBUG : BROWSER_OUTPUT: Values: 326.7 336.4 341.5 343.1 345.4 12640.7 12959.7 15196.9 15293.4 17709.5 14853.4 14892.1 14991.5 15019.8 15047.2 4381.7 4500.3 4889.0 5025.6 5056.8 3508.0 3637.5 5569.7 5728.7 5735.9 5637.4 5648.0 5666.3 5676.1 5695.7 4191.5 4283.1 4287.5 4293.1 4300.2 3697.3 3709.7 3743.6 3748.4 3748.9 10986.4 11190.8 11194.8 11195.2 11208.8 1706.2 1726.6 1731.9 1751.5 1797.8 8724.6 8997.8 9014.5 9028.2 9183.4 1598.2 1607.7 1644.8 1677.6 1694.3 52613.5 53514.2 53872.7 54489.4 54652.7 6434.3 6529.5 6552.7 6583.1 6600.3 7392.5 7396.7 7396.8 7420.1 7458.2 5022.9 5053.8 5091.4 5100.8 5108.5 5135.4 5161.1 5174.3 5186.9 5191.9 2900.4 2933.2 2963.5 2966.8 2975.9 1002.1 1009.0 1027.5 1048.8 1071.5 384.1 392.3 394.9 402.4 420.1 9975.3 10127.6 10153.7 10287.2 10387.6 404.0 411.3 415.4 418.5 436.1 5414.0 5683.5 5769.0 5791.7 5878.8 314323.0 472995.0 478753.0 483716.0 493890.0 52966.0 64168.0 70503.6 71558.0 73002.0 423.4 430.5 434.1 435.1 435.5 9266.5 9478.0 9504.3 9537.2 9572.1 30252.4 30776.2 31779.8 32577.5 33906.0 41730.4 41787.0 41931.6 42134.4 43182.6 5579.8 5590.2 5655.7 5694.7 5700.8 10109.4 10192.2 10209.3 10427.1 10452.1 8939.5 9018.6 9021.4 9160.3 9436.2 8744.0 8766.3 8883.6 8979.9 9080.6 8683.2 8719.6 9215.7 9353.1 9382.2 5532.8 5538.2 5606.7 5607.9 5621.7 8963.9 9016.2 9021.1 9081.6 9389.9 18:57:48 INFO - 2015-11-16 18:57:48,740 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,740 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4727.39 Median:5845.97 stddev:2427.27 (41.5%) stddev-sans-first:2420.85 18:57:48 INFO - 2015-11-16 18:57:48,742 DEBUG : BROWSER_OUTPUT: Values: 1354.6 1552.3 1627.0 1637.2 1663.4 5805.2 6038.1 6529.3 6714.1 6722.5 6886.9 6904.6 6921.8 6926.9 6947.1 1689.9 1733.9 2005.4 2028.2 2031.0 2013.3 2063.9 2070.2 2070.5 2071.9 1942.0 1960.1 1965.2 1970.4 1989.9 1974.6 2000.7 2004.6 2005.8 2005.9 1933.1 1986.5 1989.6 1990.6 1991.2 6891.0 6898.8 6937.2 6940.2 6986.1 3984.3 4027.3 4038.4 4052.8 4059.9 2639.9 2665.8 2736.2 2750.4 2759.0 815.1 1646.0 1647.2 1722.6 1783.6 9164.7 9169.8 9201.7 9223.4 9243.6 3539.8 3583.0 3607.7 3651.1 3651.8 7415.6 7425.3 7444.7 7450.4 7450.9 4002.5 4025.6 4028.6 4034.1 4035.4 3719.9 3722.5 3725.1 3725.5 3726.0 2722.1 2773.2 3053.3 3056.4 3105.6 902.1 906.1 909.5 912.9 927.4 903.7 929.0 930.8 961.5 1146.6 6456.5 6503.5 6520.3 6527.7 6531.1 555.6 563.3 563.5 564.1 703.9 4691.9 5256.3 5257.9 5259.2 5264.0 8048.4 8432.0 8462.6 8466.2 8474.7 7819.7 7883.2 7892.6 7949.6 8004.1 6287.6 6359.7 6420.8 6424.2 6429.9 6323.5 6382.5 6426.0 6427.5 6441.7 6962.0 7224.8 7261.6 7299.0 7389.5 7421.4 7433.1 7588.3 7621.5 7630.8 5836.7 5843.0 5885.0 5901.4 5907.3 5687.9 5846.4 6299.8 6316.7 6327.6 5598.9 5737.1 5766.6 5845.6 5877.0 5559.7 5600.3 5838.7 5939.2 5954.4 6148.3 6180.5 6188.3 6189.1 6209.6 5713.6 5777.5 5819.0 5826.6 5845.2 5810.5 5856.6 5857.9 5859.3 5861.4 18:57:48 INFO - 2015-11-16 18:57:48,742 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,742 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4564.53 Median:5294.87 stddev:1392.83 (26.3%) stddev-sans-first:1358.89 18:57:48 INFO - 2015-11-16 18:57:48,742 DEBUG : BROWSER_OUTPUT: Values: 267.6 270.9 272.8 279.4 283.3 5266.9 5322.8 5366.7 5383.1 5383.8 5037.6 5234.6 5246.4 5247.8 5255.3 3841.9 3900.8 3930.2 3992.6 4009.6 3988.4 4003.0 4004.6 4017.4 4019.3 3798.8 3973.0 3973.2 3976.1 3977.6 3834.2 3899.2 3909.1 3914.6 3940.9 3361.9 3365.3 3368.9 3369.1 3369.2 5061.5 5064.3 5079.1 5082.3 5093.7 4502.5 4508.2 4511.7 4515.1 4515.9 5368.1 5514.5 5525.5 5544.4 5544.5 3656.4 3656.5 3661.5 3661.6 3663.4 5755.8 5829.1 5836.0 5837.9 5839.3 3834.3 3835.8 3838.6 3839.5 3839.8 3738.3 3879.3 3885.0 3891.8 3891.8 4523.4 4524.3 4525.3 4527.8 4534.7 5554.3 5560.1 5560.7 5562.5 5566.0 1341.5 1369.8 1370.7 1371.1 1371.5 887.7 893.3 898.7 916.6 918.7 4927.6 4940.5 4940.6 4947.0 4948.9 5750.4 5757.0 5768.8 5769.6 5772.2 4934.6 4936.3 4940.8 4943.1 4943.6 2969.5 3004.0 3052.4 3053.8 3081.0 5458.3 5481.8 5503.2 5513.5 5515.5 5935.1 5936.6 5940.3 5945.0 5947.4 5376.6 5482.8 5485.8 5494.1 5506.4 5755.0 5760.0 5771.4 5778.8 5791.6 5634.8 5638.4 5639.7 5654.2 5674.3 5477.3 5486.1 5487.7 5492.8 5502.5 3757.4 3823.4 3837.3 3846.6 3856.1 5764.3 5764.4 5768.9 5772.2 5774.9 5568.8 5580.9 5583.2 5583.7 5585.5 5386.1 5565.9 5571.6 5571.6 5577.9 5428.2 5429.8 5430.9 5433.2 5438.3 5614.9 5615.4 5616.4 5620.9 5626.8 5479.5 5486.0 5486.4 5487.7 5491.2 18:57:48 INFO - 2015-11-16 18:57:48,742 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-16 18:57:48,742 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11585.74 Median:48893.76 stddev:13669.38 (28.0%) stddev-sans-first:13683.42 18:57:48 INFO - 2015-11-16 18:57:48,743 DEBUG : BROWSER_OUTPUT: Values: 731.6 736.5 742.0 768.6 782.3 11183.2 13540.3 13545.3 13604.9 13650.6 11880.7 12031.8 12034.7 12035.6 12045.1 585.7 593.4 745.7 749.7 761.6 744.1 745.4 751.5 751.7 751.8 786.8 791.7 793.6 793.6 794.1 611.0 620.3 772.7 784.6 788.2 573.4 578.2 578.7 578.7 579.2 11087.6 11665.8 11681.8 11686.1 11687.5 8906.5 9016.1 9080.7 9211.9 9705.5 8528.8 8586.4 8705.1 8746.4 9036.3 2805.1 2824.6 2855.7 2895.4 2899.5 38843.4 39115.8 39195.2 39209.4 39292.6 7014.2 7121.7 7165.9 7217.2 7267.5 11028.2 11126.3 11126.8 11167.2 11172.6 5276.4 5717.6 5741.0 5821.0 5938.6 3653.7 3733.1 3761.9 3787.8 3851.1 2367.3 2548.4 2601.9 2607.0 2609.1 442.3 443.2 452.3 453.7 454.2 420.3 437.9 449.0 482.7 518.4 7189.6 7359.2 7389.1 7498.3 7511.9 456.1 463.6 499.8 549.9 556.5 3178.2 3248.8 3259.2 3527.8 3540.4 44388.8 48168.8 48790.5 48861.8 48925.8 43277.6 44113.3 44171.8 44417.8 45924.8 41835.0 42347.6 42422.0 42666.4 42898.8 7414.0 7455.4 7690.4 7706.4 7943.5 29438.9 30050.4 30944.2 31501.8 31650.2 36900.6 36911.0 37528.8 37693.6 39823.2 6541.3 6692.2 6739.9 7099.6 7204.0 10607.8 10630.2 10755.7 10773.4 10880.4 9647.0 9674.4 9774.1 9822.1 10413.2 10016.7 10126.3 10422.8 10565.4 10598.5 9263.7 9336.3 9449.5 9492.2 9618.1 8155.6 8308.8 8338.6 8384.5 8619.8 6903.7 7443.8 7500.7 7666.2 7709.9 18:57:48 INFO - 2015-11-16 18:57:48,743 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:57:48 INFO - 2015-11-16 18:57:48,744 DEBUG : BROWSER_OUTPUT: 18:57:49 INFO - 2015-11-16 18:57:49,482 INFO : Browser exited with error code: 0 18:57:49 INFO - 2015-11-16 18:57:49,498 INFO : Completed test dromaeo_css (00:18:37) 18:57:49 INFO - 2015-11-16 18:57:49,498 INFO : Starting test kraken 18:57:49 INFO - 2015-11-16 18:57:49,498 DEBUG : operating with platform_type : linux_ 18:57:49 INFO - 2015-11-16 18:57:49,498 INFO : Initialising browser for kraken test... 18:57:49 INFO - 2015-11-16 18:57:49,504 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXnDXOK/profile http://localhost:39339/getInfo.html 18:57:53 INFO - 2015-11-16 18:57:53,444 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:57:53 INFO - 2015-11-16 18:57:53,445 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:57:53 INFO - 2015-11-16 18:57:53,445 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:57:53 INFO - 2015-11-16 18:57:53,445 DEBUG : BROWSER_OUTPUT: __metrics 18:57:53 INFO - 2015-11-16 18:57:53,561 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:57:54 INFO - 2015-11-16 18:57:54,823 INFO : Browser initialized. 18:57:54 INFO - 2015-11-16 18:57:54,823 INFO : Running cycle 1/1 for kraken test... 18:57:54 INFO - 2015-11-16 18:57:54,824 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXnDXOK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:58:06 INFO - 2015-11-16 18:58:06,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 141905920 18:58:06 INFO - 2015-11-16 18:58:06,766 DEBUG : BROWSER_OUTPUT: 18:58:09 INFO - 2015-11-16 18:58:09,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39339/tests/kraken/driver.html?testName=audio-beat-detection) 18:58:09 INFO - 2015-11-16 18:58:09,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 178827264 18:58:09 INFO - 2015-11-16 18:58:09,925 DEBUG : BROWSER_OUTPUT: 18:58:12 INFO - 2015-11-16 18:58:12,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39339/tests/kraken/driver.html?testName=audio-dft) 18:58:13 INFO - 2015-11-16 18:58:13,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 168468480 18:58:13 INFO - 2015-11-16 18:58:13,228 DEBUG : BROWSER_OUTPUT: 18:58:16 INFO - 2015-11-16 18:58:16,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39339/tests/kraken/driver.html?testName=audio-fft) 18:58:16 INFO - 2015-11-16 18:58:16,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 150286336 18:58:16 INFO - 2015-11-16 18:58:16,744 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-16 18:58:18,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39339/tests/kraken/driver.html?testName=audio-oscillator) 18:58:19 INFO - 2015-11-16 18:58:19,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 153563136 18:58:19 INFO - 2015-11-16 18:58:19,356 DEBUG : BROWSER_OUTPUT: 18:58:21 INFO - 2015-11-16 18:58:21,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:58:22 INFO - 2015-11-16 18:58:22,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 154583040 18:58:22 INFO - 2015-11-16 18:58:22,122 DEBUG : BROWSER_OUTPUT: 18:58:25 INFO - 2015-11-16 18:58:25,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39339/tests/kraken/driver.html?testName=imaging-darkroom) 18:58:25 INFO - 2015-11-16 18:58:25,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 155013120 18:58:25 INFO - 2015-11-16 18:58:25,663 DEBUG : BROWSER_OUTPUT: 18:58:29 INFO - 2015-11-16 18:58:29,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39339/tests/kraken/driver.html?testName=imaging-desaturate) 18:58:29 INFO - 2015-11-16 18:58:29,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 157216768 18:58:29 INFO - 2015-11-16 18:58:29,726 DEBUG : BROWSER_OUTPUT: 18:58:32 INFO - 2015-11-16 18:58:32,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39339/tests/kraken/driver.html?testName=json-parse-financial) 18:58:33 INFO - 2015-11-16 18:58:33,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 156041216 18:58:33 INFO - 2015-11-16 18:58:33,136 DEBUG : BROWSER_OUTPUT: 18:58:34 INFO - 2015-11-16 18:58:34,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:58:35 INFO - 2015-11-16 18:58:35,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 166203392 18:58:35 INFO - 2015-11-16 18:58:35,448 DEBUG : BROWSER_OUTPUT: 18:58:37 INFO - 2015-11-16 18:58:37,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39339/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:37 INFO - 2015-11-16 18:58:37,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 164405248 18:58:37 INFO - 2015-11-16 18:58:37,933 DEBUG : BROWSER_OUTPUT: 18:58:40 INFO - 2015-11-16 18:58:40,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:40 INFO - 2015-11-16 18:58:40,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 172507136 18:58:40 INFO - 2015-11-16 18:58:40,631 DEBUG : BROWSER_OUTPUT: 18:58:43 INFO - 2015-11-16 18:58:43,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:43 INFO - 2015-11-16 18:58:43,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 181374976 18:58:43 INFO - 2015-11-16 18:58:43,792 DEBUG : BROWSER_OUTPUT: 18:58:46 INFO - 2015-11-16 18:58:46,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:46 INFO - 2015-11-16 18:58:46,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 179150848 18:58:46 INFO - 2015-11-16 18:58:46,960 DEBUG : BROWSER_OUTPUT: 18:58:48 INFO - 2015-11-16 18:58:48,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39339/tests/kraken/driver.html?testName=ai-astar) 18:58:48 INFO - 2015-11-16 18:58:48,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 237793280 18:58:48 INFO - 2015-11-16 18:58:48,996 DEBUG : BROWSER_OUTPUT: 18:58:48 INFO - 2015-11-16 18:58:48,997 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:58:48 INFO - 2015-11-16 18:58:48,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:58:48 INFO - 2015-11-16 18:58:48,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:58:48 INFO - 2015-11-16 18:58:48,997 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:58:48 INFO - 2015-11-16 18:58:48,998 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;112;112;113;103;113;117;112 18:58:49 INFO - 2015-11-16 18:58:48,998 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;169;133;152;163;135;153;154;129;166;131 18:58:49 INFO - 2015-11-16 18:58:48,998 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;163;161;161;160;159;161;161;163 18:58:49 INFO - 2015-11-16 18:58:48,998 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;76;91;73;73;73;101;97;72 18:58:49 INFO - 2015-11-16 18:58:48,999 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;131;90;91;91;131;91;92;141 18:58:49 INFO - 2015-11-16 18:58:48,999 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;109;110;110;109;109 18:58:49 INFO - 2015-11-16 18:58:48,999 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;147;148;148;148;148;148;148 18:58:49 INFO - 2015-11-16 18:58:48,999 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;96;95;96;95 18:58:49 INFO - 2015-11-16 18:58:48,999 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;71;69;70;70;70;69;79;68;68 18:58:49 INFO - 2015-11-16 18:58:49,000 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;69;71;70;69;70 18:58:49 INFO - 2015-11-16 18:58:49,000 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;91;82;83;85;82;83;85;83;83 18:58:49 INFO - 2015-11-16 18:58:49,000 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;121;132;136;135;119;129;120;126;124 18:58:49 INFO - 2015-11-16 18:58:49,000 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;137;149;147;149;138;150;150;148;138 18:58:49 INFO - 2015-11-16 18:58:49,001 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;68;69;70;70;70;70;71;71;70 18:58:49 INFO - 2015-11-16 18:58:49,001 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:58:49 INFO - 2015-11-16 18:58:49,001 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:58:49 INFO - 2015-11-16 18:58:49,001 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,976 18:58:49 INFO - 2015-11-16 18:58:49,002 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:58:49 INFO - 2015-11-16 18:58:49,002 DEBUG : BROWSER_OUTPUT: __startTimestamp1447729128996__endTimestamp 18:58:49 INFO - 2015-11-16 18:58:49,002 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.90 (3.5%) stddev-sans-first:4.14 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 112.0 112.0 113.0 103.0 113.0 117.0 112.0 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.50 stddev:15.31 (10.0%) stddev-sans-first:14.32 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: Values: 169.0 133.0 152.0 163.0 135.0 153.0 154.0 129.0 166.0 131.0 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,010 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 163.0 161.0 161.0 160.0 159.0 161.0 161.0 163.0 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.00 stddev:11.43 (15.7%) stddev-sans-first:11.82 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 76.0 91.0 73.0 73.0 73.0 101.0 97.0 72.0 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.20 Median:91.00 stddev:20.98 (23.1%) stddev-sans-first:21.78 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 131.0 90.0 91.0 91.0 131.0 91.0 92.0 141.0 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 18:58:49 INFO - 2015-11-16 18:58:49,011 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 109.0 18:58:49 INFO - 2015-11-16 18:58:49,012 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,012 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 18:58:49 INFO - 2015-11-16 18:58:49,012 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 148.0 18:58:49 INFO - 2015-11-16 18:58:49,012 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.30 Median:70.00 stddev:3.20 (4.6%) stddev-sans-first:3.36 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 69.0 70.0 70.0 70.0 69.0 79.0 68.0 68.0 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 71.0 70.0 69.0 70.0 18:58:49 INFO - 2015-11-16 18:58:49,013 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:2.82 (3.4%) stddev-sans-first:2.80 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: Values: 81.0 91.0 82.0 83.0 85.0 82.0 83.0 85.0 83.0 83.0 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.50 stddev:6.20 (4.9%) stddev-sans-first:6.45 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: Values: 123.0 121.0 132.0 136.0 135.0 119.0 129.0 120.0 126.0 124.0 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:148.50 stddev:5.80 (3.9%) stddev-sans-first:5.67 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: Values: 138.0 137.0 149.0 147.0 149.0 138.0 150.0 150.0 148.0 138.0 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,014 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.10 (1.6%) stddev-sans-first:0.93 18:58:49 INFO - 2015-11-16 18:58:49,015 DEBUG : BROWSER_OUTPUT: Values: 72.0 68.0 69.0 70.0 70.0 70.0 70.0 71.0 71.0 70.0 18:58:49 INFO - 2015-11-16 18:58:49,015 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:58:49 INFO - 2015-11-16 18:58:49,015 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-16 18:58:49,918 INFO : Browser exited with error code: 0 18:58:49 INFO - 2015-11-16 18:58:49,970 INFO : Completed test kraken (00:01:00) 18:58:49 INFO - 2015-11-16 18:58:49,971 INFO : Starting test v8_7 18:58:49 INFO - 2015-11-16 18:58:49,971 DEBUG : operating with platform_type : linux_ 18:58:49 INFO - 2015-11-16 18:58:49,971 INFO : Initialising browser for v8_7 test... 18:58:49 INFO - 2015-11-16 18:58:49,977 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprOYrxv/profile http://localhost:39339/getInfo.html 18:58:54 INFO - 2015-11-16 18:58:54,057 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:58:54 INFO - 2015-11-16 18:58:54,058 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:58:54 INFO - 2015-11-16 18:58:54,058 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:58:54 INFO - 2015-11-16 18:58:54,058 DEBUG : BROWSER_OUTPUT: __metrics 18:58:54 INFO - 2015-11-16 18:58:54,280 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:58:55 INFO - 2015-11-16 18:58:55,597 INFO : Browser initialized. 18:58:55 INFO - 2015-11-16 18:58:55,598 INFO : Running cycle 1/1 for v8_7 test... 18:58:55 INFO - 2015-11-16 18:58:55,598 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprOYrxv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:59:07 INFO - 2015-11-16 18:59:07,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 142032896 18:59:07 INFO - 2015-11-16 18:59:07,454 DEBUG : BROWSER_OUTPUT: 18:59:28 INFO - 2015-11-16 18:59:28,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39339/tests/v8_7/run.html (next: http://localhost:39339/tests/v8_7/run.html) 18:59:29 INFO - 2015-11-16 18:59:29,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 442683392 18:59:29 INFO - 2015-11-16 18:59:29,100 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,100 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:59:29 INFO - 2015-11-16 18:59:29,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:59:29 INFO - 2015-11-16 18:59:29,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:59:29 INFO - 2015-11-16 18:59:29,100 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:59:29 INFO - 2015-11-16 18:59:29,100 DEBUG : BROWSER_OUTPUT: |0;Richards;170.41581458759373 18:59:29 INFO - 2015-11-16 18:59:29,100 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.19680953296177 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: |5;Earley;811.0300081103001 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: |8;Splay;615.573267933783 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 18:59:29 INFO - 2015-11-16 18:59:29,101 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:59:29 INFO - 2015-11-16 18:59:29,102 DEBUG : BROWSER_OUTPUT: __startTimestamp1447729169093__endTimestamp 18:59:29 INFO - 2015-11-16 18:59:29,102 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,102 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:59:29 INFO - 2015-11-16 18:59:29,102 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:59:29 INFO - 2015-11-16 18:59:29,102 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,102 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.42 Median:170.42 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,102 DEBUG : BROWSER_OUTPUT: Values: 170.4 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.20 Median:192.20 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: Values: 192.2 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: Values: 279.2 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: Values: 5020.0 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: Values: 1990.1 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,103 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:811.03 Median:811.03 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: Values: 811.0 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: Values: 12048.2 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: Values: 26205.1 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.57 Median:615.57 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: Values: 615.6 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: Values: 4822.1 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:59:29 INFO - 2015-11-16 18:59:29,104 DEBUG : BROWSER_OUTPUT: 18:59:29 INFO - 2015-11-16 18:59:29,958 INFO : Browser exited with error code: 0 18:59:29 INFO - 2015-11-16 18:59:29,976 INFO : Completed test v8_7 (00:00:40) 18:59:30 INFO - 2015-11-16 18:59:30,145 INFO : Completed test suite (00:20:18) 18:59:30 INFO - 2015-11-16 18:59:30,145 DEBUG : Working with test: dromaeo_css 18:59:30 INFO - 2015-11-16 18:59:30,145 DEBUG : Generating results file: dromaeo_css 18:59:30 INFO - 2015-11-16 18:59:30,146 DEBUG : Working with test: kraken 18:59:30 INFO - 2015-11-16 18:59:30,146 DEBUG : Generating results file: kraken 18:59:30 INFO - 2015-11-16 18:59:30,146 INFO : javascript benchmark 18:59:30 INFO - 2015-11-16 18:59:30,147 DEBUG : Working with test: v8_7 18:59:30 INFO - 2015-11-16 18:59:30,147 DEBUG : Generating results file: v8_7 18:59:30 INFO - 2015-11-16 18:59:30,147 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:30 INFO - 2015-11-16 18:59:30,207 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 18:59:30 INFO - 2015-11-16 18:59:30,207 DEBUG : process_Request line: dromaeo_css 5877.22 graph.html#tests=[[72,94,35]] 18:59:30 INFO - 2015-11-16 18:59:30,207 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:30 INFO - 2015-11-16 18:59:30,240 DEBUG : process_Request line: kraken 1522.70 graph.html#tests=[[232,94,35]] 18:59:30 INFO - 2015-11-16 18:59:30,241 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:30 INFO - 2015-11-16 18:59:30,267 DEBUG : process_Request line: v8_7 19734.14 graph.html#tests=[[230,94,35]] 18:59:30 INFO - 2015-11-16 18:59:30,269 INFO : javascript benchmark 18:59:30 INFO - 2015-11-16 18:59:30,273 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [326.6619049283993, 336.43478955354993, 341.53892245468614, 343.1164750766776, 345.39038596876503, 12640.683982900433, 12959.676008099803, 15196.924015379922, 15293.388264469422, 17709.468715938525, 14853.405863765436, 14892.106473611564, 14991.47529836456, 15019.849801502009, 15047.172405517693, 4381.737095774256, 4500.324951257305, 4888.973315603727, 5025.623078269126, 5056.772445239973, 3507.964920350802, 3637.5271214742047, 5569.693666848321, 5728.68492232927, 5735.913961290584, 5637.408072152406, 5648.0, 5666.348369937448, 5676.091825307952, 5695.74369153387, 4191.517975432818, 4283.057727299989, 4287.528371879091, 4293.076988447483, 4300.1614685136565, 3697.2605478904325, 3709.7403181777286, 3743.5882052974152, 3748.381517049711, 3748.850045998157, 10986.395748233845, 11190.776184476264, 11194.832077518844, 11195.160362972809, 11208.831867521994, 1706.2492503298508, 1726.6287748134087, 1731.8701097417745, 1751.509577318353, 1797.7752780902388, 8724.607392667345, 8997.775055623597, 9014.504202268872, 9028.187463128284, 9183.448993060438, 1598.1769388764797, 1607.718649236379, 1644.7944006999126, 1677.6476939842526, 1694.305334812721, 52613.47386526124, 53514.197287040726, 53872.73063634696, 54489.41075705747, 54652.72673636646, 6434.2600600930555, 6529.477641788645, 6552.705128269239, 6583.144191255106, 6600.273969863311, 7392.4825262231125, 7396.667149978264, 7396.815079622945, 7420.146683131401, 7458.179600243969, 5022.874428139326, 5053.823116190989, 5091.37076135633, 5100.821471248562, 5108.463611320833, 5135.38375394955, 5161.096808058574, 5174.275601415805, 5186.870328241824, 5191.922121168185, 2900.4054168895746, 2933.1787099612143, 2963.4517614241436, 2966.7626589872757, 2975.925601859971, 1002.1031177096457, 1008.969730908074, 1027.4965267019106, 1048.8321868501002, 1071.5124618298655, 384.1012031845495, 392.30757712637217, 394.9348357521034, 402.3502044198657, 420.05487652781244, 9975.251856110675, 10127.645532406477, 10153.746156346151, 10287.177025837915, 10387.636432724817, 403.9616236457532, 411.3254263008668, 415.40804353796324, 418.49780263683704, 436.07769567365426, 5414.022287741726, 5683.460071293221, 5769.048107062287, 5791.681457519792, 5878.823635290948, 314323.0, 472995.0, 478753.0, 483716.0, 493890.0, 52966.0, 64168.0, 70503.64748176328, 71558.0, 73002.0, 423.3586117032698, 430.52212044630437, 434.0710878719606, 435.06461108616725, 435.4687281516545, 9266.53667316618, 9478.0, 9504.33469657145, 9537.189338905993, 9572.090651388386, 30252.394952101276, 30776.230594235323, 31779.841100794347, 32577.511337329484, 33906.0, 41730.374044389966, 41787.0, 41931.58068419277, 42134.36798447964, 43182.56817431786, 5579.776808927598, 5590.2453168821685, 5655.660660360391, 5694.658320500783, 5700.800471983461, 10109.443980581138, 10192.184625229815, 10209.285350025428, 10427.113695335678, 10452.059314661718, 8939.463632182089, 9018.639254430012, 9021.368504204642, 9160.31297652692, 9436.245100392089, 8743.956280218557, 8766.298696104424, 8883.600237989434, 8979.865302020344, 9080.636774528944, 8683.175098365646, 8719.564021799011, 9215.677451289173, 9353.11145441182, 9382.202512786489, 5532.778688852401, 5538.224648549126, 5606.719664016701, 5607.943920560742, 5621.747021383966, 8963.910360896569, 9016.233620142362, 9021.097890210927, 9081.636734530544, 9389.85915211286], "dojo.html": [2621.750933661302, 2732.3169207698074, 2733.986330068349, 2745.931351716207, 2754.3389586499234, 4493.0, 4616.3767891334655, 4671.439427268729, 4763.73799441031, 4806.0628177505405, 4642.257238841786, 4646.512116227798, 4681.625469962403, 4718.551737584932, 4723.645726570512, 4341.4790225172865, 4343.435353404053, 4367.4322338096, 4379.824807007716, 4384.408104905845, 4222.282212023948, 4444.511103778582, 4466.084452687208, 4490.191765482212, 4492.707973981697, 4277.636400905927, 4327.4374331336885, 4346.369776382407, 4364.236258654754, 4377.956220437787, 4352.8476503322545, 4369.344598310247, 4375.278079116942, 4383.583559561836, 4411.911761764779, 4126.958730412687, 4273.038566322583, 4339.826406943718, 4363.410939523187, 4411.183930972748, 4538.909221815578, 4643.698159619647, 4647.024124933768, 4657.743824089674, 4694.929576056362, 5115.514026167508, 5119.360079990001, 5119.667221630582, 5124.897502049976, 5129.281900533928, 4814.951850481485, 4935.629827762932, 4937.728424936627, 5122.974385128088, 5126.641135120543, 4598.632109431271, 4655.4878963314, 4657.04530571232, 4671.462781780138, 4708.03485285519, 5138.820141295037, 5158.148905430637, 5224.2947202127225, 5232.9738351308, 5286.894262114736, 4750.263709125091, 4858.975705121452, 4863.319135321058, 5008.724520151427, 5018.071656743514, 4904.337914381585, 5009.474005229471, 5014.623903207274, 5016.623753218523, 5034.798608055637, 5045.243213517928, 5086.0, 5086.338775959176, 5087.135187018216, 5136.486351364833, 4831.251156070814, 5038.2190760432195, 5053.140966035783, 5061.772220250097, 5075.695458272516, 4034.0, 4137.668986481074, 4138.275801734684, 4150.709450338447, 4151.4395556600075, 3673.5959044505084, 3676.283124790694, 3687.520622319081, 3717.9218026772473, 3720.572134204547, 4421.646268298528, 4437.866863994085, 4441.733495990251, 4444.3333499974615, 4478.373027776114, 4812.735299558488, 4925.310456536088, 4931.161702510582, 4963.6277279204205, 5111.463296353903, 4412.0, 4423.668224883147, 4429.0, 4445.644348452116, 4481.417415735934, 4502.932456013163, 4526.637868970474, 4528.728276303433, 4541.409616749867, 4579.931301030487, 4638.443386793607, 4708.788104535372, 4778.5699287064335, 4783.6412269079265, 4896.706197628154, 5094.592432605456, 5096.541311282002, 5098.1588037973315, 5107.821226257063, 5128.051310507568, 4861.295112208639, 4865.56209941107, 4866.853994380174, 4869.780859861244, 4902.411710594752, 4696.084263568571, 4816.566509014206, 4820.25286080658, 4830.3237546744185, 5072.9746351268, 5004.074246264453, 5010.221371413096, 5024.221245706921, 5030.295758593873, 5035.471275516018, 4754.049190162051, 4870.829520966891, 4873.976464942401, 4894.632902532253, 4905.313256144072, 4918.0, 4948.035133149146, 4960.801567937242, 4969.329140566122, 4990.451050384528, 4608.147492713859, 4737.620990320697, 4816.614670826396, 4850.854474365775, 4895.902081958412, 4791.544803243686, 4878.268259761065, 4887.0, 4893.119238537098, 4924.01519696055, 4792.640551958687, 4840.661153719206, 4848.200046992207, 4850.80596776125, 4883.60931125502], "mootools.html": [1354.5529975108216, 1552.2859484637067, 1627.0237857285626, 1637.1977730911856, 1663.4094896311817, 5805.245318108645, 6038.094285857123, 6529.347065293468, 6714.060031595581, 6722.487440325925, 6886.862262754742, 6904.551204171726, 6921.757738479154, 6926.896096558543, 6947.131608548932, 1689.9408520701777, 1733.8959662420295, 2005.3683089826695, 2028.1887245102002, 2031.0149577454922, 2013.2953466286756, 2063.8761674299517, 2070.2029718558388, 2070.5030792609814, 2071.9482012949647, 1941.9708704369446, 1960.1081507913937, 1965.2335589120255, 1970.359633119242, 1989.9403017909485, 1974.6050789842018, 2000.6798912173983, 2004.6191223667602, 2005.8395328373767, 2005.8796472211714, 1933.1204302042536, 1986.4934441717414, 1989.5523507210762, 1990.6317331293612, 1991.2234228650839, 6890.965545172242, 6898.758543450955, 6937.202221744514, 6940.201876784184, 6986.056882320872, 3984.2629113613784, 4027.2750904837117, 4038.414429907647, 4052.8378864845668, 4059.939100913489, 2639.934001649955, 2665.8400495970304, 2736.179146256115, 2750.4499100179846, 2758.9862050689817, 815.1196707555825, 1645.9506214813575, 1647.1681800690694, 1722.5779683977505, 1783.6432713457361, 9164.679236226766, 9169.770755731093, 9201.67794127209, 9223.44659320443, 9243.6302547898, 3539.7876127432437, 3583.0, 3607.6933460655614, 3651.123730304708, 3651.7808931464197, 7415.555066696015, 7425.331720145213, 7444.664990075459, 7450.403967682572, 7450.888236676454, 4002.4996875390575, 4025.6175663311938, 4028.576999415078, 4034.072163402434, 4035.3745169498775, 3719.88840334785, 3722.4974628424816, 3725.0873535983856, 3725.4970578972034, 3726.049857286375, 2722.0881004863195, 2773.195773225742, 3053.3435311408152, 3056.43455960648, 3105.5652208690803, 902.1474706402518, 906.1029580715176, 909.490685216281, 912.885889263842, 927.3786563002805, 903.6882275614902, 928.9907100929039, 930.7952250504878, 961.5144352102144, 1146.5986904583497, 6456.483481321483, 6503.479721622259, 6520.282768895418, 6527.738890444424, 6531.0856480092825, 555.552784995082, 563.2846285217751, 563.5322682173786, 564.0833645326345, 703.8979347994513, 4691.906161876744, 5256.316678831728, 5257.868553286198, 5259.21111833228, 5264.0, 8048.436609437284, 8432.030316513557, 8462.619182136696, 8466.195711407407, 8474.703385381483, 7819.68721251155, 7883.172266912006, 7892.60536973149, 7949.6025198739835, 8004.119546849958, 6287.559870809091, 6359.713812878432, 6420.807375778734, 6424.196975378078, 6429.935700643027, 6323.525735569942, 6382.521310901794, 6425.967870160619, 6427.517936154713, 6441.71012304438, 6961.965190174017, 7224.783256502314, 7261.564306141649, 7298.96350518244, 7389.519681220703, 7421.369183619453, 7433.070866141732, 7588.317051465395, 7621.466497345133, 7630.847383052419, 5836.708164591839, 5842.970785146047, 5884.9705751470965, 5901.439363260483, 5907.2911250650195, 5687.857803554779, 5846.386129456516, 6299.811005669837, 6316.652584107918, 6327.557071004985, 5598.86002849932, 5737.053386191398, 5766.596338256281, 5845.561582881386, 5877.0302900022725, 5559.6664200148125, 5600.299962504687, 5838.678872662044, 5939.227900372924, 5954.404559544184, 6148.262208535004, 6180.47465965398, 6188.257409110935, 6189.102580125947, 6209.59637623553, 5713.571482138773, 5777.45114214149, 5819.039858423313, 5826.592138550261, 5845.240118784531, 5810.506106980785, 5856.560757943256, 5857.853553661193, 5859.296884373903, 5861.443162899518], "ext.html": [559.2506041903848, 570.9921987691722, 571.8913406452772, 575.7466714645553, 584.5090124295593, 28084.859575702118, 35836.82081589592, 36391.454128188096, 36440.271194576126, 36457.635423645756, 39894.8005259974, 40367.59632403675, 40376.79811600945, 40444.19111617766, 40453.39319910196, 7151.32062454066, 7287.125544934589, 7859.0, 8020.67917283308, 8022.237887400687, 10252.94873525635, 10502.68491945243, 10520.421376824272, 10533.84199237012, 10553.577856885715, 10104.141148002429, 10192.745181370488, 10225.028622280872, 10226.642067527639, 10237.539310731036, 7308.123025236952, 7505.437092218105, 10149.594016239378, 10256.846147307797, 10540.262181647287, 9903.504824758806, 10009.549570269355, 10033.698989030341, 10043.096121349114, 10051.798964020752, 37721.0, 38328.233435331415, 38330.0, 38403.231935361415, 38410.231795363936, 2757.696653368128, 2915.3586211033753, 3393.2704468539137, 3497.422925217336, 3625.111847597329, 28216.858915705496, 28710.71289287101, 29217.561736573756, 29345.85327073351, 29497.852510737524, 3016.276093737509, 3040.285532899789, 3046.2384403899027, 3100.534919762031, 3144.292534179814, 228652.99999999834, 228704.0, 229389.0, 230047.0, 232529.0, 49863.50136498661, 51412.22881656778, 54326.18510722342, 55347.723261383435, 55458.16812747812, 51101.0, 51126.0, 51281.743591281804, 51354.22968655473, 51408.485915141115, 14069.155850648995, 14311.499097531745, 14321.6419589509, 14325.068870523382, 14358.497452589108, 10114.54484548197, 10217.642382516726, 10233.846492302622, 10285.074343309137, 10313.174946004301, 18377.17302721381, 18560.721589176173, 18589.535261618566, 18609.0, 18622.0, 6455.386738259858, 6620.337966203341, 6743.325667433315, 6745.381108533917, 6745.561538499982, 774.6436639146056, 844.2064459408136, 890.5636238243214, 905.9547022648841, 973.1728031173446, 25928.874998755695, 26785.598216026774, 26913.327166820596, 26935.0, 27019.0, 895.1540793949786, 943.9339246252833, 1000.3797645459862, 1051.3166441812882, 1051.673981065872, 12803.0, 12805.807912881315, 12981.0, 13033.47866085346, 13042.869571304165, 268724.0, 271296.0, 272816.0, 273735.0, 273870.0, 45436.54563454323, 45842.770786146524, 45850.31224531568, 45905.31142032872, 45914.770426147654, 1152.5850693750244, 1228.8709685483075, 1231.599730087725, 1239.0026029046703, 1252.3300034481508, 20341.288054918008, 21330.57338853245, 21747.782522174577, 22132.88933555322, 22704.65943010889, 35269.64730352664, 35919.64080359163, 38004.809975949946, 38275.80862095672, 41247.0, 223080.0, 225167.0, 226000.0, 226212.0, 226425.0, 27692.0, 27841.0, 28011.918688944606, 28663.140105796858, 29116.56325155082, 37111.0, 37734.81132594319, 38029.0, 38060.80969595134, 38168.427473588476, 31193.220169495944, 31987.360252794348, 32312.35375292528, 32652.346953061282, 32841.343173136884, 31496.685033149377, 32414.189645259055, 36038.0, 36497.27005459929, 36628.08429789277, 32699.836500817342, 32923.50614740733, 32948.1762955928, 33267.500987484724, 33398.332033359686, 36755.0, 37899.242015160096, 38895.805520972215, 40471.79764101161, 40890.79554602327, 29150.416991660473, 29470.705292947652, 29475.705242947297, 29938.25154371158, 29960.400791984473], "prototype.html": [267.5999380925516, 270.8889355364301, 272.84311520875497, 279.3895338684972, 283.27199098317334, 5266.894662106755, 5322.840314790557, 5366.651167674098, 5383.057964856154, 5383.757730902109, 5037.5718063964605, 5234.555062819665, 5246.37043554773, 5247.842564723064, 5255.290535777669, 3841.865534706286, 3900.8244628991765, 3930.2139572085553, 3992.6406623403886, 4009.578994205603, 3988.4017397390335, 4003.0, 4004.5795191504762, 4017.3973903914352, 4019.31671615826, 3798.810059497028, 3972.9602703973023, 3973.165635216608, 3976.1252524444576, 3977.6420122189143, 3834.1564855731694, 3899.1811719538646, 3909.1009067914256, 3914.588968158345, 3940.9014774630577, 3361.949570756416, 3365.2764655599162, 3368.8652453901814, 3369.0566641340465, 3369.22507823202, 5061.519155680241, 5064.265681476202, 5079.1365467870555, 5082.3138876251605, 5093.719845408501, 4502.459704835408, 4508.1659892919915, 4511.729296242203, 4515.119551687422, 4515.909681806378, 5368.141097424394, 5514.503694667499, 5525.475079867406, 5544.44955320549, 5544.528715059225, 3656.3601369760186, 3656.542932133483, 3661.450782382664, 3661.6338366163172, 3663.377225871608, 5755.827325180209, 5829.067349224146, 5836.0, 5837.941620583782, 5839.299284085894, 3834.309824231665, 3835.846566137379, 3838.6353296436796, 3839.520059992445, 3839.7504162229366, 3738.336440284102, 3879.301725689403, 3885.048163200034, 3891.7664940103687, 3891.785951772623, 4523.36672865799, 4524.321351797191, 4525.321201819754, 4527.7736113194205, 4534.7052441591195, 5554.250176226238, 5560.138178582326, 5560.694161821139, 5562.527185189223, 5565.972170139124, 1341.530464337474, 1369.7808350663845, 1370.6915943912738, 1371.0882263294798, 1371.5062577472102, 887.729242581006, 893.3433926064338, 898.6989358564823, 916.6058594804298, 918.7243826851918, 4927.605791536668, 4940.456549779521, 4940.629452791055, 4947.035328111056, 4948.90102197954, 5750.4249575042995, 5757.0, 5768.826935191951, 5769.596128271065, 5772.191893134965, 4934.605231581465, 4936.284238785356, 4940.777665005084, 4943.060818444484, 4943.604511639061, 2969.4506516294555, 3003.9849800751294, 3052.420040192401, 3053.801502902304, 3080.969190308113, 5458.317710286215, 5481.835544933659, 5503.174523821379, 5513.531349835309, 5515.503604675519, 5935.080062590306, 5936.5547583931375, 5940.287165540163, 5944.970275148597, 5947.434993675594, 5376.623636345418, 5482.766377565016, 5485.835424937259, 5494.09347457665, 5506.394296627368, 5754.971225143848, 5760.049591817303, 5771.365149833431, 5778.797742079007, 5791.565632577658, 5634.802781902614, 5638.407967163389, 5639.746211420578, 5654.15187721845, 5674.347450043298, 5477.315335583052, 5486.149646804752, 5487.725613719218, 5492.780288788404, 5502.477264659851, 3757.380032294641, 3823.388257878726, 3837.270918525471, 3846.5576458707606, 3856.1130939883424, 5764.279465066867, 5764.36591974874, 5768.913466298093, 5772.163036359789, 5774.9133762994425, 5568.832935011957, 5580.944190558205, 5583.246261754611, 5583.720813959205, 5585.525230355465, 5386.111291636836, 5565.916511252253, 5571.554275658019, 5571.582131340085, 5577.9442205577425, 5428.240046393587, 5429.782808687608, 5430.891382172414, 5433.185022246695, 5438.265834112344, 5614.915776263278, 5615.354234263112, 5616.38219795814, 5620.85947851307, 5626.831195064155, 5479.506844384025, 5485.9725701371235, 5486.423925487767, 5487.6981766003255, 5491.176323551499], "yui.html": [731.6159016516328, 736.5065406177862, 741.9703211871525, 768.6041688530406, 782.2881178127905, 11183.217174797757, 13540.322983850792, 13545.322733863291, 13604.863951360483, 13650.590482285535, 11880.702982425422, 12031.759364812699, 12034.69913252167, 12035.638930832089, 12045.096617753681, 585.689584520205, 593.3621357041177, 745.7352639812842, 749.7151082588622, 761.584936209767, 744.140517702055, 745.4036770583539, 751.4964973467789, 751.6692655231681, 751.7857410637969, 786.8386980668978, 791.7466410748563, 793.5635400529685, 793.5833687314149, 794.0947320055142, 611.016263815257, 620.3331418724866, 772.6947855597008, 784.619459562112, 788.1960400391569, 573.3950682030456, 578.1645522220393, 578.7164289498157, 578.7453520450988, 579.1804596495953, 11087.611933582286, 11665.76668466626, 11681.824772628332, 11686.123540734394, 11687.47406366707, 8906.465612063297, 9016.098390160996, 9080.727578172666, 9211.907880921171, 9705.514724263758, 8528.829423411496, 8586.356023298278, 8705.085965973609, 8746.387752857303, 9036.277097832224, 2805.14443094856, 2824.590434387023, 2855.7429831315076, 2895.406441679451, 2899.5416821503777, 38843.41734873979, 39115.804420977714, 39195.216095677926, 39209.41185882242, 39292.60707392918, 7014.22843487216, 7121.71513139479, 7165.89251161233, 7217.206107328189, 7267.4549408794555, 11028.22802403824, 11126.276792008493, 11126.833097503544, 11167.162462815322, 11172.553097876156, 5276.419593844674, 5717.599768016282, 5741.024025915604, 5821.0, 5938.61399009063, 3653.671169594696, 3733.0667333166707, 3761.9435708464393, 3787.791671458096, 3851.056491159684, 2367.277980216016, 2548.439343344461, 2601.9479610408066, 2606.973930260673, 2609.138984135269, 442.2570082261831, 443.21993291806007, 452.2921627652713, 453.72776334199216, 454.1915390604729, 420.3106904676333, 437.9408779814748, 448.9797959091849, 482.65249020705033, 518.4478530365149, 7189.6405179740805, 7359.190489046201, 7389.076365454318, 7498.287662672037, 7511.887321690179, 456.0992040719619, 463.6082510278809, 499.8200647766801, 549.9120140777457, 556.4630131922714, 3178.2213357727505, 3248.7888287261253, 3259.152620318687, 3527.7883327000463, 3540.4335306351377, 44388.77805610951, 48168.759156204695, 48790.5120948786, 48861.755691222024, 48925.75537122291, 43277.567224327984, 44113.33829992553, 44171.77914110473, 44417.77791111088, 45924.770376147906, 41835.0, 42347.57652423498, 42422.0, 42666.360004599956, 42898.78550607227, 7413.962930185315, 7455.440841936768, 7690.423218258541, 7706.383489320729, 7943.523388596703, 29438.85280573669, 30050.398992020473, 30944.226394340323, 31501.8424907874, 31650.208744781565, 36900.630993689716, 36911.0, 37528.81235593805, 37693.62306376901, 39823.20353592854, 6541.280459149585, 6692.230393504809, 6739.865202696017, 7099.621626755095, 7203.963980180066, 10607.840882386616, 10630.202734795075, 10755.731106722395, 10773.353598784099, 10880.401577913291, 9647.0, 9674.371165874196, 9774.12032917041, 9822.116009559173, 10413.219008574539, 10016.749581260527, 10126.341787783771, 10422.843657344994, 10565.418901960466, 10598.47007649599, 9263.675771347971, 9336.253099752139, 9449.480278584744, 9492.193163581172, 9618.134367906921, 8155.63299651529, 8308.750737477885, 8338.583070846555, 8384.455010424303, 8619.784505387415, 6903.689333979883, 7443.7766866991915, 7500.662470188746, 7666.156722760604, 7709.8843517348405]}, "summary": {"lowerIsBetter": false, "suite": 5877.221867780864, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6193.086112565176, "unit": "ms", "value": 6193.086112565176}, "dojo.html": {"lowerIsBetter": false, "filtered": 4625.162752207768, "unit": "ms", "value": 4625.162752207768}, "mootools.html": {"lowerIsBetter": false, "filtered": 3888.481564807775, "unit": "ms", "value": 3888.481564807775}, "ext.html": {"lowerIsBetter": false, "filtered": 17176.93941817555, "unit": "ms", "value": 17176.93941817555}, "prototype.html": {"lowerIsBetter": false, "filtered": 4104.795676135862, "unit": "ms", "value": 4104.795676135862}, "yui.html": {"lowerIsBetter": false, "filtered": 5247.28705701516, "unit": "ms", "value": 5247.28705701516}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447727951, "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": "20151116172211", "branch": "Firefox-Non-PGO", "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 163.0, 161.0, 161.0, 160.0, 159.0, 161.0, 161.0, 163.0], "ai-astar": [111.0, 112.0, 106.0, 112.0, 112.0, 113.0, 103.0, 113.0, 117.0, 112.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0], "audio-beat-detection": [169.0, 133.0, 152.0, 163.0, 135.0, 153.0, 154.0, 129.0, 166.0, 131.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0, 70.0, 69.0, 70.0], "stanford-crypto-pbkdf2": [138.0, 137.0, 149.0, 147.0, 149.0, 138.0, 150.0, 150.0, 148.0, 138.0], "json-parse-financial": [69.0, 71.0, 69.0, 70.0, 70.0, 70.0, 69.0, 79.0, 68.0, 68.0], "stanford-crypto-sha256-iterative": [72.0, 68.0, 69.0, 70.0, 70.0, 70.0, 70.0, 71.0, 71.0, 70.0], "audio-fft": [73.0, 73.0, 76.0, 91.0, 73.0, 73.0, 73.0, 101.0, 97.0, 72.0], "imaging-darkroom": [148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0], "stanford-crypto-ccm": [123.0, 121.0, 132.0, 136.0, 135.0, 119.0, 129.0, 120.0, 126.0, 124.0], "audio-oscillator": [92.0, 92.0, 131.0, 90.0, 91.0, 91.0, 131.0, 91.0, 92.0, 141.0], "stanford-crypto-aes": [81.0, 91.0, 82.0, 83.0, 85.0, 82.0, 83.0, 85.0, 83.0, 83.0], "imaging-desaturate": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1522.7, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.2, "unit": "ms", "value": 80.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 144.4, "unit": "ms", "value": 144.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 148.5, "unit": "ms", "value": 148.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 126.5, "unit": "ms", "value": 126.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.8, "unit": "ms", "value": 147.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 70.3, "unit": "ms", "value": 70.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.2, "unit": "ms", "value": 104.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.1, "unit": "ms", "value": 111.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.1, "unit": "ms", "value": 161.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.1, "unit": "ms", "value": 70.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.4, "unit": "ms", "value": 69.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.6, "unit": "ms", "value": 109.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 83.8, "unit": "ms", "value": 83.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.7, "unit": "ms", "value": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447727951, "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": "20151116172211", "branch": "Firefox-Non-PGO", "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.19680953296177], "Encrypt": [279.17364600781684], "NavierStokes": [4822.115384615385], "Decrypt": [5020.0], "Splay": [615.573267933783], "Richards": [170.41581458759373], "RegExp": [26205.128205128207], "Earley": [811.0300081103001], "Boyer": [12048.192771084337], "RayTrace": [1990.0596421471173]}, "summary": {"lowerIsBetter": false, "suite": 19734.13770523762, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.01195399999983, "unit": "score", "value": 344.01195399999983}, "Encrypt": {"lowerIsBetter": false, "filtered": 953.4603419999996, "unit": "score", "value": 953.4603419999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 53.0241035856574, "unit": "score", "value": 53.0241035856574}, "Splay": {"lowerIsBetter": false, "filtered": 132.38229183266938, "unit": "score", "value": 132.38229183266938}, "RegExp": {"lowerIsBetter": false, "filtered": 34.76361545988257, "unit": "score", "value": 34.76361545988257}, "Richards": {"lowerIsBetter": false, "filtered": 207.15213600000004, "unit": "score", "value": 207.15213600000004}, "Earley": {"lowerIsBetter": false, "filtered": 821.7488789999996, "unit": "score", "value": 821.7488789999996}, "Boyer": {"lowerIsBetter": false, "filtered": 55.31642899999996, "unit": "score", "value": 55.31642899999996}, "RayTrace": {"lowerIsBetter": false, "filtered": 371.84262437562455, "unit": "score", "value": 371.84262437562455}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447727951, "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": "20151116172211", "branch": "Firefox-Non-PGO", "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb"}}] 18:59:30 INFO - RETURN: dromaeo_css: 5877.22 18:59:30 INFO - RETURN: kraken: 1522.70 18:59:30 INFO - RETURN: v8_7: 19734.14 18:59:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19734.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1522.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5877.22"}}} 18:59:30 INFO - Return code: 0 18:59:30 INFO - # TBPL SUCCESS # 18:59:30 INFO - Running post-action listener: _resource_record_post_action 18:59:30 INFO - Running post-run listener: _resource_record_post_run 18:59:31 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 506863616; Read time: 0; Write time: 517264 18:59:31 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 214368256; Read time: 0; Write time: 293280 18:59:31 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 287637504; Read time: 0; Write time: 223336 18:59:31 INFO - Running post-run listener: _upload_blobber_files 18:59:31 INFO - Blob upload gear active. 18:59:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:59:31 INFO - Copying logs to upload dir... 18:59:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.776630 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-16 18:59:30.984329) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:59:30.988274) ========= 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=7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009904 build_url: 'https://queue.taskcluster.net/v1/task/DvKkBnz-RzeaBufjHaluBw/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-16 18:59:31.039909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:59:31.040225) ========= 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=7d909545e45784438f4e8e36000001b3-1447727907.357097-1747341763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:59:31.089758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:59:31.090091) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:59:31.090378) ========= ========= Total master_lag: 0.21 =========