builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1447803257.91 results: success (0) buildid: 20151117132405 builduid: 32578afcad0c4ab2a10b8fc36e3f7f1a revision: 93d3671347066a184b4325c84dfc2277000bfee8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:17.906706) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:17.907263) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:17.907649) ========= 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=6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006539 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:17.948138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:17.948576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:17.971744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:17.972046) ========= 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=6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:18.024759) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:18.025144) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:18.025535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:18.025863) ========= 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=6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 15:34:18-- 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% 63.4M=0s 2015-11-17 15:34:18 (63.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:18.214168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:18.214512) ========= 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=6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018712 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:18.273151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 15:34:18.273545) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 93d3671347066a184b4325c84dfc2277000bfee8 --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 93d3671347066a184b4325c84dfc2277000bfee8 --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=6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 15:34:18,638 truncating revision to first 12 chars 2015-11-17 15:34:18,638 Setting DEBUG logging. 2015-11-17 15:34:18,638 attempt 1/10 2015-11-17 15:34:18,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/93d367134706?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 15:34:19,773 unpacking tar archive at: b2g-inbound-93d367134706/testing/mozharness/ program finished with exit code 0 elapsedTime=1.417878 ========= master_lag: 0.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 15:34:20.036145) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:20.036459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:20.074037) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:20.074406) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:34:20.074796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-17 15:34:20.075075) ========= /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=6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:34:20 INFO - MultiFileLogger online at 20151117 15:34:20 in /builds/slave/test 15:34:20 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 15:34:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:34:20 INFO - {'append_to_log': False, 15:34:20 INFO - 'base_work_dir': '/builds/slave/test', 15:34:20 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 15:34:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:34:20 INFO - 'branch': 'B2G-Inbound-Non-PGO', 15:34:20 INFO - 'buildbot_json_path': 'buildprops.json', 15:34:20 INFO - 'config_files': ('talos/linux_config.py',), 15:34:20 INFO - 'default_actions': ('clobber', 15:34:20 INFO - 'read-buildbot-config', 15:34:20 INFO - 'download-and-extract', 15:34:20 INFO - 'populate-webroot', 15:34:20 INFO - 'create-virtualenv', 15:34:20 INFO - 'install', 15:34:20 INFO - 'run-tests'), 15:34:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:34:20 INFO - 'download_minidump_stackwalk': True, 15:34:20 INFO - 'download_symbols': 'ondemand', 15:34:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:34:20 INFO - 'tooltool.py': '/tools/tooltool.py', 15:34:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:34:20 INFO - '/tools/misc-python/virtualenv.py')}, 15:34:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:34:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:34:20 INFO - 'installer_path': 'installer.exe', 15:34:20 INFO - 'log_level': 'info', 15:34:20 INFO - 'log_name': 'talos', 15:34:20 INFO - 'log_to_console': True, 15:34:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:34:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:34:20 INFO - 'opt_config_files': (), 15:34:20 INFO - 'pip_index': False, 15:34:20 INFO - 'sps_profile': False, 15:34:20 INFO - 'sps_profile_interval': 0, 15:34:20 INFO - 'suite': 'dromaeojs', 15:34:20 INFO - 'system_bits': '64', 15:34:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:34:20 INFO - 'title': 'talos-linux64-ix-018', 15:34:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:34:20 INFO - 'use_talos_json': True, 15:34:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:34:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:34:20 INFO - 'work_dir': 'build'} 15:34:20 INFO - ##### 15:34:20 INFO - ##### Running clobber step. 15:34:20 INFO - ##### 15:34:20 INFO - Running pre-action listener: _resource_record_pre_action 15:34:20 INFO - Running main action method: clobber 15:34:20 INFO - rmtree: /builds/slave/test/build 15:34:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:20 INFO - Running post-action listener: _resource_record_post_action 15:34:20 INFO - ##### 15:34:20 INFO - ##### Running read-buildbot-config step. 15:34:20 INFO - ##### 15:34:20 INFO - Running pre-action listener: _resource_record_pre_action 15:34:20 INFO - Running main action method: read_buildbot_config 15:34:20 INFO - Using buildbot properties: 15:34:20 INFO - { 15:34:20 INFO - "properties": { 15:34:20 INFO - "buildnumber": 275, 15:34:20 INFO - "product": "firefox", 15:34:20 INFO - "script_repo_revision": "production", 15:34:20 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 15:34:20 INFO - "repository": "", 15:34:20 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 15:34:20 INFO - "buildid": "20151117132405", 15:34:20 INFO - "slavename": "talos-linux64-ix-018", 15:34:20 INFO - "pgo_build": "False", 15:34:20 INFO - "basedir": "/builds/slave/test", 15:34:20 INFO - "project": "", 15:34:20 INFO - "platform": "ubuntu64_hw", 15:34:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:34:20 INFO - "slavebuilddir": "test", 15:34:20 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 15:34:20 INFO - "branch": "b2g-inbound", 15:34:20 INFO - "repo_path": "integration/b2g-inbound", 15:34:20 INFO - "stage_platform": "linux64", 15:34:20 INFO - "builduid": "32578afcad0c4ab2a10b8fc36e3f7f1a", 15:34:20 INFO - "revision": "93d3671347066a184b4325c84dfc2277000bfee8" 15:34:20 INFO - }, 15:34:20 INFO - "sourcestamp": { 15:34:20 INFO - "repository": "", 15:34:20 INFO - "hasPatch": false, 15:34:20 INFO - "project": "", 15:34:20 INFO - "branch": "b2g-inbound-linux64-talos", 15:34:20 INFO - "changes": [ 15:34:20 INFO - { 15:34:20 INFO - "category": null, 15:34:20 INFO - "files": [ 15:34:20 INFO - { 15:34:20 INFO - "url": null, 15:34:20 INFO - "name": "https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:34:20 INFO - } 15:34:20 INFO - ], 15:34:20 INFO - "repository": "", 15:34:20 INFO - "rev": "93d3671347066a184b4325c84dfc2277000bfee8", 15:34:20 INFO - "who": "kwierso@gmail.com", 15:34:20 INFO - "when": 1447803234, 15:34:20 INFO - "number": 6674651, 15:34:20 INFO - "comments": "Merge m-c to b2ginbound, a=merge", 15:34:20 INFO - "project": "", 15:34:20 INFO - "at": "Tue 17 Nov 2015 15:33:54", 15:34:20 INFO - "branch": "b2g-inbound-linux64-talos", 15:34:20 INFO - "revlink": "", 15:34:20 INFO - "properties": [ 15:34:20 INFO - [ 15:34:20 INFO - "buildid", 15:34:20 INFO - "20151117132405", 15:34:20 INFO - "Change" 15:34:20 INFO - ], 15:34:20 INFO - [ 15:34:20 INFO - "builduid", 15:34:20 INFO - "32578afcad0c4ab2a10b8fc36e3f7f1a", 15:34:20 INFO - "Change" 15:34:20 INFO - ], 15:34:20 INFO - [ 15:34:20 INFO - "pgo_build", 15:34:20 INFO - "False", 15:34:20 INFO - "Change" 15:34:20 INFO - ] 15:34:20 INFO - ], 15:34:20 INFO - "revision": "93d3671347066a184b4325c84dfc2277000bfee8" 15:34:20 INFO - } 15:34:20 INFO - ], 15:34:20 INFO - "revision": "93d3671347066a184b4325c84dfc2277000bfee8" 15:34:20 INFO - } 15:34:20 INFO - } 15:34:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:34:20 INFO - Running post-action listener: _resource_record_post_action 15:34:20 INFO - ##### 15:34:20 INFO - ##### Running download-and-extract step. 15:34:20 INFO - ##### 15:34:20 INFO - Running pre-action listener: _resource_record_pre_action 15:34:20 INFO - Running main action method: download_and_extract 15:34:20 INFO - mkdir: /builds/slave/test/build/tests 15:34: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')]} 15:34:20 INFO - https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:34:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/test_packages.json 15:34:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/test_packages.json 15:34:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:34:26 INFO - Downloaded 1302 bytes. 15:34:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:34:26 INFO - Using the following test package requirements: 15:34:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:34:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:26 INFO - u'jsshell-linux-x86_64.zip'], 15:34:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:34:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:34:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:34:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:34:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:34:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:26 INFO - https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:34:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:34:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:34:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:34:31 INFO - Downloaded 21277690 bytes. 15:34:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:34:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:34:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:34:32 INFO - Return code: 0 15:34:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:34: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')]} 15:34:32 INFO - https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:34:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:34:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:34:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:34:35 INFO - Downloaded 21277690 bytes. 15:34:35 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 15:34:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:34:35 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 15:34:36 INFO - Return code: 0 15:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:36 INFO - https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:34:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:34:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:34:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:34:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:34:37 INFO - Downloaded 11131693 bytes. 15:34:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 15:34:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:34:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:34:37 INFO - Return code: 0 15:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:37 INFO - https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:34:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:34:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:34:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:34:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:34:39 INFO - Downloaded 55658806 bytes. 15:34:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:34:39 INFO - mkdir: /builds/slave/test/properties 15:34:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:39 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:39 INFO - Contents: 15:34:39 INFO - build_url:https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:34:39 INFO - Running post-action listener: _resource_record_post_action 15:34:39 INFO - Running post-action listener: set_extra_try_arguments 15:34:39 INFO - ##### 15:34:39 INFO - ##### Running populate-webroot step. 15:34:39 INFO - ##### 15:34:39 INFO - Running pre-action listener: _resource_record_pre_action 15:34:39 INFO - Running main action method: populate_webroot 15:34:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:34:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:34:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:34:39 INFO - '../fennec_ids.txt'], 15:34:39 INFO - 'tests': ['tcheck2']}, 15:34:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:34:39 INFO - '--tppagecycles', 15:34:39 INFO - '7'], 15:34:39 INFO - 'tests': ['tsvgm']}}, 15:34:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:34:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:34:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:34:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:34:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:39 INFO - 'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:39 INFO - 'tests': ['damp', 'tps']}, 15:34:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:39 INFO - 'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['damp', 'tps']}, 15:34:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:34:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:39 INFO - 'other': {'tests': ['a11yr', 15:34:39 INFO - 'ts_paint', 15:34:39 INFO - 'tpaint', 15:34:39 INFO - 'sessionrestore', 15:34:39 INFO - 'sessionrestore_no_auto_restore']}, 15:34:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['a11yr', 15:34:39 INFO - 'ts_paint', 15:34:39 INFO - 'tpaint', 15:34:39 INFO - 'sessionrestore', 15:34:39 INFO - 'sessionrestore_no_auto_restore']}, 15:34:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['a11yr', 15:34:39 INFO - 'ts_paint', 15:34:39 INFO - 'tpaint', 15:34:39 INFO - 'sessionrestore', 15:34:39 INFO - 'sessionrestore_no_auto_restore']}, 15:34:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['a11yr', 15:34:39 INFO - 'ts_paint', 15:34:39 INFO - 'tpaint', 15:34:39 INFO - 'sessionrestore', 15:34:39 INFO - 'sessionrestore_no_auto_restore']}, 15:34:39 INFO - 'other_l64': {'tests': ['a11yr', 15:34:39 INFO - 'ts_paint', 15:34:39 INFO - 'tpaint', 15:34:39 INFO - 'sessionrestore', 15:34:39 INFO - 'sessionrestore_no_auto_restore']}, 15:34:39 INFO - 'other_nol64': {'tests': ['a11yr', 15:34:39 INFO - 'ts_paint', 15:34:39 INFO - 'tpaint', 15:34:39 INFO - 'sessionrestore', 15:34:39 INFO - 'sessionrestore_no_auto_restore']}, 15:34:39 INFO - 'svgr': {'tests': ['tsvgx', 15:34:39 INFO - 'tsvgr_opacity', 15:34:39 INFO - 'tart', 15:34:39 INFO - 'tscrollx', 15:34:39 INFO - 'cart']}, 15:34:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['tsvgx', 15:34:39 INFO - 'tsvgr_opacity', 15:34:39 INFO - 'tart', 15:34:39 INFO - 'tscrollx', 15:34:39 INFO - 'cart']}, 15:34:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:39 INFO - 'tests': ['tp5o']}, 15:34:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:39 INFO - 'talos_options': ['--e10s'], 15:34:39 INFO - 'tests': ['tp5o']}, 15:34:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:39 INFO - 'talos_options': ['--xperf_path', 15:34:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:39 INFO - 'tests': ['tp5n']}, 15:34:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:39 INFO - 'talos_options': ['--e10s', 15:34:39 INFO - '--xperf_path', 15:34:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:39 INFO - 'tests': ['tp5n']}}, 15:34:39 INFO - 'talos.zip': {'path': '', 15:34:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:34:39 INFO - Running post-action listener: _resource_record_post_action 15:34:39 INFO - ##### 15:34:39 INFO - ##### Running create-virtualenv step. 15:34:39 INFO - ##### 15:34:39 INFO - Running pre-action listener: _resource_record_pre_action 15:34:39 INFO - Running main action method: create_virtualenv 15:34:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:34:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:34:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:39 INFO - Using real prefix '/usr' 15:34:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:41 INFO - Installing pip.................done. 15:34:41 INFO - Return code: 0 15:34:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05af235c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ccac0>, '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 0x24cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cde50>, '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': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', '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 15:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:34:41 INFO - Using env: {'DISPLAY': ':0', 15:34:41 INFO - 'HOME': '/home/cltbld', 15:34:41 INFO - 'LANG': 'en_US.UTF-8', 15:34:41 INFO - 'LANGUAGE': 'en_US:en', 15:34:41 INFO - 'LOGNAME': 'cltbld', 15:34:41 INFO - 'MAIL': '/var/mail/cltbld', 15:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:41 INFO - 'MOZ_NO_REMOTE': '1', 15:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:41 INFO - 'NO_EM_RESTART': '1', 15:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:41 INFO - 'PWD': '/builds/slave/test', 15:34:41 INFO - 'SHELL': '/bin/bash', 15:34:41 INFO - 'SHLVL': '1', 15:34:41 INFO - 'TERM': 'linux', 15:34:41 INFO - 'TMOUT': '86400', 15:34:41 INFO - 'USER': 'cltbld', 15:34:41 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', 15:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:41 INFO - '_': '/tools/buildbot/bin/python'} 15:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:41 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 15:34:41 INFO - Cleaning up... 15:34:41 INFO - Return code: 0 15:34:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f05af235c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ccac0>, '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 0x24cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cde50>, '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': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', '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 15:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:34:41 INFO - Using env: {'DISPLAY': ':0', 15:34:41 INFO - 'HOME': '/home/cltbld', 15:34:41 INFO - 'LANG': 'en_US.UTF-8', 15:34:41 INFO - 'LANGUAGE': 'en_US:en', 15:34:41 INFO - 'LOGNAME': 'cltbld', 15:34:41 INFO - 'MAIL': '/var/mail/cltbld', 15:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:41 INFO - 'MOZ_NO_REMOTE': '1', 15:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:41 INFO - 'NO_EM_RESTART': '1', 15:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:41 INFO - 'PWD': '/builds/slave/test', 15:34:41 INFO - 'SHELL': '/bin/bash', 15:34:41 INFO - 'SHLVL': '1', 15:34:41 INFO - 'TERM': 'linux', 15:34:41 INFO - 'TMOUT': '86400', 15:34:41 INFO - 'USER': 'cltbld', 15:34:41 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', 15:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:41 INFO - '_': '/tools/buildbot/bin/python'} 15:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:42 INFO - Downloading/unpacking psutil>=0.7.1 15:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:34:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:43 INFO - Installing collected packages: psutil 15:34:43 INFO - Running setup.py install for psutil 15:34:44 INFO - building 'psutil._psutil_linux' extension 15:34:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:34:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:34:44 INFO - building 'psutil._psutil_posix' extension 15:34:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:34:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:34:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:44 INFO - Successfully installed psutil 15:34:44 INFO - Cleaning up... 15:34:44 INFO - Return code: 0 15:34:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05af235c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ccac0>, '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 0x24cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cde50>, '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': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', '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 15:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:34:44 INFO - Using env: {'DISPLAY': ':0', 15:34:44 INFO - 'HOME': '/home/cltbld', 15:34:44 INFO - 'LANG': 'en_US.UTF-8', 15:34:44 INFO - 'LANGUAGE': 'en_US:en', 15:34:44 INFO - 'LOGNAME': 'cltbld', 15:34:44 INFO - 'MAIL': '/var/mail/cltbld', 15:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:44 INFO - 'MOZ_NO_REMOTE': '1', 15:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:44 INFO - 'NO_EM_RESTART': '1', 15:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:44 INFO - 'PWD': '/builds/slave/test', 15:34:44 INFO - 'SHELL': '/bin/bash', 15:34:44 INFO - 'SHLVL': '1', 15:34:44 INFO - 'TERM': 'linux', 15:34:44 INFO - 'TMOUT': '86400', 15:34:44 INFO - 'USER': 'cltbld', 15:34:44 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', 15:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:44 INFO - '_': '/tools/buildbot/bin/python'} 15:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:34:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:34:46 INFO - Installing collected packages: mozsystemmonitor 15:34:46 INFO - Running setup.py install for mozsystemmonitor 15:34:46 INFO - Successfully installed mozsystemmonitor 15:34:46 INFO - Cleaning up... 15:34:46 INFO - Return code: 0 15:34:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05af235c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ccac0>, '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 0x24cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cde50>, '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': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', '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 15:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:34:46 INFO - Using env: {'DISPLAY': ':0', 15:34:46 INFO - 'HOME': '/home/cltbld', 15:34:46 INFO - 'LANG': 'en_US.UTF-8', 15:34:46 INFO - 'LANGUAGE': 'en_US:en', 15:34:46 INFO - 'LOGNAME': 'cltbld', 15:34:46 INFO - 'MAIL': '/var/mail/cltbld', 15:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:46 INFO - 'MOZ_NO_REMOTE': '1', 15:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:46 INFO - 'NO_EM_RESTART': '1', 15:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:46 INFO - 'PWD': '/builds/slave/test', 15:34:46 INFO - 'SHELL': '/bin/bash', 15:34:46 INFO - 'SHLVL': '1', 15:34:46 INFO - 'TERM': 'linux', 15:34:46 INFO - 'TMOUT': '86400', 15:34:46 INFO - 'USER': 'cltbld', 15:34:46 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', 15:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:46 INFO - '_': '/tools/buildbot/bin/python'} 15:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:34:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:34:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:34:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:48 INFO - Downloading docopt-0.6.1.tar.gz 15:34:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:34:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:34:49 INFO - Running setup.py install for blobuploader 15:34:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:34:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:34:49 INFO - Running setup.py install for requests 15:34:49 INFO - Running setup.py install for docopt 15:34:49 INFO - Successfully installed blobuploader requests docopt 15:34:49 INFO - Cleaning up... 15:34:49 INFO - Return code: 0 15:34:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:49 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')]} 15:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:49 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')]} 15:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:49 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 0x7f05af235c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ccac0>, '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 0x24cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cde50>, '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': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', '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 15:34:49 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 15:34:49 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 15:34:49 INFO - Using env: {'DISPLAY': ':0', 15:34:49 INFO - 'HOME': '/home/cltbld', 15:34:49 INFO - 'LANG': 'en_US.UTF-8', 15:34:49 INFO - 'LANGUAGE': 'en_US:en', 15:34:49 INFO - 'LOGNAME': 'cltbld', 15:34:49 INFO - 'MAIL': '/var/mail/cltbld', 15:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:49 INFO - 'MOZ_NO_REMOTE': '1', 15:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:49 INFO - 'NO_EM_RESTART': '1', 15:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:49 INFO - 'PWD': '/builds/slave/test', 15:34:49 INFO - 'SHELL': '/bin/bash', 15:34:49 INFO - 'SHLVL': '1', 15:34:49 INFO - 'TERM': 'linux', 15:34:49 INFO - 'TMOUT': '86400', 15:34:49 INFO - 'USER': 'cltbld', 15:34:49 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', 15:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:49 INFO - '_': '/tools/buildbot/bin/python'} 15:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:49 INFO - Running setup.py (path:/tmp/pip-OgrLUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:49 INFO - Running setup.py (path:/tmp/pip-zwgBcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:50 INFO - Running setup.py (path:/tmp/pip-UJC8Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:50 INFO - Running setup.py (path:/tmp/pip-Fd_YE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:50 INFO - Running setup.py (path:/tmp/pip-d8FLB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:50 INFO - Running setup.py (path:/tmp/pip-0a280d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:50 INFO - Running setup.py (path:/tmp/pip-lXjdso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:50 INFO - Running setup.py (path:/tmp/pip-BDkYOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:50 INFO - Running setup.py (path:/tmp/pip-x8fEyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:50 INFO - Running setup.py (path:/tmp/pip-t0oD89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:50 INFO - Running setup.py (path:/tmp/pip-6fQR4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:50 INFO - Running setup.py (path:/tmp/pip-Ry1Pzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:50 INFO - Running setup.py (path:/tmp/pip-_hW4oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:50 INFO - Running setup.py (path:/tmp/pip-9Ntfz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:50 INFO - Running setup.py (path:/tmp/pip-_eQ55W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:50 INFO - Running setup.py (path:/tmp/pip-ywLDfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:51 INFO - Running setup.py (path:/tmp/pip-lJyRqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:34:51 INFO - Running setup.py install for manifestparser 15:34:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozcrash 15:34:51 INFO - Running setup.py install for mozdebug 15:34:51 INFO - Running setup.py install for mozdevice 15:34:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozfile 15:34:51 INFO - Running setup.py install for mozhttpd 15:34:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozinfo 15:34:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozInstall 15:34:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozleak 15:34:52 INFO - Running setup.py install for mozlog 15:34:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for moznetwork 15:34:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozprocess 15:34:52 INFO - Running setup.py install for mozprofile 15:34:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozrunner 15:34:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozscreenshot 15:34:52 INFO - Running setup.py install for moztest 15:34:52 INFO - Running setup.py install for mozversion 15:34:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:52 INFO - Cleaning up... 15:34:52 INFO - Return code: 0 15:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:52 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')]} 15:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:52 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')]} 15:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:52 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 0x7f05af235c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ccac0>, '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 0x24cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cde50>, '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': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', '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 15:34:52 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 15:34:52 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 15:34:52 INFO - Using env: {'DISPLAY': ':0', 15:34:52 INFO - 'HOME': '/home/cltbld', 15:34:52 INFO - 'LANG': 'en_US.UTF-8', 15:34:52 INFO - 'LANGUAGE': 'en_US:en', 15:34:52 INFO - 'LOGNAME': 'cltbld', 15:34:52 INFO - 'MAIL': '/var/mail/cltbld', 15:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:52 INFO - 'MOZ_NO_REMOTE': '1', 15:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:52 INFO - 'NO_EM_RESTART': '1', 15:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:52 INFO - 'PWD': '/builds/slave/test', 15:34:52 INFO - 'SHELL': '/bin/bash', 15:34:52 INFO - 'SHLVL': '1', 15:34:52 INFO - 'TERM': 'linux', 15:34:52 INFO - 'TMOUT': '86400', 15:34:52 INFO - 'USER': 'cltbld', 15:34:52 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', 15:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:52 INFO - '_': '/tools/buildbot/bin/python'} 15:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:53 INFO - Running setup.py (path:/tmp/pip-BZGtb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:53 INFO - Running setup.py (path:/tmp/pip-fhTKD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:53 INFO - Running setup.py (path:/tmp/pip-uFp2Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:53 INFO - Running setup.py (path:/tmp/pip-QST9lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:53 INFO - Running setup.py (path:/tmp/pip-7H2Sau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:53 INFO - Running setup.py (path:/tmp/pip-eMhfue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:53 INFO - Running setup.py (path:/tmp/pip-Z00VJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:53 INFO - Running setup.py (path:/tmp/pip-YH9_yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:53 INFO - Running setup.py (path:/tmp/pip-449MOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:53 INFO - Running setup.py (path:/tmp/pip-O62Vpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:53 INFO - Running setup.py (path:/tmp/pip-Coo7DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:53 INFO - Running setup.py (path:/tmp/pip-N3L828-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:53 INFO - Running setup.py (path:/tmp/pip-vg9B4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:54 INFO - Running setup.py (path:/tmp/pip-OYlClA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:54 INFO - Running setup.py (path:/tmp/pip-ClKPKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:54 INFO - Running setup.py (path:/tmp/pip-n9S0rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:54 INFO - Running setup.py (path:/tmp/pip-GZH1_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:55 INFO - Downloading blessings-1.5.1.tar.gz 15:34:55 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 15:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:56 INFO - Installing collected packages: blessings 15:34:56 INFO - Running setup.py install for blessings 15:34:56 INFO - Successfully installed blessings 15:34:56 INFO - Cleaning up... 15:34:56 INFO - Return code: 0 15:34:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:56 INFO - Reading from file tmpfile_stdout 15:34:56 INFO - Current package versions: 15:34:56 INFO - argparse == 1.2.1 15:34:56 INFO - blessings == 1.5.1 15:34:56 INFO - blobuploader == 1.2.4 15:34:56 INFO - docopt == 0.6.1 15:34:56 INFO - manifestparser == 1.1 15:34:56 INFO - mozInstall == 1.12 15:34:56 INFO - mozcrash == 0.16 15:34:56 INFO - mozdebug == 0.1 15:34:56 INFO - mozdevice == 0.47 15:34:56 INFO - mozfile == 1.2 15:34:56 INFO - mozhttpd == 0.7 15:34:56 INFO - mozinfo == 0.9 15:34:56 INFO - mozleak == 0.1 15:34:56 INFO - mozlog == 3.0 15:34:56 INFO - moznetwork == 0.27 15:34:56 INFO - mozprocess == 0.22 15:34:56 INFO - mozprofile == 0.27 15:34:56 INFO - mozrunner == 6.11 15:34:56 INFO - mozscreenshot == 0.1 15:34:56 INFO - mozsystemmonitor == 0.0 15:34:56 INFO - moztest == 0.7 15:34:56 INFO - mozversion == 1.4 15:34:56 INFO - psutil == 3.1.1 15:34:56 INFO - requests == 1.2.3 15:34:56 INFO - wsgiref == 0.1.2 15:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05af235c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ccac0>, '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 0x24cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cde50>, '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': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', '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 15:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:34:56 INFO - Using env: {'DISPLAY': ':0', 15:34:56 INFO - 'HOME': '/home/cltbld', 15:34:56 INFO - 'LANG': 'en_US.UTF-8', 15:34:56 INFO - 'LANGUAGE': 'en_US:en', 15:34:56 INFO - 'LOGNAME': 'cltbld', 15:34:56 INFO - 'MAIL': '/var/mail/cltbld', 15:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:56 INFO - 'MOZ_NO_REMOTE': '1', 15:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:56 INFO - 'NO_EM_RESTART': '1', 15:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:56 INFO - 'PWD': '/builds/slave/test', 15:34:56 INFO - 'SHELL': '/bin/bash', 15:34:56 INFO - 'SHLVL': '1', 15:34:56 INFO - 'TERM': 'linux', 15:34:56 INFO - 'TMOUT': '86400', 15:34:56 INFO - 'USER': 'cltbld', 15:34:56 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', 15:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:56 INFO - '_': '/tools/buildbot/bin/python'} 15:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 INFO - Cleaning up... 15:34:56 INFO - Return code: 0 15:34:56 INFO - Running post-action listener: _resource_record_post_action 15:34:56 INFO - Running post-action listener: _start_resource_monitoring 15:34:56 INFO - Starting resource monitoring. 15:34:56 INFO - ##### 15:34:56 INFO - ##### Running install step. 15:34:56 INFO - ##### 15:34:56 INFO - Running pre-action listener: _resource_record_pre_action 15:34:56 INFO - Running main action method: install 15:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:56 INFO - Reading from file tmpfile_stdout 15:34:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:56 INFO - Reading from file tmpfile_stdout 15:34:56 INFO - Output received: 15:34:56 INFO - Usage: mozinstall [options] installer 15:34:56 INFO - Options: 15:34:56 INFO - -h, --help show this help message and exit 15:34:56 INFO - -d DEST, --destination=DEST 15:34:56 INFO - Directory to install application into. [default: 15:34:56 INFO - "/builds/slave/test"] 15:34:56 INFO - --app=APP Application being installed. [default: firefox] 15:34:56 INFO - mkdir: /builds/slave/test/build/application 15:34:56 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'] 15:34:56 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 15:35:11 INFO - Reading from file tmpfile_stdout 15:35:11 INFO - Output received: 15:35:11 INFO - /builds/slave/test/build/application/firefox/firefox 15:35:11 INFO - Running post-action listener: _resource_record_post_action 15:35:11 INFO - ##### 15:35:11 INFO - ##### Running run-tests step. 15:35:11 INFO - ##### 15:35:11 INFO - Running pre-action listener: _resource_record_pre_action 15:35:11 INFO - Running main action method: run_tests 15:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:35:11 INFO - Python 2.7.3 15:35:11 INFO - Return code: 0 15:35:11 INFO - grabbing minidump binary from tooltool 15:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ccac0>, '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 0x24cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cde50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:35:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:35:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:35:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:11 INFO - Return code: 0 15:35:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:35:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:35:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:35:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:35:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:35:11 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/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 15:35:11 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/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 15:35:11 INFO - Using env: {'DISPLAY': ':0', 15:35:11 INFO - 'HOME': '/home/cltbld', 15:35:11 INFO - 'LANG': 'en_US.UTF-8', 15:35:11 INFO - 'LANGUAGE': 'en_US:en', 15:35:11 INFO - 'LOGNAME': 'cltbld', 15:35:11 INFO - 'MAIL': '/var/mail/cltbld', 15:35:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:11 INFO - 'MOZ_NO_REMOTE': '1', 15:35:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:11 INFO - 'NO_EM_RESTART': '1', 15:35:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:11 INFO - 'PWD': '/builds/slave/test', 15:35:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:11 INFO - 'SHELL': '/bin/bash', 15:35:11 INFO - 'SHLVL': '1', 15:35:11 INFO - 'TERM': 'linux', 15:35:11 INFO - 'TMOUT': '86400', 15:35:11 INFO - 'USER': 'cltbld', 15:35:11 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809', 15:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:11 INFO - '_': '/tools/buildbot/bin/python'} 15:35:11 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/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 15:35:11 INFO - mozversion INFO | application_buildid: 20151117132405 15:35:11 INFO - mozversion INFO | application_changeset: 93d3671347066a184b4325c84dfc2277000bfee8 15:35:11 INFO - mozversion INFO | application_display_name: Nightly 15:35:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:11 INFO - mozversion INFO | application_name: Firefox 15:35:11 INFO - mozversion INFO | application_remotingname: firefox 15:35:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 15:35:11 INFO - mozversion INFO | application_vendor: Mozilla 15:35:11 INFO - mozversion INFO | application_version: 45.0a1 15:35:11 INFO - mozversion INFO | platform_buildid: 20151117132405 15:35:11 INFO - mozversion INFO | platform_changeset: 93d3671347066a184b4325c84dfc2277000bfee8 15:35:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 15:35:11 INFO - mozversion INFO | platform_version: 45.0a1 15:35:11 INFO - 2015-11-17 15:35:11,369 DEBUG : using testdate: 1447803311 15:35:11 INFO - 2015-11-17 15:35:11,369 DEBUG : actual date: 1447803311 15:35:11 INFO - 2015-11-17 15:35:11,376 INFO : starting webserver on 'localhost:46023' 15:35:11 INFO - 2015-11-17 15:35:11,376 INFO : Starting test suite talos-linux64-ix-018 15:35:11 INFO - 2015-11-17 15:35:11,376 INFO : Starting test dromaeo_css 15:35:11 INFO - 2015-11-17 15:35:11,376 DEBUG : operating with platform_type : linux_ 15:35:11 INFO - 2015-11-17 15:35:11,377 INFO : Initialising browser for dromaeo_css test... 15:35:11 INFO - 2015-11-17 15:35:11,384 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2wZv0_/profile http://localhost:46023/getInfo.html 15:35:17 INFO - 2015-11-17 15:35:17,672 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:35:17 INFO - 2015-11-17 15:35:17,672 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:35:17 INFO - 2015-11-17 15:35:17,672 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:35:17 INFO - 2015-11-17 15:35:17,673 DEBUG : BROWSER_OUTPUT: __metrics 15:35:17 INFO - 2015-11-17 15:35:17,850 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:19 INFO - 2015-11-17 15:35:19,254 INFO : Browser initialized. 15:35:19 INFO - 2015-11-17 15:35:19,254 INFO : Running cycle 1/1 for dromaeo_css test... 15:35:19 INFO - 2015-11-17 15:35:19,255 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2wZv0_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:35:31 INFO - 2015-11-17 15:35:31,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 141410304 15:35:31 INFO - 2015-11-17 15:35:31,163 DEBUG : BROWSER_OUTPUT: 15:36:22 INFO - 2015-11-17 15:36:22,518 DEBUG : BROWSER_OUTPUT: 1447803382514 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] 15:38:34 INFO - 2015-11-17 15:38:34,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46023/tests/dromaeo/cssquery-ext.html) 15:38:35 INFO - 2015-11-17 15:38:35,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 215252992 15:38:35 INFO - 2015-11-17 15:38:35,410 DEBUG : BROWSER_OUTPUT: 15:41:37 INFO - 2015-11-17 15:41:37,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-ext.html (next: http://localhost:46023/tests/dromaeo/cssquery-jquery.html) 15:41:38 INFO - 2015-11-17 15:41:38,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 228909056 15:41:38 INFO - 2015-11-17 15:41:38,358 DEBUG : BROWSER_OUTPUT: 15:44:40 INFO - 2015-11-17 15:44:40,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46023/tests/dromaeo/cssquery-mootools.html) 15:44:41 INFO - 2015-11-17 15:44:41,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 214601728 15:44:41 INFO - 2015-11-17 15:44:41,053 DEBUG : BROWSER_OUTPUT: 15:47:43 INFO - 2015-11-17 15:47:43,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46023/tests/dromaeo/cssquery-prototype.html) 15:47:43 INFO - 2015-11-17 15:47:43,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 202821632 15:47:43 INFO - 2015-11-17 15:47:43,593 DEBUG : BROWSER_OUTPUT: 15:50:46 INFO - 2015-11-17 15:50:46,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46023/tests/dromaeo/cssquery-yui.html) 15:50:46 INFO - 2015-11-17 15:50:46,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 207597568 15:50:46 INFO - 2015-11-17 15:50:46,740 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-yui.html (next: http://localhost:46023/tests/dromaeo/cssquery-dojo.html) 15:53:49 INFO - 2015-11-17 15:53:49,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 222814208 15:53:49 INFO - 2015-11-17 15:53:49,407 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,407 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:53:49 INFO - 2015-11-17 15:53:49,407 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:53:49 INFO - 2015-11-17 15:53:49,407 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:53:49 INFO - 2015-11-17 15:53:49,407 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:53:49 INFO - 2015-11-17 15:53:49,407 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2683.7852971762263;2758.4896794093092;2777.7222277772225;2778.4582006508726;2786.540220863558;4547.590716835484;4713.033828065247;4817.036592681465;4822.49363816799;4839.3224948507195;4718.127146477896;4729.432468103832;4765.90468190636;4767.237242041266;4827.468978412372;4374.956250437487;4389.122175564892;4396;4526.434195725535;4555.111753208126;4481.708688935225;4512;4545.499995000548;4551.3121484870635;4573.3368661544055;4214.325707886739;4286.271333873249;4310.073334233123;4312.525622181557;4385.605295523386;4427.822887084512;4439.4228750262255;4443.644508439349;4446.622037126848;4476.776161191928;4411.404460397837;4416.315471101984;4416.84541041062;4418.911621767546;4458.910821783546;4557.931631025504;4659.091477161955;4692.95307046932;4695.5304469552775;4752.120857641347;5080.695158290478;5145.76844042019;5146.408163061258;5192.844214673566;5196.558292545138;5197.063659032635;5197.428282888917;5199.662021968597;5201.219817027439;5203.4796520348045;4557.339185818038;4672.95327046732;4821.855344339676;4828.8792780180775;4863.927041094386;5132.0762262792305;5239.449857764956;5321.600879933943;5337;5386.218998245233;5070.797168113234;5072.188449848007;5072.289879416885;5074.67014644047;5084.110280700863;4876.707397556158;4988.35151430319;5167.9224811627855;5174.482551744871;5215.478452154754;4958.082754690394;4985.1276026695905;5013.523715247045;5127.6154288428515;5150.072986862401;5119.129747942784;5143.022825663112;5154.046501397253;5156.561692256125;5156.793728250828;3990.221906728218;3995.06116062725;3997.900052498711;4015.8393664253103;4026.013626661487;3374.5613070301197;3458.3256265028076;3463.255400088993;3481.3733527964705;3559.661832125944;4449.3993310902615;4491.618212451913;4500.617447516997;4505.45934487857;4542.068875880436;5231.915178505008;5238.266642670029;5257;5257.737113144328;5261.631685781958;4167.416561681367;4271.893202669959;4273.957260427418;4276.700630955866;4504.707194032443;4454.10917816438;4620.838270660511;4634.21218392874;4640.69835460694;4660.883477913011;4912;4918.458969513422;4946.208606622923;4960.70235785854;4993.101241776442;4918.8770280743265;5178.792848286026;5188.58491320701;5193.76628051731;5235.4502777207845;4733.857984260478;4781.9043619128115;4799.352087468147;4852.393450818648;4860.8298709545;5095.133827249302;5130.281760553451;5134.358205224347;5160.668891007267;5172.793088276427;5258.447862974333;5262.763175657181;5264.105102132723;5264.263003179634;5270.815521456884;4783.928241076317;4855.441624213261;4890.510948905081;4890.779914903766;4975;4993.600511959107;5050.949490505048;5055;5058.797648094035;5091.338126043591;4893.21708526634;4924;4946.554810067111;4947.2579113133315;4969.552740253394;4735.976320118378;4825.855224343275;4858.125537403302;4860.635452341018;4989.077020751172;4954.826581069645;4986.1772807487805;5003.899922001612;5005.574526165171;5036.84889453317 15:53:49 INFO - 2015-11-17 15:53:49,411 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.3171036204747;562.5078056700387;566.6798258983674;574.7270046727805;575.4676923845442;25325.873370633144;25851.095211667594;25869.611955820677;25873.094441694546;37092.62907370926;38866.805665971704;39364.606353936455;39416;39495.40756888649;39671.24766908796;7895.289423951829;8047.95976020122;8048.557329346912;8050.637721302555;8054.395920305971;6857.314268573127;7013.473989450786;7861.292483676468;10141.44222067786;10444.216683748711;10115.443650599214;10215.642452514163;10226.744331391701;10251.384916904972;10261.333013354108;6843.486738494583;10039.74900627483;10073.043060909202;10082.395056296646;10157.796844063078;6785.9660701696175;10081.49592520371;10355.689329320132;10359;10359.689209323657;38037.23925521502;38552.614473855465;38564;38585;38611.8069409654;2810.3676672748675;2815.2398852309966;2829.278533973844;2857.4427986542632;3418.572678415198;28668.856655716798;28679;28876.711232887614;28999.275018124506;29295.853520732475;2937.3186533645994;2965.154930844699;2989.3871756290127;3007.6541197762317;3046.7257946784675;212562.99999999846;234448;235373;235470;236168;32951.835240823646;55535.44464555303;56823;56857.71571142118;56965.71517142388;52071.21893171605;52261.7386913063;52397.7380113097;52399.21401178985;52423;11643.184977051695;11682.591109311303;11752.823707644393;11783;11787.349771032063;8717.825643487095;8925.598348074353;8946.507942063248;8948.194662480279;9037.954810225907;18856.622867542574;19089.140988655545;19107.375873050667;19225.65420420557;19236.519087022938;7031.964840175869;7382.852342953111;7387.2612738726775;7418.703251869865;7421.183669796318;766.7967988483057;853.50923219148;872.8079822439054;933.9112784285481;934.9626014959325;25953.870230649103;26098.478030439666;27452;27785.72214277872;27815.165545033276;905.8867641544807;917.7522069041321;939.9107084827067;973.9756506087405;1064.4571268653042;12672.176308539916;13012.089153759336;13862.861371386158;14433.20617366055;14837.703245935238;216508;218333;219918;220128;220798;43153.136937261705;43232.567674322854;43435.56564434315;43520.12959740851;43684.78157609192;1182.1961066474707;1198.8321634971112;1201.9519219231133;1209.7580483903255;1213.5631172777794;26212.344691382106;26603.201903942914;26606;26779.062732804257;27106.72893271042;40974.79512602418;41305.380419294335;41309.79345103255;41338.1732365357;41351.79324103481;260924;305614;307357;345560;352880;28410.573841391983;28601.570976435785;28662.856685716437;28741;29100;38397.232055359294;38432.423513647875;39600.80199598984;39816.60183398129;39858.402123967586;33670.66329336675;33932;34139.65860341365;34340.82829585836;34631.307373852884;32942.67057329396;33396;34221.657783422845;34221.82889085539;34314.313713726086;33069.37028816016;33445;33495.33009339849;33855;33867;30135.547966780076;30504.84747576248;30702.692973070876;30829.845850770602;30972.22569435782;23467.382303939772;23769.762302377447;23895.283141505784;23992.76007239905;24041.398965026016 15:53:49 INFO - 2015-11-17 15:53:49,411 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.63630006992327;331.29764898415357;333.5147360590341;333.606344513474;336.7945553212538;8440.32477401808;8702.303815694746;10523.158147348213;15382.692346153084;15845.920770396146;9973.102420782147;10167.186625069995;10238.846417303746;10244.436555989418;10896.400697961628;4047.494063242095;4156.251874662559;4156.521999969997;4159.085001299709;4159.417681524589;3152.763542734304;3248.707616314531;4219.071804203086;4554.066416384633;4696.225122854725;4574.947762014739;4575.611073058794;4591.4260717410325;4642.07158568286;4643.9535604644025;4504.391907092549;4562.292844609091;4575.702579332333;4590.701604395704;4621.861344159681;3966.2662407454714;3973.602639736032;3996.3805610130476;3997.480327557399;3999.7400168988925;11172.10623150146;11427.942860285646;11477;12076.456559454846;12179.695507612381;1646.7365221564492;1668.1742537443922;1697.8302169782924;1702.2339947023765;1705.7270836666073;8786.516741579211;9065.637374505011;9309.953450232706;9327.253819694408;9484.952575237148;1574.205026461641;1604.7592861070816;1654.619437529375;1671.548681855892;1671.6155284284562;54279;54672.17991730127;55558.44441555573;55949.44050559483;56124.719376402856;6363.522735794834;6438.645874476855;6447.580907241015;6458.935410645833;6496.415322620986;7600.3539699126195;7611.543307401574;7622.618869056525;7622.885656715153;7629.351505122016;4682.344471773954;4696.01383709418;4711.2226482629985;4762.833300834454;4787.473377928425;4630.907381852344;4645.5354464553275;4672.6261899047995;4693.882652933636;4694.014257006067;2940.4707152712717;2958.8816447341865;2959.230600044004;2971.5097008993275;2973.6431628204755;1008.5763979128784;1047.7590154264562;1071.3839542263229;1079.6491140379408;1108.8336749487642;389.47032036431;411.3582810815138;416.0970693594906;435.9738415695068;445.9353393757952;10481.266311358284;10780.353178809297;10853.837192442119;10942.617008404668;11074;365.81160702238367;417.5365344467638;422.4571425717938;440.9294512877924;443.5586591341636;5451.6643422360985;5544.750486228129;5592.748326325243;5607.327120745536;5713.5714821388565;441581;447061;464667;464805;465639;63941.36058639354;64318;64801;65864.34135658678;69544;470.40963590694145;485.3665965914445;485.48053582666915;485.48296064690993;486.34829328699715;10080.344777589433;10125.949370253102;10174.491275436347;10190.694279171637;10328.896711033094;29639.703602964557;32114.19714507156;32678.34643307168;33050.504242435905;33357;36019.459708103874;37951;38125.4281185788;42426;42679.78660106679;6022.759089636365;6202.100695399232;6208.441240288395;6213.689315534115;6217.968910155601;10358.430286334324;10865.619703310345;10867.347959122479;10935.070519005656;11060.281081729661;9332.30007749435;9547.188488978236;9649.421034737657;9703.805923881624;9899.257555683209;9424.81150376975;9504.097110774464;9649.662261820802;9707.126358627758;9917.553710082919;7882.054153501616;8505.192006759347;8821.2060914518;9452.43285402878;9706.86448981223;5648.237487939075;5977.6114552553945;6209.285932117684;6278.905816412849;6284.151639528605;9069.501177435304;9626.181774548962;9651.71044868655;9869.161121304769;9972.105299992978 15:53:49 INFO - 2015-11-17 15:53:49,411 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1198.101423932051;1601.9199040047997;1622.1402656592004;1667.424738465229;1667.9749803752939;6102.11519329697;6989.126359205099;7050.682719277632;7079.185893622229;7091.503594748369;6940.4794640401915;7026.4730145239055;7026.894596581055;7040.753573624924;7058.400035996933;2050.8769473831544;2074.7095406643084;2076.709260703503;2077.1483691686412;2079.8336133109315;2070.8446866484996;2093.905774240155;2095.7170781944396;2098.8845613491253;2118.3644906528057;2076.045019291128;2080.8855512946784;2082.052666036957;2094.3298144593737;2095.9476013099643;2082.79172082792;2090.989545052265;2092.905819238138;2093.7173481579944;2094.4449720823995;2071.6271071207175;2082.2816128435666;2099.8950052497466;2110.6622940329476;2111.535462198314;6014.518838492954;6156.507479401637;7014.789556313319;7060.152781666182;7060.92939070613;3969.146633473817;4034.8587799426878;4040.5353384360883;4049;4054.3918412238104;2731.289864635189;2769.667639883227;2812.8452935088562;2819.3938303264895;2867.1111955293927;737.2038198745342;824.6701319472199;878.0517041595062;888.8800011998427;892.9910700892973;8877.422967507091;8924.062973387765;8925.107489251088;8937.374383793138;9100.044495327962;3893.474380958591;3917.7845218512684;3968.861089861841;4052.128792309609;4052.4731784867777;8145.470544414594;8157.918420815835;8160.30637395828;8163.755087347389;8170.060443049007;4186.937195942063;4197.076643138505;4198.076423186894;4204.222218889515;4204.558521355275;3711.7958512282084;3734.047817806442;3738.6261373862394;3740.3080430120513;3747.1568896997956;3464.4803279507773;3469.7918124912585;3513.1041584396326;3545.8227088645463;3558.5729712434672;1132.230083543182;1140.0252783869837;1141.897229249355;1142.457332766929;1148.8631146068305;1133.699569614053;1142.491591241906;1171.5138217639585;1174.929504229749;1175.482787573465;6551.21385433751;6575.736970521221;6587.50593705474;6594.109795177686;6594.868102638016;406.96744260459093;407.9347304431336;411.55757560622453;414.04769031228057;414.14065813437236;5176.7411629418375;5183.092958732207;5186.144286192812;5219.269302297681;5228.163493841043;7656.425768067305;8175.468594541336;8480.406371553932;8548.316134709208;8561.571921403905;7704.036995375578;8256.876146857801;8388.37087218461;8491.74524764258;8515.701950431705;6578.736850526021;6630.436412904861;6666.200055993312;6669.899951500828;6674.666266686743;6116.14373987651;6223.782167624111;6235.937640623536;6250.062490626442;6257.843553911189;7393.8151546211775;7420.5547667140145;7494.737684181027;7556.735514256975;7628.084629844454;7403.074615673041;7533.472656913963;7699.26856948589;7782.5330480169105;7811.648475818488;6406.167198264196;6476;6500.154979852589;6502.967485162544;6504.739810407531;6678.866422671616;6711.530192886451;6745.93254067453;6991.545549539263;6992.545484543489;6609.4712423007;6651.301613330724;6674.599524028574;6736.797896063126;6749.122614060141;6198.442140207403;6272.310045894857;6301.180846489927;6319.304876463677;6399.840003999937;5791.855203619774;6112.938870611237;6120.143179954721;6120.357362476876;6153.29237137717;5734.598578099493;5774.335951365479;5777.537796976148;5783.248177736868;5800.187973683772;5930.11048342752;5948.345681974893;5966.836466889089;6002.549808764447;6006.759729610942 15:53:49 INFO - 2015-11-17 15:53:49,412 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.32162167554515;289.76673777609017;291.9956200656992;295.34138870319185;299.79613862573456;5094.949050509494;5427.972860135698;5447.019536483432;5455.754491047907;5473.644213126144;5464.26232458618;5481.972590137044;5485.753141108649;5489.451054894508;5500.889982200363;4243.108947121108;4247.787610619464;4252.936205956913;4259.148170365939;4260.0414906646065;4249.553796851333;4256.765877876715;4261.382099595557;4263.488381394237;4267.850625228118;4142.544320124784;4167.854125105622;4203.453551038361;4216.51510076342;4231.561269168482;4185.121124563845;4186.748795072275;4194.2450358935375;4195.5175154857125;4197.370394440828;3636.090977255686;3646.3436581415335;3648.325059863907;3657.3782456982376;3660.6705396514176;5310;5324.8136315228785;5324.866878328034;5329.813456529042;5330.520253177233;4522.819087236507;4852;4859;4872.269159626049;4874.2444921037295;4610.354550362952;5500.312460942382;5744.942550574483;5776;5792.073268277056;3860.36304009838;3951.565327813938;3951.6443520083044;3960;3970.940435893464;5795.2176456178295;5943.138244954457;5994.2806863176265;6078.939210607881;6081.574289799716;3951.5455722591696;4059.3910913362643;4067.9593204068174;4076.0217547788316;4078.6737061035046;4130.772807495557;4141.751494910315;4142.420061191436;4142.855000074983;4144.191882582928;4764.118638051971;4781.617470602343;4782.95217047832;4783.976080119577;4785.186518291899;5622.240997465372;5767.538596912237;5770.740316685759;5774.682392468455;5781.479666830005;1434.7560914644534;1450.9564713058626;1451.100317802969;1452.4988878836784;1453.0482533940285;961.927855410847;967.7000129959735;974.7319487141093;985.1724551376877;985.7042887133831;5045.873853153627;5047.116754567936;5054.898902021939;5064.341635587423;5065.088284108896;5992.760289588455;6004.729787159588;6005.909911351333;6012.579119461683;6020.8795824084145;5035.647504674637;5040.873978150576;5051.924221136685;5053.090443720165;5056.949430505648;3136.2159460134967;3192.0902542775198;3211.2935154266024;3211.71094601487;3215.276562773404;5566.693831839288;5575.275214222125;5579.0515612346;5580.86047848807;5583.664980101207;6051.122587224828;6054.243219597551;6054.303755068136;6059.484943779828;6063.272407311063;5560.443955604407;5564.165375193753;5566.693831839288;5573.386927437979;5578.944210557924;5865.501432378125;6021.819345419644;6044.818655440344;6059.33347331802;6062.514998800174;5809.30288365382;5820.476157145878;5889.116632505158;5890.852728681817;5898.4101589840675;5490;5719.113537401709;5723.656580605177;5730.942690573041;5731.083026715705;3963.2271707016853;4056.5537790842395;4182.539920608791;4198.328267477189;4199.517055538652;5941.31674857397;5960.552958528215;5979.162917191509;5982.880342393215;5988.970055149871;5715.2855893013375;5745.8563535911935;5753.8561535961935;5759.827205183684;5763.625364351304;5588.217649529151;5738.024535828836;5753.913691294718;5755.597108202385;5766.250387449605;5619.662820230636;5624.606277560695;5629.057974998619;5630.774769009357;5635.802746903839;5776.56675749312;5804.477597016289;5809.970950145223;5810.01229790945;5812.622179558315;5537.280153580009;5646.604737668488;5655.943440565707;5657.519110875457;5660.688662123458 15:53:49 INFO - 2015-11-17 15:53:49,412 DEBUG : BROWSER_OUTPUT: |5;yui.html;706.3042902740799;712.2948281201612;713.1655962523846;713.5468977199477;728.2535401213755;11462.197646164772;11828.112891533126;11836.940815295911;11844.940775296122;11882.108841836864;11500.482478288477;11580.710482237948;11601.419929003538;11601.593944211954;11605.941970290158;599.1701493431607;755.1165136789955;772.1622040086513;772.2972095393166;772.9072511298652;597.7459579678641;774.7133560582564;787.4527203593505;788.7554857994012;789.8420315936836;805.5005896344245;827.1315119124924;827.7185756842672;828.1015098618007;828.6312590897053;621.919150510433;628.2241431831684;800.4036992440668;816.6855760532209;816.873384625384;603.5262319079502;605.8909396308707;606.8755905039457;607.4411541381895;607.5443417436923;11066.889331106666;11216.439178041066;11224.270422422516;11224.719382015433;11236.325820450798;10363.378197308186;11818.468168932419;12008.099392545506;12020.63938081859;12203.755924881452;8759.430637008574;8827.955860220658;8869.37914345996;8940.5082720451;8972.820543589158;3145.889893853704;3176.2059485128716;3196.1172208629655;3205.423023855705;3224.6130464344196;40849.38725919084;40979.590204098175;41011.179776404606;41110.58889411097;41115.794421027706;9128.26973842091;9135.888850017385;9173.128552787475;9302.95348523253;9428.481433521221;17031.615573819676;17034.48896533106;17063.65872682564;17067.914660426617;17073;6314.684265786784;6437.549371544041;6443.710033048524;6535.477161827042;6639.1037209977;3504.7196224301993;3533.611302756695;3587.695045921074;3604.5133906922756;3611.9277614447565;2746.7939904507243;2811.803173777816;2816;2819.210621026116;2833.971660283412;416.11783019997193;417.62413827555446;417.86210550518257;427.2395136656756;432.15082363156546;415.5221495280452;426.58695792031386;476.1263082244052;488.68724016629386;539.6384422436977;6529.869402611921;7384.963075184697;7399.223081576357;7575.431842611826;8004.63979120941;421.8839819049786;437.65862627150875;487.95608395244597;494.5697243398267;523.6910222968467;3195.472746996766;3251;3281.5898012748407;3813.103920578662;3858.9966608681943;58411.415885841445;59875.70062149748;59903.700481498185;59914.70042649759;59983.40016599865;50496.242556361685;51091;51216.23175652368;51343;51420.22869656958;42741.57258427438;43134.352984705256;43262.35106473405;46673.29990050152;47565.52434475611;7080.716771329296;7122.287771223044;7184.6048467334795;7235.710571577289;7303.196648368569;33475;34370.65629343675;34372;34381.31237375289;34743.65256347404;39308.80345598254;41926.16147676968;42448.78775606102;42625.57374426216;42649;9985.800283994135;10000.09948367968;10030.699079027641;10149.84775228387;10153.39079655223;10843.945780271048;10903.29128606638;11058.502367393647;11124.499397526968;11346.773064538498;10159.84760228612;10407.94796026015;10488.31825931312;10867.945660271647;10870.565177392815;9998.400095994264;10181.134603558781;10309.536070876979;10367.222458315808;10712;6859.759908403182;9210.723678289662;9633.133018028411;9891.950540247253;10351.327163734333;8846.77883052903;9091.18179363834;9287.257019438293;9596.760080997752;9722.076402741728;8904.86642700373;9406.43561386319;9413.717588472357;9420.665457227717;9575.473348965874 15:53:49 INFO - 2015-11-17 15:53:49,412 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:53:49 INFO - 2015-11-17 15:53:49,412 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:53:49 INFO - 2015-11-17 15:53:49,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,907 15:53:49 INFO - 2015-11-17 15:53:49,412 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:53:49 INFO - 2015-11-17 15:53:49,413 DEBUG : BROWSER_OUTPUT: __startTimestamp1447804429404__endTimestamp 15:53:49 INFO - 2015-11-17 15:53:49,413 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,413 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:53:49 INFO - 2015-11-17 15:53:49,413 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:53:49 INFO - 2015-11-17 15:53:49,413 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,413 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4726.17 Median:4858.13 stddev:532.44 (11.0%) stddev-sans-first:509.39 15:53:49 INFO - 2015-11-17 15:53:49,414 DEBUG : BROWSER_OUTPUT: Values: 2683.8 2758.5 2777.7 2778.5 2786.5 4547.6 4713.0 4817.0 4822.5 4839.3 4718.1 4729.4 4765.9 4767.2 4827.5 4375.0 4389.1 4396.0 4526.4 4555.1 4481.7 4512.0 4545.5 4551.3 4573.3 4214.3 4286.3 4310.1 4312.5 4385.6 4427.8 4439.4 4443.6 4446.6 4476.8 4411.4 4416.3 4416.8 4418.9 4458.9 4557.9 4659.1 4693.0 4695.5 4752.1 5080.7 5145.8 5146.4 5192.8 5196.6 5197.1 5197.4 5199.7 5201.2 5203.5 4557.3 4673.0 4821.9 4828.9 4863.9 5132.1 5239.4 5321.6 5337.0 5386.2 5070.8 5072.2 5072.3 5074.7 5084.1 4876.7 4988.4 5167.9 5174.5 5215.5 4958.1 4985.1 5013.5 5127.6 5150.1 5119.1 5143.0 5154.0 5156.6 5156.8 3990.2 3995.1 3997.9 4015.8 4026.0 3374.6 3458.3 3463.3 3481.4 3559.7 4449.4 4491.6 4500.6 4505.5 4542.1 5231.9 5238.3 5257.0 5257.7 5261.6 4167.4 4271.9 4274.0 4276.7 4504.7 4454.1 4620.8 4634.2 4640.7 4660.9 4912.0 4918.5 4946.2 4960.7 4993.1 4918.9 5178.8 5188.6 5193.8 5235.5 4733.9 4781.9 4799.4 4852.4 4860.8 5095.1 5130.3 5134.4 5160.7 5172.8 5258.4 5262.8 5264.1 5264.3 5270.8 4783.9 4855.4 4890.5 4890.8 4975.0 4993.6 5050.9 5055.0 5058.8 5091.3 4893.2 4924.0 4946.6 4947.3 4969.6 4736.0 4825.9 4858.1 4860.6 4989.1 4954.8 4986.2 5003.9 5005.6 5036.8 15:53:49 INFO - 2015-11-17 15:53:49,414 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41156.20 Median:30901.04 stddev:67717.12 (219.1%) stddev-sans-first:67838.43 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: Values: 546.3 562.5 566.7 574.7 575.5 25325.9 25851.1 25869.6 25873.1 37092.6 38866.8 39364.6 39416.0 39495.4 39671.2 7895.3 8048.0 8048.6 8050.6 8054.4 6857.3 7013.5 7861.3 10141.4 10444.2 10115.4 10215.6 10226.7 10251.4 10261.3 6843.5 10039.7 10073.0 10082.4 10157.8 6786.0 10081.5 10355.7 10359.0 10359.7 38037.2 38552.6 38564.0 38585.0 38611.8 2810.4 2815.2 2829.3 2857.4 3418.6 28668.9 28679.0 28876.7 28999.3 29295.9 2937.3 2965.2 2989.4 3007.7 3046.7 212563.0 234448.0 235373.0 235470.0 236168.0 32951.8 55535.4 56823.0 56857.7 56965.7 52071.2 52261.7 52397.7 52399.2 52423.0 11643.2 11682.6 11752.8 11783.0 11787.3 8717.8 8925.6 8946.5 8948.2 9038.0 18856.6 19089.1 19107.4 19225.7 19236.5 7032.0 7382.9 7387.3 7418.7 7421.2 766.8 853.5 872.8 933.9 935.0 25953.9 26098.5 27452.0 27785.7 27815.2 905.9 917.8 939.9 974.0 1064.5 12672.2 13012.1 13862.9 14433.2 14837.7 216508.0 218333.0 219918.0 220128.0 220798.0 43153.1 43232.6 43435.6 43520.1 43684.8 1182.2 1198.8 1202.0 1209.8 1213.6 26212.3 26603.2 26606.0 26779.1 27106.7 40974.8 41305.4 41309.8 41338.2 41351.8 260924.0 305614.0 307357.0 345560.0 352880.0 28410.6 28601.6 28662.9 28741.0 29100.0 38397.2 38432.4 39600.8 39816.6 39858.4 33670.7 33932.0 34139.7 34340.8 34631.3 32942.7 33396.0 34221.7 34221.8 34314.3 33069.4 33445.0 33495.3 33855.0 33867.0 30135.5 30504.8 30702.7 30829.8 30972.2 23467.4 23769.8 23895.3 23992.8 24041.4 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23152.07 Median:4575.28 stddev:74918.82 (1637.5%) stddev-sans-first:75109.39 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: Values: 330.6 331.3 333.5 333.6 336.8 8440.3 8702.3 10523.2 15382.7 15845.9 9973.1 10167.2 10238.8 10244.4 10896.4 4047.5 4156.3 4156.5 4159.1 4159.4 3152.8 3248.7 4219.1 4554.1 4696.2 4574.9 4575.6 4591.4 4642.1 4644.0 4504.4 4562.3 4575.7 4590.7 4621.9 3966.3 3973.6 3996.4 3997.5 3999.7 11172.1 11427.9 11477.0 12076.5 12179.7 1646.7 1668.2 1697.8 1702.2 1705.7 8786.5 9065.6 9310.0 9327.3 9485.0 1574.2 1604.8 1654.6 1671.5 1671.6 54279.0 54672.2 55558.4 55949.4 56124.7 6363.5 6438.6 6447.6 6458.9 6496.4 7600.4 7611.5 7622.6 7622.9 7629.4 4682.3 4696.0 4711.2 4762.8 4787.5 4630.9 4645.5 4672.6 4693.9 4694.0 2940.5 2958.9 2959.2 2971.5 2973.6 1008.6 1047.8 1071.4 1079.6 1108.8 389.5 411.4 416.1 436.0 445.9 10481.3 10780.4 10853.8 10942.6 11074.0 365.8 417.5 422.5 440.9 443.6 5451.7 5544.8 5592.7 5607.3 5713.6 441581.0 447061.0 464667.0 464805.0 465639.0 63941.4 64318.0 64801.0 65864.3 69544.0 470.4 485.4 485.5 485.5 486.3 10080.3 10125.9 10174.5 10190.7 10328.9 29639.7 32114.2 32678.3 33050.5 33357.0 36019.5 37951.0 38125.4 42426.0 42679.8 6022.8 6202.1 6208.4 6213.7 6218.0 10358.4 10865.6 10867.3 10935.1 11060.3 9332.3 9547.2 9649.4 9703.8 9899.3 9424.8 9504.1 9649.7 9707.1 9917.6 7882.1 8505.2 8821.2 9452.4 9706.9 5648.2 5977.6 6209.3 6278.9 6284.2 9069.5 9626.2 9651.7 9869.2 9972.1 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4885.59 Median:6010.64 stddev:2500.62 (41.6%) stddev-sans-first:2492.27 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: Values: 1198.1 1601.9 1622.1 1667.4 1668.0 6102.1 6989.1 7050.7 7079.2 7091.5 6940.5 7026.5 7026.9 7040.8 7058.4 2050.9 2074.7 2076.7 2077.1 2079.8 2070.8 2093.9 2095.7 2098.9 2118.4 2076.0 2080.9 2082.1 2094.3 2095.9 2082.8 2091.0 2092.9 2093.7 2094.4 2071.6 2082.3 2099.9 2110.7 2111.5 6014.5 6156.5 7014.8 7060.2 7060.9 3969.1 4034.9 4040.5 4049.0 4054.4 2731.3 2769.7 2812.8 2819.4 2867.1 737.2 824.7 878.1 888.9 893.0 8877.4 8924.1 8925.1 8937.4 9100.0 3893.5 3917.8 3968.9 4052.1 4052.5 8145.5 8157.9 8160.3 8163.8 8170.1 4186.9 4197.1 4198.1 4204.2 4204.6 3711.8 3734.0 3738.6 3740.3 3747.2 3464.5 3469.8 3513.1 3545.8 3558.6 1132.2 1140.0 1141.9 1142.5 1148.9 1133.7 1142.5 1171.5 1174.9 1175.5 6551.2 6575.7 6587.5 6594.1 6594.9 407.0 407.9 411.6 414.0 414.1 5176.7 5183.1 5186.1 5219.3 5228.2 7656.4 8175.5 8480.4 8548.3 8561.6 7704.0 8256.9 8388.4 8491.7 8515.7 6578.7 6630.4 6666.2 6669.9 6674.7 6116.1 6223.8 6235.9 6250.1 6257.8 7393.8 7420.6 7494.7 7556.7 7628.1 7403.1 7533.5 7699.3 7782.5 7811.6 6406.2 6476.0 6500.2 6503.0 6504.7 6678.9 6711.5 6745.9 6991.5 6992.5 6609.5 6651.3 6674.6 6736.8 6749.1 6198.4 6272.3 6301.2 6319.3 6399.8 5791.9 6112.9 6120.1 6120.4 6153.3 5734.6 5774.3 5777.5 5783.2 5800.2 5930.1 5948.3 5966.8 6002.5 6006.8 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,415 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4751.02 Median:5468.95 stddev:1407.19 (25.7%) stddev-sans-first:1370.54 15:53:49 INFO - 2015-11-17 15:53:49,417 DEBUG : BROWSER_OUTPUT: Values: 280.3 289.8 292.0 295.3 299.8 5094.9 5428.0 5447.0 5455.8 5473.6 5464.3 5482.0 5485.8 5489.5 5500.9 4243.1 4247.8 4252.9 4259.1 4260.0 4249.6 4256.8 4261.4 4263.5 4267.9 4142.5 4167.9 4203.5 4216.5 4231.6 4185.1 4186.7 4194.2 4195.5 4197.4 3636.1 3646.3 3648.3 3657.4 3660.7 5310.0 5324.8 5324.9 5329.8 5330.5 4522.8 4852.0 4859.0 4872.3 4874.2 4610.4 5500.3 5744.9 5776.0 5792.1 3860.4 3951.6 3951.6 3960.0 3970.9 5795.2 5943.1 5994.3 6078.9 6081.6 3951.5 4059.4 4068.0 4076.0 4078.7 4130.8 4141.8 4142.4 4142.9 4144.2 4764.1 4781.6 4783.0 4784.0 4785.2 5622.2 5767.5 5770.7 5774.7 5781.5 1434.8 1451.0 1451.1 1452.5 1453.0 961.9 967.7 974.7 985.2 985.7 5045.9 5047.1 5054.9 5064.3 5065.1 5992.8 6004.7 6005.9 6012.6 6020.9 5035.6 5040.9 5051.9 5053.1 5056.9 3136.2 3192.1 3211.3 3211.7 3215.3 5566.7 5575.3 5579.1 5580.9 5583.7 6051.1 6054.2 6054.3 6059.5 6063.3 5560.4 5564.2 5566.7 5573.4 5578.9 5865.5 6021.8 6044.8 6059.3 6062.5 5809.3 5820.5 5889.1 5890.9 5898.4 5490.0 5719.1 5723.7 5730.9 5731.1 3963.2 4056.6 4182.5 4198.3 4199.5 5941.3 5960.6 5979.2 5982.9 5989.0 5715.3 5745.9 5753.9 5759.8 5763.6 5588.2 5738.0 5753.9 5755.6 5766.3 5619.7 5624.6 5629.1 5630.8 5635.8 5776.6 5804.5 5810.0 5810.0 5812.6 5537.3 5646.6 5655.9 5657.5 5660.7 15:53:49 INFO - 2015-11-17 15:53:49,417 DEBUG : BROWSER_OUTPUT: 15:53:49 INFO - 2015-11-17 15:53:49,417 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12875.32 Median:23555.48 stddev:15580.58 (66.1%) stddev-sans-first:15597.49 15:53:49 INFO - 2015-11-17 15:53:49,417 DEBUG : BROWSER_OUTPUT: Values: 706.3 712.3 713.2 713.5 728.3 11462.2 11828.1 11836.9 11844.9 11882.1 11500.5 11580.7 11601.4 11601.6 11605.9 599.2 755.1 772.2 772.3 772.9 597.7 774.7 787.5 788.8 789.8 805.5 827.1 827.7 828.1 828.6 621.9 628.2 800.4 816.7 816.9 603.5 605.9 606.9 607.4 607.5 11066.9 11216.4 11224.3 11224.7 11236.3 10363.4 11818.5 12008.1 12020.6 12203.8 8759.4 8828.0 8869.4 8940.5 8972.8 3145.9 3176.2 3196.1 3205.4 3224.6 40849.4 40979.6 41011.2 41110.6 41115.8 9128.3 9135.9 9173.1 9303.0 9428.5 17031.6 17034.5 17063.7 17067.9 17073.0 6314.7 6437.5 6443.7 6535.5 6639.1 3504.7 3533.6 3587.7 3604.5 3611.9 2746.8 2811.8 2816.0 2819.2 2834.0 416.1 417.6 417.9 427.2 432.2 415.5 426.6 476.1 488.7 539.6 6529.9 7385.0 7399.2 7575.4 8004.6 421.9 437.7 488.0 494.6 523.7 3195.5 3251.0 3281.6 3813.1 3859.0 58411.4 59875.7 59903.7 59914.7 59983.4 50496.2 51091.0 51216.2 51343.0 51420.2 42741.6 43134.4 43262.4 46673.3 47565.5 7080.7 7122.3 7184.6 7235.7 7303.2 33475.0 34370.7 34372.0 34381.3 34743.7 39308.8 41926.2 42448.8 42625.6 42649.0 9985.8 10000.1 10030.7 10149.8 10153.4 10843.9 10903.3 11058.5 11124.5 11346.8 10159.8 10407.9 10488.3 10867.9 10870.6 9998.4 10181.1 10309.5 10367.2 10712.0 6859.8 9210.7 9633.1 9892.0 10351.3 8846.8 9091.2 9287.3 9596.8 9722.1 8904.9 9406.4 9413.7 9420.7 9575.5 15:53:49 INFO - 2015-11-17 15:53:49,417 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:53:49 INFO - 2015-11-17 15:53:49,417 DEBUG : BROWSER_OUTPUT: 15:53:50 INFO - 2015-11-17 15:53:50,185 INFO : Browser exited with error code: 0 15:53:50 INFO - 2015-11-17 15:53:50,206 INFO : Completed test dromaeo_css (00:18:38) 15:53:50 INFO - 2015-11-17 15:53:50,206 INFO : Starting test kraken 15:53:50 INFO - 2015-11-17 15:53:50,206 DEBUG : operating with platform_type : linux_ 15:53:50 INFO - 2015-11-17 15:53:50,206 INFO : Initialising browser for kraken test... 15:53:50 INFO - 2015-11-17 15:53:50,212 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTnZsNX/profile http://localhost:46023/getInfo.html 15:53:54 INFO - 2015-11-17 15:53:54,404 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:53:54 INFO - 2015-11-17 15:53:54,404 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:53:54 INFO - 2015-11-17 15:53:54,404 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:53:54 INFO - 2015-11-17 15:53:54,404 DEBUG : BROWSER_OUTPUT: __metrics 15:53:54 INFO - 2015-11-17 15:53:54,565 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:55 INFO - 2015-11-17 15:53:55,832 INFO : Browser initialized. 15:53:55 INFO - 2015-11-17 15:53:55,833 INFO : Running cycle 1/1 for kraken test... 15:53:55 INFO - 2015-11-17 15:53:55,833 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTnZsNX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:54:07 INFO - 2015-11-17 15:54:07,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 140603392 15:54:07 INFO - 2015-11-17 15:54:07,646 DEBUG : BROWSER_OUTPUT: 15:54:10 INFO - 2015-11-17 15:54:10,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46023/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:10 INFO - 2015-11-17 15:54:10,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 177905664 15:54:10 INFO - 2015-11-17 15:54:10,806 DEBUG : BROWSER_OUTPUT: 15:54:13 INFO - 2015-11-17 15:54:13,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46023/tests/kraken/driver.html?testName=audio-dft) 15:54:14 INFO - 2015-11-17 15:54:14,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 167772160 15:54:14 INFO - 2015-11-17 15:54:14,079 DEBUG : BROWSER_OUTPUT: 15:54:17 INFO - 2015-11-17 15:54:17,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46023/tests/kraken/driver.html?testName=audio-fft) 15:54:17 INFO - 2015-11-17 15:54:17,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 151662592 15:54:17 INFO - 2015-11-17 15:54:17,659 DEBUG : BROWSER_OUTPUT: 15:54:19 INFO - 2015-11-17 15:54:19,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46023/tests/kraken/driver.html?testName=audio-oscillator) 15:54:20 INFO - 2015-11-17 15:54:20,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 153694208 15:54:20 INFO - 2015-11-17 15:54:20,301 DEBUG : BROWSER_OUTPUT: 15:54:22 INFO - 2015-11-17 15:54:22,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:23 INFO - 2015-11-17 15:54:23,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 156164096 15:54:23 INFO - 2015-11-17 15:54:23,075 DEBUG : BROWSER_OUTPUT: 15:54:26 INFO - 2015-11-17 15:54:26,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46023/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:26 INFO - 2015-11-17 15:54:26,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 156028928 15:54:26 INFO - 2015-11-17 15:54:26,599 DEBUG : BROWSER_OUTPUT: 15:54:30 INFO - 2015-11-17 15:54:30,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46023/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:30 INFO - 2015-11-17 15:54:30,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 156766208 15:54:30 INFO - 2015-11-17 15:54:30,634 DEBUG : BROWSER_OUTPUT: 15:54:33 INFO - 2015-11-17 15:54:33,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46023/tests/kraken/driver.html?testName=json-parse-financial) 15:54:34 INFO - 2015-11-17 15:54:34,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 157757440 15:54:34 INFO - 2015-11-17 15:54:34,012 DEBUG : BROWSER_OUTPUT: 15:54:35 INFO - 2015-11-17 15:54:35,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:36 INFO - 2015-11-17 15:54:36,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 163921920 15:54:36 INFO - 2015-11-17 15:54:36,304 DEBUG : BROWSER_OUTPUT: 15:54:38 INFO - 2015-11-17 15:54:38,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:38 INFO - 2015-11-17 15:54:38,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 163549184 15:54:38 INFO - 2015-11-17 15:54:38,793 DEBUG : BROWSER_OUTPUT: 15:54:40 INFO - 2015-11-17 15:54:40,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:41 INFO - 2015-11-17 15:54:41,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 171216896 15:54:41 INFO - 2015-11-17 15:54:41,486 DEBUG : BROWSER_OUTPUT: 15:54:44 INFO - 2015-11-17 15:54:44,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:44 INFO - 2015-11-17 15:54:44,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 178511872 15:54:44 INFO - 2015-11-17 15:54:44,627 DEBUG : BROWSER_OUTPUT: 15:54:47 INFO - 2015-11-17 15:54:47,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:47 INFO - 2015-11-17 15:54:47,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 175976448 15:54:47 INFO - 2015-11-17 15:54:47,758 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46023/tests/kraken/driver.html?testName=ai-astar) 15:54:49 INFO - 2015-11-17 15:54:49,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 236412928 15:54:49 INFO - 2015-11-17 15:54:49,771 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,771 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:54:49 INFO - 2015-11-17 15:54:49,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:54:49 INFO - 2015-11-17 15:54:49,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:54:49 INFO - 2015-11-17 15:54:49,771 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:54:49 INFO - 2015-11-17 15:54:49,772 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;105;110;112;111;103;110;102;110 15:54:49 INFO - 2015-11-17 15:54:49,772 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;156;166;134;158;148;131;165;129 15:54:49 INFO - 2015-11-17 15:54:49,772 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;163;163;166;161;159;159;162;163;161 15:54:49 INFO - 2015-11-17 15:54:49,772 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;83;97;72;72;73;97;90;74 15:54:49 INFO - 2015-11-17 15:54:49,772 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;131;91;92;92;138;91;91;125 15:54:49 INFO - 2015-11-17 15:54:49,772 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;109;110;109;110;109 15:54:49 INFO - 2015-11-17 15:54:49,772 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;148;148;149;149;147;149;150;149 15:54:49 INFO - 2015-11-17 15:54:49,772 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;95;95;96;96;96;96;96;95 15:54:49 INFO - 2015-11-17 15:54:49,773 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;68;69;68;69;70;69;77;67;67 15:54:49 INFO - 2015-11-17 15:54:49,773 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;79;68;70;70;70;69;69;69 15:54:49 INFO - 2015-11-17 15:54:49,773 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;88;83;82;87;84;83;83;81;82 15:54:49 INFO - 2015-11-17 15:54:49,773 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;128;120;128;134;125;134;123;129;120 15:54:49 INFO - 2015-11-17 15:54:49,773 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;133;145;143;143;138;147;145;155;133 15:54:49 INFO - 2015-11-17 15:54:49,773 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;71;70;69;69;71;70;73;71;71 15:54:49 INFO - 2015-11-17 15:54:49,773 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:54:49 INFO - 2015-11-17 15:54:49,773 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1003 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: __startTimestamp1447804489766__endTimestamp 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:3.69 (3.3%) stddev-sans-first:3.80 15:54:49 INFO - 2015-11-17 15:54:49,774 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 105.0 110.0 112.0 111.0 103.0 110.0 102.0 110.0 15:54:49 INFO - 2015-11-17 15:54:49,775 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,775 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.00 Median:154.50 stddev:14.76 (9.6%) stddev-sans-first:15.50 15:54:49 INFO - 2015-11-17 15:54:49,775 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 156.0 166.0 134.0 158.0 148.0 131.0 165.0 129.0 15:54:49 INFO - 2015-11-17 15:54:49,775 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,776 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:2.16 (1.3%) stddev-sans-first:2.20 15:54:49 INFO - 2015-11-17 15:54:49,776 DEBUG : BROWSER_OUTPUT: Values: 160.0 163.0 163.0 166.0 161.0 159.0 159.0 162.0 163.0 161.0 15:54:49 INFO - 2015-11-17 15:54:49,776 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,776 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:78.50 stddev:10.60 (13.5%) stddev-sans-first:10.91 15:54:49 INFO - 2015-11-17 15:54:49,776 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 83.0 97.0 72.0 72.0 73.0 97.0 90.0 74.0 15:54:49 INFO - 2015-11-17 15:54:49,776 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,776 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.40 Median:91.00 stddev:19.52 (21.5%) stddev-sans-first:20.19 15:54:49 INFO - 2015-11-17 15:54:49,776 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 131.0 91.0 92.0 92.0 138.0 91.0 91.0 125.0 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 148.0 148.0 149.0 149.0 147.0 149.0 150.0 149.0 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 15:54:49 INFO - 2015-11-17 15:54:49,777 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.30 Median:69.00 stddev:2.87 (4.2%) stddev-sans-first:3.04 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 68.0 69.0 70.0 69.0 77.0 67.0 67.0 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:69.50 stddev:3.16 (4.5%) stddev-sans-first:3.32 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 79.0 68.0 70.0 70.0 70.0 69.0 69.0 69.0 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.37 (2.9%) stddev-sans-first:2.35 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: Values: 81.0 88.0 83.0 82.0 87.0 84.0 83.0 83.0 81.0 82.0 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.50 stddev:5.34 (4.2%) stddev-sans-first:5.26 15:54:49 INFO - 2015-11-17 15:54:49,778 DEBUG : BROWSER_OUTPUT: Values: 133.0 128.0 120.0 128.0 134.0 125.0 134.0 123.0 129.0 120.0 15:54:49 INFO - 2015-11-17 15:54:49,779 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,779 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:144.00 stddev:6.99 (4.9%) stddev-sans-first:6.98 15:54:49 INFO - 2015-11-17 15:54:49,779 DEBUG : BROWSER_OUTPUT: Values: 135.0 133.0 145.0 143.0 143.0 138.0 147.0 145.0 155.0 133.0 15:54:49 INFO - 2015-11-17 15:54:49,779 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2015-11-17 15:54:49,779 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:71.00 stddev:1.42 (2.0%) stddev-sans-first:1.24 15:54:49 INFO - 2015-11-17 15:54:49,779 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 70.0 69.0 69.0 71.0 70.0 73.0 71.0 71.0 15:54:49 INFO - 2015-11-17 15:54:49,779 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:54:49 INFO - 2015-11-17 15:54:49,779 DEBUG : BROWSER_OUTPUT: 15:54:50 INFO - 2015-11-17 15:54:50,825 INFO : Browser exited with error code: 0 15:54:50 INFO - 2015-11-17 15:54:50,875 INFO : Completed test kraken (00:01:00) 15:54:50 INFO - 2015-11-17 15:54:50,875 INFO : Starting test v8_7 15:54:50 INFO - 2015-11-17 15:54:50,875 DEBUG : operating with platform_type : linux_ 15:54:50 INFO - 2015-11-17 15:54:50,876 INFO : Initialising browser for v8_7 test... 15:54:50 INFO - 2015-11-17 15:54:50,881 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp50KADy/profile http://localhost:46023/getInfo.html 15:54:54 INFO - 2015-11-17 15:54:54,831 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:54:54 INFO - 2015-11-17 15:54:54,831 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:54:54 INFO - 2015-11-17 15:54:54,831 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:54:54 INFO - 2015-11-17 15:54:54,831 DEBUG : BROWSER_OUTPUT: __metrics 15:54:54 INFO - 2015-11-17 15:54:54,988 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:56 INFO - 2015-11-17 15:54:56,351 INFO : Browser initialized. 15:54:56 INFO - 2015-11-17 15:54:56,352 INFO : Running cycle 1/1 for v8_7 test... 15:54:56 INFO - 2015-11-17 15:54:56,352 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp50KADy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:55:08 INFO - 2015-11-17 15:55:08,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 142036992 15:55:08 INFO - 2015-11-17 15:55:08,233 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46023/tests/v8_7/run.html (next: http://localhost:46023/tests/v8_7/run.html) 15:55:29 INFO - 2015-11-17 15:55:29,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 439500800 15:55:29 INFO - 2015-11-17 15:55:29,886 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,887 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:55:29 INFO - 2015-11-17 15:55:29,887 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:55:29 INFO - 2015-11-17 15:55:29,887 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:55:29 INFO - 2015-11-17 15:55:29,888 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:55:29 INFO - 2015-11-17 15:55:29,888 DEBUG : BROWSER_OUTPUT: |0;Richards;163.42539630658604 15:55:29 INFO - 2015-11-17 15:55:29,888 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.42419601837673 15:55:29 INFO - 2015-11-17 15:55:29,888 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 15:55:29 INFO - 2015-11-17 15:55:29,889 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 15:55:29 INFO - 2015-11-17 15:55:29,889 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 15:55:29 INFO - 2015-11-17 15:55:29,889 DEBUG : BROWSER_OUTPUT: |5;Earley;786.1635220125786 15:55:29 INFO - 2015-11-17 15:55:29,889 DEBUG : BROWSER_OUTPUT: |6;Boyer;12204.819277108434 15:55:29 INFO - 2015-11-17 15:55:29,889 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 15:55:29 INFO - 2015-11-17 15:55:29,890 DEBUG : BROWSER_OUTPUT: |8;Splay;617.9012345679013 15:55:29 INFO - 2015-11-17 15:55:29,890 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 15:55:29 INFO - 2015-11-17 15:55:29,890 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:55:29 INFO - 2015-11-17 15:55:29,890 DEBUG : BROWSER_OUTPUT: __startTimestamp1447804529885__endTimestamp 15:55:29 INFO - 2015-11-17 15:55:29,890 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,890 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:55:29 INFO - 2015-11-17 15:55:29,890 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:55:29 INFO - 2015-11-17 15:55:29,890 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,891 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.43 Median:163.43 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,891 DEBUG : BROWSER_OUTPUT: Values: 163.4 15:55:29 INFO - 2015-11-17 15:55:29,891 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,891 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.42 Median:191.42 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,891 DEBUG : BROWSER_OUTPUT: Values: 191.4 15:55:29 INFO - 2015-11-17 15:55:29,891 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,891 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,891 DEBUG : BROWSER_OUTPUT: Values: 279.2 15:55:29 INFO - 2015-11-17 15:55:29,892 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,893 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,893 DEBUG : BROWSER_OUTPUT: Values: 5030.2 15:55:29 INFO - 2015-11-17 15:55:29,893 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,893 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,893 DEBUG : BROWSER_OUTPUT: Values: 1976.3 15:55:29 INFO - 2015-11-17 15:55:29,893 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,894 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,894 DEBUG : BROWSER_OUTPUT: Values: 786.2 15:55:29 INFO - 2015-11-17 15:55:29,894 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,894 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12204.82 Median:12204.82 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,894 DEBUG : BROWSER_OUTPUT: Values: 12204.8 15:55:29 INFO - 2015-11-17 15:55:29,895 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,895 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,895 DEBUG : BROWSER_OUTPUT: Values: 27108.1 15:55:29 INFO - 2015-11-17 15:55:29,895 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,895 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.90 Median:617.90 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,896 DEBUG : BROWSER_OUTPUT: Values: 617.9 15:55:29 INFO - 2015-11-17 15:55:29,896 DEBUG : BROWSER_OUTPUT: 15:55:29 INFO - 2015-11-17 15:55:29,896 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:55:29 INFO - 2015-11-17 15:55:29,896 DEBUG : BROWSER_OUTPUT: Values: 4830.9 15:55:29 INFO - 2015-11-17 15:55:29,897 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:55:29 INFO - 2015-11-17 15:55:29,897 DEBUG : BROWSER_OUTPUT: 15:55:30 INFO - 2015-11-17 15:55:30,865 INFO : Browser exited with error code: 0 15:55:30 INFO - 2015-11-17 15:55:30,882 INFO : Completed test v8_7 (00:00:40) 15:55:30 INFO - 2015-11-17 15:55:30,898 INFO : Completed test suite (00:20:19) 15:55:30 INFO - 2015-11-17 15:55:30,899 DEBUG : Working with test: dromaeo_css 15:55:30 INFO - 2015-11-17 15:55:30,899 DEBUG : Generating results file: dromaeo_css 15:55:30 INFO - 2015-11-17 15:55:30,900 DEBUG : Working with test: kraken 15:55:30 INFO - 2015-11-17 15:55:30,900 DEBUG : Generating results file: kraken 15:55:30 INFO - 2015-11-17 15:55:30,900 INFO : javascript benchmark 15:55:30 INFO - 2015-11-17 15:55:30,900 DEBUG : Working with test: v8_7 15:55:30 INFO - 2015-11-17 15:55:30,901 DEBUG : Generating results file: v8_7 15:55:30 INFO - 2015-11-17 15:55:30,901 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:30 INFO - 2015-11-17 15:55:30,952 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 15:55:30 INFO - 2015-11-17 15:55:30,952 DEBUG : process_Request line: dromaeo_css 5990.48 graph.html#tests=[[72,203,35]] 15:55:30 INFO - 2015-11-17 15:55:30,952 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:30 INFO - 2015-11-17 15:55:30,978 DEBUG : process_Request line: kraken 1516.90 graph.html#tests=[[232,203,35]] 15:55:30 INFO - 2015-11-17 15:55:30,978 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:31 INFO - 2015-11-17 15:55:31,004 DEBUG : process_Request line: v8_7 19794.90 graph.html#tests=[[230,203,35]] 15:55:31 INFO - 2015-11-17 15:55:31,006 INFO : javascript benchmark 15:55:31 INFO - 2015-11-17 15:55:31,010 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [330.63630006992327, 331.29764898415357, 333.5147360590341, 333.606344513474, 336.7945553212538, 8440.32477401808, 8702.303815694746, 10523.158147348213, 15382.692346153084, 15845.920770396146, 9973.102420782147, 10167.186625069995, 10238.846417303746, 10244.436555989418, 10896.400697961628, 4047.494063242095, 4156.251874662559, 4156.521999969997, 4159.085001299709, 4159.417681524589, 3152.763542734304, 3248.707616314531, 4219.071804203086, 4554.066416384633, 4696.225122854725, 4574.947762014739, 4575.611073058794, 4591.4260717410325, 4642.07158568286, 4643.9535604644025, 4504.391907092549, 4562.292844609091, 4575.702579332333, 4590.701604395704, 4621.861344159681, 3966.2662407454714, 3973.602639736032, 3996.3805610130476, 3997.480327557399, 3999.7400168988925, 11172.10623150146, 11427.942860285646, 11477.0, 12076.456559454846, 12179.695507612381, 1646.7365221564492, 1668.1742537443922, 1697.8302169782924, 1702.2339947023765, 1705.7270836666073, 8786.516741579211, 9065.637374505011, 9309.953450232706, 9327.253819694408, 9484.952575237148, 1574.205026461641, 1604.7592861070816, 1654.619437529375, 1671.548681855892, 1671.6155284284562, 54279.0, 54672.17991730127, 55558.44441555573, 55949.44050559483, 56124.719376402856, 6363.522735794834, 6438.645874476855, 6447.580907241015, 6458.935410645833, 6496.415322620986, 7600.3539699126195, 7611.543307401574, 7622.618869056525, 7622.885656715153, 7629.351505122016, 4682.344471773954, 4696.01383709418, 4711.2226482629985, 4762.833300834454, 4787.473377928425, 4630.907381852344, 4645.5354464553275, 4672.6261899047995, 4693.882652933636, 4694.014257006067, 2940.4707152712717, 2958.8816447341865, 2959.230600044004, 2971.5097008993275, 2973.6431628204755, 1008.5763979128784, 1047.7590154264562, 1071.3839542263229, 1079.6491140379408, 1108.8336749487642, 389.47032036431, 411.3582810815138, 416.0970693594906, 435.9738415695068, 445.9353393757952, 10481.266311358284, 10780.353178809297, 10853.837192442119, 10942.617008404668, 11074.0, 365.81160702238367, 417.5365344467638, 422.4571425717938, 440.9294512877924, 443.5586591341636, 5451.6643422360985, 5544.750486228129, 5592.748326325243, 5607.327120745536, 5713.5714821388565, 441581.0, 447061.0, 464667.0, 464805.0, 465639.0, 63941.36058639354, 64318.0, 64801.0, 65864.34135658678, 69544.0, 470.40963590694145, 485.3665965914445, 485.48053582666915, 485.48296064690993, 486.34829328699715, 10080.344777589433, 10125.949370253102, 10174.491275436347, 10190.694279171637, 10328.896711033094, 29639.703602964557, 32114.19714507156, 32678.34643307168, 33050.504242435905, 33357.0, 36019.459708103874, 37951.0, 38125.4281185788, 42426.0, 42679.78660106679, 6022.759089636365, 6202.100695399232, 6208.441240288395, 6213.689315534115, 6217.968910155601, 10358.430286334324, 10865.619703310345, 10867.347959122479, 10935.070519005656, 11060.281081729661, 9332.30007749435, 9547.188488978236, 9649.421034737657, 9703.805923881624, 9899.257555683209, 9424.81150376975, 9504.097110774464, 9649.662261820802, 9707.126358627758, 9917.553710082919, 7882.054153501616, 8505.192006759347, 8821.2060914518, 9452.43285402878, 9706.86448981223, 5648.237487939075, 5977.6114552553945, 6209.285932117684, 6278.905816412849, 6284.151639528605, 9069.501177435304, 9626.181774548962, 9651.71044868655, 9869.161121304769, 9972.105299992978], "dojo.html": [2683.7852971762263, 2758.4896794093092, 2777.7222277772225, 2778.4582006508726, 2786.540220863558, 4547.590716835484, 4713.033828065247, 4817.036592681465, 4822.49363816799, 4839.3224948507195, 4718.127146477896, 4729.432468103832, 4765.90468190636, 4767.237242041266, 4827.468978412372, 4374.956250437487, 4389.122175564892, 4396.0, 4526.434195725535, 4555.111753208126, 4481.708688935225, 4512.0, 4545.499995000548, 4551.3121484870635, 4573.3368661544055, 4214.325707886739, 4286.271333873249, 4310.073334233123, 4312.525622181557, 4385.605295523386, 4427.822887084512, 4439.4228750262255, 4443.644508439349, 4446.622037126848, 4476.776161191928, 4411.404460397837, 4416.315471101984, 4416.84541041062, 4418.911621767546, 4458.910821783546, 4557.931631025504, 4659.091477161955, 4692.95307046932, 4695.5304469552775, 4752.120857641347, 5080.695158290478, 5145.76844042019, 5146.408163061258, 5192.844214673566, 5196.558292545138, 5197.063659032635, 5197.428282888917, 5199.662021968597, 5201.219817027439, 5203.4796520348045, 4557.339185818038, 4672.95327046732, 4821.855344339676, 4828.8792780180775, 4863.927041094386, 5132.0762262792305, 5239.449857764956, 5321.600879933943, 5337.0, 5386.218998245233, 5070.797168113234, 5072.188449848007, 5072.289879416885, 5074.67014644047, 5084.110280700863, 4876.707397556158, 4988.35151430319, 5167.9224811627855, 5174.482551744871, 5215.478452154754, 4958.082754690394, 4985.1276026695905, 5013.523715247045, 5127.6154288428515, 5150.072986862401, 5119.129747942784, 5143.022825663112, 5154.046501397253, 5156.561692256125, 5156.793728250828, 3990.221906728218, 3995.06116062725, 3997.900052498711, 4015.8393664253103, 4026.013626661487, 3374.5613070301197, 3458.3256265028076, 3463.255400088993, 3481.3733527964705, 3559.661832125944, 4449.3993310902615, 4491.618212451913, 4500.617447516997, 4505.45934487857, 4542.068875880436, 5231.915178505008, 5238.266642670029, 5257.0, 5257.737113144328, 5261.631685781958, 4167.416561681367, 4271.893202669959, 4273.957260427418, 4276.700630955866, 4504.707194032443, 4454.10917816438, 4620.838270660511, 4634.21218392874, 4640.69835460694, 4660.883477913011, 4912.0, 4918.458969513422, 4946.208606622923, 4960.70235785854, 4993.101241776442, 4918.8770280743265, 5178.792848286026, 5188.58491320701, 5193.76628051731, 5235.4502777207845, 4733.857984260478, 4781.9043619128115, 4799.352087468147, 4852.393450818648, 4860.8298709545, 5095.133827249302, 5130.281760553451, 5134.358205224347, 5160.668891007267, 5172.793088276427, 5258.447862974333, 5262.763175657181, 5264.105102132723, 5264.263003179634, 5270.815521456884, 4783.928241076317, 4855.441624213261, 4890.510948905081, 4890.779914903766, 4975.0, 4993.600511959107, 5050.949490505048, 5055.0, 5058.797648094035, 5091.338126043591, 4893.21708526634, 4924.0, 4946.554810067111, 4947.2579113133315, 4969.552740253394, 4735.976320118378, 4825.855224343275, 4858.125537403302, 4860.635452341018, 4989.077020751172, 4954.826581069645, 4986.1772807487805, 5003.899922001612, 5005.574526165171, 5036.84889453317], "mootools.html": [1198.101423932051, 1601.9199040047997, 1622.1402656592004, 1667.424738465229, 1667.9749803752939, 6102.11519329697, 6989.126359205099, 7050.682719277632, 7079.185893622229, 7091.503594748369, 6940.4794640401915, 7026.4730145239055, 7026.894596581055, 7040.753573624924, 7058.400035996933, 2050.8769473831544, 2074.7095406643084, 2076.709260703503, 2077.1483691686412, 2079.8336133109315, 2070.8446866484996, 2093.905774240155, 2095.7170781944396, 2098.8845613491253, 2118.3644906528057, 2076.045019291128, 2080.8855512946784, 2082.052666036957, 2094.3298144593737, 2095.9476013099643, 2082.79172082792, 2090.989545052265, 2092.905819238138, 2093.7173481579944, 2094.4449720823995, 2071.6271071207175, 2082.2816128435666, 2099.8950052497466, 2110.6622940329476, 2111.535462198314, 6014.518838492954, 6156.507479401637, 7014.789556313319, 7060.152781666182, 7060.92939070613, 3969.146633473817, 4034.8587799426878, 4040.5353384360883, 4049.0, 4054.3918412238104, 2731.289864635189, 2769.667639883227, 2812.8452935088562, 2819.3938303264895, 2867.1111955293927, 737.2038198745342, 824.6701319472199, 878.0517041595062, 888.8800011998427, 892.9910700892973, 8877.422967507091, 8924.062973387765, 8925.107489251088, 8937.374383793138, 9100.044495327962, 3893.474380958591, 3917.7845218512684, 3968.861089861841, 4052.128792309609, 4052.4731784867777, 8145.470544414594, 8157.918420815835, 8160.30637395828, 8163.755087347389, 8170.060443049007, 4186.937195942063, 4197.076643138505, 4198.076423186894, 4204.222218889515, 4204.558521355275, 3711.7958512282084, 3734.047817806442, 3738.6261373862394, 3740.3080430120513, 3747.1568896997956, 3464.4803279507773, 3469.7918124912585, 3513.1041584396326, 3545.8227088645463, 3558.5729712434672, 1132.230083543182, 1140.0252783869837, 1141.897229249355, 1142.457332766929, 1148.8631146068305, 1133.699569614053, 1142.491591241906, 1171.5138217639585, 1174.929504229749, 1175.482787573465, 6551.21385433751, 6575.736970521221, 6587.50593705474, 6594.109795177686, 6594.868102638016, 406.96744260459093, 407.9347304431336, 411.55757560622453, 414.04769031228057, 414.14065813437236, 5176.7411629418375, 5183.092958732207, 5186.144286192812, 5219.269302297681, 5228.163493841043, 7656.425768067305, 8175.468594541336, 8480.406371553932, 8548.316134709208, 8561.571921403905, 7704.036995375578, 8256.876146857801, 8388.37087218461, 8491.74524764258, 8515.701950431705, 6578.736850526021, 6630.436412904861, 6666.200055993312, 6669.899951500828, 6674.666266686743, 6116.14373987651, 6223.782167624111, 6235.937640623536, 6250.062490626442, 6257.843553911189, 7393.8151546211775, 7420.5547667140145, 7494.737684181027, 7556.735514256975, 7628.084629844454, 7403.074615673041, 7533.472656913963, 7699.26856948589, 7782.5330480169105, 7811.648475818488, 6406.167198264196, 6476.0, 6500.154979852589, 6502.967485162544, 6504.739810407531, 6678.866422671616, 6711.530192886451, 6745.93254067453, 6991.545549539263, 6992.545484543489, 6609.4712423007, 6651.301613330724, 6674.599524028574, 6736.797896063126, 6749.122614060141, 6198.442140207403, 6272.310045894857, 6301.180846489927, 6319.304876463677, 6399.840003999937, 5791.855203619774, 6112.938870611237, 6120.143179954721, 6120.357362476876, 6153.29237137717, 5734.598578099493, 5774.335951365479, 5777.537796976148, 5783.248177736868, 5800.187973683772, 5930.11048342752, 5948.345681974893, 5966.836466889089, 6002.549808764447, 6006.759729610942], "ext.html": [546.3171036204747, 562.5078056700387, 566.6798258983674, 574.7270046727805, 575.4676923845442, 25325.873370633144, 25851.095211667594, 25869.611955820677, 25873.094441694546, 37092.62907370926, 38866.805665971704, 39364.606353936455, 39416.0, 39495.40756888649, 39671.24766908796, 7895.289423951829, 8047.95976020122, 8048.557329346912, 8050.637721302555, 8054.395920305971, 6857.314268573127, 7013.473989450786, 7861.292483676468, 10141.44222067786, 10444.216683748711, 10115.443650599214, 10215.642452514163, 10226.744331391701, 10251.384916904972, 10261.333013354108, 6843.486738494583, 10039.74900627483, 10073.043060909202, 10082.395056296646, 10157.796844063078, 6785.9660701696175, 10081.49592520371, 10355.689329320132, 10359.0, 10359.689209323657, 38037.23925521502, 38552.614473855465, 38564.0, 38585.0, 38611.8069409654, 2810.3676672748675, 2815.2398852309966, 2829.278533973844, 2857.4427986542632, 3418.572678415198, 28668.856655716798, 28679.0, 28876.711232887614, 28999.275018124506, 29295.853520732475, 2937.3186533645994, 2965.154930844699, 2989.3871756290127, 3007.6541197762317, 3046.7257946784675, 212562.99999999846, 234448.0, 235373.0, 235470.0, 236168.0, 32951.835240823646, 55535.44464555303, 56823.0, 56857.71571142118, 56965.71517142388, 52071.21893171605, 52261.7386913063, 52397.7380113097, 52399.21401178985, 52423.0, 11643.184977051695, 11682.591109311303, 11752.823707644393, 11783.0, 11787.349771032063, 8717.825643487095, 8925.598348074353, 8946.507942063248, 8948.194662480279, 9037.954810225907, 18856.622867542574, 19089.140988655545, 19107.375873050667, 19225.65420420557, 19236.519087022938, 7031.964840175869, 7382.852342953111, 7387.2612738726775, 7418.703251869865, 7421.183669796318, 766.7967988483057, 853.50923219148, 872.8079822439054, 933.9112784285481, 934.9626014959325, 25953.870230649103, 26098.478030439666, 27452.0, 27785.72214277872, 27815.165545033276, 905.8867641544807, 917.7522069041321, 939.9107084827067, 973.9756506087405, 1064.4571268653042, 12672.176308539916, 13012.089153759336, 13862.861371386158, 14433.20617366055, 14837.703245935238, 216508.0, 218333.0, 219918.0, 220128.0, 220798.0, 43153.136937261705, 43232.567674322854, 43435.56564434315, 43520.12959740851, 43684.78157609192, 1182.1961066474707, 1198.8321634971112, 1201.9519219231133, 1209.7580483903255, 1213.5631172777794, 26212.344691382106, 26603.201903942914, 26606.0, 26779.062732804257, 27106.72893271042, 40974.79512602418, 41305.380419294335, 41309.79345103255, 41338.1732365357, 41351.79324103481, 260924.0, 305614.0, 307357.0, 345560.0, 352880.0, 28410.573841391983, 28601.570976435785, 28662.856685716437, 28741.0, 29100.0, 38397.232055359294, 38432.423513647875, 39600.80199598984, 39816.60183398129, 39858.402123967586, 33670.66329336675, 33932.0, 34139.65860341365, 34340.82829585836, 34631.307373852884, 32942.67057329396, 33396.0, 34221.657783422845, 34221.82889085539, 34314.313713726086, 33069.37028816016, 33445.0, 33495.33009339849, 33855.0, 33867.0, 30135.547966780076, 30504.84747576248, 30702.692973070876, 30829.845850770602, 30972.22569435782, 23467.382303939772, 23769.762302377447, 23895.283141505784, 23992.76007239905, 24041.398965026016], "prototype.html": [280.32162167554515, 289.76673777609017, 291.9956200656992, 295.34138870319185, 299.79613862573456, 5094.949050509494, 5427.972860135698, 5447.019536483432, 5455.754491047907, 5473.644213126144, 5464.26232458618, 5481.972590137044, 5485.753141108649, 5489.451054894508, 5500.889982200363, 4243.108947121108, 4247.787610619464, 4252.936205956913, 4259.148170365939, 4260.0414906646065, 4249.553796851333, 4256.765877876715, 4261.382099595557, 4263.488381394237, 4267.850625228118, 4142.544320124784, 4167.854125105622, 4203.453551038361, 4216.51510076342, 4231.561269168482, 4185.121124563845, 4186.748795072275, 4194.2450358935375, 4195.5175154857125, 4197.370394440828, 3636.090977255686, 3646.3436581415335, 3648.325059863907, 3657.3782456982376, 3660.6705396514176, 5310.0, 5324.8136315228785, 5324.866878328034, 5329.813456529042, 5330.520253177233, 4522.819087236507, 4852.0, 4859.0, 4872.269159626049, 4874.2444921037295, 4610.354550362952, 5500.312460942382, 5744.942550574483, 5776.0, 5792.073268277056, 3860.36304009838, 3951.565327813938, 3951.6443520083044, 3960.0, 3970.940435893464, 5795.2176456178295, 5943.138244954457, 5994.2806863176265, 6078.939210607881, 6081.574289799716, 3951.5455722591696, 4059.3910913362643, 4067.9593204068174, 4076.0217547788316, 4078.6737061035046, 4130.772807495557, 4141.751494910315, 4142.420061191436, 4142.855000074983, 4144.191882582928, 4764.118638051971, 4781.617470602343, 4782.95217047832, 4783.976080119577, 4785.186518291899, 5622.240997465372, 5767.538596912237, 5770.740316685759, 5774.682392468455, 5781.479666830005, 1434.7560914644534, 1450.9564713058626, 1451.100317802969, 1452.4988878836784, 1453.0482533940285, 961.927855410847, 967.7000129959735, 974.7319487141093, 985.1724551376877, 985.7042887133831, 5045.873853153627, 5047.116754567936, 5054.898902021939, 5064.341635587423, 5065.088284108896, 5992.760289588455, 6004.729787159588, 6005.909911351333, 6012.579119461683, 6020.8795824084145, 5035.647504674637, 5040.873978150576, 5051.924221136685, 5053.090443720165, 5056.949430505648, 3136.2159460134967, 3192.0902542775198, 3211.2935154266024, 3211.71094601487, 3215.276562773404, 5566.693831839288, 5575.275214222125, 5579.0515612346, 5580.86047848807, 5583.664980101207, 6051.122587224828, 6054.243219597551, 6054.303755068136, 6059.484943779828, 6063.272407311063, 5560.443955604407, 5564.165375193753, 5566.693831839288, 5573.386927437979, 5578.944210557924, 5865.501432378125, 6021.819345419644, 6044.818655440344, 6059.33347331802, 6062.514998800174, 5809.30288365382, 5820.476157145878, 5889.116632505158, 5890.852728681817, 5898.4101589840675, 5490.0, 5719.113537401709, 5723.656580605177, 5730.942690573041, 5731.083026715705, 3963.2271707016853, 4056.5537790842395, 4182.539920608791, 4198.328267477189, 4199.517055538652, 5941.31674857397, 5960.552958528215, 5979.162917191509, 5982.880342393215, 5988.970055149871, 5715.2855893013375, 5745.8563535911935, 5753.8561535961935, 5759.827205183684, 5763.625364351304, 5588.217649529151, 5738.024535828836, 5753.913691294718, 5755.597108202385, 5766.250387449605, 5619.662820230636, 5624.606277560695, 5629.057974998619, 5630.774769009357, 5635.802746903839, 5776.56675749312, 5804.477597016289, 5809.970950145223, 5810.01229790945, 5812.622179558315, 5537.280153580009, 5646.604737668488, 5655.943440565707, 5657.519110875457, 5660.688662123458], "yui.html": [706.3042902740799, 712.2948281201612, 713.1655962523846, 713.5468977199477, 728.2535401213755, 11462.197646164772, 11828.112891533126, 11836.940815295911, 11844.940775296122, 11882.108841836864, 11500.482478288477, 11580.710482237948, 11601.419929003538, 11601.593944211954, 11605.941970290158, 599.1701493431607, 755.1165136789955, 772.1622040086513, 772.2972095393166, 772.9072511298652, 597.7459579678641, 774.7133560582564, 787.4527203593505, 788.7554857994012, 789.8420315936836, 805.5005896344245, 827.1315119124924, 827.7185756842672, 828.1015098618007, 828.6312590897053, 621.919150510433, 628.2241431831684, 800.4036992440668, 816.6855760532209, 816.873384625384, 603.5262319079502, 605.8909396308707, 606.8755905039457, 607.4411541381895, 607.5443417436923, 11066.889331106666, 11216.439178041066, 11224.270422422516, 11224.719382015433, 11236.325820450798, 10363.378197308186, 11818.468168932419, 12008.099392545506, 12020.63938081859, 12203.755924881452, 8759.430637008574, 8827.955860220658, 8869.37914345996, 8940.5082720451, 8972.820543589158, 3145.889893853704, 3176.2059485128716, 3196.1172208629655, 3205.423023855705, 3224.6130464344196, 40849.38725919084, 40979.590204098175, 41011.179776404606, 41110.58889411097, 41115.794421027706, 9128.26973842091, 9135.888850017385, 9173.128552787475, 9302.95348523253, 9428.481433521221, 17031.615573819676, 17034.48896533106, 17063.65872682564, 17067.914660426617, 17073.0, 6314.684265786784, 6437.549371544041, 6443.710033048524, 6535.477161827042, 6639.1037209977, 3504.7196224301993, 3533.611302756695, 3587.695045921074, 3604.5133906922756, 3611.9277614447565, 2746.7939904507243, 2811.803173777816, 2816.0, 2819.210621026116, 2833.971660283412, 416.11783019997193, 417.62413827555446, 417.86210550518257, 427.2395136656756, 432.15082363156546, 415.5221495280452, 426.58695792031386, 476.1263082244052, 488.68724016629386, 539.6384422436977, 6529.869402611921, 7384.963075184697, 7399.223081576357, 7575.431842611826, 8004.63979120941, 421.8839819049786, 437.65862627150875, 487.95608395244597, 494.5697243398267, 523.6910222968467, 3195.472746996766, 3251.0, 3281.5898012748407, 3813.103920578662, 3858.9966608681943, 58411.415885841445, 59875.70062149748, 59903.700481498185, 59914.70042649759, 59983.40016599865, 50496.242556361685, 51091.0, 51216.23175652368, 51343.0, 51420.22869656958, 42741.57258427438, 43134.352984705256, 43262.35106473405, 46673.29990050152, 47565.52434475611, 7080.716771329296, 7122.287771223044, 7184.6048467334795, 7235.710571577289, 7303.196648368569, 33475.0, 34370.65629343675, 34372.0, 34381.31237375289, 34743.65256347404, 39308.80345598254, 41926.16147676968, 42448.78775606102, 42625.57374426216, 42649.0, 9985.800283994135, 10000.09948367968, 10030.699079027641, 10149.84775228387, 10153.39079655223, 10843.945780271048, 10903.29128606638, 11058.502367393647, 11124.499397526968, 11346.773064538498, 10159.84760228612, 10407.94796026015, 10488.31825931312, 10867.945660271647, 10870.565177392815, 9998.400095994264, 10181.134603558781, 10309.536070876979, 10367.222458315808, 10712.0, 6859.759908403182, 9210.723678289662, 9633.133018028411, 9891.950540247253, 10351.327163734333, 8846.77883052903, 9091.18179363834, 9287.257019438293, 9596.760080997752, 9722.076402741728, 8904.86642700373, 9406.43561386319, 9413.717588472357, 9420.665457227717, 9575.473348965874]}, "summary": {"lowerIsBetter": false, "suite": 5990.4779468532015, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6111.877116623419, "unit": "ms", "value": 6111.877116623419}, "dojo.html": {"lowerIsBetter": false, "filtered": 4690.841343758215, "unit": "ms", "value": 4690.841343758215}, "mootools.html": {"lowerIsBetter": false, "filtered": 3968.253502791707, "unit": "ms", "value": 3968.253502791707}, "ext.html": {"lowerIsBetter": false, "filtered": 16831.329426122436, "unit": "ms", "value": 16831.329426122436}, "prototype.html": {"lowerIsBetter": false, "filtered": 4290.379132703313, "unit": "ms", "value": 4290.379132703313}, "yui.html": {"lowerIsBetter": false, "filtered": 5624.548372660407, "unit": "ms", "value": 5624.548372660407}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-018"}, "testrun": {"date": 1447803311, "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": "20151117132405", "branch": "B2G-Inbound-Non-PGO", "revision": "93d3671347066a184b4325c84dfc2277000bfee8"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 163.0, 163.0, 166.0, 161.0, 159.0, 159.0, 162.0, 163.0, 161.0], "ai-astar": [111.0, 111.0, 105.0, 110.0, 112.0, 111.0, 103.0, 110.0, 102.0, 110.0], "imaging-gaussian-blur": [110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "audio-beat-detection": [153.0, 130.0, 156.0, 166.0, 134.0, 158.0, 148.0, 131.0, 165.0, 129.0], "json-stringify-tinderbox": [69.0, 69.0, 79.0, 68.0, 70.0, 70.0, 70.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [135.0, 133.0, 145.0, 143.0, 143.0, 138.0, 147.0, 145.0, 155.0, 133.0], "json-parse-financial": [69.0, 68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 77.0, 67.0, 67.0], "stanford-crypto-sha256-iterative": [68.0, 71.0, 70.0, 69.0, 69.0, 71.0, 70.0, 73.0, 71.0, 71.0], "audio-fft": [73.0, 72.0, 83.0, 97.0, 72.0, 72.0, 73.0, 97.0, 90.0, 74.0], "imaging-darkroom": [149.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0, 149.0, 150.0, 149.0], "stanford-crypto-ccm": [133.0, 128.0, 120.0, 128.0, 134.0, 125.0, 134.0, 123.0, 129.0, 120.0], "audio-oscillator": [91.0, 92.0, 131.0, 91.0, 92.0, 92.0, 138.0, 91.0, 91.0, 125.0], "stanford-crypto-aes": [81.0, 88.0, 83.0, 82.0, 87.0, 84.0, 83.0, 83.0, 81.0, 82.0], "imaging-desaturate": [95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1516.9, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.3, "unit": "ms", "value": 80.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 141.7, "unit": "ms", "value": 141.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 147.0, "unit": "ms", "value": 147.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 127.4, "unit": "ms", "value": 127.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.6, "unit": "ms", "value": 148.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 69.3, "unit": "ms", "value": 69.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.4, "unit": "ms", "value": 103.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.5, "unit": "ms", "value": 108.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.7, "unit": "ms", "value": 161.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.3, "unit": "ms", "value": 70.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.2, "unit": "ms", "value": 70.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 83.4, "unit": "ms", "value": 83.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.7, "unit": "ms", "value": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-018"}, "testrun": {"date": 1447803311, "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": "20151117132405", "branch": "B2G-Inbound-Non-PGO", "revision": "93d3671347066a184b4325c84dfc2277000bfee8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.42419601837673], "Encrypt": [279.17364600781684], "NavierStokes": [4830.917874396136], "Decrypt": [5030.150753768844], "Splay": [617.9012345679013], "Richards": [163.42539630658604], "RegExp": [27108.108108108107], "Earley": [786.1635220125786], "Boyer": [12204.819277108434], "RayTrace": [1976.2845849802372]}, "summary": {"lowerIsBetter": false, "suite": 19794.898481617303, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.40043199999997, "unit": "score", "value": 345.40043199999997}, "Encrypt": {"lowerIsBetter": false, "filtered": 953.4603419999996, "unit": "score", "value": 953.4603419999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 131.88353646353647, "unit": "score", "value": 131.88353646353647}, "RegExp": {"lowerIsBetter": false, "filtered": 33.60562811565303, "unit": "score", "value": 33.60562811565303}, "Richards": {"lowerIsBetter": false, "filtered": 216.01293800000005, "unit": "score", "value": 216.01293800000005}, "Earley": {"lowerIsBetter": false, "filtered": 847.7409359999999, "unit": "score", "value": 847.7409359999999}, "Boyer": {"lowerIsBetter": false, "filtered": 54.606543928923976, "unit": "score", "value": 54.606543928923976}, "RayTrace": {"lowerIsBetter": false, "filtered": 374.434434, "unit": "score", "value": 374.434434}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-018"}, "testrun": {"date": 1447803311, "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": "20151117132405", "branch": "B2G-Inbound-Non-PGO", "revision": "93d3671347066a184b4325c84dfc2277000bfee8"}}] 15:55:31 INFO - RETURN: dromaeo_css: 5990.48 15:55:31 INFO - RETURN: kraken: 1516.90 15:55:31 INFO - RETURN: v8_7: 19794.90 15:55:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19794.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1516.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "5990.48"}}} 15:55:31 INFO - Return code: 0 15:55:31 INFO - # TBPL SUCCESS # 15:55:31 INFO - Running post-action listener: _resource_record_post_action 15:55:31 INFO - Running post-run listener: _resource_record_post_run 15:55:32 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 16384; Write bytes: 507121664; Read time: 432; Write time: 894556 15:55:32 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 130809856; Read time: 0; Write time: 289144 15:55:32 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 12288; Write bytes: 368967680; Read time: 296; Write time: 588924 15:55:32 INFO - Running post-run listener: _upload_blobber_files 15:55:32 INFO - Blob upload gear active. 15:55:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:55:32 INFO - Copying logs to upload dir... 15:55:32 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.801845 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-17 15:55:31.905991) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:31.909027) ========= 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=6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009889 build_url: 'https://queue.taskcluster.net/v1/task/dDrunNr6ShC-qfgvQxKfrw/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 15:55:31.961965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:31.962553) ========= 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=6d5287d839824eebc594b0c9000001d1-1447802960.177325-208474809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004769 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:32.015043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 15:55:32.015537) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 15:55:32.015839) ========= ========= Total master_lag: 0.60 =========