builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1447765865.4 results: success (0) buildid: 20151117033907 builduid: 001d3c996cb64cc5b6b9b06c4e791c87 revision: 7c586c1697bef9e773068abdea2294f6b9c296ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.401527) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.402069) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.402382) ========= 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=f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006575 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.424726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.425013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.465747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.466059) ========= 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=f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004784 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.516057) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.516366) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.516768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.517063) ========= 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=f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 05:11:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.3M=0s 2015-11-17 05:11:06 (95.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175144 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.704971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.705303) ========= 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=f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017406 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.754622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:05.754986) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7c586c1697bef9e773068abdea2294f6b9c296ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7c586c1697bef9e773068abdea2294f6b9c296ef --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=f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 05:11:06,274 truncating revision to first 12 chars 2015-11-17 05:11:06,274 Setting DEBUG logging. 2015-11-17 05:11:06,274 attempt 1/10 2015-11-17 05:11:06,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/7c586c1697be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 05:11:06,835 unpacking tar archive at: b2g-inbound-7c586c1697be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.844939 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:06.612447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:06.612745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:06.657438) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:06.657867) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 05:11:06.658319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-17 05:11:06.658633) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:07 INFO - MultiFileLogger online at 20151117 05:11:07 in /builds/slave/test 05:11:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 05:11:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:07 INFO - {'append_to_log': False, 05:11:07 INFO - 'base_work_dir': '/builds/slave/test', 05:11:07 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 05:11:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:07 INFO - 'branch': 'B2G-Inbound-Non-PGO', 05:11:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:07 INFO - 'config_files': ('talos/linux_config.py',), 05:11:07 INFO - 'default_actions': ('clobber', 05:11:07 INFO - 'read-buildbot-config', 05:11:07 INFO - 'download-and-extract', 05:11:07 INFO - 'populate-webroot', 05:11:07 INFO - 'create-virtualenv', 05:11:07 INFO - 'install', 05:11:07 INFO - 'run-tests'), 05:11:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:07 INFO - 'download_minidump_stackwalk': True, 05:11:07 INFO - 'download_symbols': 'ondemand', 05:11:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:07 INFO - 'installer_path': 'installer.exe', 05:11:07 INFO - 'log_level': 'info', 05:11:07 INFO - 'log_name': 'talos', 05:11:07 INFO - 'log_to_console': True, 05:11:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:07 INFO - 'opt_config_files': (), 05:11:07 INFO - 'pip_index': False, 05:11:07 INFO - 'sps_profile': False, 05:11:07 INFO - 'sps_profile_interval': 0, 05:11:07 INFO - 'suite': 'dromaeojs', 05:11:07 INFO - 'system_bits': '64', 05:11:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:07 INFO - 'title': 'talos-linux64-ix-047', 05:11:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:07 INFO - 'use_talos_json': True, 05:11:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:07 INFO - 'work_dir': 'build'} 05:11:07 INFO - ##### 05:11:07 INFO - ##### Running clobber step. 05:11:07 INFO - ##### 05:11:07 INFO - Running pre-action listener: _resource_record_pre_action 05:11:07 INFO - Running main action method: clobber 05:11:07 INFO - rmtree: /builds/slave/test/build 05:11:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:07 INFO - Running post-action listener: _resource_record_post_action 05:11:07 INFO - ##### 05:11:07 INFO - ##### Running read-buildbot-config step. 05:11:07 INFO - ##### 05:11:07 INFO - Running pre-action listener: _resource_record_pre_action 05:11:07 INFO - Running main action method: read_buildbot_config 05:11:07 INFO - Using buildbot properties: 05:11:07 INFO - { 05:11:07 INFO - "properties": { 05:11:07 INFO - "buildnumber": 274, 05:11:07 INFO - "product": "firefox", 05:11:07 INFO - "script_repo_revision": "production", 05:11:07 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:11:07 INFO - "repository": "", 05:11:07 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 05:11:07 INFO - "buildid": "20151117033907", 05:11:07 INFO - "slavename": "talos-linux64-ix-047", 05:11:07 INFO - "pgo_build": "False", 05:11:07 INFO - "basedir": "/builds/slave/test", 05:11:07 INFO - "project": "", 05:11:07 INFO - "platform": "ubuntu64_hw", 05:11:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:11:07 INFO - "slavebuilddir": "test", 05:11:07 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 05:11:07 INFO - "branch": "b2g-inbound", 05:11:07 INFO - "repo_path": "integration/b2g-inbound", 05:11:07 INFO - "stage_platform": "linux64", 05:11:07 INFO - "builduid": "001d3c996cb64cc5b6b9b06c4e791c87", 05:11:07 INFO - "revision": "7c586c1697bef9e773068abdea2294f6b9c296ef" 05:11:07 INFO - }, 05:11:07 INFO - "sourcestamp": { 05:11:07 INFO - "repository": "", 05:11:07 INFO - "hasPatch": false, 05:11:07 INFO - "project": "", 05:11:07 INFO - "branch": "b2g-inbound-linux64-talos", 05:11:07 INFO - "changes": [ 05:11:07 INFO - { 05:11:07 INFO - "category": null, 05:11:07 INFO - "files": [ 05:11:07 INFO - { 05:11:07 INFO - "url": null, 05:11:07 INFO - "name": "https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:11:07 INFO - } 05:11:07 INFO - ], 05:11:07 INFO - "repository": "", 05:11:07 INFO - "rev": "7c586c1697bef9e773068abdea2294f6b9c296ef", 05:11:07 INFO - "who": "cbook@mozilla.com", 05:11:07 INFO - "when": 1447765773, 05:11:07 INFO - "number": 6671692, 05:11:07 INFO - "comments": "Merge mozilla-central to b2g-inbound", 05:11:07 INFO - "project": "", 05:11:07 INFO - "at": "Tue 17 Nov 2015 05:09:33", 05:11:07 INFO - "branch": "b2g-inbound-linux64-talos", 05:11:07 INFO - "revlink": "", 05:11:07 INFO - "properties": [ 05:11:07 INFO - [ 05:11:07 INFO - "buildid", 05:11:07 INFO - "20151117033907", 05:11:07 INFO - "Change" 05:11:07 INFO - ], 05:11:07 INFO - [ 05:11:07 INFO - "builduid", 05:11:07 INFO - "001d3c996cb64cc5b6b9b06c4e791c87", 05:11:07 INFO - "Change" 05:11:07 INFO - ], 05:11:07 INFO - [ 05:11:07 INFO - "pgo_build", 05:11:07 INFO - "False", 05:11:07 INFO - "Change" 05:11:07 INFO - ] 05:11:07 INFO - ], 05:11:07 INFO - "revision": "7c586c1697bef9e773068abdea2294f6b9c296ef" 05:11:07 INFO - } 05:11:07 INFO - ], 05:11:07 INFO - "revision": "7c586c1697bef9e773068abdea2294f6b9c296ef" 05:11:07 INFO - } 05:11:07 INFO - } 05:11:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:11:07 INFO - Running post-action listener: _resource_record_post_action 05:11:07 INFO - ##### 05:11:07 INFO - ##### Running download-and-extract step. 05:11:07 INFO - ##### 05:11:07 INFO - Running pre-action listener: _resource_record_pre_action 05:11:07 INFO - Running main action method: download_and_extract 05:11:07 INFO - mkdir: /builds/slave/test/build/tests 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:07 INFO - https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/test_packages.json 05:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/test_packages.json 05:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:11:08 INFO - Downloaded 1302 bytes. 05:11:08 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:11:08 INFO - Using the following test package requirements: 05:11:08 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:08 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:08 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:08 INFO - u'jsshell-linux-x86_64.zip'], 05:11:08 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:08 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:08 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:08 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:08 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:08 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:08 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:08 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:08 INFO - https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:11:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:11:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/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 05:11:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/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 05:11:09 INFO - Downloaded 21275225 bytes. 05:11:09 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 05:11:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:11:09 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 05:11:10 INFO - Return code: 0 05:11:10 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 05:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:10 INFO - https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:11:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:11:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/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 05:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/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 05:11:18 INFO - Downloaded 21275225 bytes. 05:11:18 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 05:11:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:11:18 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 05:11:19 INFO - Return code: 0 05:11:19 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')]} 05:11:19 INFO - https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/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 05:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/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 05:11:20 INFO - Downloaded 11131693 bytes. 05:11:20 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 05:11:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:20 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 05:11:20 INFO - Return code: 0 05:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:20 INFO - https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/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 05:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIQPK3zzSFyxghHocDG28Q/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 05:11:21 INFO - Downloaded 55647358 bytes. 05:11:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:11:21 INFO - mkdir: /builds/slave/test/properties 05:11:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:21 INFO - Contents: 05:11:21 INFO - build_url:https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:11:21 INFO - Running post-action listener: _resource_record_post_action 05:11:21 INFO - Running post-action listener: set_extra_try_arguments 05:11:21 INFO - ##### 05:11:21 INFO - ##### Running populate-webroot step. 05:11:21 INFO - ##### 05:11:21 INFO - Running pre-action listener: _resource_record_pre_action 05:11:21 INFO - Running main action method: populate_webroot 05:11:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:11:21 INFO - '../fennec_ids.txt'], 05:11:21 INFO - 'tests': ['tcheck2']}, 05:11:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:21 INFO - '--tppagecycles', 05:11:21 INFO - '7'], 05:11:21 INFO - 'tests': ['tsvgm']}}, 05:11:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:11:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:11:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:11:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:21 INFO - 'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:21 INFO - 'tests': ['damp', 'tps']}, 05:11:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:21 INFO - 'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['damp', 'tps']}, 05:11:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:11:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:21 INFO - 'other': {'tests': ['a11yr', 05:11:21 INFO - 'ts_paint', 05:11:21 INFO - 'tpaint', 05:11:21 INFO - 'sessionrestore', 05:11:21 INFO - 'sessionrestore_no_auto_restore']}, 05:11:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['a11yr', 05:11:21 INFO - 'ts_paint', 05:11:21 INFO - 'tpaint', 05:11:21 INFO - 'sessionrestore', 05:11:21 INFO - 'sessionrestore_no_auto_restore']}, 05:11:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['a11yr', 05:11:21 INFO - 'ts_paint', 05:11:21 INFO - 'tpaint', 05:11:21 INFO - 'sessionrestore', 05:11:21 INFO - 'sessionrestore_no_auto_restore']}, 05:11:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['a11yr', 05:11:21 INFO - 'ts_paint', 05:11:21 INFO - 'tpaint', 05:11:21 INFO - 'sessionrestore', 05:11:21 INFO - 'sessionrestore_no_auto_restore']}, 05:11:21 INFO - 'other_l64': {'tests': ['a11yr', 05:11:21 INFO - 'ts_paint', 05:11:21 INFO - 'tpaint', 05:11:21 INFO - 'sessionrestore', 05:11:21 INFO - 'sessionrestore_no_auto_restore']}, 05:11:21 INFO - 'other_nol64': {'tests': ['a11yr', 05:11:21 INFO - 'ts_paint', 05:11:21 INFO - 'tpaint', 05:11:21 INFO - 'sessionrestore', 05:11:21 INFO - 'sessionrestore_no_auto_restore']}, 05:11:21 INFO - 'svgr': {'tests': ['tsvgx', 05:11:21 INFO - 'tsvgr_opacity', 05:11:21 INFO - 'tart', 05:11:21 INFO - 'tscrollx', 05:11:21 INFO - 'cart']}, 05:11:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['tsvgx', 05:11:21 INFO - 'tsvgr_opacity', 05:11:21 INFO - 'tart', 05:11:21 INFO - 'tscrollx', 05:11:21 INFO - 'cart']}, 05:11:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:21 INFO - 'tests': ['tp5o']}, 05:11:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:21 INFO - 'talos_options': ['--e10s'], 05:11:21 INFO - 'tests': ['tp5o']}, 05:11:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:21 INFO - 'talos_options': ['--xperf_path', 05:11:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:21 INFO - 'tests': ['tp5n']}, 05:11:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:21 INFO - 'talos_options': ['--e10s', 05:11:21 INFO - '--xperf_path', 05:11:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:21 INFO - 'tests': ['tp5n']}}, 05:11:21 INFO - 'talos.zip': {'path': '', 05:11:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:21 INFO - Running post-action listener: _resource_record_post_action 05:11:21 INFO - ##### 05:11:21 INFO - ##### Running create-virtualenv step. 05:11:21 INFO - ##### 05:11:21 INFO - Running pre-action listener: _resource_record_pre_action 05:11:21 INFO - Running main action method: create_virtualenv 05:11:21 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:21 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 05:11:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:21 INFO - Using real prefix '/usr' 05:11:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:22 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:24 INFO - Installing pip.................done. 05:11:24 INFO - Return code: 0 05:11:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:24 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')]} 05:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 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')]} 05:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 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 0x7fcd6fc6ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe989a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf27ac0>, '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 0xf289a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf28e50>, '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': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', '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 05:11:24 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 05:11:24 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 05:11:24 INFO - Using env: {'DISPLAY': ':0', 05:11:24 INFO - 'HOME': '/home/cltbld', 05:11:24 INFO - 'LANG': 'en_US.UTF-8', 05:11:24 INFO - 'LANGUAGE': 'en_US:en', 05:11:24 INFO - 'LOGNAME': 'cltbld', 05:11:24 INFO - 'MAIL': '/var/mail/cltbld', 05:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:24 INFO - 'MOZ_NO_REMOTE': '1', 05:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:24 INFO - 'NO_EM_RESTART': '1', 05:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:24 INFO - 'PWD': '/builds/slave/test', 05:11:24 INFO - 'SHELL': '/bin/bash', 05:11:24 INFO - 'SHLVL': '1', 05:11:24 INFO - 'TERM': 'linux', 05:11:24 INFO - 'TMOUT': '86400', 05:11:24 INFO - 'USER': 'cltbld', 05:11:24 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', 05:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:24 INFO - '_': '/tools/buildbot/bin/python'} 05:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:24 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 05:11:24 INFO - Cleaning up... 05:11:24 INFO - Return code: 0 05:11:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:11:24 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')]} 05:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 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')]} 05:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 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 0x7fcd6fc6ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe989a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf27ac0>, '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 0xf289a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf28e50>, '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': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', '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 05:11:24 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 05:11:24 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 05:11:24 INFO - Using env: {'DISPLAY': ':0', 05:11:24 INFO - 'HOME': '/home/cltbld', 05:11:24 INFO - 'LANG': 'en_US.UTF-8', 05:11:24 INFO - 'LANGUAGE': 'en_US:en', 05:11:24 INFO - 'LOGNAME': 'cltbld', 05:11:24 INFO - 'MAIL': '/var/mail/cltbld', 05:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:24 INFO - 'MOZ_NO_REMOTE': '1', 05:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:24 INFO - 'NO_EM_RESTART': '1', 05:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:24 INFO - 'PWD': '/builds/slave/test', 05:11:24 INFO - 'SHELL': '/bin/bash', 05:11:24 INFO - 'SHLVL': '1', 05:11:24 INFO - 'TERM': 'linux', 05:11:24 INFO - 'TMOUT': '86400', 05:11:24 INFO - 'USER': 'cltbld', 05:11:24 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', 05:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:24 INFO - '_': '/tools/buildbot/bin/python'} 05:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:24 INFO - Downloading/unpacking psutil>=0.7.1 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:24 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 05:11:26 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:11:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:26 INFO - Installing collected packages: psutil 05:11:26 INFO - Running setup.py install for psutil 05:11:26 INFO - building 'psutil._psutil_linux' extension 05:11:26 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 05:11:26 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 05:11:27 INFO - building 'psutil._psutil_posix' extension 05:11:27 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 05:11:27 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 05:11:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:27 INFO - Successfully installed psutil 05:11:27 INFO - Cleaning up... 05:11:27 INFO - Return code: 0 05:11:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:11:27 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')]} 05:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:27 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')]} 05:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:27 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 0x7fcd6fc6ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe989a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf27ac0>, '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 0xf289a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf28e50>, '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': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', '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 05:11:27 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 05:11:27 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 05:11:27 INFO - Using env: {'DISPLAY': ':0', 05:11:27 INFO - 'HOME': '/home/cltbld', 05:11:27 INFO - 'LANG': 'en_US.UTF-8', 05:11:27 INFO - 'LANGUAGE': 'en_US:en', 05:11:27 INFO - 'LOGNAME': 'cltbld', 05:11:27 INFO - 'MAIL': '/var/mail/cltbld', 05:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:27 INFO - 'MOZ_NO_REMOTE': '1', 05:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:27 INFO - 'NO_EM_RESTART': '1', 05:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:27 INFO - 'PWD': '/builds/slave/test', 05:11:27 INFO - 'SHELL': '/bin/bash', 05:11:27 INFO - 'SHLVL': '1', 05:11:27 INFO - 'TERM': 'linux', 05:11:27 INFO - 'TMOUT': '86400', 05:11:27 INFO - 'USER': 'cltbld', 05:11:27 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', 05:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:27 INFO - '_': '/tools/buildbot/bin/python'} 05:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:11:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:11:29 INFO - Installing collected packages: mozsystemmonitor 05:11:29 INFO - Running setup.py install for mozsystemmonitor 05:11:29 INFO - Successfully installed mozsystemmonitor 05:11:29 INFO - Cleaning up... 05:11:29 INFO - Return code: 0 05:11:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd6fc6ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe989a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf27ac0>, '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 0xf289a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf28e50>, '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': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', '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 05:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:29 INFO - Using env: {'DISPLAY': ':0', 05:11:29 INFO - 'HOME': '/home/cltbld', 05:11:29 INFO - 'LANG': 'en_US.UTF-8', 05:11:29 INFO - 'LANGUAGE': 'en_US:en', 05:11:29 INFO - 'LOGNAME': 'cltbld', 05:11:29 INFO - 'MAIL': '/var/mail/cltbld', 05:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:29 INFO - 'MOZ_NO_REMOTE': '1', 05:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:29 INFO - 'NO_EM_RESTART': '1', 05:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:29 INFO - 'PWD': '/builds/slave/test', 05:11:29 INFO - 'SHELL': '/bin/bash', 05:11:29 INFO - 'SHLVL': '1', 05:11:29 INFO - 'TERM': 'linux', 05:11:29 INFO - 'TMOUT': '86400', 05:11:29 INFO - 'USER': 'cltbld', 05:11:29 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', 05:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:29 INFO - '_': '/tools/buildbot/bin/python'} 05:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - Downloading docopt-0.6.1.tar.gz 05:11:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:32 INFO - Running setup.py install for blobuploader 05:11:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:32 INFO - Running setup.py install for requests 05:11:32 INFO - Running setup.py install for docopt 05:11:32 INFO - Successfully installed blobuploader requests docopt 05:11:32 INFO - Cleaning up... 05:11:32 INFO - Return code: 0 05:11:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:32 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 0x7fcd6fc6ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe989a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf27ac0>, '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 0xf289a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf28e50>, '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': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', '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 05:11:32 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 05:11:32 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 05:11:32 INFO - Using env: {'DISPLAY': ':0', 05:11:32 INFO - 'HOME': '/home/cltbld', 05:11:32 INFO - 'LANG': 'en_US.UTF-8', 05:11:32 INFO - 'LANGUAGE': 'en_US:en', 05:11:32 INFO - 'LOGNAME': 'cltbld', 05:11:32 INFO - 'MAIL': '/var/mail/cltbld', 05:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:32 INFO - 'MOZ_NO_REMOTE': '1', 05:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:32 INFO - 'NO_EM_RESTART': '1', 05:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:32 INFO - 'PWD': '/builds/slave/test', 05:11:32 INFO - 'SHELL': '/bin/bash', 05:11:32 INFO - 'SHLVL': '1', 05:11:32 INFO - 'TERM': 'linux', 05:11:32 INFO - 'TMOUT': '86400', 05:11:32 INFO - 'USER': 'cltbld', 05:11:32 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', 05:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:32 INFO - '_': '/tools/buildbot/bin/python'} 05:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:32 INFO - Running setup.py (path:/tmp/pip-0Srd0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:32 INFO - Running setup.py (path:/tmp/pip-FMhaVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:32 INFO - Running setup.py (path:/tmp/pip-AQJ0Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:33 INFO - Running setup.py (path:/tmp/pip-nddLuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:33 INFO - Running setup.py (path:/tmp/pip-0sHP89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:33 INFO - Running setup.py (path:/tmp/pip-v8PKzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:33 INFO - Running setup.py (path:/tmp/pip-WfNueN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:33 INFO - Running setup.py (path:/tmp/pip-aqnmap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:33 INFO - Running setup.py (path:/tmp/pip-kSTxGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:33 INFO - Running setup.py (path:/tmp/pip-DT6rTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:33 INFO - Running setup.py (path:/tmp/pip-hhPUNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:33 INFO - Running setup.py (path:/tmp/pip-SX4R9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:33 INFO - Running setup.py (path:/tmp/pip-HAnXIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:33 INFO - Running setup.py (path:/tmp/pip-mZRNfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:33 INFO - Running setup.py (path:/tmp/pip-BVITse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:33 INFO - Running setup.py (path:/tmp/pip-_l2QLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:33 INFO - Running setup.py (path:/tmp/pip-Y1zMTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:34 INFO - Running setup.py install for manifestparser 05:11:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozcrash 05:11:34 INFO - Running setup.py install for mozdebug 05:11:34 INFO - Running setup.py install for mozdevice 05:11:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozfile 05:11:34 INFO - Running setup.py install for mozhttpd 05:11:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozinfo 05:11:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozInstall 05:11:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozleak 05:11:34 INFO - Running setup.py install for mozlog 05:11:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Running setup.py install for moznetwork 05:11:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Running setup.py install for mozprocess 05:11:35 INFO - Running setup.py install for mozprofile 05:11:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Running setup.py install for mozrunner 05:11:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Running setup.py install for mozscreenshot 05:11:35 INFO - Running setup.py install for moztest 05:11:35 INFO - Running setup.py install for mozversion 05:11:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:35 INFO - Cleaning up... 05:11:35 INFO - Return code: 0 05:11:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:35 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')]} 05:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:35 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')]} 05:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:35 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 0x7fcd6fc6ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe989a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf27ac0>, '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 0xf289a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf28e50>, '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': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', '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 05:11:35 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 05:11:35 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 05:11:35 INFO - Using env: {'DISPLAY': ':0', 05:11:35 INFO - 'HOME': '/home/cltbld', 05:11:35 INFO - 'LANG': 'en_US.UTF-8', 05:11:35 INFO - 'LANGUAGE': 'en_US:en', 05:11:35 INFO - 'LOGNAME': 'cltbld', 05:11:35 INFO - 'MAIL': '/var/mail/cltbld', 05:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:35 INFO - 'MOZ_NO_REMOTE': '1', 05:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:35 INFO - 'NO_EM_RESTART': '1', 05:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:35 INFO - 'PWD': '/builds/slave/test', 05:11:35 INFO - 'SHELL': '/bin/bash', 05:11:35 INFO - 'SHLVL': '1', 05:11:35 INFO - 'TERM': 'linux', 05:11:35 INFO - 'TMOUT': '86400', 05:11:35 INFO - 'USER': 'cltbld', 05:11:35 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', 05:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:35 INFO - '_': '/tools/buildbot/bin/python'} 05:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:36 INFO - Running setup.py (path:/tmp/pip-wrtIjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:36 INFO - Running setup.py (path:/tmp/pip-ZBJfg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:36 INFO - Running setup.py (path:/tmp/pip-hOqLys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:36 INFO - Running setup.py (path:/tmp/pip-YWKLjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:36 INFO - Running setup.py (path:/tmp/pip-xCcCgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:36 INFO - Running setup.py (path:/tmp/pip-0WOG6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:36 INFO - Running setup.py (path:/tmp/pip-S2VPeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:36 INFO - Running setup.py (path:/tmp/pip-PrRTDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:36 INFO - Running setup.py (path:/tmp/pip-svxa3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:36 INFO - Running setup.py (path:/tmp/pip-q4YVeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:36 INFO - Running setup.py (path:/tmp/pip-B8z3y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:36 INFO - Running setup.py (path:/tmp/pip-GMGjmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:36 INFO - Running setup.py (path:/tmp/pip-kTWnWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:37 INFO - Running setup.py (path:/tmp/pip-fIZT1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:37 INFO - Running setup.py (path:/tmp/pip-NXoSFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:37 INFO - Running setup.py (path:/tmp/pip-vBnxBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:37 INFO - Running setup.py (path:/tmp/pip-ffw9WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:37 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)) 05:11:37 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)) 05:11:37 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)) 05:11:37 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)) 05:11:37 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)) 05:11:37 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)) 05:11:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:37 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 05:11:37 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 05:11:37 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 05:11:37 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 05:11:37 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 05:11:37 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 05:11:38 INFO - Downloading blessings-1.5.1.tar.gz 05:11:38 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 05:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:39 INFO - Installing collected packages: blessings 05:11:39 INFO - Running setup.py install for blessings 05:11:39 INFO - Successfully installed blessings 05:11:39 INFO - Cleaning up... 05:11:39 INFO - Return code: 0 05:11:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:39 INFO - Reading from file tmpfile_stdout 05:11:39 INFO - Current package versions: 05:11:39 INFO - argparse == 1.2.1 05:11:39 INFO - blessings == 1.5.1 05:11:39 INFO - blobuploader == 1.2.4 05:11:39 INFO - docopt == 0.6.1 05:11:39 INFO - manifestparser == 1.1 05:11:39 INFO - mozInstall == 1.12 05:11:39 INFO - mozcrash == 0.16 05:11:39 INFO - mozdebug == 0.1 05:11:39 INFO - mozdevice == 0.47 05:11:39 INFO - mozfile == 1.2 05:11:39 INFO - mozhttpd == 0.7 05:11:39 INFO - mozinfo == 0.9 05:11:39 INFO - mozleak == 0.1 05:11:39 INFO - mozlog == 3.0 05:11:39 INFO - moznetwork == 0.27 05:11:39 INFO - mozprocess == 0.22 05:11:39 INFO - mozprofile == 0.27 05:11:39 INFO - mozrunner == 6.11 05:11:39 INFO - mozscreenshot == 0.1 05:11:39 INFO - mozsystemmonitor == 0.0 05:11:39 INFO - moztest == 0.7 05:11:39 INFO - mozversion == 1.4 05:11:39 INFO - psutil == 3.1.1 05:11:39 INFO - requests == 1.2.3 05:11:39 INFO - wsgiref == 0.1.2 05:11:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:39 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 0x7fcd6fc6ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe989a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf27ac0>, '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 0xf289a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf28e50>, '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': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', '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 05:11:39 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 05:11:39 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 05:11:39 INFO - Using env: {'DISPLAY': ':0', 05:11:39 INFO - 'HOME': '/home/cltbld', 05:11:39 INFO - 'LANG': 'en_US.UTF-8', 05:11:39 INFO - 'LANGUAGE': 'en_US:en', 05:11:39 INFO - 'LOGNAME': 'cltbld', 05:11:39 INFO - 'MAIL': '/var/mail/cltbld', 05:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:39 INFO - 'MOZ_NO_REMOTE': '1', 05:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:39 INFO - 'NO_EM_RESTART': '1', 05:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:39 INFO - 'PWD': '/builds/slave/test', 05:11:39 INFO - 'SHELL': '/bin/bash', 05:11:39 INFO - 'SHLVL': '1', 05:11:39 INFO - 'TERM': 'linux', 05:11:39 INFO - 'TMOUT': '86400', 05:11:39 INFO - 'USER': 'cltbld', 05:11:39 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', 05:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:39 INFO - '_': '/tools/buildbot/bin/python'} 05:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:39 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)) 05:11:39 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)) 05:11:39 INFO - Cleaning up... 05:11:39 INFO - Return code: 0 05:11:39 INFO - Running post-action listener: _resource_record_post_action 05:11:39 INFO - Running post-action listener: _start_resource_monitoring 05:11:39 INFO - Starting resource monitoring. 05:11:39 INFO - ##### 05:11:39 INFO - ##### Running install step. 05:11:39 INFO - ##### 05:11:39 INFO - Running pre-action listener: _resource_record_pre_action 05:11:39 INFO - Running main action method: install 05:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:39 INFO - Reading from file tmpfile_stdout 05:11:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:39 INFO - Reading from file tmpfile_stdout 05:11:39 INFO - Output received: 05:11:39 INFO - Usage: mozinstall [options] installer 05:11:39 INFO - Options: 05:11:39 INFO - -h, --help show this help message and exit 05:11:39 INFO - -d DEST, --destination=DEST 05:11:39 INFO - Directory to install application into. [default: 05:11:39 INFO - "/builds/slave/test"] 05:11:39 INFO - --app=APP Application being installed. [default: firefox] 05:11:39 INFO - mkdir: /builds/slave/test/build/application 05:11:39 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'] 05:11:39 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 05:11:54 INFO - Reading from file tmpfile_stdout 05:11:54 INFO - Output received: 05:11:54 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:54 INFO - Running post-action listener: _resource_record_post_action 05:11:54 INFO - ##### 05:11:54 INFO - ##### Running run-tests step. 05:11:54 INFO - ##### 05:11:54 INFO - Running pre-action listener: _resource_record_pre_action 05:11:54 INFO - Running main action method: run_tests 05:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:54 INFO - Python 2.7.3 05:11:54 INFO - Return code: 0 05:11:54 INFO - grabbing minidump binary from tooltool 05:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:54 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 0xf27ac0>, '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 0xf289a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf28e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:54 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 05:11:54 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 05:11:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:54 INFO - Return code: 0 05:11:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 05:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 05:11:54 INFO - Using env: {'DISPLAY': ':0', 05:11:54 INFO - 'HOME': '/home/cltbld', 05:11:54 INFO - 'LANG': 'en_US.UTF-8', 05:11:54 INFO - 'LANGUAGE': 'en_US:en', 05:11:54 INFO - 'LOGNAME': 'cltbld', 05:11:54 INFO - 'MAIL': '/var/mail/cltbld', 05:11:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:54 INFO - 'MOZ_NO_REMOTE': '1', 05:11:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:54 INFO - 'NO_EM_RESTART': '1', 05:11:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:54 INFO - 'PWD': '/builds/slave/test', 05:11:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:54 INFO - 'SHELL': '/bin/bash', 05:11:54 INFO - 'SHLVL': '1', 05:11:54 INFO - 'TERM': 'linux', 05:11:54 INFO - 'TMOUT': '86400', 05:11:54 INFO - 'USER': 'cltbld', 05:11:54 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837', 05:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:54 INFO - '_': '/tools/buildbot/bin/python'} 05:11:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 05:11:54 INFO - mozversion INFO | application_buildid: 20151117033907 05:11:54 INFO - mozversion INFO | application_changeset: 7c586c1697bef9e773068abdea2294f6b9c296ef 05:11:54 INFO - mozversion INFO | application_display_name: Nightly 05:11:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:54 INFO - mozversion INFO | application_name: Firefox 05:11:54 INFO - mozversion INFO | application_remotingname: firefox 05:11:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 05:11:54 INFO - mozversion INFO | application_vendor: Mozilla 05:11:54 INFO - mozversion INFO | application_version: 45.0a1 05:11:54 INFO - mozversion INFO | platform_buildid: 20151117033907 05:11:54 INFO - mozversion INFO | platform_changeset: 7c586c1697bef9e773068abdea2294f6b9c296ef 05:11:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 05:11:54 INFO - mozversion INFO | platform_version: 45.0a1 05:11:54 INFO - 2015-11-17 05:11:54,308 DEBUG : using testdate: 1447765914 05:11:54 INFO - 2015-11-17 05:11:54,308 DEBUG : actual date: 1447765914 05:11:54 INFO - 2015-11-17 05:11:54,316 INFO : starting webserver on 'localhost:49353' 05:11:54 INFO - 2015-11-17 05:11:54,317 INFO : Starting test suite talos-linux64-ix-047 05:11:54 INFO - 2015-11-17 05:11:54,317 INFO : Starting test dromaeo_css 05:11:54 INFO - 2015-11-17 05:11:54,317 DEBUG : operating with platform_type : linux_ 05:11:54 INFO - 2015-11-17 05:11:54,318 INFO : Initialising browser for dromaeo_css test... 05:11:54 INFO - 2015-11-17 05:11:54,333 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaHpPxL/profile http://localhost:49353/getInfo.html 05:11:58 INFO - 2015-11-17 05:11:58,427 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:11:58 INFO - 2015-11-17 05:11:58,427 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:11:58 INFO - 2015-11-17 05:11:58,427 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:11:58 INFO - 2015-11-17 05:11:58,427 DEBUG : BROWSER_OUTPUT: __metrics 05:11:58 INFO - 2015-11-17 05:11:58,548 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:59 INFO - 2015-11-17 05:11:59,804 INFO : Browser initialized. 05:11:59 INFO - 2015-11-17 05:11:59,804 INFO : Running cycle 1/1 for dromaeo_css test... 05:11:59 INFO - 2015-11-17 05:11:59,804 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaHpPxL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:12:11 INFO - 2015-11-17 05:12:11,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 141393920 05:12:11 INFO - 2015-11-17 05:12:11,692 DEBUG : BROWSER_OUTPUT: 05:13:03 INFO - 2015-11-17 05:13:03,212 DEBUG : BROWSER_OUTPUT: 1447765983208 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] 05:15:15 INFO - 2015-11-17 05:15:15,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49353/tests/dromaeo/cssquery-ext.html) 05:15:16 INFO - 2015-11-17 05:15:16,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 238825472 05:15:16 INFO - 2015-11-17 05:15:16,252 DEBUG : BROWSER_OUTPUT: 05:18:18 INFO - 2015-11-17 05:18:18,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/dromaeo/cssquery-ext.html (next: http://localhost:49353/tests/dromaeo/cssquery-jquery.html) 05:18:19 INFO - 2015-11-17 05:18:19,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 224391168 05:18:19 INFO - 2015-11-17 05:18:19,363 DEBUG : BROWSER_OUTPUT: 05:21:21 INFO - 2015-11-17 05:21:21,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49353/tests/dromaeo/cssquery-mootools.html) 05:21:21 INFO - 2015-11-17 05:21:21,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 210657280 05:21:21 INFO - 2015-11-17 05:21:21,965 DEBUG : BROWSER_OUTPUT: 05:24:23 INFO - 2015-11-17 05:24:23,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49353/tests/dromaeo/cssquery-prototype.html) 05:24:24 INFO - 2015-11-17 05:24:24,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 205611008 05:24:24 INFO - 2015-11-17 05:24:24,503 DEBUG : BROWSER_OUTPUT: 05:27:27 INFO - 2015-11-17 05:27:27,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49353/tests/dromaeo/cssquery-yui.html) 05:27:27 INFO - 2015-11-17 05:27:27,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 206323712 05:27:27 INFO - 2015-11-17 05:27:27,875 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/dromaeo/cssquery-yui.html (next: http://localhost:49353/tests/dromaeo/cssquery-dojo.html) 05:30:30 INFO - 2015-11-17 05:30:30,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 248492032 05:30:30 INFO - 2015-11-17 05:30:30,615 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,617 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:30 INFO - 2015-11-17 05:30:30,617 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:30 INFO - 2015-11-17 05:30:30,617 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:30 INFO - 2015-11-17 05:30:30,617 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:30 INFO - 2015-11-17 05:30:30,621 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2658.956656115251;2759.51708451021;2764.654418197725;2768.501669699454;2769.29383007333;4553.772311384434;4692.577668009879;4758.881027974302;4792.52074792521;4807.038592281545;4695.718256904588;4730;4733.219018861883;4821.108095002427;4838.830640927559;4380.802863871126;4391.494978077514;4419.845305414311;4426.203283408985;4431.822727090913;4175.916481670365;4448.199324121657;4474.284114541674;4499.527549607294;4514.413126293577;4322.719023263509;4335.978320108411;4410.801513931849;4447.688661793676;4459.2865141577195;4385.736855788663;4389.253826849444;4393.758343291118;4440.178566965122;4448.777561121963;4206.053637931472;4305.354196870463;4375.16871794358;4399.428074350314;4417.403650507173;4689.835855745033;4806.7836947337455;4846.321514987904;4858.246971719389;4863.635227357927;5137.229415587654;5151.381834179885;5156.123459011939;5192.636515443921;5195.558377537914;4876.268559716035;5170.069387510247;5177.818776342848;5190.273361729361;5190.844274671766;4671.04243630055;4673.649476289292;4678.368420263289;4688.648351373627;4785.808567657325;5256.159014557652;5262.657927234794;5268.367795864521;5287.365516138088;5298.655587386885;5033.2701758245585;5035.571976382049;5037.4458809530925;5042.823501177441;5088.109580823341;4839.564439200489;4958.057968985881;4967.254911763264;5013.674111182761;5160.406553246425;5086.567641750418;5095.210242412432;5095.617828662791;5103.923441148386;5110.4634013428795;5070.340855688737;5075.061113693979;5085.160948443539;5087.745612719424;5115.718635475085;4070.61329173728;4178.519470260898;4178.8537401190815;4309.48286205651;4346.521882592912;3650.5619325681087;3724.2365315110337;3746.119661879456;3751.324761542894;3767.1335592813807;4393.0774537347515;4412.69111162222;4422.535633758409;4431.224535706238;4447.021655235843;4979.427365852901;5135.948640513547;5178.508041736029;5197.688138711689;5198.766055527511;4285.892852678708;4321.9135617287475;4367.061081867414;4382.868513944587;4417.690761646718;4557.567031132037;4558.772061396983;4576.427946506687;4589.65577581676;4610.723356598614;4665.136949664323;4781.2350023996;4894.045661096052;4895.485973972682;4899.338589290472;4992.700437973734;5065.468125846733;5065.974670126626;5100.48995100487;5116.820911268088;4950.727709975986;4960.826371076995;4963.057019166346;4963.503649635008;5005;4891.461939186615;5016.448190698947;5122.871928201825;5128.230765385073;5129.563987061141;5000.849974500771;5043.167877300204;5109.335786347751;5118.360204974379;5139.434662187082;4965.975170124127;4988.9251661225835;4990.8253211137435;4994.175960966545;5037.0681423936685;4681.368015318025;4796.472388037383;4985.351904252424;4996.075725990703;4996.325496058131;4701.365315682339;4732.455767586634;4769.95230047709;4770.570648641639;4797.328374027569;4951.925721114114;4966.950330496793;4968.130577148912;4968.652194346361;5010.799568017239;4685.062987402465;4795.400574928134;4868.367112275523;4885.731284779229;4919.778609962489 05:30:30 INFO - 2015-11-17 05:30:30,621 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.038821286323;548.202365558113;552.5745176214315;562.0557463461384;562.755201487353;28278;28801.423971520584;28805.279868003283;36654.633453665454;37870.62129378705;40570.79714601423;40964;41004.58995410045;41016;41040;7781.766547003571;7952.125266220711;7953.681852725884;7959.204079592024;7960.880586791174;7035.0854388929365;7179.317964793362;10010.399376037425;10285.537150828231;10291.125254353388;9976.351537150098;10082;10091.394516329006;10096.747581310452;10098.848517272247;6924.896126558106;7053.153621565445;9909.75225619358;10039.598416063349;10048.598056077748;9733.756656083655;9907.653232136912;9910;9959.601615935353;9965.15296199824;37892.43161352582;38212;38237.42643860344;38242.426363604565;38259.61740382588;2658.3088397016722;2704.067096851583;2746.5605503119605;2761.558150695879;3560.5193298904574;28511.28721781972;28623.85688071567;28980;29193.854030729923;29521.557176642367;3042.589250451183;3098.349346637209;3156.0847354267235;3173.143251322153;3217.5978002749657;214397;215055;215166;215695;215764;44122.77938610286;45078.774606127416;53288.46711532913;53555.19667204995;54161.1875821863;55898;55938.72030639821;56298.43701563014;56347.43652563422;56423.71788141033;12133.635990920286;12215.450304736309;12326.876731232753;12342.938285308515;12345.506179752889;8059.798505037304;8079.394045446615;8172.6730930762105;8185.4270201085355;8186.181381861767;18697;18735.25058997652;18819.247230110916;18846.52883677919;18902.149403276886;6797.116374871235;7019.89470157948;7057.788266352018;7108.609026503488;7122.786316410516;782.5578548120294;831.9001719793664;886.534569351083;947.2989987409405;1053.2995557954027;23629;24939.376515586893;25025.874870625532;25245.74754252434;25297.494050118894;919.7332773495746;926.2682480840195;926.4256161179977;929.8605209218535;936.279065119854;12857.549985750455;13100.803487947689;13491.527796527074;13509.797353039712;14257.78613320801;205774;210492;211319;211861;212053;42430.78784606057;42671.786641066596;42719.786401067795;42800.57199428028;42836;1158.629238643626;1194.7849387110405;1215.781159391318;1221.6823625857342;1225.5281716539196;22190.667139993235;25275.368115797253;26054.218373448068;27163.59254611222;27268.72731272662;39197.02007449837;39547;39606.40590391089;39607;39681.2063758729;175891;178342.1082894577;178386;178492;179065;23507.88246058759;23993.16023939154;28894.71105289004;29236.26909327199;29742.55386169166;34068.65931340754;36537.81731091328;36712.63287367092;37525.249495010496;37707.43438848474;31620.36759264848;32681.836590816893;34100.82949585236;36740.26519469649;36883.446748299335;31762.841185793925;32889;34084.488732669524;35584;36119.638803611626;32760.672393276716;33345.83327083349;33362.833185833915;33393.165170870925;33422.832885835414;28419.715802841707;28730.569041464812;30409.847950760988;30504.84747576248;30771.692283077777;23064.192753253556;23187.84196954448;23417.76582234156;23551.52896942086;23689.40776480602 05:30:30 INFO - 2015-11-17 05:30:30,622 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.9730850512381;329.6653896295259;338.9306737243995;340.11400302212735;341.69418370558344;12530.310832904186;13021.088523803337;15072.924635376821;15428.691426171485;17094.572635684097;12985.74028519429;15741.291641876114;16154.353825846982;16475.022997240347;16484.587885302873;4794.928076078853;4937.703737775727;4939.28380384844;4946.7526623668855;4946.802127914879;3424.914377140579;3537.6108628050893;4859.83363992641;4922.01559688062;5530.364008139075;5663.801766938158;5701.03082475978;5710.2862142232225;5727.341355744101;5727.599068065237;5582.972085139569;5696;5782.681952492611;5795.971020144893;5810.912836307417;5090.567301779353;5093.439721630618;5112.846614601568;5122.487751224885;5128.153854613985;19451.80548194528;19609.80390196094;19991.50021249466;20020.399388018384;20256.49358766028;1736.496416039347;1739.8869073510182;1741.703910335246;1792.7759030121235;1792.7848658160974;12760.872391276062;12913.354332283348;13144.934275328658;13160.934195329059;13200;1582.5647946814604;1585.5877471857284;1623.1235133028151;1632.2246932706987;1676.9161541922856;52373;53949.73025134888;54097.18854217229;54172.45827541753;54854.17718734222;6306.527010474233;6339.714712837841;6388.39310265524;6426.742930282736;6445.323241059715;7450.105987281561;7451.925480745123;7454.552726836408;7463.925360746432;7475.626218689153;4680.227762419163;4683.7423941682855;4687.601553867891;4691.648126390534;4716.976415117971;4640.69835460694;4753.35829662998;4779.378680771478;4784.832530861403;4791.568758811654;2887.104997450797;2896.4641541314923;2908.5055540558155;2939.1476471823357;2943.484890144216;1056.536696675095;1083.5232497700986;2854.5432730762977;2916.6354205724283;2998.1005698290423;400.1736414304452;404.57519604415245;423.2614088415673;424.2850796408062;430.8750462365879;10677.359358438518;10867.891321086689;10887.237893347548;11016.944915275533;11216;420.86321945367877;424.932010878258;432.5695932547136;441.4107166932117;448.3678014000244;5676.801311954062;5690.971545142248;5846.444587764156;5865.970670146622;5882.735276912549;436334;442325;497168;500702;507041;61997;67991.3200867985;68414.3158568408;68495;68556;486.5766782898901;491.8008206676302;492.31076492909494;492.6256045405446;493.62977766674993;9851.261155413516;9893.406395616286;9896.703098907044;10061.446620435947;10068.798624027331;31697.5245371315;32763.508547371333;33983.83008084944;34003;34172.48741268933;42309.36535952025;42544;42544.57455425406;43480.34779478247;43777;5858.560607954506;5930.436608522184;5935.881282374415;5944.375840536682;5955.255593050869;8164.306033987177;10993.725156871142;11235.438228088726;11271.323720576791;11271.718207044561;9788.314817962959;10049.246306526893;10076.244281678757;10282.177425806067;10282.948585257025;9618.615255389706;9736.026397360207;9744.366616169926;9808.558614862492;9948.801023979335;9786.853197201905;9924.1068303853;9929.652462164078;10129.746756331151;10158.034986676254;6114.38856114385;6178.258608966953;6183.721732521957;6188.938110618837;6192.318844927145;9757.756056098655;9860.950695246765;9942.105210531086;9944.651937182452;10051.69844904654 05:30:30 INFO - 2015-11-17 05:30:30,624 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1176.0474016046996;1555.6888622275546;1623.0829581286573;1633.7876076110108;1663.0437498438394;6119.143319935207;6478.028295755639;6810.318968103194;7197.7480788172425;7226.96386518068;7075.929240707592;7093.1842838073635;7123.9287607123915;7141.107361579802;7151.14186297645;1647.9423220187296;1713.1776747161307;2049;2071.1508281604547;2073.9585208295825;2039.276056999766;2078.4596005038647;2085.238887805955;2085.259732794859;2086.405374468277;2037.5721098569245;2044.9591008179827;2051.8563700540967;2083.479130217446;2084.27050532314;2037;2063.1025503905776;2092.937211883638;2095.549456866781;2100.222917520512;2042.0402410866868;2064.1846470644164;2064.6283668939586;2067.069818581629;2068.513899233679;7078.646067696646;7140.642967851639;7146.749863754796;7147.2138064812825;7151.427885769126;4125.278076336659;4174.436451079096;4190.308599081148;4199.223143718422;4207.64235040022;2593.0664960614163;2676.2372723773633;2679.61145633882;2701.149138021517;2701.7163197864334;734.2950767263434;884.4737381258141;895.8208358328295;914.533587870191;948.369334392628;9635;9672.903270967341;9701.029897010243;9703;9719.854202187043;3814.599467055975;3829.3107240696386;3869.187470631143;3923.9607603923596;3928.1161738609158;8259.297959673375;8282.296004839536;8298.921140251729;8306.875396869053;8312.085670576233;4129.504459464823;4140.68944829139;4143.585641435832;4145.54399016108;4148.211839750498;3714.888553343404;3732.4774531565604;3737.177820879402;3742.7754334740002;3749.2314075614436;3488.686018258369;3506.1760486285702;3508.947365789515;3519.9296014080087;3534.0988048047584;1106.0653747583278;1110.9888901111046;1114.9331040137617;1121.7924683933497;1122.893325134111;873.5632183908046;878.4729162502448;1152.7694461107812;1168.2581560709011;1170.1224081938547;6900;6946.6179360134665;6965.199002114821;6976.825579360557;6980.406665433394;910.226307638502;917.1702453605101;949.1552518258756;995.5619527407918;1009.6112996496402;5345.67925924438;5390.51485366319;5391.406945236021;5394.730263486888;5396.136618141157;7527.322540971339;7911.525308481395;8490.448120872123;8565.10066443027;8695.391322607484;8250.752477425687;8445.408821382567;8457.238848503664;8506.574671266411;8522.914770852336;6654.833629159213;6677.666116694146;6780.254172041072;6817.659117044128;6834.726610935606;6719.798406047827;6721;6728.899066513908;6732.865342693217;6753.257141714309;7416.998705174732;7541.7360392386;7649.770506884803;7719.961400192963;7752.573608451589;7815.374770018271;7972.800679983046;8004.079530854026;8031.598420078856;8037.31682806968;5880.470757631833;5912.113183022581;5943.494802941798;5943.8706645737175;5948.315943666361;6524.1192439022025;6552.312007239171;6552.475801935739;6562.5406221564035;6724.462043036643;6313.116163736989;6364.204474440695;6429.903551446826;6461.321561236003;6653.334666533308;6435.646039467874;6447.742090316335;6464.062710906798;6525.706343214471;6539.705713243011;6022.277326720821;6457.451116654949;6487.22153341602;6487.805365839033;6499.317571655098;6047.395260473917;6081.331053584014;6087.847803804763;6089.086637004485;6113.877722445615;6112.78605248832;6146;6182.165407669907;6283.465905397909;6323 05:30:30 INFO - 2015-11-17 05:30:30,625 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.9617547806524;310.6536212123483;311.2545453638537;314.9417357788809;315.3157647904048;5378.616501964519;5430.918536221955;5450.890982180354;5460.262864513289;5484.149956756699;5373.892522149555;5383.542398896098;5384;5391.81128660497;5395.919061214076;3931.0565464288507;4022.8994275143064;4188.476440444944;4188.85339013133;4197.412362269285;4062.878113656595;4151.647109995654;4186.916261674764;4197.8530751423705;4208.957910420902;4103.09731858992;4111.71218014739;4157.48031496063;4162.105147393309;4163.770992595406;3865.6714179294936;3966;3980.2636512245326;3988.4017397390335;4106.958930410688;3419.247765491613;3430.811305378203;3569.428891377367;3667.3765459871884;3669.614690457517;5185.377754669426;5187.429382767892;5196.194589838581;5200.505951934598;5203.037438073969;4770.546798054179;4777;4780.976095119537;4782.928256076161;4783.354247176656;5463.672179669193;5622.381538030813;5639.68981706006;5647.265855438766;5650.434956504358;3913.7651740895353;3915.8433662653742;3916.118873253524;3916.7649941003633;3922.490076290064;5863.824085277449;5943.078822782476;5948.464638182541;5948.553858460633;5951.49412299955;4010.3984402339297;4028.436018957348;4031.3348297531165;4034.0318323602123;4034.636882680514;3821.464994900716;3841.366174581163;3925.784081875467;4089.6932730045364;4092.652124569445;4522.479914809774;4621.145088158634;4667.766611669471;4669.486356500782;4674.532546745366;5643.294588176478;5643.871225754865;5644.842807224509;5650.773969041193;5658.886822263532;1392.1020941492884;1404.39610967283;1405.4940221520244;1406.2617126008722;1406.6834962133644;946.5598496699068;965.5944503308627;971.7959228562081;990.1138481059412;991.5984026469291;4927.852164435001;4932.704037757746;4946.925796113062;4955.4796746341835;4960.652754307164;5838;5850.3564607893095;5855.121731740188;5862.5896187267335;5867.735951882176;4926.064047830901;4930.186519224288;4947.134251505972;4949.851504454872;4951.851444456672;3091.5053591425262;3127.8436078196;3138.089953913385;3160.083575763049;3171.5559821624993;5553.139263414178;5559.58303127259;5562.415946325577;5563.693996830213;5563.833085007456;6036.004059330161;6037.4264444878545;6038.456538911431;6047.455728984412;6047.63714177142;5530.198121272393;5552.194931734956;5563.638363506359;5564.66612003273;5564.8330550083565;5669.376368599368;5838.766449341979;5843.678597677169;5845.883082338414;5846.41535846429;5701.600887937804;5713.143028545752;5713.600047996601;5715.085586306171;5718.370979192368;5552.139418390156;5558.666480011212;5559.833205003856;5560.193771903132;5560.999020176407;3960.702947279023;4046.1705350403686;4055.8377664893073;4057.208844275338;4064.7764372959773;5661.943380566142;5821.039528477754;5831.125331200354;5847.707614619337;5847.795327163529;5515.200295957144;5672.688002159921;5698.1452782083015;5700.914486282792;5702.230198923258;5680.289963754531;5683.005474042109;5686.800961966312;5687.146927960839;5688.488036076773;5404.486573775485;5535.557155427476;5540.667559946416;5542.057850165401;5544.63959842609;5717.085266357363;5720.856978575569;5727.284089488814;5734.254546908875;5734.569907257056;5584.246126772834;5589.888202235851;5591.804286849941;5594.328680558359;5598.944010560005 05:30:30 INFO - 2015-11-17 05:30:30,625 DEBUG : BROWSER_OUTPUT: |5;yui.html;638.7213689432875;639.3223183425566;688.3391943734017;704.6969802984717;720.0567256893473;11601.477933492992;11762.353070581115;11785.646430607074;11807.350595717233;11860.169788114836;11489.770204595903;11517.078633709305;11595.072394208464;11625.651230463078;12556.497740090408;597.8983572792614;756.2399788212853;766.2950085920966;768.7424712721245;768.8154842837735;602.066796465479;744.5272252119888;761.1855314813153;762.1578156137472;762.4472257613241;786.0371045469311;795.5783434779576;799.8640231160688;800.1718221640604;800.671724592917;609.7682880505401;615.4215037864437;775.825439276164;789.917058708836;790.5533373643873;582.1151849189251;582.6445868020504;582.8834233153344;583.5477504933668;584.0829897061615;11464.541418343257;11599.246049006788;11599.710007249801;11604.941975290154;11620.186586938918;8558.186972237627;8808.603612837438;8822.86765698515;9049.864252036225;9122;8576.09950955147;8665.393422460367;8739.126087391274;9109.362344635878;9116.863247051233;2786.21985843964;2809.606655068292;2835.4470878178763;2864.298246929495;2884.1491759930873;38726.419103713466;39234.41148382777;39341.213175736324;39445.80277098625;39725.60274397248;6300.558960872695;6357.777477788255;6379.71291291893;6868.175818901664;7034.8944765828555;10507.579696812194;10598.364098154136;10618.893811061946;10621.681349559525;10631.946840265904;5525.281713377316;5595.300587426572;5598.496135347838;5632;5728.79949201776;3437.2094418283937;3468.601110872282;3498.9125271868406;3503.4219353806848;3557.8043207623828;2405.2663937499233;2432.3067925641462;2434.8782560871887;2435.744246854055;2436.1108195508864;347.2343482620815;352.17590837440514;353.43626915070934;354.11824556853765;368.74003827301686;403.91517781265674;417.1094712788219;423.3903179421623;435.70589851849877;477.73246981690363;6820.03136102899;6884.65576721162;6973.51185417026;6981.441484681213;7072.71709131629;390.23124444843614;400.3814107204376;505.4263411028509;529.5922139952293;545.364650182533;3383.509391138271;3423.400904841643;3509.64903509647;3517.1734642359024;3560.626134255918;44623;45127.32309015367;45323;45437;47358.76320618375;44639.77680111644;44996.3250551242;45161.32258016132;45466.31800522995;45552.08895822131;41322.38016429756;41362.793186034476;41479.1704165915;42352.36471452931;42391.57608423938;7050.929490705233;7434.553926764412;7489.251074892467;7514.736984205527;7708.460407771627;31982.84008580035;32166.517502237017;32534.674653253165;32577.511337330434;33809.49285760667;40200.597994019685;40229;40283.1943361137;41228.58771412368;41405.171896562504;6856.382925536725;6885.51801373899;6966.164060312795;7049.7885063448175;7184.497085204194;10198.541065651914;10319.535620896928;10443.268971171945;10909.945450272699;10946.179036572448;9901.851472228067;10058.396496210251;10232.386056836614;10326.432046237529;10472.633457828939;10148.289619726549;10196.745081373025;10288.12550933179;10389.37663740178;10804.783904322027;10202.183825294107;10255.179585633281;10343.655324807727;10362.948185259025;10467.581296748349;7876.72431464896;7986.680532778624;8178.591070446335;8254.504729716236;8465.322774178174;8422.199891010345;8448.91551084506;8510.872336914827;8525.573721313785;8605.65577376923 05:30:30 INFO - 2015-11-17 05:30:30,625 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:30 INFO - 2015-11-17 05:30:30,625 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:30:30 INFO - 2015-11-17 05:30:30,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,917 05:30:30 INFO - 2015-11-17 05:30:30,625 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:30:30 INFO - 2015-11-17 05:30:30,625 DEBUG : BROWSER_OUTPUT: __startTimestamp1447767030616__endTimestamp 05:30:30 INFO - 2015-11-17 05:30:30,625 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,626 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:30 INFO - 2015-11-17 05:30:30,626 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:30:30 INFO - 2015-11-17 05:30:30,626 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,626 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4708.81 Median:4838.83 stddev:493.36 (10.2%) stddev-sans-first:467.94 05:30:30 INFO - 2015-11-17 05:30:30,627 DEBUG : BROWSER_OUTPUT: Values: 2659.0 2759.5 2764.7 2768.5 2769.3 4553.8 4692.6 4758.9 4792.5 4807.0 4695.7 4730.0 4733.2 4821.1 4838.8 4380.8 4391.5 4419.8 4426.2 4431.8 4175.9 4448.2 4474.3 4499.5 4514.4 4322.7 4336.0 4410.8 4447.7 4459.3 4385.7 4389.3 4393.8 4440.2 4448.8 4206.1 4305.4 4375.2 4399.4 4417.4 4689.8 4806.8 4846.3 4858.2 4863.6 5137.2 5151.4 5156.1 5192.6 5195.6 4876.3 5170.1 5177.8 5190.3 5190.8 4671.0 4673.6 4678.4 4688.6 4785.8 5256.2 5262.7 5268.4 5287.4 5298.7 5033.3 5035.6 5037.4 5042.8 5088.1 4839.6 4958.1 4967.3 5013.7 5160.4 5086.6 5095.2 5095.6 5103.9 5110.5 5070.3 5075.1 5085.2 5087.7 5115.7 4070.6 4178.5 4178.9 4309.5 4346.5 3650.6 3724.2 3746.1 3751.3 3767.1 4393.1 4412.7 4422.5 4431.2 4447.0 4979.4 5135.9 5178.5 5197.7 5198.8 4285.9 4321.9 4367.1 4382.9 4417.7 4557.6 4558.8 4576.4 4589.7 4610.7 4665.1 4781.2 4894.0 4895.5 4899.3 4992.7 5065.5 5066.0 5100.5 5116.8 4950.7 4960.8 4963.1 4963.5 5005.0 4891.5 5016.4 5122.9 5128.2 5129.6 5000.8 5043.2 5109.3 5118.4 5139.4 4966.0 4988.9 4990.8 4994.2 5037.1 4681.4 4796.5 4985.4 4996.1 4996.3 4701.4 4732.5 4770.0 4770.6 4797.3 4951.9 4967.0 4968.1 4968.7 5010.8 4685.1 4795.4 4868.4 4885.7 4919.8 05:30:30 INFO - 2015-11-17 05:30:30,627 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,627 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36554.34 Median:32824.84 stddev:52244.60 (159.2%) stddev-sans-first:52321.18 05:30:30 INFO - 2015-11-17 05:30:30,627 DEBUG : BROWSER_OUTPUT: Values: 543.0 548.2 552.6 562.1 562.8 28278.0 28801.4 28805.3 36654.6 37870.6 40570.8 40964.0 41004.6 41016.0 41040.0 7781.8 7952.1 7953.7 7959.2 7960.9 7035.1 7179.3 10010.4 10285.5 10291.1 9976.4 10082.0 10091.4 10096.7 10098.8 6924.9 7053.2 9909.8 10039.6 10048.6 9733.8 9907.7 9910.0 9959.6 9965.2 37892.4 38212.0 38237.4 38242.4 38259.6 2658.3 2704.1 2746.6 2761.6 3560.5 28511.3 28623.9 28980.0 29193.9 29521.6 3042.6 3098.3 3156.1 3173.1 3217.6 214397.0 215055.0 215166.0 215695.0 215764.0 44122.8 45078.8 53288.5 53555.2 54161.2 55898.0 55938.7 56298.4 56347.4 56423.7 12133.6 12215.5 12326.9 12342.9 12345.5 8059.8 8079.4 8172.7 8185.4 8186.2 18697.0 18735.3 18819.2 18846.5 18902.1 6797.1 7019.9 7057.8 7108.6 7122.8 782.6 831.9 886.5 947.3 1053.3 23629.0 24939.4 25025.9 25245.7 25297.5 919.7 926.3 926.4 929.9 936.3 12857.5 13100.8 13491.5 13509.8 14257.8 205774.0 210492.0 211319.0 211861.0 212053.0 42430.8 42671.8 42719.8 42800.6 42836.0 1158.6 1194.8 1215.8 1221.7 1225.5 22190.7 25275.4 26054.2 27163.6 27268.7 39197.0 39547.0 39606.4 39607.0 39681.2 175891.0 178342.1 178386.0 178492.0 179065.0 23507.9 23993.2 28894.7 29236.3 29742.6 34068.7 36537.8 36712.6 37525.2 37707.4 31620.4 32681.8 34100.8 36740.3 36883.4 31762.8 32889.0 34084.5 35584.0 36119.6 32760.7 33345.8 33362.8 33393.2 33422.8 28419.7 28730.6 30409.8 30504.8 30771.7 23064.2 23187.8 23417.8 23551.5 23689.4 05:30:30 INFO - 2015-11-17 05:30:30,628 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,628 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24598.08 Median:4689.62 stddev:78203.32 (1667.6%) stddev-sans-first:78401.46 05:30:30 INFO - 2015-11-17 05:30:30,628 DEBUG : BROWSER_OUTPUT: Values: 325.0 329.7 338.9 340.1 341.7 12530.3 13021.1 15072.9 15428.7 17094.6 12985.7 15741.3 16154.4 16475.0 16484.6 4794.9 4937.7 4939.3 4946.8 4946.8 3424.9 3537.6 4859.8 4922.0 5530.4 5663.8 5701.0 5710.3 5727.3 5727.6 5583.0 5696.0 5782.7 5796.0 5810.9 5090.6 5093.4 5112.8 5122.5 5128.2 19451.8 19609.8 19991.5 20020.4 20256.5 1736.5 1739.9 1741.7 1792.8 1792.8 12760.9 12913.4 13144.9 13160.9 13200.0 1582.6 1585.6 1623.1 1632.2 1676.9 52373.0 53949.7 54097.2 54172.5 54854.2 6306.5 6339.7 6388.4 6426.7 6445.3 7450.1 7451.9 7454.6 7463.9 7475.6 4680.2 4683.7 4687.6 4691.6 4717.0 4640.7 4753.4 4779.4 4784.8 4791.6 2887.1 2896.5 2908.5 2939.1 2943.5 1056.5 1083.5 2854.5 2916.6 2998.1 400.2 404.6 423.3 424.3 430.9 10677.4 10867.9 10887.2 11016.9 11216.0 420.9 424.9 432.6 441.4 448.4 5676.8 5691.0 5846.4 5866.0 5882.7 436334.0 442325.0 497168.0 500702.0 507041.0 61997.0 67991.3 68414.3 68495.0 68556.0 486.6 491.8 492.3 492.6 493.6 9851.3 9893.4 9896.7 10061.4 10068.8 31697.5 32763.5 33983.8 34003.0 34172.5 42309.4 42544.0 42544.6 43480.3 43777.0 5858.6 5930.4 5935.9 5944.4 5955.3 8164.3 10993.7 11235.4 11271.3 11271.7 9788.3 10049.2 10076.2 10282.2 10282.9 9618.6 9736.0 9744.4 9808.6 9948.8 9786.9 9924.1 9929.7 10129.7 10158.0 6114.4 6178.3 6183.7 6188.9 6192.3 9757.8 9861.0 9942.1 9944.7 10051.7 05:30:30 INFO - 2015-11-17 05:30:30,628 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,628 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4972.84 Median:6318.06 stddev:2576.63 (40.8%) stddev-sans-first:2568.05 05:30:30 INFO - 2015-11-17 05:30:30,629 DEBUG : BROWSER_OUTPUT: Values: 1176.0 1555.7 1623.1 1633.8 1663.0 6119.1 6478.0 6810.3 7197.7 7227.0 7075.9 7093.2 7123.9 7141.1 7151.1 1647.9 1713.2 2049.0 2071.2 2074.0 2039.3 2078.5 2085.2 2085.3 2086.4 2037.6 2045.0 2051.9 2083.5 2084.3 2037.0 2063.1 2092.9 2095.5 2100.2 2042.0 2064.2 2064.6 2067.1 2068.5 7078.6 7140.6 7146.7 7147.2 7151.4 4125.3 4174.4 4190.3 4199.2 4207.6 2593.1 2676.2 2679.6 2701.1 2701.7 734.3 884.5 895.8 914.5 948.4 9635.0 9672.9 9701.0 9703.0 9719.9 3814.6 3829.3 3869.2 3924.0 3928.1 8259.3 8282.3 8298.9 8306.9 8312.1 4129.5 4140.7 4143.6 4145.5 4148.2 3714.9 3732.5 3737.2 3742.8 3749.2 3488.7 3506.2 3508.9 3519.9 3534.1 1106.1 1111.0 1114.9 1121.8 1122.9 873.6 878.5 1152.8 1168.3 1170.1 6900.0 6946.6 6965.2 6976.8 6980.4 910.2 917.2 949.2 995.6 1009.6 5345.7 5390.5 5391.4 5394.7 5396.1 7527.3 7911.5 8490.4 8565.1 8695.4 8250.8 8445.4 8457.2 8506.6 8522.9 6654.8 6677.7 6780.3 6817.7 6834.7 6719.8 6721.0 6728.9 6732.9 6753.3 7417.0 7541.7 7649.8 7720.0 7752.6 7815.4 7972.8 8004.1 8031.6 8037.3 5880.5 5912.1 5943.5 5943.9 5948.3 6524.1 6552.3 6552.5 6562.5 6724.5 6313.1 6364.2 6429.9 6461.3 6653.3 6435.6 6447.7 6464.1 6525.7 6539.7 6022.3 6457.5 6487.2 6487.8 6499.3 6047.4 6081.3 6087.8 6089.1 6113.9 6112.8 6146.0 6182.2 6283.5 6323.0 05:30:30 INFO - 2015-11-17 05:30:30,629 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,629 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4674.19 Median:5400.20 stddev:1390.34 (25.7%) stddev-sans-first:1355.03 05:30:30 INFO - 2015-11-17 05:30:30,629 DEBUG : BROWSER_OUTPUT: Values: 306.0 310.7 311.3 314.9 315.3 5378.6 5430.9 5450.9 5460.3 5484.1 5373.9 5383.5 5384.0 5391.8 5395.9 3931.1 4022.9 4188.5 4188.9 4197.4 4062.9 4151.6 4186.9 4197.9 4209.0 4103.1 4111.7 4157.5 4162.1 4163.8 3865.7 3966.0 3980.3 3988.4 4107.0 3419.2 3430.8 3569.4 3667.4 3669.6 5185.4 5187.4 5196.2 5200.5 5203.0 4770.5 4777.0 4781.0 4782.9 4783.4 5463.7 5622.4 5639.7 5647.3 5650.4 3913.8 3915.8 3916.1 3916.8 3922.5 5863.8 5943.1 5948.5 5948.6 5951.5 4010.4 4028.4 4031.3 4034.0 4034.6 3821.5 3841.4 3925.8 4089.7 4092.7 4522.5 4621.1 4667.8 4669.5 4674.5 5643.3 5643.9 5644.8 5650.8 5658.9 1392.1 1404.4 1405.5 1406.3 1406.7 946.6 965.6 971.8 990.1 991.6 4927.9 4932.7 4946.9 4955.5 4960.7 5838.0 5850.4 5855.1 5862.6 5867.7 4926.1 4930.2 4947.1 4949.9 4951.9 3091.5 3127.8 3138.1 3160.1 3171.6 5553.1 5559.6 5562.4 5563.7 5563.8 6036.0 6037.4 6038.5 6047.5 6047.6 5530.2 5552.2 5563.6 5564.7 5564.8 5669.4 5838.8 5843.7 5845.9 5846.4 5701.6 5713.1 5713.6 5715.1 5718.4 5552.1 5558.7 5559.8 5560.2 5561.0 3960.7 4046.2 4055.8 4057.2 4064.8 5661.9 5821.0 5831.1 5847.7 5847.8 5515.2 5672.7 5698.1 5700.9 5702.2 5680.3 5683.0 5686.8 5687.1 5688.5 5404.5 5535.6 5540.7 5542.1 5544.6 5717.1 5720.9 5727.3 5734.3 5734.6 5584.2 5589.9 5591.8 5594.3 5598.9 05:30:30 INFO - 2015-11-17 05:30:30,629 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-17 05:30:30,630 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11608.93 Median:44631.39 stddev:13774.57 (30.9%) stddev-sans-first:13788.58 05:30:30 INFO - 2015-11-17 05:30:30,631 DEBUG : BROWSER_OUTPUT: Values: 638.7 639.3 688.3 704.7 720.1 11601.5 11762.4 11785.6 11807.4 11860.2 11489.8 11517.1 11595.1 11625.7 12556.5 597.9 756.2 766.3 768.7 768.8 602.1 744.5 761.2 762.2 762.4 786.0 795.6 799.9 800.2 800.7 609.8 615.4 775.8 789.9 790.6 582.1 582.6 582.9 583.5 584.1 11464.5 11599.2 11599.7 11604.9 11620.2 8558.2 8808.6 8822.9 9049.9 9122.0 8576.1 8665.4 8739.1 9109.4 9116.9 2786.2 2809.6 2835.4 2864.3 2884.1 38726.4 39234.4 39341.2 39445.8 39725.6 6300.6 6357.8 6379.7 6868.2 7034.9 10507.6 10598.4 10618.9 10621.7 10631.9 5525.3 5595.3 5598.5 5632.0 5728.8 3437.2 3468.6 3498.9 3503.4 3557.8 2405.3 2432.3 2434.9 2435.7 2436.1 347.2 352.2 353.4 354.1 368.7 403.9 417.1 423.4 435.7 477.7 6820.0 6884.7 6973.5 6981.4 7072.7 390.2 400.4 505.4 529.6 545.4 3383.5 3423.4 3509.6 3517.2 3560.6 44623.0 45127.3 45323.0 45437.0 47358.8 44639.8 44996.3 45161.3 45466.3 45552.1 41322.4 41362.8 41479.2 42352.4 42391.6 7050.9 7434.6 7489.3 7514.7 7708.5 31982.8 32166.5 32534.7 32577.5 33809.5 40200.6 40229.0 40283.2 41228.6 41405.2 6856.4 6885.5 6966.2 7049.8 7184.5 10198.5 10319.5 10443.3 10909.9 10946.2 9901.9 10058.4 10232.4 10326.4 10472.6 10148.3 10196.7 10288.1 10389.4 10804.8 10202.2 10255.2 10343.7 10362.9 10467.6 7876.7 7986.7 8178.6 8254.5 8465.3 8422.2 8448.9 8510.9 8525.6 8605.7 05:30:30 INFO - 2015-11-17 05:30:30,631 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:30 INFO - 2015-11-17 05:30:30,631 DEBUG : BROWSER_OUTPUT: 05:30:31 INFO - 2015-11-17 05:30:31,391 INFO : Browser exited with error code: 0 05:30:31 INFO - 2015-11-17 05:30:31,409 INFO : Completed test dromaeo_css (00:18:37) 05:30:31 INFO - 2015-11-17 05:30:31,409 INFO : Starting test kraken 05:30:31 INFO - 2015-11-17 05:30:31,409 DEBUG : operating with platform_type : linux_ 05:30:31 INFO - 2015-11-17 05:30:31,409 INFO : Initialising browser for kraken test... 05:30:31 INFO - 2015-11-17 05:30:31,415 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2lHCFA/profile http://localhost:49353/getInfo.html 05:30:35 INFO - 2015-11-17 05:30:35,372 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:35 INFO - 2015-11-17 05:30:35,372 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:35 INFO - 2015-11-17 05:30:35,372 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:30:35 INFO - 2015-11-17 05:30:35,372 DEBUG : BROWSER_OUTPUT: __metrics 05:30:35 INFO - 2015-11-17 05:30:35,508 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:36 INFO - 2015-11-17 05:30:36,785 INFO : Browser initialized. 05:30:36 INFO - 2015-11-17 05:30:36,785 INFO : Running cycle 1/1 for kraken test... 05:30:36 INFO - 2015-11-17 05:30:36,785 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2lHCFA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:48 INFO - 2015-11-17 05:30:48,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 141701120 05:30:48 INFO - 2015-11-17 05:30:48,653 DEBUG : BROWSER_OUTPUT: 05:30:51 INFO - 2015-11-17 05:30:51,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49353/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:51 INFO - 2015-11-17 05:30:51,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 177864704 05:30:51 INFO - 2015-11-17 05:30:51,795 DEBUG : BROWSER_OUTPUT: 05:30:54 INFO - 2015-11-17 05:30:54,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49353/tests/kraken/driver.html?testName=audio-dft) 05:30:55 INFO - 2015-11-17 05:30:55,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 168214528 05:30:55 INFO - 2015-11-17 05:30:55,093 DEBUG : BROWSER_OUTPUT: 05:30:58 INFO - 2015-11-17 05:30:58,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49353/tests/kraken/driver.html?testName=audio-fft) 05:30:58 INFO - 2015-11-17 05:30:58,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 151101440 05:30:58 INFO - 2015-11-17 05:30:58,671 DEBUG : BROWSER_OUTPUT: 05:31:00 INFO - 2015-11-17 05:31:00,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49353/tests/kraken/driver.html?testName=audio-oscillator) 05:31:01 INFO - 2015-11-17 05:31:01,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 154685440 05:31:01 INFO - 2015-11-17 05:31:01,257 DEBUG : BROWSER_OUTPUT: 05:31:03 INFO - 2015-11-17 05:31:03,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49353/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:04 INFO - 2015-11-17 05:31:04,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 155136000 05:31:04 INFO - 2015-11-17 05:31:04,037 DEBUG : BROWSER_OUTPUT: 05:31:07 INFO - 2015-11-17 05:31:07,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49353/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:07 INFO - 2015-11-17 05:31:07,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 156413952 05:31:07 INFO - 2015-11-17 05:31:07,586 DEBUG : BROWSER_OUTPUT: 05:31:11 INFO - 2015-11-17 05:31:11,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49353/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:11 INFO - 2015-11-17 05:31:11,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 157229056 05:31:11 INFO - 2015-11-17 05:31:11,648 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-17 05:31:14,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49353/tests/kraken/driver.html?testName=json-parse-financial) 05:31:15 INFO - 2015-11-17 05:31:15,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 157843456 05:31:15 INFO - 2015-11-17 05:31:15,080 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-17 05:31:16,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49353/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:17 INFO - 2015-11-17 05:31:17,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 162930688 05:31:17 INFO - 2015-11-17 05:31:17,442 DEBUG : BROWSER_OUTPUT: 05:31:19 INFO - 2015-11-17 05:31:19,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49353/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:19 INFO - 2015-11-17 05:31:19,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 163606528 05:31:19 INFO - 2015-11-17 05:31:19,908 DEBUG : BROWSER_OUTPUT: 05:31:22 INFO - 2015-11-17 05:31:22,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49353/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:22 INFO - 2015-11-17 05:31:22,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 170864640 05:31:22 INFO - 2015-11-17 05:31:22,614 DEBUG : BROWSER_OUTPUT: 05:31:25 INFO - 2015-11-17 05:31:25,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:25 INFO - 2015-11-17 05:31:25,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 179183616 05:31:25 INFO - 2015-11-17 05:31:25,707 DEBUG : BROWSER_OUTPUT: 05:31:28 INFO - 2015-11-17 05:31:28,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:28 INFO - 2015-11-17 05:31:28,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 175661056 05:31:28 INFO - 2015-11-17 05:31:28,868 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49353/tests/kraken/driver.html?testName=ai-astar) 05:31:30 INFO - 2015-11-17 05:31:30,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 234872832 05:31:30 INFO - 2015-11-17 05:31:30,868 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,869 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:31:30 INFO - 2015-11-17 05:31:30,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:31:30 INFO - 2015-11-17 05:31:30,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:31:30 INFO - 2015-11-17 05:31:30,870 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:31:30 INFO - 2015-11-17 05:31:30,870 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;110;113;114;102;112;103;110 05:31:30 INFO - 2015-11-17 05:31:30,870 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;132;154;167;137;154;164;135;165;134 05:31:30 INFO - 2015-11-17 05:31:30,870 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;162;162;161;161;162;161;164;164 05:31:30 INFO - 2015-11-17 05:31:30,870 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;82;92;71;72;72;91;87;73 05:31:30 INFO - 2015-11-17 05:31:30,870 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;134;91;92;91;127;91;93;126 05:31:30 INFO - 2015-11-17 05:31:30,871 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;109;109;109;110;109 05:31:30 INFO - 2015-11-17 05:31:30,871 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;148;149;147;148;147;148;148 05:31:30 INFO - 2015-11-17 05:31:30,871 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;96;96;95;95;96;95;96;95 05:31:30 INFO - 2015-11-17 05:31:30,871 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;71;70;71;71;70;70;80;69;69 05:31:30 INFO - 2015-11-17 05:31:30,871 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;70;70;70;69;69 05:31:30 INFO - 2015-11-17 05:31:30,872 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;82;95;83;83;82;84;85;83 05:31:30 INFO - 2015-11-17 05:31:30,872 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;119;127;117;129;124;128;119;122;127 05:31:30 INFO - 2015-11-17 05:31:30,872 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;142;145;144;149;135;146;146;146;134 05:31:30 INFO - 2015-11-17 05:31:30,872 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;70;69;68;72;69;68;69 05:31:30 INFO - 2015-11-17 05:31:30,872 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:31:30 INFO - 2015-11-17 05:31:30,872 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:31:30 INFO - 2015-11-17 05:31:30,872 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,968 05:31:30 INFO - 2015-11-17 05:31:30,872 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:31:30 INFO - 2015-11-17 05:31:30,873 DEBUG : BROWSER_OUTPUT: __startTimestamp1447767090868__endTimestamp 05:31:30 INFO - 2015-11-17 05:31:30,873 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,876 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:31:30 INFO - 2015-11-17 05:31:30,876 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:31:30 INFO - 2015-11-17 05:31:30,876 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,876 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:4.24 (3.8%) stddev-sans-first:4.50 05:31:30 INFO - 2015-11-17 05:31:30,876 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 110.0 113.0 114.0 102.0 112.0 103.0 110.0 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.00 Median:156.00 stddev:14.06 (9.0%) stddev-sans-first:14.62 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: Values: 158.0 132.0 154.0 167.0 137.0 154.0 164.0 135.0 165.0 134.0 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.16 (0.7%) stddev-sans-first:1.20 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 162.0 162.0 161.0 161.0 162.0 161.0 164.0 164.0 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.60 Median:77.50 stddev:8.53 (11.0%) stddev-sans-first:8.80 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 82.0 92.0 71.0 72.0 72.0 91.0 87.0 73.0 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.00 Median:91.50 stddev:18.07 (19.8%) stddev-sans-first:18.73 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 134.0 91.0 92.0 91.0 127.0 91.0 93.0 126.0 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 05:31:30 INFO - 2015-11-17 05:31:30,877 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 148.0 149.0 147.0 148.0 147.0 148.0 148.0 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:70.50 stddev:3.21 (4.6%) stddev-sans-first:3.38 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 71.0 71.0 70.0 70.0 80.0 69.0 69.0 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 70.0 70.0 70.0 69.0 69.0 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.50 stddev:3.84 (4.6%) stddev-sans-first:4.03 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 82.0 95.0 83.0 83.0 82.0 84.0 85.0 83.0 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,878 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:125.50 stddev:4.25 (3.4%) stddev-sans-first:4.48 05:31:30 INFO - 2015-11-17 05:31:30,879 DEBUG : BROWSER_OUTPUT: Values: 122.0 119.0 127.0 117.0 129.0 124.0 128.0 119.0 122.0 127.0 05:31:30 INFO - 2015-11-17 05:31:30,879 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,879 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:145.50 stddev:5.23 (3.6%) stddev-sans-first:5.17 05:31:30 INFO - 2015-11-17 05:31:30,879 DEBUG : BROWSER_OUTPUT: Values: 137.0 142.0 145.0 144.0 149.0 135.0 146.0 146.0 146.0 134.0 05:31:30 INFO - 2015-11-17 05:31:30,879 DEBUG : BROWSER_OUTPUT: 05:31:30 INFO - 2015-11-17 05:31:30,879 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 05:31:30 INFO - 2015-11-17 05:31:30,879 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 70.0 69.0 68.0 72.0 69.0 68.0 69.0 05:31:30 INFO - 2015-11-17 05:31:30,880 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:31:30 INFO - 2015-11-17 05:31:30,880 DEBUG : BROWSER_OUTPUT: 05:31:31 INFO - 2015-11-17 05:31:31,853 INFO : Browser exited with error code: 0 05:31:31 INFO - 2015-11-17 05:31:31,907 INFO : Completed test kraken (00:01:00) 05:31:31 INFO - 2015-11-17 05:31:31,908 INFO : Starting test v8_7 05:31:31 INFO - 2015-11-17 05:31:31,908 DEBUG : operating with platform_type : linux_ 05:31:31 INFO - 2015-11-17 05:31:31,908 INFO : Initialising browser for v8_7 test... 05:31:31 INFO - 2015-11-17 05:31:31,914 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgrXthT/profile http://localhost:49353/getInfo.html 05:31:35 INFO - 2015-11-17 05:31:35,933 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:31:35 INFO - 2015-11-17 05:31:35,933 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:31:35 INFO - 2015-11-17 05:31:35,934 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:31:35 INFO - 2015-11-17 05:31:35,934 DEBUG : BROWSER_OUTPUT: __metrics 05:31:36 INFO - 2015-11-17 05:31:36,091 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:37 INFO - 2015-11-17 05:31:37,333 INFO : Browser initialized. 05:31:37 INFO - 2015-11-17 05:31:37,334 INFO : Running cycle 1/1 for v8_7 test... 05:31:37 INFO - 2015-11-17 05:31:37,334 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgrXthT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:31:49 INFO - 2015-11-17 05:31:49,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 141668352 05:31:49 INFO - 2015-11-17 05:31:49,273 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49353/tests/v8_7/run.html (next: http://localhost:49353/tests/v8_7/run.html) 05:32:10 INFO - 2015-11-17 05:32:10,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 438616064 05:32:10 INFO - 2015-11-17 05:32:10,900 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,900 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:32:10 INFO - 2015-11-17 05:32:10,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:32:10 INFO - 2015-11-17 05:32:10,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:32:10 INFO - 2015-11-17 05:32:10,901 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:32:10 INFO - 2015-11-17 05:32:10,901 DEBUG : BROWSER_OUTPUT: |0;Richards;168.8048615800135 05:32:10 INFO - 2015-11-17 05:32:10,901 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.71779141104295 05:32:10 INFO - 2015-11-17 05:32:10,901 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 05:32:10 INFO - 2015-11-17 05:32:10,901 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 05:32:10 INFO - 2015-11-17 05:32:10,901 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 05:32:10 INFO - 2015-11-17 05:32:10,902 DEBUG : BROWSER_OUTPUT: |5;Earley;803.8585209003215 05:32:10 INFO - 2015-11-17 05:32:10,902 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 05:32:10 INFO - 2015-11-17 05:32:10,902 DEBUG : BROWSER_OUTPUT: |7;RegExp;27054.054054054053 05:32:10 INFO - 2015-11-17 05:32:10,902 DEBUG : BROWSER_OUTPUT: |8;Splay;617.5567833026397 05:32:10 INFO - 2015-11-17 05:32:10,902 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 05:32:10 INFO - 2015-11-17 05:32:10,902 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:32:10 INFO - 2015-11-17 05:32:10,903 DEBUG : BROWSER_OUTPUT: __startTimestamp1447767130893__endTimestamp 05:32:10 INFO - 2015-11-17 05:32:10,903 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,903 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:32:10 INFO - 2015-11-17 05:32:10,903 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:32:10 INFO - 2015-11-17 05:32:10,903 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,903 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.80 Median:168.80 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,903 DEBUG : BROWSER_OUTPUT: Values: 168.8 05:32:10 INFO - 2015-11-17 05:32:10,903 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,904 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.72 Median:191.72 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,904 DEBUG : BROWSER_OUTPUT: Values: 191.7 05:32:10 INFO - 2015-11-17 05:32:10,904 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,904 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,904 DEBUG : BROWSER_OUTPUT: Values: 280.4 05:32:10 INFO - 2015-11-17 05:32:10,904 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,904 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: Values: 5030.2 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: Values: 1986.1 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:803.86 Median:803.86 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: Values: 803.9 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: Values: 12195.1 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,905 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: Values: 27054.1 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.56 Median:617.56 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: Values: 617.6 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: Values: 4845.4 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:32:10 INFO - 2015-11-17 05:32:10,906 DEBUG : BROWSER_OUTPUT: 05:32:11 INFO - 2015-11-17 05:32:11,841 INFO : Browser exited with error code: 0 05:32:11 INFO - 2015-11-17 05:32:11,856 INFO : Completed test v8_7 (00:00:39) 05:32:11 INFO - 2015-11-17 05:32:11,957 INFO : Completed test suite (00:20:17) 05:32:11 INFO - 2015-11-17 05:32:11,957 DEBUG : Working with test: dromaeo_css 05:32:11 INFO - 2015-11-17 05:32:11,958 DEBUG : Generating results file: dromaeo_css 05:32:11 INFO - 2015-11-17 05:32:11,959 DEBUG : Working with test: kraken 05:32:11 INFO - 2015-11-17 05:32:11,959 DEBUG : Generating results file: kraken 05:32:11 INFO - 2015-11-17 05:32:11,959 INFO : javascript benchmark 05:32:11 INFO - 2015-11-17 05:32:11,959 DEBUG : Working with test: v8_7 05:32:11 INFO - 2015-11-17 05:32:11,959 DEBUG : Generating results file: v8_7 05:32:11 INFO - 2015-11-17 05:32:11,960 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:12 INFO - 2015-11-17 05:32:12,024 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 05:32:12 INFO - 2015-11-17 05:32:12,024 DEBUG : process_Request line: dromaeo_css 5988.94 graph.html#tests=[[72,203,35]] 05:32:12 INFO - 2015-11-17 05:32:12,024 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:12 INFO - 2015-11-17 05:32:12,060 DEBUG : process_Request line: kraken 1515.70 graph.html#tests=[[232,203,35]] 05:32:12 INFO - 2015-11-17 05:32:12,060 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:12 INFO - 2015-11-17 05:32:12,101 DEBUG : process_Request line: v8_7 19665.75 graph.html#tests=[[230,203,35]] 05:32:12 INFO - 2015-11-17 05:32:12,103 INFO : javascript benchmark 05:32:12 INFO - 2015-11-17 05:32:12,106 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [324.9730850512381, 329.6653896295259, 338.9306737243995, 340.11400302212735, 341.69418370558344, 12530.310832904186, 13021.088523803337, 15072.924635376821, 15428.691426171485, 17094.572635684097, 12985.74028519429, 15741.291641876114, 16154.353825846982, 16475.022997240347, 16484.587885302873, 4794.928076078853, 4937.703737775727, 4939.28380384844, 4946.7526623668855, 4946.802127914879, 3424.914377140579, 3537.6108628050893, 4859.83363992641, 4922.01559688062, 5530.364008139075, 5663.801766938158, 5701.03082475978, 5710.2862142232225, 5727.341355744101, 5727.599068065237, 5582.972085139569, 5696.0, 5782.681952492611, 5795.971020144893, 5810.912836307417, 5090.567301779353, 5093.439721630618, 5112.846614601568, 5122.487751224885, 5128.153854613985, 19451.80548194528, 19609.80390196094, 19991.50021249466, 20020.399388018384, 20256.49358766028, 1736.496416039347, 1739.8869073510182, 1741.703910335246, 1792.7759030121235, 1792.7848658160974, 12760.872391276062, 12913.354332283348, 13144.934275328658, 13160.934195329059, 13200.0, 1582.5647946814604, 1585.5877471857284, 1623.1235133028151, 1632.2246932706987, 1676.9161541922856, 52373.0, 53949.73025134888, 54097.18854217229, 54172.45827541753, 54854.17718734222, 6306.527010474233, 6339.714712837841, 6388.39310265524, 6426.742930282736, 6445.323241059715, 7450.105987281561, 7451.925480745123, 7454.552726836408, 7463.925360746432, 7475.626218689153, 4680.227762419163, 4683.7423941682855, 4687.601553867891, 4691.648126390534, 4716.976415117971, 4640.69835460694, 4753.35829662998, 4779.378680771478, 4784.832530861403, 4791.568758811654, 2887.104997450797, 2896.4641541314923, 2908.5055540558155, 2939.1476471823357, 2943.484890144216, 1056.536696675095, 1083.5232497700986, 2854.5432730762977, 2916.6354205724283, 2998.1005698290423, 400.1736414304452, 404.57519604415245, 423.2614088415673, 424.2850796408062, 430.8750462365879, 10677.359358438518, 10867.891321086689, 10887.237893347548, 11016.944915275533, 11216.0, 420.86321945367877, 424.932010878258, 432.5695932547136, 441.4107166932117, 448.3678014000244, 5676.801311954062, 5690.971545142248, 5846.444587764156, 5865.970670146622, 5882.735276912549, 436334.0, 442325.0, 497168.0, 500702.0, 507041.0, 61997.0, 67991.3200867985, 68414.3158568408, 68495.0, 68556.0, 486.5766782898901, 491.8008206676302, 492.31076492909494, 492.6256045405446, 493.62977766674993, 9851.261155413516, 9893.406395616286, 9896.703098907044, 10061.446620435947, 10068.798624027331, 31697.5245371315, 32763.508547371333, 33983.83008084944, 34003.0, 34172.48741268933, 42309.36535952025, 42544.0, 42544.57455425406, 43480.34779478247, 43777.0, 5858.560607954506, 5930.436608522184, 5935.881282374415, 5944.375840536682, 5955.255593050869, 8164.306033987177, 10993.725156871142, 11235.438228088726, 11271.323720576791, 11271.718207044561, 9788.314817962959, 10049.246306526893, 10076.244281678757, 10282.177425806067, 10282.948585257025, 9618.615255389706, 9736.026397360207, 9744.366616169926, 9808.558614862492, 9948.801023979335, 9786.853197201905, 9924.1068303853, 9929.652462164078, 10129.746756331151, 10158.034986676254, 6114.38856114385, 6178.258608966953, 6183.721732521957, 6188.938110618837, 6192.318844927145, 9757.756056098655, 9860.950695246765, 9942.105210531086, 9944.651937182452, 10051.69844904654], "dojo.html": [2658.956656115251, 2759.51708451021, 2764.654418197725, 2768.501669699454, 2769.29383007333, 4553.772311384434, 4692.577668009879, 4758.881027974302, 4792.52074792521, 4807.038592281545, 4695.718256904588, 4730.0, 4733.219018861883, 4821.108095002427, 4838.830640927559, 4380.802863871126, 4391.494978077514, 4419.845305414311, 4426.203283408985, 4431.822727090913, 4175.916481670365, 4448.199324121657, 4474.284114541674, 4499.527549607294, 4514.413126293577, 4322.719023263509, 4335.978320108411, 4410.801513931849, 4447.688661793676, 4459.2865141577195, 4385.736855788663, 4389.253826849444, 4393.758343291118, 4440.178566965122, 4448.777561121963, 4206.053637931472, 4305.354196870463, 4375.16871794358, 4399.428074350314, 4417.403650507173, 4689.835855745033, 4806.7836947337455, 4846.321514987904, 4858.246971719389, 4863.635227357927, 5137.229415587654, 5151.381834179885, 5156.123459011939, 5192.636515443921, 5195.558377537914, 4876.268559716035, 5170.069387510247, 5177.818776342848, 5190.273361729361, 5190.844274671766, 4671.04243630055, 4673.649476289292, 4678.368420263289, 4688.648351373627, 4785.808567657325, 5256.159014557652, 5262.657927234794, 5268.367795864521, 5287.365516138088, 5298.655587386885, 5033.2701758245585, 5035.571976382049, 5037.4458809530925, 5042.823501177441, 5088.109580823341, 4839.564439200489, 4958.057968985881, 4967.254911763264, 5013.674111182761, 5160.406553246425, 5086.567641750418, 5095.210242412432, 5095.617828662791, 5103.923441148386, 5110.4634013428795, 5070.340855688737, 5075.061113693979, 5085.160948443539, 5087.745612719424, 5115.718635475085, 4070.61329173728, 4178.519470260898, 4178.8537401190815, 4309.48286205651, 4346.521882592912, 3650.5619325681087, 3724.2365315110337, 3746.119661879456, 3751.324761542894, 3767.1335592813807, 4393.0774537347515, 4412.69111162222, 4422.535633758409, 4431.224535706238, 4447.021655235843, 4979.427365852901, 5135.948640513547, 5178.508041736029, 5197.688138711689, 5198.766055527511, 4285.892852678708, 4321.9135617287475, 4367.061081867414, 4382.868513944587, 4417.690761646718, 4557.567031132037, 4558.772061396983, 4576.427946506687, 4589.65577581676, 4610.723356598614, 4665.136949664323, 4781.2350023996, 4894.045661096052, 4895.485973972682, 4899.338589290472, 4992.700437973734, 5065.468125846733, 5065.974670126626, 5100.48995100487, 5116.820911268088, 4950.727709975986, 4960.826371076995, 4963.057019166346, 4963.503649635008, 5005.0, 4891.461939186615, 5016.448190698947, 5122.871928201825, 5128.230765385073, 5129.563987061141, 5000.849974500771, 5043.167877300204, 5109.335786347751, 5118.360204974379, 5139.434662187082, 4965.975170124127, 4988.9251661225835, 4990.8253211137435, 4994.175960966545, 5037.0681423936685, 4681.368015318025, 4796.472388037383, 4985.351904252424, 4996.075725990703, 4996.325496058131, 4701.365315682339, 4732.455767586634, 4769.95230047709, 4770.570648641639, 4797.328374027569, 4951.925721114114, 4966.950330496793, 4968.130577148912, 4968.652194346361, 5010.799568017239, 4685.062987402465, 4795.400574928134, 4868.367112275523, 4885.731284779229, 4919.778609962489], "mootools.html": [1176.0474016046996, 1555.6888622275546, 1623.0829581286573, 1633.7876076110108, 1663.0437498438394, 6119.143319935207, 6478.028295755639, 6810.318968103194, 7197.7480788172425, 7226.96386518068, 7075.929240707592, 7093.1842838073635, 7123.9287607123915, 7141.107361579802, 7151.14186297645, 1647.9423220187296, 1713.1776747161307, 2049.0, 2071.1508281604547, 2073.9585208295825, 2039.276056999766, 2078.4596005038647, 2085.238887805955, 2085.259732794859, 2086.405374468277, 2037.5721098569245, 2044.9591008179827, 2051.8563700540967, 2083.479130217446, 2084.27050532314, 2037.0, 2063.1025503905776, 2092.937211883638, 2095.549456866781, 2100.222917520512, 2042.0402410866868, 2064.1846470644164, 2064.6283668939586, 2067.069818581629, 2068.513899233679, 7078.646067696646, 7140.642967851639, 7146.749863754796, 7147.2138064812825, 7151.427885769126, 4125.278076336659, 4174.436451079096, 4190.308599081148, 4199.223143718422, 4207.64235040022, 2593.0664960614163, 2676.2372723773633, 2679.61145633882, 2701.149138021517, 2701.7163197864334, 734.2950767263434, 884.4737381258141, 895.8208358328295, 914.533587870191, 948.369334392628, 9635.0, 9672.903270967341, 9701.029897010243, 9703.0, 9719.854202187043, 3814.599467055975, 3829.3107240696386, 3869.187470631143, 3923.9607603923596, 3928.1161738609158, 8259.297959673375, 8282.296004839536, 8298.921140251729, 8306.875396869053, 8312.085670576233, 4129.504459464823, 4140.68944829139, 4143.585641435832, 4145.54399016108, 4148.211839750498, 3714.888553343404, 3732.4774531565604, 3737.177820879402, 3742.7754334740002, 3749.2314075614436, 3488.686018258369, 3506.1760486285702, 3508.947365789515, 3519.9296014080087, 3534.0988048047584, 1106.0653747583278, 1110.9888901111046, 1114.9331040137617, 1121.7924683933497, 1122.893325134111, 873.5632183908046, 878.4729162502448, 1152.7694461107812, 1168.2581560709011, 1170.1224081938547, 6900.0, 6946.6179360134665, 6965.199002114821, 6976.825579360557, 6980.406665433394, 910.226307638502, 917.1702453605101, 949.1552518258756, 995.5619527407918, 1009.6112996496402, 5345.67925924438, 5390.51485366319, 5391.406945236021, 5394.730263486888, 5396.136618141157, 7527.322540971339, 7911.525308481395, 8490.448120872123, 8565.10066443027, 8695.391322607484, 8250.752477425687, 8445.408821382567, 8457.238848503664, 8506.574671266411, 8522.914770852336, 6654.833629159213, 6677.666116694146, 6780.254172041072, 6817.659117044128, 6834.726610935606, 6719.798406047827, 6721.0, 6728.899066513908, 6732.865342693217, 6753.257141714309, 7416.998705174732, 7541.7360392386, 7649.770506884803, 7719.961400192963, 7752.573608451589, 7815.374770018271, 7972.800679983046, 8004.079530854026, 8031.598420078856, 8037.31682806968, 5880.470757631833, 5912.113183022581, 5943.494802941798, 5943.8706645737175, 5948.315943666361, 6524.1192439022025, 6552.312007239171, 6552.475801935739, 6562.5406221564035, 6724.462043036643, 6313.116163736989, 6364.204474440695, 6429.903551446826, 6461.321561236003, 6653.334666533308, 6435.646039467874, 6447.742090316335, 6464.062710906798, 6525.706343214471, 6539.705713243011, 6022.277326720821, 6457.451116654949, 6487.22153341602, 6487.805365839033, 6499.317571655098, 6047.395260473917, 6081.331053584014, 6087.847803804763, 6089.086637004485, 6113.877722445615, 6112.78605248832, 6146.0, 6182.165407669907, 6283.465905397909, 6323.0], "ext.html": [543.038821286323, 548.202365558113, 552.5745176214315, 562.0557463461384, 562.755201487353, 28278.0, 28801.423971520584, 28805.279868003283, 36654.633453665454, 37870.62129378705, 40570.79714601423, 40964.0, 41004.58995410045, 41016.0, 41040.0, 7781.766547003571, 7952.125266220711, 7953.681852725884, 7959.204079592024, 7960.880586791174, 7035.0854388929365, 7179.317964793362, 10010.399376037425, 10285.537150828231, 10291.125254353388, 9976.351537150098, 10082.0, 10091.394516329006, 10096.747581310452, 10098.848517272247, 6924.896126558106, 7053.153621565445, 9909.75225619358, 10039.598416063349, 10048.598056077748, 9733.756656083655, 9907.653232136912, 9910.0, 9959.601615935353, 9965.15296199824, 37892.43161352582, 38212.0, 38237.42643860344, 38242.426363604565, 38259.61740382588, 2658.3088397016722, 2704.067096851583, 2746.5605503119605, 2761.558150695879, 3560.5193298904574, 28511.28721781972, 28623.85688071567, 28980.0, 29193.854030729923, 29521.557176642367, 3042.589250451183, 3098.349346637209, 3156.0847354267235, 3173.143251322153, 3217.5978002749657, 214397.0, 215055.0, 215166.0, 215695.0, 215764.0, 44122.77938610286, 45078.774606127416, 53288.46711532913, 53555.19667204995, 54161.1875821863, 55898.0, 55938.72030639821, 56298.43701563014, 56347.43652563422, 56423.71788141033, 12133.635990920286, 12215.450304736309, 12326.876731232753, 12342.938285308515, 12345.506179752889, 8059.798505037304, 8079.394045446615, 8172.6730930762105, 8185.4270201085355, 8186.181381861767, 18697.0, 18735.25058997652, 18819.247230110916, 18846.52883677919, 18902.149403276886, 6797.116374871235, 7019.89470157948, 7057.788266352018, 7108.609026503488, 7122.786316410516, 782.5578548120294, 831.9001719793664, 886.534569351083, 947.2989987409405, 1053.2995557954027, 23629.0, 24939.376515586893, 25025.874870625532, 25245.74754252434, 25297.494050118894, 919.7332773495746, 926.2682480840195, 926.4256161179977, 929.8605209218535, 936.279065119854, 12857.549985750455, 13100.803487947689, 13491.527796527074, 13509.797353039712, 14257.78613320801, 205774.0, 210492.0, 211319.0, 211861.0, 212053.0, 42430.78784606057, 42671.786641066596, 42719.786401067795, 42800.57199428028, 42836.0, 1158.629238643626, 1194.7849387110405, 1215.781159391318, 1221.6823625857342, 1225.5281716539196, 22190.667139993235, 25275.368115797253, 26054.218373448068, 27163.59254611222, 27268.72731272662, 39197.02007449837, 39547.0, 39606.40590391089, 39607.0, 39681.2063758729, 175891.0, 178342.1082894577, 178386.0, 178492.0, 179065.0, 23507.88246058759, 23993.16023939154, 28894.71105289004, 29236.26909327199, 29742.55386169166, 34068.65931340754, 36537.81731091328, 36712.63287367092, 37525.249495010496, 37707.43438848474, 31620.36759264848, 32681.836590816893, 34100.82949585236, 36740.26519469649, 36883.446748299335, 31762.841185793925, 32889.0, 34084.488732669524, 35584.0, 36119.638803611626, 32760.672393276716, 33345.83327083349, 33362.833185833915, 33393.165170870925, 33422.832885835414, 28419.715802841707, 28730.569041464812, 30409.847950760988, 30504.84747576248, 30771.692283077777, 23064.192753253556, 23187.84196954448, 23417.76582234156, 23551.52896942086, 23689.40776480602], "prototype.html": [305.9617547806524, 310.6536212123483, 311.2545453638537, 314.9417357788809, 315.3157647904048, 5378.616501964519, 5430.918536221955, 5450.890982180354, 5460.262864513289, 5484.149956756699, 5373.892522149555, 5383.542398896098, 5384.0, 5391.81128660497, 5395.919061214076, 3931.0565464288507, 4022.8994275143064, 4188.476440444944, 4188.85339013133, 4197.412362269285, 4062.878113656595, 4151.647109995654, 4186.916261674764, 4197.8530751423705, 4208.957910420902, 4103.09731858992, 4111.71218014739, 4157.48031496063, 4162.105147393309, 4163.770992595406, 3865.6714179294936, 3966.0, 3980.2636512245326, 3988.4017397390335, 4106.958930410688, 3419.247765491613, 3430.811305378203, 3569.428891377367, 3667.3765459871884, 3669.614690457517, 5185.377754669426, 5187.429382767892, 5196.194589838581, 5200.505951934598, 5203.037438073969, 4770.546798054179, 4777.0, 4780.976095119537, 4782.928256076161, 4783.354247176656, 5463.672179669193, 5622.381538030813, 5639.68981706006, 5647.265855438766, 5650.434956504358, 3913.7651740895353, 3915.8433662653742, 3916.118873253524, 3916.7649941003633, 3922.490076290064, 5863.824085277449, 5943.078822782476, 5948.464638182541, 5948.553858460633, 5951.49412299955, 4010.3984402339297, 4028.436018957348, 4031.3348297531165, 4034.0318323602123, 4034.636882680514, 3821.464994900716, 3841.366174581163, 3925.784081875467, 4089.6932730045364, 4092.652124569445, 4522.479914809774, 4621.145088158634, 4667.766611669471, 4669.486356500782, 4674.532546745366, 5643.294588176478, 5643.871225754865, 5644.842807224509, 5650.773969041193, 5658.886822263532, 1392.1020941492884, 1404.39610967283, 1405.4940221520244, 1406.2617126008722, 1406.6834962133644, 946.5598496699068, 965.5944503308627, 971.7959228562081, 990.1138481059412, 991.5984026469291, 4927.852164435001, 4932.704037757746, 4946.925796113062, 4955.4796746341835, 4960.652754307164, 5838.0, 5850.3564607893095, 5855.121731740188, 5862.5896187267335, 5867.735951882176, 4926.064047830901, 4930.186519224288, 4947.134251505972, 4949.851504454872, 4951.851444456672, 3091.5053591425262, 3127.8436078196, 3138.089953913385, 3160.083575763049, 3171.5559821624993, 5553.139263414178, 5559.58303127259, 5562.415946325577, 5563.693996830213, 5563.833085007456, 6036.004059330161, 6037.4264444878545, 6038.456538911431, 6047.455728984412, 6047.63714177142, 5530.198121272393, 5552.194931734956, 5563.638363506359, 5564.66612003273, 5564.8330550083565, 5669.376368599368, 5838.766449341979, 5843.678597677169, 5845.883082338414, 5846.41535846429, 5701.600887937804, 5713.143028545752, 5713.600047996601, 5715.085586306171, 5718.370979192368, 5552.139418390156, 5558.666480011212, 5559.833205003856, 5560.193771903132, 5560.999020176407, 3960.702947279023, 4046.1705350403686, 4055.8377664893073, 4057.208844275338, 4064.7764372959773, 5661.943380566142, 5821.039528477754, 5831.125331200354, 5847.707614619337, 5847.795327163529, 5515.200295957144, 5672.688002159921, 5698.1452782083015, 5700.914486282792, 5702.230198923258, 5680.289963754531, 5683.005474042109, 5686.800961966312, 5687.146927960839, 5688.488036076773, 5404.486573775485, 5535.557155427476, 5540.667559946416, 5542.057850165401, 5544.63959842609, 5717.085266357363, 5720.856978575569, 5727.284089488814, 5734.254546908875, 5734.569907257056, 5584.246126772834, 5589.888202235851, 5591.804286849941, 5594.328680558359, 5598.944010560005], "yui.html": [638.7213689432875, 639.3223183425566, 688.3391943734017, 704.6969802984717, 720.0567256893473, 11601.477933492992, 11762.353070581115, 11785.646430607074, 11807.350595717233, 11860.169788114836, 11489.770204595903, 11517.078633709305, 11595.072394208464, 11625.651230463078, 12556.497740090408, 597.8983572792614, 756.2399788212853, 766.2950085920966, 768.7424712721245, 768.8154842837735, 602.066796465479, 744.5272252119888, 761.1855314813153, 762.1578156137472, 762.4472257613241, 786.0371045469311, 795.5783434779576, 799.8640231160688, 800.1718221640604, 800.671724592917, 609.7682880505401, 615.4215037864437, 775.825439276164, 789.917058708836, 790.5533373643873, 582.1151849189251, 582.6445868020504, 582.8834233153344, 583.5477504933668, 584.0829897061615, 11464.541418343257, 11599.246049006788, 11599.710007249801, 11604.941975290154, 11620.186586938918, 8558.186972237627, 8808.603612837438, 8822.86765698515, 9049.864252036225, 9122.0, 8576.09950955147, 8665.393422460367, 8739.126087391274, 9109.362344635878, 9116.863247051233, 2786.21985843964, 2809.606655068292, 2835.4470878178763, 2864.298246929495, 2884.1491759930873, 38726.419103713466, 39234.41148382777, 39341.213175736324, 39445.80277098625, 39725.60274397248, 6300.558960872695, 6357.777477788255, 6379.71291291893, 6868.175818901664, 7034.8944765828555, 10507.579696812194, 10598.364098154136, 10618.893811061946, 10621.681349559525, 10631.946840265904, 5525.281713377316, 5595.300587426572, 5598.496135347838, 5632.0, 5728.79949201776, 3437.2094418283937, 3468.601110872282, 3498.9125271868406, 3503.4219353806848, 3557.8043207623828, 2405.2663937499233, 2432.3067925641462, 2434.8782560871887, 2435.744246854055, 2436.1108195508864, 347.2343482620815, 352.17590837440514, 353.43626915070934, 354.11824556853765, 368.74003827301686, 403.91517781265674, 417.1094712788219, 423.3903179421623, 435.70589851849877, 477.73246981690363, 6820.03136102899, 6884.65576721162, 6973.51185417026, 6981.441484681213, 7072.71709131629, 390.23124444843614, 400.3814107204376, 505.4263411028509, 529.5922139952293, 545.364650182533, 3383.509391138271, 3423.400904841643, 3509.64903509647, 3517.1734642359024, 3560.626134255918, 44623.0, 45127.32309015367, 45323.0, 45437.0, 47358.76320618375, 44639.77680111644, 44996.3250551242, 45161.32258016132, 45466.31800522995, 45552.08895822131, 41322.38016429756, 41362.793186034476, 41479.1704165915, 42352.36471452931, 42391.57608423938, 7050.929490705233, 7434.553926764412, 7489.251074892467, 7514.736984205527, 7708.460407771627, 31982.84008580035, 32166.517502237017, 32534.674653253165, 32577.511337330434, 33809.49285760667, 40200.597994019685, 40229.0, 40283.1943361137, 41228.58771412368, 41405.171896562504, 6856.382925536725, 6885.51801373899, 6966.164060312795, 7049.7885063448175, 7184.497085204194, 10198.541065651914, 10319.535620896928, 10443.268971171945, 10909.945450272699, 10946.179036572448, 9901.851472228067, 10058.396496210251, 10232.386056836614, 10326.432046237529, 10472.633457828939, 10148.289619726549, 10196.745081373025, 10288.12550933179, 10389.37663740178, 10804.783904322027, 10202.183825294107, 10255.179585633281, 10343.655324807727, 10362.948185259025, 10467.581296748349, 7876.72431464896, 7986.680532778624, 8178.591070446335, 8254.504729716236, 8465.322774178174, 8422.199891010345, 8448.91551084506, 8510.872336914827, 8525.573721313785, 8605.65577376923]}, "summary": {"lowerIsBetter": false, "suite": 5988.9389375919, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6754.375600683852, "unit": "ms", "value": 6754.375600683852}, "dojo.html": {"lowerIsBetter": false, "filtered": 4678.262132335302, "unit": "ms", "value": 4678.262132335302}, "mootools.html": {"lowerIsBetter": false, "filtered": 4079.9184376535513, "unit": "ms", "value": 4079.9184376535513}, "ext.html": {"lowerIsBetter": false, "filtered": 16387.717613861172, "unit": "ms", "value": 16387.717613861172}, "prototype.html": {"lowerIsBetter": false, "filtered": 4227.570931828493, "unit": "ms", "value": 4227.570931828493}, "yui.html": {"lowerIsBetter": false, "filtered": 5165.673142010032, "unit": "ms", "value": 5165.673142010032}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-047"}, "testrun": {"date": 1447765914, "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": "20151117033907", "branch": "B2G-Inbound-Non-PGO", "revision": "7c586c1697bef9e773068abdea2294f6b9c296ef"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 163.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 164.0, 164.0], "ai-astar": [109.0, 112.0, 105.0, 110.0, 113.0, 114.0, 102.0, 112.0, 103.0, 110.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0], "audio-beat-detection": [158.0, 132.0, 154.0, 167.0, 137.0, 154.0, 164.0, 135.0, 165.0, 134.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [137.0, 142.0, 145.0, 144.0, 149.0, 135.0, 146.0, 146.0, 146.0, 134.0], "json-parse-financial": [70.0, 71.0, 70.0, 71.0, 71.0, 70.0, 70.0, 80.0, 69.0, 69.0], "stanford-crypto-sha256-iterative": [70.0, 69.0, 69.0, 70.0, 69.0, 68.0, 72.0, 69.0, 68.0, 69.0], "audio-fft": [73.0, 73.0, 82.0, 92.0, 71.0, 72.0, 72.0, 91.0, 87.0, 73.0], "imaging-darkroom": [147.0, 147.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 148.0, 148.0], "stanford-crypto-ccm": [122.0, 119.0, 127.0, 117.0, 129.0, 124.0, 128.0, 119.0, 122.0, 127.0], "audio-oscillator": [92.0, 93.0, 134.0, 91.0, 92.0, 91.0, 127.0, 91.0, 93.0, 126.0], "stanford-crypto-aes": [83.0, 85.0, 82.0, 95.0, 83.0, 83.0, 82.0, 84.0, 85.0, 83.0], "imaging-desaturate": [95.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1515.7, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.6, "unit": "ms", "value": 78.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 142.4, "unit": "ms", "value": 142.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 150.0, "unit": "ms", "value": 150.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.4, "unit": "ms", "value": 123.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.7, "unit": "ms", "value": 147.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.1, "unit": "ms", "value": 71.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.0, "unit": "ms", "value": 103.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.0, "unit": "ms", "value": 109.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.3, "unit": "ms", "value": 162.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 69.3, "unit": "ms", "value": 69.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.3, "unit": "ms", "value": 69.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.5, "unit": "ms", "value": 84.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.6, "unit": "ms", "value": 95.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-047"}, "testrun": {"date": 1447765914, "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": "20151117033907", "branch": "B2G-Inbound-Non-PGO", "revision": "7c586c1697bef9e773068abdea2294f6b9c296ef"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.71779141104295], "Encrypt": [280.42624789680315], "NavierStokes": [4845.410628019324], "Decrypt": [5030.150753768844], "Splay": [617.5567833026397], "Richards": [168.8048615800135], "RegExp": [27054.054054054053], "Earley": [803.8585209003215], "Boyer": [12195.121951219513], "RayTrace": [1986.111111111111]}, "summary": {"lowerIsBetter": false, "suite": 19665.74929551057, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.87148800000006, "unit": "score", "value": 344.87148800000006}, "Encrypt": {"lowerIsBetter": false, "filtered": 949.2014460000001, "unit": "score", "value": 949.2014460000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.26919242273203, "unit": "score", "value": 306.26919242273203}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 131.9570964214711, "unit": "score", "value": 131.9570964214711}, "RegExp": {"lowerIsBetter": false, "filtered": 33.67277222777225, "unit": "score", "value": 33.67277222777225}, "Richards": {"lowerIsBetter": false, "filtered": 209.1290480000001, "unit": "score", "value": 209.1290480000001}, "Earley": {"lowerIsBetter": false, "filtered": 829.0799720000001, "unit": "score", "value": 829.0799720000001}, "Boyer": {"lowerIsBetter": false, "filtered": 54.64996600000001, "unit": "score", "value": 54.64996600000001}, "RayTrace": {"lowerIsBetter": false, "filtered": 372.5818741258742, "unit": "score", "value": 372.5818741258742}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-047"}, "testrun": {"date": 1447765914, "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": "20151117033907", "branch": "B2G-Inbound-Non-PGO", "revision": "7c586c1697bef9e773068abdea2294f6b9c296ef"}}] 05:32:12 INFO - RETURN: dromaeo_css: 5988.94 05:32:12 INFO - RETURN: kraken: 1515.70 05:32:12 INFO - RETURN: v8_7: 19665.75 05:32:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19665.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1515.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "5988.94"}}} 05:32:12 INFO - Return code: 0 05:32:12 INFO - # TBPL SUCCESS # 05:32:12 INFO - Running post-action listener: _resource_record_post_action 05:32:12 INFO - Running post-run listener: _resource_record_post_run 05:32:13 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513302528; Read time: 8; Write time: 451712 05:32:13 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 233185280; Read time: 0; Write time: 258652 05:32:13 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 274370560; Read time: 0; Write time: 146916 05:32:13 INFO - Running post-run listener: _upload_blobber_files 05:32:13 INFO - Blob upload gear active. 05:32:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:32:13 INFO - Copying logs to upload dir... 05:32:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.188348 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-17 05:32:12.869937) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:32:12.873153) ========= 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=f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010025 build_url: 'https://queue.taskcluster.net/v1/task/BIQPK3zzSFyxghHocDG28Q/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-17 05:32:12.923505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:32:12.923840) ========= 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=f5f5a079460e1a9be8676904000001c1-1447762656.801579-1942412837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:32:12.973557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:32:12.973879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:32:12.974176) ========= ========= Total master_lag: 0.23 =========