builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1450271456.58 results: success (0) buildid: 20151216031209 builduid: 46c157bd106441a4b4c4b8a184600ec0 revision: f52b36d6bc1aeb421c58d39208e0a50625915cd7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.577093) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.577585) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.578052) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005180 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.601779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.602104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.616230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.616578) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.667241) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.667623) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.668116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.668437) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 05:10:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-16 05:10:56 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109218 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.791942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.792704) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:56.844459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 05:10:56.845149) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev f52b36d6bc1aeb421c58d39208e0a50625915cd7 --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 f52b36d6bc1aeb421c58d39208e0a50625915cd7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 05:10:56,848 truncating revision to first 12 chars 2015-12-16 05:10:56,848 Setting DEBUG logging. 2015-12-16 05:10:56,848 attempt 1/10 2015-12-16 05:10:56,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/f52b36d6bc1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 05:10:57,950 unpacking tar archive at: b2g-inbound-f52b36d6bc1a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.393259 ========= master_lag: 0.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 05:10:58.760556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:58.760909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:59.070833) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:59.071151) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:59.071636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-16 05:10:59.071977) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:59 INFO - MultiFileLogger online at 20151216 05:10:59 in /builds/slave/test 05:10:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 05:10:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:59 INFO - {'append_to_log': False, 05:10:59 INFO - 'base_work_dir': '/builds/slave/test', 05:10:59 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 05:10:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:59 INFO - 'branch': 'B2G-Inbound-Non-PGO', 05:10:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:59 INFO - 'config_files': ('talos/linux_config.py',), 05:10:59 INFO - 'default_actions': ('clobber', 05:10:59 INFO - 'read-buildbot-config', 05:10:59 INFO - 'download-and-extract', 05:10:59 INFO - 'populate-webroot', 05:10:59 INFO - 'create-virtualenv', 05:10:59 INFO - 'install', 05:10:59 INFO - 'run-tests'), 05:10:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:59 INFO - 'download_minidump_stackwalk': True, 05:10:59 INFO - 'download_symbols': 'ondemand', 05:10:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:59 INFO - 'installer_path': 'installer.exe', 05:10:59 INFO - 'log_level': 'info', 05:10:59 INFO - 'log_name': 'talos', 05:10:59 INFO - 'log_to_console': True, 05:10:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:59 INFO - 'opt_config_files': (), 05:10:59 INFO - 'pip_index': False, 05:10:59 INFO - 'sps_profile': False, 05:10:59 INFO - 'sps_profile_interval': 0, 05:10:59 INFO - 'suite': 'dromaeojs', 05:10:59 INFO - 'system_bits': '64', 05:10:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:59 INFO - 'title': 'talos-linux64-ix-047', 05:10:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:59 INFO - 'use_talos_json': True, 05:10:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:59 INFO - 'work_dir': 'build'} 05:10:59 INFO - ##### 05:10:59 INFO - ##### Running clobber step. 05:10:59 INFO - ##### 05:10:59 INFO - Running pre-action listener: _resource_record_pre_action 05:10:59 INFO - Running main action method: clobber 05:10:59 INFO - rmtree: /builds/slave/test/build 05:10:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:00 INFO - Running post-action listener: _resource_record_post_action 05:11:00 INFO - ##### 05:11:00 INFO - ##### Running read-buildbot-config step. 05:11:00 INFO - ##### 05:11:00 INFO - Running pre-action listener: _resource_record_pre_action 05:11:00 INFO - Running main action method: read_buildbot_config 05:11:00 INFO - Using buildbot properties: 05:11:00 INFO - { 05:11:00 INFO - "properties": { 05:11:00 INFO - "buildnumber": 306, 05:11:00 INFO - "product": "firefox", 05:11:00 INFO - "script_repo_revision": "production", 05:11:00 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:11:00 INFO - "repository": "", 05:11:00 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 05:11:00 INFO - "buildid": "20151216031209", 05:11:00 INFO - "slavename": "talos-linux64-ix-047", 05:11:00 INFO - "pgo_build": "False", 05:11:00 INFO - "basedir": "/builds/slave/test", 05:11:00 INFO - "project": "", 05:11:00 INFO - "platform": "ubuntu64_hw", 05:11:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:11:00 INFO - "slavebuilddir": "test", 05:11:00 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 05:11:00 INFO - "branch": "b2g-inbound", 05:11:00 INFO - "repo_path": "integration/b2g-inbound", 05:11:00 INFO - "stage_platform": "linux64", 05:11:00 INFO - "builduid": "46c157bd106441a4b4c4b8a184600ec0", 05:11:00 INFO - "revision": "f52b36d6bc1aeb421c58d39208e0a50625915cd7" 05:11:00 INFO - }, 05:11:00 INFO - "sourcestamp": { 05:11:00 INFO - "repository": "", 05:11:00 INFO - "hasPatch": false, 05:11:00 INFO - "project": "", 05:11:00 INFO - "branch": "b2g-inbound-linux64-talos", 05:11:00 INFO - "changes": [ 05:11:00 INFO - { 05:11:00 INFO - "category": null, 05:11:00 INFO - "files": [ 05:11:00 INFO - { 05:11:00 INFO - "url": null, 05:11:00 INFO - "name": "https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 05:11:00 INFO - } 05:11:00 INFO - ], 05:11:00 INFO - "repository": "", 05:11:00 INFO - "rev": "f52b36d6bc1aeb421c58d39208e0a50625915cd7", 05:11:00 INFO - "who": "cbook@mozilla.com", 05:11:00 INFO - "when": 1450269609, 05:11:00 INFO - "number": 7365860, 05:11:00 INFO - "comments": "Merge mozilla-central to b2g-inbound", 05:11:00 INFO - "project": "", 05:11:00 INFO - "at": "Wed 16 Dec 2015 04:40:09", 05:11:00 INFO - "branch": "b2g-inbound-linux64-talos", 05:11:00 INFO - "revlink": "", 05:11:00 INFO - "properties": [ 05:11:00 INFO - [ 05:11:00 INFO - "buildid", 05:11:00 INFO - "20151216031209", 05:11:00 INFO - "Change" 05:11:00 INFO - ], 05:11:00 INFO - [ 05:11:00 INFO - "builduid", 05:11:00 INFO - "46c157bd106441a4b4c4b8a184600ec0", 05:11:00 INFO - "Change" 05:11:00 INFO - ], 05:11:00 INFO - [ 05:11:00 INFO - "pgo_build", 05:11:00 INFO - "False", 05:11:00 INFO - "Change" 05:11:00 INFO - ] 05:11:00 INFO - ], 05:11:00 INFO - "revision": "f52b36d6bc1aeb421c58d39208e0a50625915cd7" 05:11:00 INFO - } 05:11:00 INFO - ], 05:11:00 INFO - "revision": "f52b36d6bc1aeb421c58d39208e0a50625915cd7" 05:11:00 INFO - } 05:11:00 INFO - } 05:11:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:11:00 INFO - Running post-action listener: _resource_record_post_action 05:11:00 INFO - ##### 05:11:00 INFO - ##### Running download-and-extract step. 05:11:00 INFO - ##### 05:11:00 INFO - Running pre-action listener: _resource_record_pre_action 05:11:00 INFO - Running main action method: download_and_extract 05:11:00 INFO - mkdir: /builds/slave/test/build/tests 05:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:00 INFO - https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:11:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/test_packages.json 05:11:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/test_packages.json 05:11:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:11:00 INFO - Downloaded 1302 bytes. 05:11:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:11:00 INFO - Using the following test package requirements: 05:11:00 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:00 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:00 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'jsshell-linux-x86_64.zip'], 05:11:00 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:00 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:00 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:00 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:00 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:00 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:00 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:00 INFO - https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:01 INFO - Downloaded 21869124 bytes. 05:11:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:11:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:11:02 INFO - Return code: 0 05:11:02 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:02 INFO - https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:05 INFO - Downloaded 21869124 bytes. 05:11:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:11:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:11:07 INFO - Return code: 0 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:07 INFO - https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:11:08 INFO - Downloaded 11132052 bytes. 05:11:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 05:11:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:11:08 INFO - Return code: 0 05:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:08 INFO - https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:11:10 INFO - Downloaded 57743504 bytes. 05:11:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:10 INFO - mkdir: /builds/slave/test/properties 05:11:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:10 INFO - Contents: 05:11:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:10 INFO - Running post-action listener: _resource_record_post_action 05:11:10 INFO - Running post-action listener: set_extra_try_arguments 05:11:10 INFO - ##### 05:11:10 INFO - ##### Running populate-webroot step. 05:11:10 INFO - ##### 05:11:10 INFO - Running pre-action listener: _resource_record_pre_action 05:11:10 INFO - Running main action method: populate_webroot 05:11:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:10 INFO - '--tppagecycles', 05:11:10 INFO - '7'], 05:11:10 INFO - 'tests': ['tsvgm']}}, 05:11:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:11:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:11:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:11:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'tests': ['damp', 'tps']}, 05:11:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['damp', 'tps']}, 05:11:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:11:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:10 INFO - 'other': {'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore']}, 05:11:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore']}, 05:11:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore']}, 05:11:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore']}, 05:11:10 INFO - 'other_l64': {'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore']}, 05:11:10 INFO - 'other_nol64': {'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore']}, 05:11:10 INFO - 'svgr': {'tests': ['tsvgx', 05:11:10 INFO - 'tsvgr_opacity', 05:11:10 INFO - 'tart', 05:11:10 INFO - 'tscrollx', 05:11:10 INFO - 'cart']}, 05:11:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['tsvgx', 05:11:10 INFO - 'tsvgr_opacity', 05:11:10 INFO - 'tart', 05:11:10 INFO - 'tscrollx', 05:11:10 INFO - 'cart']}, 05:11:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'tests': ['tp5o']}, 05:11:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--e10s'], 05:11:10 INFO - 'tests': ['tp5o']}, 05:11:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--xperf_path', 05:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:10 INFO - 'tests': ['tp5n']}, 05:11:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--e10s', 05:11:10 INFO - '--xperf_path', 05:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:10 INFO - 'tests': ['tp5n']}}, 05:11:10 INFO - 'talos.zip': {'path': '', 05:11:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:10 INFO - Running post-action listener: _resource_record_post_action 05:11:10 INFO - ##### 05:11:10 INFO - ##### Running create-virtualenv step. 05:11:10 INFO - ##### 05:11:10 INFO - Running pre-action listener: _resource_record_pre_action 05:11:10 INFO - Running main action method: create_virtualenv 05:11:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:11:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:10 INFO - Using real prefix '/usr' 05:11:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:13 INFO - Installing pip.................done. 05:11:13 INFO - Return code: 0 05:11:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:13 INFO - Using env: {'DISPLAY': ':0', 05:11:13 INFO - 'HOME': '/home/cltbld', 05:11:13 INFO - 'LANG': 'en_US.UTF-8', 05:11:13 INFO - 'LANGUAGE': 'en_US:en', 05:11:13 INFO - 'LOGNAME': 'cltbld', 05:11:13 INFO - 'MAIL': '/var/mail/cltbld', 05:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:13 INFO - 'MOZ_NO_REMOTE': '1', 05:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:13 INFO - 'NO_EM_RESTART': '1', 05:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:13 INFO - 'PWD': '/builds/slave/test', 05:11:13 INFO - 'SHELL': '/bin/bash', 05:11:13 INFO - 'SHLVL': '1', 05:11:13 INFO - 'TERM': 'linux', 05:11:13 INFO - 'TMOUT': '86400', 05:11:13 INFO - 'USER': 'cltbld', 05:11:13 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:13 INFO - '_': '/tools/buildbot/bin/python'} 05:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:11:13 INFO - Cleaning up... 05:11:13 INFO - Return code: 0 05:11:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:11:13 INFO - Using env: {'DISPLAY': ':0', 05:11:13 INFO - 'HOME': '/home/cltbld', 05:11:13 INFO - 'LANG': 'en_US.UTF-8', 05:11:13 INFO - 'LANGUAGE': 'en_US:en', 05:11:13 INFO - 'LOGNAME': 'cltbld', 05:11:13 INFO - 'MAIL': '/var/mail/cltbld', 05:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:13 INFO - 'MOZ_NO_REMOTE': '1', 05:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:13 INFO - 'NO_EM_RESTART': '1', 05:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:13 INFO - 'PWD': '/builds/slave/test', 05:11:13 INFO - 'SHELL': '/bin/bash', 05:11:13 INFO - 'SHLVL': '1', 05:11:13 INFO - 'TERM': 'linux', 05:11:13 INFO - 'TMOUT': '86400', 05:11:13 INFO - 'USER': 'cltbld', 05:11:13 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:13 INFO - '_': '/tools/buildbot/bin/python'} 05:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:13 INFO - Downloading/unpacking psutil>=0.7.1 05:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:11:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:15 INFO - Installing collected packages: psutil 05:11:15 INFO - Running setup.py install for psutil 05:11:15 INFO - building 'psutil._psutil_linux' extension 05:11:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:11:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:11:15 INFO - building 'psutil._psutil_posix' extension 05:11:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:11:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:11:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:16 INFO - Successfully installed psutil 05:11:16 INFO - Cleaning up... 05:11:16 INFO - Return code: 0 05:11:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:16 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 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:11:16 INFO - Using env: {'DISPLAY': ':0', 05:11:16 INFO - 'HOME': '/home/cltbld', 05:11:16 INFO - 'LANG': 'en_US.UTF-8', 05:11:16 INFO - 'LANGUAGE': 'en_US:en', 05:11:16 INFO - 'LOGNAME': 'cltbld', 05:11:16 INFO - 'MAIL': '/var/mail/cltbld', 05:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:16 INFO - 'MOZ_NO_REMOTE': '1', 05:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:16 INFO - 'NO_EM_RESTART': '1', 05:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:16 INFO - 'PWD': '/builds/slave/test', 05:11:16 INFO - 'SHELL': '/bin/bash', 05:11:16 INFO - 'SHLVL': '1', 05:11:16 INFO - 'TERM': 'linux', 05:11:16 INFO - 'TMOUT': '86400', 05:11:16 INFO - 'USER': 'cltbld', 05:11:16 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:16 INFO - '_': '/tools/buildbot/bin/python'} 05:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:11:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:11:18 INFO - Installing collected packages: mozsystemmonitor 05:11:18 INFO - Running setup.py install for mozsystemmonitor 05:11:18 INFO - Successfully installed mozsystemmonitor 05:11:18 INFO - Cleaning up... 05:11:18 INFO - Return code: 0 05:11:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:18 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 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:18 INFO - Using env: {'DISPLAY': ':0', 05:11:18 INFO - 'HOME': '/home/cltbld', 05:11:18 INFO - 'LANG': 'en_US.UTF-8', 05:11:18 INFO - 'LANGUAGE': 'en_US:en', 05:11:18 INFO - 'LOGNAME': 'cltbld', 05:11:18 INFO - 'MAIL': '/var/mail/cltbld', 05:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:18 INFO - 'MOZ_NO_REMOTE': '1', 05:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:18 INFO - 'NO_EM_RESTART': '1', 05:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:18 INFO - 'PWD': '/builds/slave/test', 05:11:18 INFO - 'SHELL': '/bin/bash', 05:11:18 INFO - 'SHLVL': '1', 05:11:18 INFO - 'TERM': 'linux', 05:11:18 INFO - 'TMOUT': '86400', 05:11:18 INFO - 'USER': 'cltbld', 05:11:18 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:18 INFO - '_': '/tools/buildbot/bin/python'} 05:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:20 INFO - Downloading docopt-0.6.1.tar.gz 05:11:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:21 INFO - Running setup.py install for blobuploader 05:11:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:21 INFO - Running setup.py install for requests 05:11:21 INFO - Running setup.py install for docopt 05:11:21 INFO - Successfully installed blobuploader requests docopt 05:11:21 INFO - Cleaning up... 05:11:21 INFO - Return code: 0 05:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:21 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 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:21 INFO - Using env: {'DISPLAY': ':0', 05:11:21 INFO - 'HOME': '/home/cltbld', 05:11:21 INFO - 'LANG': 'en_US.UTF-8', 05:11:21 INFO - 'LANGUAGE': 'en_US:en', 05:11:21 INFO - 'LOGNAME': 'cltbld', 05:11:21 INFO - 'MAIL': '/var/mail/cltbld', 05:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:21 INFO - 'MOZ_NO_REMOTE': '1', 05:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:21 INFO - 'NO_EM_RESTART': '1', 05:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:21 INFO - 'PWD': '/builds/slave/test', 05:11:21 INFO - 'SHELL': '/bin/bash', 05:11:21 INFO - 'SHLVL': '1', 05:11:21 INFO - 'TERM': 'linux', 05:11:21 INFO - 'TMOUT': '86400', 05:11:21 INFO - 'USER': 'cltbld', 05:11:21 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:21 INFO - '_': '/tools/buildbot/bin/python'} 05:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:21 INFO - Running setup.py (path:/tmp/pip-4qUvtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:21 INFO - Running setup.py (path:/tmp/pip-mCXCpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:22 INFO - Running setup.py (path:/tmp/pip-HNnxnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:22 INFO - Running setup.py (path:/tmp/pip-DOYS8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:22 INFO - Running setup.py (path:/tmp/pip-MsEZdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:22 INFO - Running setup.py (path:/tmp/pip-IpCZyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:22 INFO - Running setup.py (path:/tmp/pip-35oalA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:22 INFO - Running setup.py (path:/tmp/pip-K7MXsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:22 INFO - Running setup.py (path:/tmp/pip-3xydGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:22 INFO - Running setup.py (path:/tmp/pip-5fv3kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:22 INFO - Running setup.py (path:/tmp/pip-eUyqKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:22 INFO - Running setup.py (path:/tmp/pip-yo6UJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:22 INFO - Running setup.py (path:/tmp/pip-qCaEQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:22 INFO - Running setup.py (path:/tmp/pip-SaRB8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:22 INFO - Running setup.py (path:/tmp/pip-GNdt7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:22 INFO - Running setup.py (path:/tmp/pip-IxSXF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:23 INFO - Running setup.py (path:/tmp/pip-iR0qgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:23 INFO - Running setup.py install for manifestparser 05:11:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozcrash 05:11:23 INFO - Running setup.py install for mozdebug 05:11:23 INFO - Running setup.py install for mozdevice 05:11:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozfile 05:11:23 INFO - Running setup.py install for mozhttpd 05:11:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozinfo 05:11:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozInstall 05:11:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozleak 05:11:23 INFO - Running setup.py install for mozlog 05:11:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:24 INFO - Running setup.py install for moznetwork 05:11:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:24 INFO - Running setup.py install for mozprocess 05:11:24 INFO - Running setup.py install for mozprofile 05:11:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:24 INFO - Running setup.py install for mozrunner 05:11:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:24 INFO - Running setup.py install for mozscreenshot 05:11:24 INFO - Running setup.py install for moztest 05:11:24 INFO - Running setup.py install for mozversion 05:11:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:24 INFO - Cleaning up... 05:11:24 INFO - Return code: 0 05:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:24 INFO - Using env: {'DISPLAY': ':0', 05:11:24 INFO - 'HOME': '/home/cltbld', 05:11:24 INFO - 'LANG': 'en_US.UTF-8', 05:11:24 INFO - 'LANGUAGE': 'en_US:en', 05:11:24 INFO - 'LOGNAME': 'cltbld', 05:11:24 INFO - 'MAIL': '/var/mail/cltbld', 05:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:24 INFO - 'MOZ_NO_REMOTE': '1', 05:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:24 INFO - 'NO_EM_RESTART': '1', 05:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:24 INFO - 'PWD': '/builds/slave/test', 05:11:24 INFO - 'SHELL': '/bin/bash', 05:11:24 INFO - 'SHLVL': '1', 05:11:24 INFO - 'TERM': 'linux', 05:11:24 INFO - 'TMOUT': '86400', 05:11:24 INFO - 'USER': 'cltbld', 05:11:24 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:24 INFO - '_': '/tools/buildbot/bin/python'} 05:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:25 INFO - Running setup.py (path:/tmp/pip-eMJDt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:25 INFO - Running setup.py (path:/tmp/pip-VjuGRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:25 INFO - Running setup.py (path:/tmp/pip-dttK5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:25 INFO - Running setup.py (path:/tmp/pip-r3oTs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:25 INFO - Running setup.py (path:/tmp/pip-sJA3iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:25 INFO - Running setup.py (path:/tmp/pip-LIj7SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:25 INFO - Running setup.py (path:/tmp/pip-3Ndhui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:25 INFO - Running setup.py (path:/tmp/pip-ArpTjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:25 INFO - Running setup.py (path:/tmp/pip-7QHBvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:25 INFO - Running setup.py (path:/tmp/pip-Vt9v6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:25 INFO - Running setup.py (path:/tmp/pip-xsLPHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:25 INFO - Running setup.py (path:/tmp/pip-fodHog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:25 INFO - Running setup.py (path:/tmp/pip-mepNCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:26 INFO - Running setup.py (path:/tmp/pip-LWSpPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:26 INFO - Running setup.py (path:/tmp/pip-fbFvFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:26 INFO - Running setup.py (path:/tmp/pip-7ECQwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:26 INFO - Running setup.py (path:/tmp/pip-cyVBdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:28 INFO - Downloading blessings-1.5.1.tar.gz 05:11:28 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:28 INFO - Installing collected packages: blessings 05:11:28 INFO - Running setup.py install for blessings 05:11:28 INFO - Successfully installed blessings 05:11:28 INFO - Cleaning up... 05:11:28 INFO - Return code: 0 05:11:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:28 INFO - Reading from file tmpfile_stdout 05:11:28 INFO - Current package versions: 05:11:28 INFO - argparse == 1.2.1 05:11:28 INFO - blessings == 1.5.1 05:11:28 INFO - blobuploader == 1.2.4 05:11:28 INFO - docopt == 0.6.1 05:11:28 INFO - manifestparser == 1.1 05:11:28 INFO - mozInstall == 1.12 05:11:28 INFO - mozcrash == 0.16 05:11:28 INFO - mozdebug == 0.1 05:11:28 INFO - mozdevice == 0.47 05:11:28 INFO - mozfile == 1.2 05:11:28 INFO - mozhttpd == 0.7 05:11:28 INFO - mozinfo == 0.9 05:11:28 INFO - mozleak == 0.1 05:11:28 INFO - mozlog == 3.1 05:11:28 INFO - moznetwork == 0.27 05:11:28 INFO - mozprocess == 0.22 05:11:28 INFO - mozprofile == 0.27 05:11:28 INFO - mozrunner == 6.11 05:11:28 INFO - mozscreenshot == 0.1 05:11:28 INFO - mozsystemmonitor == 0.0 05:11:28 INFO - moztest == 0.7 05:11:28 INFO - mozversion == 1.4 05:11:28 INFO - psutil == 3.1.1 05:11:28 INFO - requests == 1.2.3 05:11:28 INFO - wsgiref == 0.1.2 05:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 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 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:28 INFO - Using env: {'DISPLAY': ':0', 05:11:28 INFO - 'HOME': '/home/cltbld', 05:11:28 INFO - 'LANG': 'en_US.UTF-8', 05:11:28 INFO - 'LANGUAGE': 'en_US:en', 05:11:28 INFO - 'LOGNAME': 'cltbld', 05:11:28 INFO - 'MAIL': '/var/mail/cltbld', 05:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:28 INFO - 'MOZ_NO_REMOTE': '1', 05:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:28 INFO - 'NO_EM_RESTART': '1', 05:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:28 INFO - 'PWD': '/builds/slave/test', 05:11:28 INFO - 'SHELL': '/bin/bash', 05:11:28 INFO - 'SHLVL': '1', 05:11:28 INFO - 'TERM': 'linux', 05:11:28 INFO - 'TMOUT': '86400', 05:11:28 INFO - 'USER': 'cltbld', 05:11:28 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:28 INFO - '_': '/tools/buildbot/bin/python'} 05:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:28 INFO - Cleaning up... 05:11:28 INFO - Return code: 0 05:11:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:28 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', 'jsonschema'] in /builds/slave/test/build 05:11:28 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 jsonschema 05:11:28 INFO - Using env: {'DISPLAY': ':0', 05:11:28 INFO - 'HOME': '/home/cltbld', 05:11:28 INFO - 'LANG': 'en_US.UTF-8', 05:11:28 INFO - 'LANGUAGE': 'en_US:en', 05:11:28 INFO - 'LOGNAME': 'cltbld', 05:11:28 INFO - 'MAIL': '/var/mail/cltbld', 05:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:28 INFO - 'MOZ_NO_REMOTE': '1', 05:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:28 INFO - 'NO_EM_RESTART': '1', 05:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:28 INFO - 'PWD': '/builds/slave/test', 05:11:28 INFO - 'SHELL': '/bin/bash', 05:11:28 INFO - 'SHLVL': '1', 05:11:28 INFO - 'TERM': 'linux', 05:11:28 INFO - 'TMOUT': '86400', 05:11:28 INFO - 'USER': 'cltbld', 05:11:28 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:28 INFO - '_': '/tools/buildbot/bin/python'} 05:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:28 INFO - Downloading/unpacking jsonschema 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:11:30 INFO - Downloading/unpacking functools32 (from jsonschema) 05:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:30 INFO - warning: no files found matching '*.txt' 05:11:30 INFO - no previously-included directories found matching 'build' 05:11:30 INFO - no previously-included directories found matching 'dist' 05:11:30 INFO - no previously-included directories found matching '.git*' 05:11:30 INFO - Installing collected packages: jsonschema, functools32 05:11:30 INFO - Running setup.py install for functools32 05:11:30 INFO - warning: no files found matching '*.txt' 05:11:30 INFO - no previously-included directories found matching 'build' 05:11:30 INFO - no previously-included directories found matching 'dist' 05:11:30 INFO - no previously-included directories found matching '.git*' 05:11:30 INFO - Successfully installed jsonschema functools32 05:11:30 INFO - Cleaning up... 05:11:31 INFO - Return code: 0 05:11:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:31 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0809d70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:31 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', 'flake8'] in /builds/slave/test/build 05:11:31 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 flake8 05:11:31 INFO - Using env: {'DISPLAY': ':0', 05:11:31 INFO - 'HOME': '/home/cltbld', 05:11:31 INFO - 'LANG': 'en_US.UTF-8', 05:11:31 INFO - 'LANGUAGE': 'en_US:en', 05:11:31 INFO - 'LOGNAME': 'cltbld', 05:11:31 INFO - 'MAIL': '/var/mail/cltbld', 05:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:31 INFO - 'MOZ_NO_REMOTE': '1', 05:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:31 INFO - 'NO_EM_RESTART': '1', 05:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:31 INFO - 'PWD': '/builds/slave/test', 05:11:31 INFO - 'SHELL': '/bin/bash', 05:11:31 INFO - 'SHLVL': '1', 05:11:31 INFO - 'TERM': 'linux', 05:11:31 INFO - 'TMOUT': '86400', 05:11:31 INFO - 'USER': 'cltbld', 05:11:31 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:31 INFO - '_': '/tools/buildbot/bin/python'} 05:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:31 INFO - Downloading/unpacking flake8 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:11:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:11:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:11:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:33 INFO - no previously-included directories found matching 'docs/_build' 05:11:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:33 INFO - Running setup.py install for pep8 05:11:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:33 INFO - no previously-included directories found matching 'docs/_build' 05:11:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:33 INFO - Cleaning up... 05:11:33 INFO - Return code: 0 05:11:33 INFO - Running post-action listener: _resource_record_post_action 05:11:33 INFO - Running post-action listener: _start_resource_monitoring 05:11:33 INFO - Starting resource monitoring. 05:11:33 INFO - ##### 05:11:33 INFO - ##### Running install step. 05:11:33 INFO - ##### 05:11:33 INFO - Running pre-action listener: _resource_record_pre_action 05:11:33 INFO - Running main action method: install 05:11:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:34 INFO - Reading from file tmpfile_stdout 05:11:34 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:34 INFO - Reading from file tmpfile_stdout 05:11:34 INFO - Output received: 05:11:34 INFO - Usage: mozinstall [options] installer 05:11:34 INFO - Options: 05:11:34 INFO - -h, --help show this help message and exit 05:11:34 INFO - -d DEST, --destination=DEST 05:11:34 INFO - Directory to install application into. [default: 05:11:34 INFO - "/builds/slave/test"] 05:11:34 INFO - --app=APP Application being installed. [default: firefox] 05:11:34 INFO - mkdir: /builds/slave/test/build/application 05:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:11:48 INFO - Reading from file tmpfile_stdout 05:11:48 INFO - Output received: 05:11:48 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:48 INFO - Running post-action listener: _resource_record_post_action 05:11:48 INFO - ##### 05:11:48 INFO - ##### Running run-tests step. 05:11:48 INFO - ##### 05:11:48 INFO - Running pre-action listener: _resource_record_pre_action 05:11:48 INFO - Running main action method: run_tests 05:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:48 INFO - Python 2.7.3 05:11:48 INFO - Return code: 0 05:11:48 INFO - grabbing minidump binary from tooltool 05:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:48 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 0xec60b0>, '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 0xec6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec7440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:11:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:11:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:48 INFO - Return code: 0 05:11:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:11:49 INFO - Return code: 0 05:11:49 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/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 05:11:49 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/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 05:11:49 INFO - Using env: {'DISPLAY': ':0', 05:11:49 INFO - 'HOME': '/home/cltbld', 05:11:49 INFO - 'LANG': 'en_US.UTF-8', 05:11:49 INFO - 'LANGUAGE': 'en_US:en', 05:11:49 INFO - 'LOGNAME': 'cltbld', 05:11:49 INFO - 'MAIL': '/var/mail/cltbld', 05:11:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:49 INFO - 'MOZ_NO_REMOTE': '1', 05:11:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:49 INFO - 'NO_EM_RESTART': '1', 05:11:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:49 INFO - 'PWD': '/builds/slave/test', 05:11:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:49 INFO - 'SHELL': '/bin/bash', 05:11:49 INFO - 'SHLVL': '1', 05:11:49 INFO - 'TERM': 'linux', 05:11:49 INFO - 'TMOUT': '86400', 05:11:49 INFO - 'USER': 'cltbld', 05:11:49 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110', 05:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:49 INFO - '_': '/tools/buildbot/bin/python'} 05:11:49 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/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 05:11:50 INFO - mozversion INFO | application_buildid: 20151216031209 05:11:50 INFO - mozversion INFO | application_changeset: f52b36d6bc1aeb421c58d39208e0a50625915cd7 05:11:50 INFO - mozversion INFO | application_display_name: Nightly 05:11:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:50 INFO - mozversion INFO | application_name: Firefox 05:11:50 INFO - mozversion INFO | application_remotingname: firefox 05:11:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 05:11:50 INFO - mozversion INFO | application_vendor: Mozilla 05:11:50 INFO - mozversion INFO | application_version: 46.0a1 05:11:50 INFO - mozversion INFO | platform_buildid: 20151216031209 05:11:50 INFO - mozversion INFO | platform_changeset: f52b36d6bc1aeb421c58d39208e0a50625915cd7 05:11:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 05:11:50 INFO - mozversion INFO | platform_version: 46.0a1 05:11:50 INFO - 2015-12-16 05:11:50,048 DEBUG : using testdate: 1450271510 05:11:50 INFO - 2015-12-16 05:11:50,048 DEBUG : actual date: 1450271510 05:11:50 INFO - 2015-12-16 05:11:50,058 INFO : starting webserver on 'localhost:42480' 05:11:50 INFO - 2015-12-16 05:11:50,059 INFO : Starting test suite talos-linux64-ix-047 05:11:50 INFO - 2015-12-16 05:11:50,059 INFO : Starting test dromaeo_css 05:11:50 INFO - 2015-12-16 05:11:50,059 DEBUG : operating with platform_type : linux_ 05:11:50 INFO - 2015-12-16 05:11:50,060 INFO : Initialising browser for dromaeo_css test... 05:11:50 INFO - 2015-12-16 05:11:50,072 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOMyDC/profile http://localhost:42480/getInfo.html 05:11:54 INFO - 2015-12-16 05:11:54,544 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:11:54 INFO - 2015-12-16 05:11:54,544 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:11:54 INFO - 2015-12-16 05:11:54,544 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:11:54 INFO - 2015-12-16 05:11:54,545 DEBUG : BROWSER_OUTPUT: __metrics 05:11:54 INFO - 2015-12-16 05:11:54,629 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:11:54 INFO - 2015-12-16 05:11:54,692 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:54 ERROR - 2015-12-16 05:11:54,708 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:11:55 INFO - 2015-12-16 05:11:55,592 INFO : Browser initialized. 05:11:55 INFO - 2015-12-16 05:11:55,592 INFO : Running cycle 1/1 for dromaeo_css test... 05:11:55 INFO - 2015-12-16 05:11:55,593 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOMyDC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:12:07 INFO - 2015-12-16 05:12:07,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 142303232 05:12:07 INFO - 2015-12-16 05:12:07,650 DEBUG : BROWSER_OUTPUT: 05:12:58 INFO - 2015-12-16 05:12:58,946 DEBUG : BROWSER_OUTPUT: 1450271578942 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:15:10 INFO - 2015-12-16 05:15:10,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42480/tests/dromaeo/cssquery-ext.html) 05:15:12 INFO - 2015-12-16 05:15:12,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 255180800 05:15:12 INFO - 2015-12-16 05:15:12,085 DEBUG : BROWSER_OUTPUT: 05:18:14 INFO - 2015-12-16 05:18:14,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/dromaeo/cssquery-ext.html (next: http://localhost:42480/tests/dromaeo/cssquery-jquery.html) 05:18:15 INFO - 2015-12-16 05:18:15,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 223522816 05:18:15 INFO - 2015-12-16 05:18:15,223 DEBUG : BROWSER_OUTPUT: 05:21:17 INFO - 2015-12-16 05:21:17,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42480/tests/dromaeo/cssquery-mootools.html) 05:21:17 INFO - 2015-12-16 05:21:17,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 209805312 05:21:17 INFO - 2015-12-16 05:21:17,864 DEBUG : BROWSER_OUTPUT: 05:24:19 INFO - 2015-12-16 05:24:19,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42480/tests/dromaeo/cssquery-prototype.html) 05:24:20 INFO - 2015-12-16 05:24:20,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 200957952 05:24:20 INFO - 2015-12-16 05:24:20,372 DEBUG : BROWSER_OUTPUT: 05:27:23 INFO - 2015-12-16 05:27:23,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42480/tests/dromaeo/cssquery-yui.html) 05:27:23 INFO - 2015-12-16 05:27:23,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 204709888 05:27:23 INFO - 2015-12-16 05:27:23,622 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/dromaeo/cssquery-yui.html (next: http://localhost:42480/tests/dromaeo/cssquery-dojo.html) 05:30:26 INFO - 2015-12-16 05:30:26,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 249495552 05:30:26 INFO - 2015-12-16 05:30:26,499 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,499 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:26 INFO - 2015-12-16 05:30:26,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:26 INFO - 2015-12-16 05:30:26,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:26 INFO - 2015-12-16 05:30:26,499 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:26 INFO - 2015-12-16 05:30:26,500 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2632.973670263297;2701.743334383234;2709.390387162888;2718.4019515706564;2719.048333083421;4539.773011349427;4662.603678687311;4709.058188362333;4726.527347265276;4742.596879265262;4614.100250451155;4654.8370807021765;4699.788509517071;4705.435347758265;4755.7622118894005;4359.367891655708;4363.6509079273665;4374.19077470669;4396.934045989313;4398.34024896265;4146.834126634931;4417.182821178092;4424.314231294138;4473.463184417875;4492.483364413101;4235.3646952957;4296.011917259032;4314.525402205755;4327.956720432819;4338.1540599583095;4388.912221755579;4398.538153493901;4404.14119246747;4410.360497727844;4458.643308535309;4151.418801367811;4247.532771395144;4372.846950356722;4378.321360189176;4432.844850430251;4567.543245675406;4594.081183763261;4704.411948506437;4707.552782485658;4742.857714268543;5030.40574219919;5034.244863270502;5047.4447810740785;5063;5083.05963396769;4819.5180481951875;4983.053219888246;5080.1617733074;5095.133827249377;5101.8724531887;4589.47221069578;4603.5166307537565;4630.72215667061;4721.881952951135;4741.83403580873;5230;5230.581553475713;5242.7378631068295;5267.499587539178;5276.868078297996;5011.473795251519;5011.824586139541;5013.899722005613;5016.498350164954;5054.696718196847;4929.556339929351;4993.90012199754;5083.593312534988;5088.185890257541;5108.6168537359845;5043.747812609355;5048.040872234264;5050.242463630411;5056.595472362203;5069.44236134025;4975.726335051607;5016.347874776256;5023.623228257895;5030.044291584587;5064.240363945438;4006.0585762345827;4107.568705285962;4109.0549173690215;4179.9968007677935;4271.594198551133;3711.536057992751;3722.088088418355;3722.7207959402613;3742.3825068863875;3763.2097259575794;4425.468943726773;4429.867103986886;4429.911401771947;4450.910981780346;4467.374567560544;4824.638152138604;4946.752662366939;4948.134076536592;4961.231009193581;5137.948620513747;4354.129174165117;4356.324769660708;4359.67302452311;4365.716228445141;4379.934300985487;4473.955260447354;4474.373587697725;4474.6420286377015;4479.059397526556;4513.684042117086;4647.256438969748;4691.132140554008;4766.213574760126;4771.332013518041;4826.58973987208;5070.847874563769;5090.567301779391;5090.872728181677;5094.388673359221;5119.769610367468;4847.34560834297;4850.369451971363;4854.781534831011;4858.95141048585;4878.853634390974;4813.975930120327;4907.60739140875;4911.950880491149;4911.9754401227765;5087.974560127176;5117.078925793393;5119.180931051014;5120.48795120485;5124.718140502308;5139.100657384868;4923.753812309442;4925.458199598113;4931.087748766489;4931.802727890844;4969.35398398206;4674.182018146878;4738.620910327235;4779.187538118459;4779.283107533898;4948;4668.369770081132;4777.689450185727;4783.04339132168;4819.927701084416;4828.975855120702;5017.523335283142;5026.824061157842;5036.439419155179;5036.571891389126;5087.974560127176;4647.3029045643425;4770.546798054179;4909.042736666316;4936.358273424432;4939.901201975868 05:30:26 INFO - 2015-12-16 05:30:26,500 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.0642510943952;563.6195567991605;573.6730063863597;576.4293349583912;579.7391173971714;26520.734792652092;26938.19185424438;34374.99999999997;34946.475802862915;35023;38494.03764905879;38893.22213555727;38895.611043889556;38922.221555568874;39023.80488097563;6987.2663370346145;7933.682652693899;8110.310623596972;8112.148224436438;8121.878171827428;7092.609906455143;7187.245339239383;7189.532680375759;10126.544305506233;10432.269741118125;10005.04952029556;10167.847482287772;10174.949125254363;10177.287589868713;10177.643782467616;10078.092971632552;10188.235882308782;10190.286679932407;10195.796084078314;10196.694099176962;7185.245549217361;7362.37419819316;7367.1527774306105;7369.4841361104745;7373.483856130073;36753.26493470142;37426.43860342097;37447.25105497902;37472.25055498902;37486.43770343447;2908.1130255272133;2934.853257337146;2935.2661834541364;3000.5799188113683;3025.13783571681;28166.436671266663;28391.57412638812;28497.57253641197;28536.28659283514;28603.57094643561;3047.162030441624;3070.7236348728497;3091.27355071558;3121.9687803121906;3170;207432.9999999985;207865;207883;208175;209607;51141;51734.22398664023;51740.22389664158;51752.482475174766;51760;55721.442785572435;55884.72057639686;55905.720471397384;56039.43960560424;56102.719486403126;12702.872971270353;14043.1574105554;14325.212113333866;14326.785098223534;14332.785008224884;9342.439453632804;9392.060793920553;9417.670381536613;11199.888001119885;11496.94251528737;17567.73648395275;17768.200430980636;17847.375341863233;17855.107244637715;17940.461786146436;7107.786766397016;7291.4531410144455;7362.77911662651;7435.739749108863;7542.924570754222;850.8553545897089;851.1445996773203;915.3409545127497;963.4460185393286;1048.444324508012;22667.319980400614;22998.655020174712;25767.742322576534;26038.218853434428;27384.863075684494;944.617429940875;979.5983646704817;987.2940847294219;1008.909198172168;1065.5524679634573;12274.938625306995;12327.260364378166;12535;12555.309457979716;12625;264934;269875;269974;271174;271429;43541.56458435438;43651;43765.56234437678;43811.780941095094;43870;1246.731952630189;1258.704204511939;1260.7856664367264;1263.0211586020723;1273.5606215855514;22821.31536053921;22948.196813111463;23297;23616.409589760395;23773.64339534943;34512.654873451946;34943.475847861795;34991.475127873615;35981.28037439184;36399.81800090983;325532;327901;330032;330103;330708;27127.457450851267;27521.17436476909;27527.17418477449;27528.724712753417;27575.172744817686;37535.43696844604;38605.613943860204;38868.80565597154;38955;39004.804975976076;32165.678343217205;32895;33283.50074748929;33857.322853543286;33958.49062264118;31160.22099447532;32692.673073269914;32778;32845.50731738978;33228.83385583057;29042.27394315159;29472.557911630913;29599;29674.55488167636;29772.553411699275;27445.588316175672;28560.285992850346;28845.711542884303;29002;29048.273793155342;22265.974404973273;22650.093996240626;22975.310740677807;22978;23114.653280201146 05:30:26 INFO - 2015-12-16 05:30:26,500 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.7616092574272;335.80187689263346;335.91731266149867;336.3525213963121;343.16097142486615;12563.371831408438;12800.295983720891;14339.498117565887;14981.400743970242;16718.41485548006;9837.114659680645;10173.084422402;10178.287519873611;14778.113313201215;15183.240837958114;4403.559644035595;4508.932366014513;4514.571115743999;4515.322701594754;4519.954800452003;3459.5848498180126;3557.92884142317;4667.953320466803;5006.424261209971;5179.404368497633;5140.691558506483;5143.485651434845;5157.948420515784;5170.482951704837;5170.844874653766;5049.2173713074535;5132.538071573557;5625.915611265835;5643.181738647873;5676.886462270772;5043.974780126113;5045.520675535819;5046.142155833517;5047.419546752134;5047.772850221749;12074.335911524862;12077.698057548543;12091.334976576285;12108.21296615717;16446.84872058956;1844.1240410804894;1852.7684039495064;1911.206849157612;1923.951901202467;1944.7414886473823;9066.95466522663;9155.267578593763;9277.768055798659;9353.11145441182;12755;1695.9745603815952;1730.8788384813067;1745.7730495035564;1776.9289228430848;1794.55136215946;49071.75464122692;50974.49025509734;52235.21647175295;54278.457215427734;56542;9308.348415610977;9692.806143877084;9971.40171589707;9974.601015959426;10027;12641.304728239851;12653.240805551697;12671;12672.049596280316;12703.809442858364;6940.826479337956;6983.127109111361;7003.894941575881;7013.088298521262;7014.754483593049;6553;6582.3746744059235;6596.505262105361;6623.768168114189;6647.700853461509;4195.7692326922315;4213.157368526307;4269.978650106729;4280.76455794928;4289.82840686369;1545.2196640696377;1643.589102724319;1673.1634182908547;1675.304748529371;1761.709317962522;860.4407135361939;861.9913800861912;862.6635612111281;874.8337815814975;944.6268723854176;15113.848861511464;15213.695726085416;15928.362865485482;15947.60130996711;16195.271212795453;737.7823542055106;787.4684587903142;807.2815194476921;858.9398742088118;920.4063379120564;8231;8451.873221901677;8536.957315213509;8632.91367086321;8647.697330593399;489739;490400;492601;506695;516176;69835.30164698287;72070.27929720741;73529.26470735332;73669.47478939101;74239;1055.1927775251938;1059.2426415113232;1074.4735079810994;1079.9892001080045;1082.832161015044;13616.251106189255;13747.450101995808;14307.92846035763;14439.2058436787;14477.131372117707;29116.56325155082;29311.70688293175;29780.38404047376;30380.5442918352;30862.845685771426;36643.083922901074;37735.245295093395;37962;38464.423033655075;38493.42259866048;8496.447730897471;8699.347548933729;8829.823403532022;8909.331800115147;8917.331200159884;15505.534833955;15989.1205983672;16040.759388609413;16199.43301984425;16643.750343745094;12705.872941270469;12852.550160744702;13201.20792752438;13388.598342049754;13644.795328069888;12954.28751418681;13148.934255328662;13242.271675057964;13499.190048597116;13705.177689338672;9964.352317099365;12939.223646581235;13045.282509462071;13173.077884547989;13902.374393152535;8858.557072146496;9068.863967040632;9116.863247051433;9362.344635875423;9376.765580860532;13072.673183170496;13077.738445230852;13155;13723.519676811264;14211.076280041763 05:30:26 INFO - 2015-12-16 05:30:26,500 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1407.2752532445786;1652.3886162120014;1687;1713.700102482066;1738.6435780664965;5917.88164236715;7114.217436082034;7266.30970057845;7273.599952002638;7279.563226206431;7181.605011724353;7333.376662983653;7350.705971761123;7357.0803649543805;7372.447066470009;2073.6578464553368;2110.9577808443823;2117.3647905628327;2117.5976564452703;2118.353902059871;2086.54096098858;2110.799474049963;2118.8516803823663;2128.861623994443;2131.5310631661087;2038.2662241593089;2064.6696528555435;2069.9896500517552;2097.6329142400095;2100.1809294375207;2072.8756274623497;2098.2551194325947;2101.737282839645;2105.031685424699;2106.7998540138738;1958.8530860185401;1980.9702854457194;1994.9202031918705;1996.371143089922;1996.550776075386;7071;7092.50352475327;7127.322904324081;7143.642817859086;7163.534370265916;4274.508431530352;4329.935050974238;4338.175746608166;4342.761148136851;4344.543822898581;2688.8655567221563;2698.271466703979;2746.7115952825066;2758.213909035935;2775.278427608816;828.2669837194067;845.720912099012;848.7581039403802;856.1994535109692;900.4057322167338;9405.388649737744;9446.52767361636;9465.858012129824;9531.952340238255;9555.61777528898;3934.8622798201927;3955.3473676843;3998.360262358067;4000.639942405139;4032.6773858091283;8299.253067223979;8301.29438997692;8303.626336814857;8306.584670766437;8313.08556058833;4369.060651959844;4384.69307148503;4394.231009573312;4394.824207031683;4395.780210989437;3273.459879119966;3372.1906742381652;3822.847086116524;3990.5610382857863;3997.780122093313;3450.3271861987173;3484.7038001769624;3496.8251587420527;3522.43641017436;3538.876139335111;1117.5306371324064;1119.1885882734953;1121.8878112188715;1124.1512657943201;1136.63059505661;1190.5118901250446;1196.4257156564897;1197.144042009967;1209.4678341529698;1211.8485189351331;6664.5334826561675;6731;6732.4950628703045;6746.257911629717;6771.695273712695;433.79177994562156;438.25715412376354;444.34237328753625;446.3884478264798;447.9417675702138;5343.385510666323;5427.6472029317965;5430.972845135749;5432.13085906261;5435.565154787608;8263.710770123016;8275.83448331042;8473.95763021181;8480;8574;8395.370347223983;8441.620127094173;8445.451045682012;8464.534450605153;8468.407211495136;6616.669166541654;6652.501062420338;6661.800145995725;6682.665866706645;6734.966325168343;6776.525643204928;6881.483888708267;6884.483663725341;6886.276940921131;6892.758753443605;7571.924280757122;7731.536107833548;7735.071791385069;7762.534247945141;7831.647575858986;7908.960455197687;7952.602369881599;8032.959835200787;8156.510609363457;8162.306203972729;5227.294315267391;5577.414371490935;5668.291463567054;6374.07575901501;6458.54790164684;6571.408573228432;6578.76974305897;6580.473562115115;6619.404253617197;6627.801165965029;6199.783007594712;6417.71120299597;6433.453156481752;6452.193475815523;6469.741210351722;6113.57204995646;6194.349593292639;6291.779787707408;6321.49428045746;6330.52521060913;6378.52161087911;6409.647469389042;6419.967900160469;6427.710753016032;6432.710528026157;5907.113932910098;5922.911156332572;5934.970325148347;5956.8808623828145;5963.105534169909;5955.493783028491;5991.400859913973;6009.699515024318;6026.126211699191;6029.758809647565 05:30:26 INFO - 2015-12-16 05:30:26,500 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.47760985445905;297.59972836534865;300.5446748176513;302.5008735586281;305.36484113044867;5269.525742683158;5337.279467271917;5383.67697938124;5452.2094296327;5476.808311709091;5341.946580534203;5397.7031263280505;5409.702466364349;5411.702356370398;5416.593755468346;3912.6674232690257;4186.1418409226035;4201.033762234688;4202.474690663675;4204.033072393336;4025.5974402559655;4045.1505183911268;4150.813213405404;4166.437530933331;4174.958250417502;4066.4103704962763;4108.85619003335;4112.09533902541;4117.814698338582;4120.443740095079;3858.884233473;3927.3912543555793;4006.8597599084183;4107.603414838954;4116.526599441057;3576.159602493412;3595.4247320428867;3595.7842529448317;3609.9819500902327;3611.7291203159866;5118.10433174193;5126.61550383719;5136.871578210575;5137.768800403991;5141.100307446182;4729.810807567727;4734.431868175807;4738.384010078702;4739.644526660514;4741;5505.256790333294;5576.944230557683;5609.35492418373;5616.887662246773;5622.91565626516;3932.4494570760116;3933.8623148189677;3934.5868683788076;3936.626020528045;3936.940945885814;5833.970830145822;5909.497692696126;5919.112133180014;5925;5928.881422371528;4124.1957818225155;4125.525564560054;4131.421600975866;4131.958680413218;4133.028738246509;4093.1404405074672;4192.559781222928;4197.286461301586;4199.097194103282;4204.705670603028;4785;4793.520647935178;4793.688410253392;4798.064377446364;4800.807967681323;5643.71781410936;5659.660420374791;5660.26416565852;5668.659880407189;5670.8015219467125;1457.234951650392;1489.5605796289904;1491.8209814822292;1492.7014597080627;1494.0811400988532;989.9554520046615;998.8301988661945;1018.6943916824923;1022.6318525330875;1025.1235193909101;4972.776225069881;4987.127252730757;4987.725675087832;4988.925166122511;4990.3762029746285;5807.070868660994;5855.707214639251;5874.236349274567;5876.7355469004;5881.823545293648;4968.950310496921;4973.925391119136;4981.12830254704;4985.252212168204;4985.326980857611;3085.3520760640067;3121.71904528589;3144.827034513078;3156.8105913645254;3156.9684303157132;5539.307586551681;5545.972270138624;5553.305836770403;5553.8333849984565;5554.77780888768;6005.429484198994;6008.429199226067;6009.45914867664;6013.398660134039;6015.037593984942;5542.612017158841;5552.028395030773;5556.194351818964;5557.138643510343;5557.833265002057;5676.432356764456;5840.371832675398;5842.678652674143;5846.298444186555;5847.502962248256;5692.800751973661;5698.316202055614;5700.429957004267;5705.7147142643535;5708.543316534584;5539.25220095282;5546.334439867242;5548.472895074961;5549.694766787866;5556.055470569932;3993.820278087435;4084.081081756581;4086.4891888513935;4086.959130408658;4119.588041195856;5837.737301821513;5840;5840.415958404125;5846.444587764156;5852.7658893643775;5581.776728930798;5589.832305030693;5591.273134492652;5593.692346920959;5596.468335508121;5619.072852979376;5631.577631677723;5635.605507614428;5637.913971830285;5638.661680299195;5356.625036247426;5441.319835020622;5452.536534394462;5504.6421982571;5508.283923089973;5486.643368181056;5602.4957753802355;5607.467290607386;5628.409017053151;5653.067243904709;5448.318960129984;5493.7802487900035;5498.670079795225;5499.240243122163;5502.119660854244 05:30:26 INFO - 2015-12-16 05:30:26,501 DEBUG : BROWSER_OUTPUT: |5;yui.html;666.5300962821211;697.1355519156248;737.6717360774455;738.9741359052427;742.109468637635;10316.329438586487;10622.36265824051;10631.202659800518;10634.096101831354;10657.573697052117;11665.708357291072;11682.591109311175;11713.590024349129;11723.0621550276;11730.706732331695;637.2003136064257;641.5316818722335;797.4896066517433;810.7689308547066;811.1726039439768;800.0439474827583;805.4402190477621;811.679386642276;812.0377352836878;812.9105798362175;846.6317152038852;849.2314455417826;852.6802449081595;853.5220276645067;856.8029353248756;656.6651007985914;658.9011648252753;661.5567569728294;662.4799532367068;841.2638940926689;486.2268992302256;626.4017862940881;629.6851574212893;631.7788773929134;633.6356594957917;11713.941430292794;11720.179587428884;11759.7060073498;11764.823527647091;11766.764664706743;10833.512491937881;11485.540578376855;11522.711932201679;11605.361705106216;11647.88352116485;9490.525473726286;9524.380915240487;9617.086376794194;9630.374025688308;9661.372010819274;3289.0461766087806;3300.603927528688;3324.4680851063713;3380.6957373836226;3395.711364534018;38939.41590876139;39022.60977390246;39285.60714392848;39577.40633890494;40007;9215;9326.766830829283;9355.812883742286;9442.669506567374;9501.334906556613;15456.84543154554;15464;15519.612009699847;15526;15568.766468502981;6148.1392605035335;6232.844178895473;6250.1874756282305;6310.05349197624;6450.9354906450335;3427.520147179397;3449.4998225257195;3519.63043880394;3563.6080031196548;3576.213233088716;2483.3915690655904;2525.8989640414543;2530.671012768328;2534.5944648856093;2542.995516770865;423.85800756746835;427.7989345007904;431.5878336188932;433.57509640552433;438.4234731328293;535.5233841880729;577.5264283287664;589.6933594530819;610.2737742086903;613.8066509049635;6672.933270667231;7044.894326585106;7087.362137407658;8612.612432440555;8901.910980890108;425.8105143211241;475.9952400475951;544.9999251373695;578.4533615733176;616.901295792671;3610.355236353365;3630.6913912317223;3830.6451612903293;3852.9614703853163;3896.1038961038553;47813.28280075802;48521;48602;48636.27045594319;48769.512304876494;42546.787266063475;42694.146117077486;43192.56807431886;43818;44261.77869110634;39006.804965975556;39121.80439097843;39314.41028384576;39449.80275098606;39663.60336396657;7022.613756243456;7070.893936590853;7202.49582529218;7216.386607138242;7286.599237042014;33650.83174584111;34019;34480.65519344775;37576.62423375731;38018.239635206584;41669.1666166681;42022.36966445445;42254.15491690087;43117.568824311355;43599.56400435955;10671.893281067401;10738.624148154777;10756.085732712807;10908.7272818177;11188.776224475629;10556.947215263874;10622.575096996343;10740.62407815754;11496.54013839437;12252.877471225174;10748.838767418338;10790.460476975963;11037.282576632493;11308.660740177807;11320.490577923849;10431.63489277902;10796.244262901522;10958.45207739594;10976.506057227603;11345.886541134483;10484.580616775549;10551.366917984946;10601.310914790514;10792.244542881923;10816.459177040959;9142.3600347975;9263.86104208424;9334.53327333617;9554.856677149988;9623.5669394876;9073.546322683971;9085.318601104811;9214.216791572524;9250.444973301623;9297.72106836796 05:30:26 INFO - 2015-12-16 05:30:26,501 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:26 INFO - 2015-12-16 05:30:26,502 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:30:26 INFO - 2015-12-16 05:30:26,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1012 05:30:26 INFO - 2015-12-16 05:30:26,502 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:30:26 INFO - 2015-12-16 05:30:26,502 DEBUG : BROWSER_OUTPUT: __startTimestamp1450272626491__endTimestamp 05:30:26 INFO - 2015-12-16 05:30:26,502 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,502 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:26 INFO - 2015-12-16 05:30:26,502 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4662.82 Median:4770.55 stddev:488.42 (10.2%) stddev-sans-first:463.23 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: Values: 2633.0 2701.7 2709.4 2718.4 2719.0 4539.8 4662.6 4709.1 4726.5 4742.6 4614.1 4654.8 4699.8 4705.4 4755.8 4359.4 4363.7 4374.2 4396.9 4398.3 4146.8 4417.2 4424.3 4473.5 4492.5 4235.4 4296.0 4314.5 4328.0 4338.2 4388.9 4398.5 4404.1 4410.4 4458.6 4151.4 4247.5 4372.8 4378.3 4432.8 4567.5 4594.1 4704.4 4707.6 4742.9 5030.4 5034.2 5047.4 5063.0 5083.1 4819.5 4983.1 5080.2 5095.1 5101.9 4589.5 4603.5 4630.7 4721.9 4741.8 5230.0 5230.6 5242.7 5267.5 5276.9 5011.5 5011.8 5013.9 5016.5 5054.7 4929.6 4993.9 5083.6 5088.2 5108.6 5043.7 5048.0 5050.2 5056.6 5069.4 4975.7 5016.3 5023.6 5030.0 5064.2 4006.1 4107.6 4109.1 4180.0 4271.6 3711.5 3722.1 3722.7 3742.4 3763.2 4425.5 4429.9 4429.9 4450.9 4467.4 4824.6 4946.8 4948.1 4961.2 5137.9 4354.1 4356.3 4359.7 4365.7 4379.9 4474.0 4474.4 4474.6 4479.1 4513.7 4647.3 4691.1 4766.2 4771.3 4826.6 5070.8 5090.6 5090.9 5094.4 5119.8 4847.3 4850.4 4854.8 4859.0 4878.9 4814.0 4907.6 4912.0 4912.0 5088.0 5117.1 5119.2 5120.5 5124.7 5139.1 4923.8 4925.5 4931.1 4931.8 4969.4 4674.2 4738.6 4779.2 4779.3 4948.0 4668.4 4777.7 4783.0 4819.9 4829.0 5017.5 5026.8 5036.4 5036.6 5088.0 4647.3 4770.5 4909.0 4936.4 4939.9 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41826.40 Median:3081.00 stddev:71661.14 (2325.9%) stddev-sans-first:71795.16 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: Values: 552.1 563.6 573.7 576.4 579.7 26520.7 26938.2 34375.0 34946.5 35023.0 38494.0 38893.2 38895.6 38922.2 39023.8 6987.3 7933.7 8110.3 8112.1 8121.9 7092.6 7187.2 7189.5 10126.5 10432.3 10005.0 10167.8 10174.9 10177.3 10177.6 10078.1 10188.2 10190.3 10195.8 10196.7 7185.2 7362.4 7367.2 7369.5 7373.5 36753.3 37426.4 37447.3 37472.3 37486.4 2908.1 2934.9 2935.3 3000.6 3025.1 28166.4 28391.6 28497.6 28536.3 28603.6 3047.2 3070.7 3091.3 3122.0 3170.0 207433.0 207865.0 207883.0 208175.0 209607.0 51141.0 51734.2 51740.2 51752.5 51760.0 55721.4 55884.7 55905.7 56039.4 56102.7 12702.9 14043.2 14325.2 14326.8 14332.8 9342.4 9392.1 9417.7 11199.9 11496.9 17567.7 17768.2 17847.4 17855.1 17940.5 7107.8 7291.5 7362.8 7435.7 7542.9 850.9 851.1 915.3 963.4 1048.4 22667.3 22998.7 25767.7 26038.2 27384.9 944.6 979.6 987.3 1008.9 1065.6 12274.9 12327.3 12535.0 12555.3 12625.0 264934.0 269875.0 269974.0 271174.0 271429.0 43541.6 43651.0 43765.6 43811.8 43870.0 1246.7 1258.7 1260.8 1263.0 1273.6 22821.3 22948.2 23297.0 23616.4 23773.6 34512.7 34943.5 34991.5 35981.3 36399.8 325532.0 327901.0 330032.0 330103.0 330708.0 27127.5 27521.2 27527.2 27528.7 27575.2 37535.4 38605.6 38868.8 38955.0 39004.8 32165.7 32895.0 33283.5 33857.3 33958.5 31160.2 32692.7 32778.0 32845.5 33228.8 29042.3 29472.6 29599.0 29674.6 29772.6 27445.6 28560.3 28845.7 29002.0 29048.3 22266.0 22650.1 22975.3 22978.0 23114.7 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26094.16 Median:38478.92 stddev:81512.61 (211.8%) stddev-sans-first:81718.32 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: Values: 335.8 335.8 335.9 336.4 343.2 12563.4 12800.3 14339.5 14981.4 16718.4 9837.1 10173.1 10178.3 14778.1 15183.2 4403.6 4508.9 4514.6 4515.3 4520.0 3459.6 3557.9 4668.0 5006.4 5179.4 5140.7 5143.5 5157.9 5170.5 5170.8 5049.2 5132.5 5625.9 5643.2 5676.9 5044.0 5045.5 5046.1 5047.4 5047.8 12074.3 12077.7 12091.3 12108.2 16446.8 1844.1 1852.8 1911.2 1924.0 1944.7 9067.0 9155.3 9277.8 9353.1 12755.0 1696.0 1730.9 1745.8 1776.9 1794.6 49071.8 50974.5 52235.2 54278.5 56542.0 9308.3 9692.8 9971.4 9974.6 10027.0 12641.3 12653.2 12671.0 12672.0 12703.8 6940.8 6983.1 7003.9 7013.1 7014.8 6553.0 6582.4 6596.5 6623.8 6647.7 4195.8 4213.2 4270.0 4280.8 4289.8 1545.2 1643.6 1673.2 1675.3 1761.7 860.4 862.0 862.7 874.8 944.6 15113.8 15213.7 15928.4 15947.6 16195.3 737.8 787.5 807.3 858.9 920.4 8231.0 8451.9 8537.0 8632.9 8647.7 489739.0 490400.0 492601.0 506695.0 516176.0 69835.3 72070.3 73529.3 73669.5 74239.0 1055.2 1059.2 1074.5 1080.0 1082.8 13616.3 13747.5 14307.9 14439.2 14477.1 29116.6 29311.7 29780.4 30380.5 30862.8 36643.1 37735.2 37962.0 38464.4 38493.4 8496.4 8699.3 8829.8 8909.3 8917.3 15505.5 15989.1 16040.8 16199.4 16643.8 12705.9 12852.6 13201.2 13388.6 13644.8 12954.3 13148.9 13242.3 13499.2 13705.2 9964.4 12939.2 13045.3 13173.1 13902.4 8858.6 9068.9 9116.9 9362.3 9376.8 13072.7 13077.7 13155.0 13723.5 14211.1 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,503 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4978.23 Median:6000.55 stddev:2579.21 (43.0%) stddev-sans-first:2572.48 05:30:26 INFO - 2015-12-16 05:30:26,505 DEBUG : BROWSER_OUTPUT: Values: 1407.3 1652.4 1687.0 1713.7 1738.6 5917.9 7114.2 7266.3 7273.6 7279.6 7181.6 7333.4 7350.7 7357.1 7372.4 2073.7 2111.0 2117.4 2117.6 2118.4 2086.5 2110.8 2118.9 2128.9 2131.5 2038.3 2064.7 2070.0 2097.6 2100.2 2072.9 2098.3 2101.7 2105.0 2106.8 1958.9 1981.0 1994.9 1996.4 1996.6 7071.0 7092.5 7127.3 7143.6 7163.5 4274.5 4329.9 4338.2 4342.8 4344.5 2688.9 2698.3 2746.7 2758.2 2775.3 828.3 845.7 848.8 856.2 900.4 9405.4 9446.5 9465.9 9532.0 9555.6 3934.9 3955.3 3998.4 4000.6 4032.7 8299.3 8301.3 8303.6 8306.6 8313.1 4369.1 4384.7 4394.2 4394.8 4395.8 3273.5 3372.2 3822.8 3990.6 3997.8 3450.3 3484.7 3496.8 3522.4 3538.9 1117.5 1119.2 1121.9 1124.2 1136.6 1190.5 1196.4 1197.1 1209.5 1211.8 6664.5 6731.0 6732.5 6746.3 6771.7 433.8 438.3 444.3 446.4 447.9 5343.4 5427.6 5431.0 5432.1 5435.6 8263.7 8275.8 8474.0 8480.0 8574.0 8395.4 8441.6 8445.5 8464.5 8468.4 6616.7 6652.5 6661.8 6682.7 6735.0 6776.5 6881.5 6884.5 6886.3 6892.8 7571.9 7731.5 7735.1 7762.5 7831.6 7909.0 7952.6 8033.0 8156.5 8162.3 5227.3 5577.4 5668.3 6374.1 6458.5 6571.4 6578.8 6580.5 6619.4 6627.8 6199.8 6417.7 6433.5 6452.2 6469.7 6113.6 6194.3 6291.8 6321.5 6330.5 6378.5 6409.6 6420.0 6427.7 6432.7 5907.1 5922.9 5935.0 5956.9 5963.1 5955.5 5991.4 6009.7 6026.1 6029.8 05:30:26 INFO - 2015-12-16 05:30:26,505 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,505 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4677.70 Median:5349.29 stddev:1367.76 (25.6%) stddev-sans-first:1331.42 05:30:26 INFO - 2015-12-16 05:30:26,505 DEBUG : BROWSER_OUTPUT: Values: 293.5 297.6 300.5 302.5 305.4 5269.5 5337.3 5383.7 5452.2 5476.8 5341.9 5397.7 5409.7 5411.7 5416.6 3912.7 4186.1 4201.0 4202.5 4204.0 4025.6 4045.2 4150.8 4166.4 4175.0 4066.4 4108.9 4112.1 4117.8 4120.4 3858.9 3927.4 4006.9 4107.6 4116.5 3576.2 3595.4 3595.8 3610.0 3611.7 5118.1 5126.6 5136.9 5137.8 5141.1 4729.8 4734.4 4738.4 4739.6 4741.0 5505.3 5576.9 5609.4 5616.9 5622.9 3932.4 3933.9 3934.6 3936.6 3936.9 5834.0 5909.5 5919.1 5925.0 5928.9 4124.2 4125.5 4131.4 4132.0 4133.0 4093.1 4192.6 4197.3 4199.1 4204.7 4785.0 4793.5 4793.7 4798.1 4800.8 5643.7 5659.7 5660.3 5668.7 5670.8 1457.2 1489.6 1491.8 1492.7 1494.1 990.0 998.8 1018.7 1022.6 1025.1 4972.8 4987.1 4987.7 4988.9 4990.4 5807.1 5855.7 5874.2 5876.7 5881.8 4969.0 4973.9 4981.1 4985.3 4985.3 3085.4 3121.7 3144.8 3156.8 3157.0 5539.3 5546.0 5553.3 5553.8 5554.8 6005.4 6008.4 6009.5 6013.4 6015.0 5542.6 5552.0 5556.2 5557.1 5557.8 5676.4 5840.4 5842.7 5846.3 5847.5 5692.8 5698.3 5700.4 5705.7 5708.5 5539.3 5546.3 5548.5 5549.7 5556.1 3993.8 4084.1 4086.5 4087.0 4119.6 5837.7 5840.0 5840.4 5846.4 5852.8 5581.8 5589.8 5591.3 5593.7 5596.5 5619.1 5631.6 5635.6 5637.9 5638.7 5356.6 5441.3 5452.5 5504.6 5508.3 5486.6 5602.5 5607.5 5628.4 5653.1 5448.3 5493.8 5498.7 5499.2 5502.1 05:30:26 INFO - 2015-12-16 05:30:26,505 DEBUG : BROWSER_OUTPUT: 05:30:26 INFO - 2015-12-16 05:30:26,505 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12271.42 Median:42620.47 stddev:13863.24 (32.5%) stddev-sans-first:13874.73 05:30:26 INFO - 2015-12-16 05:30:26,507 DEBUG : BROWSER_OUTPUT: Values: 666.5 697.1 737.7 739.0 742.1 10316.3 10622.4 10631.2 10634.1 10657.6 11665.7 11682.6 11713.6 11723.1 11730.7 637.2 641.5 797.5 810.8 811.2 800.0 805.4 811.7 812.0 812.9 846.6 849.2 852.7 853.5 856.8 656.7 658.9 661.6 662.5 841.3 486.2 626.4 629.7 631.8 633.6 11713.9 11720.2 11759.7 11764.8 11766.8 10833.5 11485.5 11522.7 11605.4 11647.9 9490.5 9524.4 9617.1 9630.4 9661.4 3289.0 3300.6 3324.5 3380.7 3395.7 38939.4 39022.6 39285.6 39577.4 40007.0 9215.0 9326.8 9355.8 9442.7 9501.3 15456.8 15464.0 15519.6 15526.0 15568.8 6148.1 6232.8 6250.2 6310.1 6450.9 3427.5 3449.5 3519.6 3563.6 3576.2 2483.4 2525.9 2530.7 2534.6 2543.0 423.9 427.8 431.6 433.6 438.4 535.5 577.5 589.7 610.3 613.8 6672.9 7044.9 7087.4 8612.6 8901.9 425.8 476.0 545.0 578.5 616.9 3610.4 3630.7 3830.6 3853.0 3896.1 47813.3 48521.0 48602.0 48636.3 48769.5 42546.8 42694.1 43192.6 43818.0 44261.8 39006.8 39121.8 39314.4 39449.8 39663.6 7022.6 7070.9 7202.5 7216.4 7286.6 33650.8 34019.0 34480.7 37576.6 38018.2 41669.2 42022.4 42254.2 43117.6 43599.6 10671.9 10738.6 10756.1 10908.7 11188.8 10556.9 10622.6 10740.6 11496.5 12252.9 10748.8 10790.5 11037.3 11308.7 11320.5 10431.6 10796.2 10958.5 10976.5 11345.9 10484.6 10551.4 10601.3 10792.2 10816.5 9142.4 9263.9 9334.5 9554.9 9623.6 9073.5 9085.3 9214.2 9250.4 9297.7 05:30:26 INFO - 2015-12-16 05:30:26,507 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:26 INFO - 2015-12-16 05:30:26,507 DEBUG : BROWSER_OUTPUT: 05:30:27 INFO - 2015-12-16 05:30:27,209 INFO : Browser exited with error code: 0 05:30:27 INFO - 2015-12-16 05:30:27,228 INFO : Completed test dromaeo_css (00:18:37) 05:30:27 INFO - 2015-12-16 05:30:27,228 INFO : Starting test kraken 05:30:27 INFO - 2015-12-16 05:30:27,228 DEBUG : operating with platform_type : linux_ 05:30:27 INFO - 2015-12-16 05:30:27,228 INFO : Initialising browser for kraken test... 05:30:27 INFO - 2015-12-16 05:30:27,234 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwwwjAl/profile http://localhost:42480/getInfo.html 05:30:31 INFO - 2015-12-16 05:30:31,632 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:31 INFO - 2015-12-16 05:30:31,632 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:31 INFO - 2015-12-16 05:30:31,632 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:30:31 INFO - 2015-12-16 05:30:31,632 DEBUG : BROWSER_OUTPUT: __metrics 05:30:31 INFO - 2015-12-16 05:30:31,749 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:30:31 INFO - 2015-12-16 05:30:31,805 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:31 ERROR - 2015-12-16 05:30:31,813 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:30:32 INFO - 2015-12-16 05:30:32,754 INFO : Browser initialized. 05:30:32 INFO - 2015-12-16 05:30:32,754 INFO : Running cycle 1/1 for kraken test... 05:30:32 INFO - 2015-12-16 05:30:32,755 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwwwjAl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:44 INFO - 2015-12-16 05:30:44,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 142589952 05:30:44 INFO - 2015-12-16 05:30:44,813 DEBUG : BROWSER_OUTPUT: 05:30:47 INFO - 2015-12-16 05:30:47,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42480/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:48 INFO - 2015-12-16 05:30:48,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 177434624 05:30:48 INFO - 2015-12-16 05:30:48,029 DEBUG : BROWSER_OUTPUT: 05:30:50 INFO - 2015-12-16 05:30:50,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42480/tests/kraken/driver.html?testName=audio-dft) 05:30:51 INFO - 2015-12-16 05:30:51,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 167043072 05:30:51 INFO - 2015-12-16 05:30:51,360 DEBUG : BROWSER_OUTPUT: 05:30:54 INFO - 2015-12-16 05:30:54,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42480/tests/kraken/driver.html?testName=audio-fft) 05:30:54 INFO - 2015-12-16 05:30:54,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 155701248 05:30:54 INFO - 2015-12-16 05:30:54,905 DEBUG : BROWSER_OUTPUT: 05:30:56 INFO - 2015-12-16 05:30:56,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42480/tests/kraken/driver.html?testName=audio-oscillator) 05:30:57 INFO - 2015-12-16 05:30:57,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 156635136 05:30:57 INFO - 2015-12-16 05:30:57,516 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-12-16 05:30:59,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42480/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:00 INFO - 2015-12-16 05:31:00,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 157241344 05:31:00 INFO - 2015-12-16 05:31:00,345 DEBUG : BROWSER_OUTPUT: 05:31:03 INFO - 2015-12-16 05:31:03,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42480/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:03 INFO - 2015-12-16 05:31:03,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 158199808 05:31:03 INFO - 2015-12-16 05:31:03,933 DEBUG : BROWSER_OUTPUT: 05:31:07 INFO - 2015-12-16 05:31:07,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42480/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:07 INFO - 2015-12-16 05:31:07,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 157061120 05:31:07 INFO - 2015-12-16 05:31:07,965 DEBUG : BROWSER_OUTPUT: 05:31:10 INFO - 2015-12-16 05:31:10,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42480/tests/kraken/driver.html?testName=json-parse-financial) 05:31:11 INFO - 2015-12-16 05:31:11,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 157360128 05:31:11 INFO - 2015-12-16 05:31:11,431 DEBUG : BROWSER_OUTPUT: 05:31:13 INFO - 2015-12-16 05:31:13,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42480/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:13 INFO - 2015-12-16 05:31:13,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 165777408 05:31:13 INFO - 2015-12-16 05:31:13,786 DEBUG : BROWSER_OUTPUT: 05:31:15 INFO - 2015-12-16 05:31:15,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42480/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:16 INFO - 2015-12-16 05:31:16,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 165007360 05:31:16 INFO - 2015-12-16 05:31:16,269 DEBUG : BROWSER_OUTPUT: 05:31:18 INFO - 2015-12-16 05:31:18,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42480/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:19 INFO - 2015-12-16 05:31:19,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 178667520 05:31:19 INFO - 2015-12-16 05:31:19,016 DEBUG : BROWSER_OUTPUT: 05:31:21 INFO - 2015-12-16 05:31:21,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:22 INFO - 2015-12-16 05:31:22,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 185032704 05:31:22 INFO - 2015-12-16 05:31:22,138 DEBUG : BROWSER_OUTPUT: 05:31:24 INFO - 2015-12-16 05:31:24,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:25 INFO - 2015-12-16 05:31:25,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 180211712 05:31:25 INFO - 2015-12-16 05:31:25,363 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42480/tests/kraken/driver.html?testName=ai-astar) 05:31:27 INFO - 2015-12-16 05:31:27,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 239792128 05:31:27 INFO - 2015-12-16 05:31:27,374 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,377 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:31:27 INFO - 2015-12-16 05:31:27,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:31:27 INFO - 2015-12-16 05:31:27,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:31:27 INFO - 2015-12-16 05:31:27,377 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:31:27 INFO - 2015-12-16 05:31:27,377 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;107;112;112;114;102;112;112;112 05:31:27 INFO - 2015-12-16 05:31:27,377 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;139;150;175;134;151;155;138;174;139 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;161;161;161;161;161;161;161 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;84;91;72;74;71;114;91;74 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;128;95;96;96;135;97;96;132 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;109;109;110;109;109 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;147;147;147;146;146;148;147 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;70;71;72;73;73;73;80;70;71 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;69;68;69;70;69 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;86;85;90;84;84;83;84;86 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;127;119;118;128;128;126;125;128;123 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;150;149;165;141;141;150;161;147;141 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;70;69;69;71;70;69;68;68;68 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:31:27 INFO - 2015-12-16 05:31:27,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1001 05:31:27 INFO - 2015-12-16 05:31:27,379 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:31:27 INFO - 2015-12-16 05:31:27,379 DEBUG : BROWSER_OUTPUT: __startTimestamp1450272687376__endTimestamp 05:31:27 INFO - 2015-12-16 05:31:27,379 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.65 (3.3%) stddev-sans-first:3.87 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 107.0 112.0 112.0 114.0 102.0 112.0 112.0 112.0 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.20 Median:153.00 stddev:14.54 (9.5%) stddev-sans-first:15.27 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: Values: 157.0 139.0 150.0 175.0 134.0 151.0 155.0 138.0 174.0 139.0 05:31:27 INFO - 2015-12-16 05:31:27,382 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 161.0 161.0 161.0 161.0 161.0 161.0 161.0 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:74.00 stddev:13.75 (18.6%) stddev-sans-first:14.13 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 84.0 91.0 72.0 74.0 71.0 114.0 91.0 74.0 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:96.00 stddev:17.31 (18.0%) stddev-sans-first:17.93 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 128.0 95.0 96.0 96.0 135.0 97.0 96.0 132.0 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 05:31:27 INFO - 2015-12-16 05:31:27,383 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 147.0 147.0 147.0 146.0 146.0 148.0 147.0 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:72.50 stddev:2.88 (4.0%) stddev-sans-first:3.05 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 71.0 72.0 73.0 73.0 73.0 80.0 70.0 71.0 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 69.0 68.0 69.0 70.0 69.0 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.00 (2.4%) stddev-sans-first:2.09 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 86.0 85.0 90.0 84.0 84.0 83.0 84.0 86.0 05:31:27 INFO - 2015-12-16 05:31:27,384 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.50 stddev:3.94 (3.1%) stddev-sans-first:3.87 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: Values: 120.0 127.0 119.0 118.0 128.0 128.0 126.0 125.0 128.0 123.0 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:149.50 stddev:8.78 (5.9%) stddev-sans-first:8.63 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: Values: 139.0 150.0 149.0 165.0 141.0 141.0 150.0 161.0 147.0 141.0 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.35 (1.9%) stddev-sans-first:1.05 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 69.0 69.0 71.0 70.0 69.0 68.0 68.0 68.0 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:31:27 INFO - 2015-12-16 05:31:27,385 DEBUG : BROWSER_OUTPUT: 05:31:28 INFO - 2015-12-16 05:31:28,325 INFO : Browser exited with error code: 0 05:31:28 INFO - 2015-12-16 05:31:28,379 INFO : Completed test kraken (00:01:01) 05:31:28 INFO - 2015-12-16 05:31:28,379 INFO : Starting test v8_7 05:31:28 INFO - 2015-12-16 05:31:28,379 DEBUG : operating with platform_type : linux_ 05:31:28 INFO - 2015-12-16 05:31:28,379 INFO : Initialising browser for v8_7 test... 05:31:28 INFO - 2015-12-16 05:31:28,385 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTrIo2v/profile http://localhost:42480/getInfo.html 05:31:32 INFO - 2015-12-16 05:31:32,788 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:31:32 INFO - 2015-12-16 05:31:32,788 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:31:32 INFO - 2015-12-16 05:31:32,788 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:31:32 INFO - 2015-12-16 05:31:32,788 DEBUG : BROWSER_OUTPUT: __metrics 05:31:32 INFO - 2015-12-16 05:31:32,897 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:31:32 INFO - 2015-12-16 05:31:32,961 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:34 INFO - 2015-12-16 05:31:34,055 INFO : Browser initialized. 05:31:34 INFO - 2015-12-16 05:31:34,056 INFO : Running cycle 1/1 for v8_7 test... 05:31:34 INFO - 2015-12-16 05:31:34,056 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTrIo2v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:31:46 INFO - 2015-12-16 05:31:46,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 142606336 05:31:46 INFO - 2015-12-16 05:31:46,161 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42480/tests/v8_7/run.html (next: http://localhost:42480/tests/v8_7/run.html) 05:32:07 INFO - 2015-12-16 05:32:07,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 453795840 05:32:07 INFO - 2015-12-16 05:32:07,802 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,803 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:32:07 INFO - 2015-12-16 05:32:07,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:32:07 INFO - 2015-12-16 05:32:07,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:32:07 INFO - 2015-12-16 05:32:07,803 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:32:07 INFO - 2015-12-16 05:32:07,803 DEBUG : BROWSER_OUTPUT: |0;Richards;167.78523489932886 05:32:07 INFO - 2015-12-16 05:32:07,804 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.04651162790697 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2008.0321285140562 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: |7;RegExp;28000 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: |8;Splay;604.9606775559589 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 05:32:07 INFO - 2015-12-16 05:32:07,805 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: __startTimestamp1450272727802__endTimestamp 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.79 Median:167.79 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: Values: 167.8 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.05 Median:186.05 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: Values: 186.0 05:32:07 INFO - 2015-12-16 05:32:07,806 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: Values: 278.4 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: Values: 5181.3 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2008.03 Median:2008.03 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: Values: 2008.0 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: Values: 789.9 05:32:07 INFO - 2015-12-16 05:32:07,807 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: Values: 12120.5 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28000.00 Median:28000.00 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: Values: 28000.0 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.96 Median:604.96 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: Values: 605.0 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: Values: 4822.1 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:32:07 INFO - 2015-12-16 05:32:07,808 DEBUG : BROWSER_OUTPUT: 05:32:08 INFO - 2015-12-16 05:32:08,695 INFO : Browser exited with error code: 0 05:32:08 INFO - 2015-12-16 05:32:08,709 INFO : Completed test v8_7 (00:00:40) 05:32:08 INFO - 2015-12-16 05:32:08,850 INFO : Completed test suite (00:20:18) 05:32:08 INFO - 2015-12-16 05:32:08,850 DEBUG : Working with test: dromaeo_css 05:32:08 INFO - 2015-12-16 05:32:08,850 DEBUG : Generating results file: dromaeo_css 05:32:08 INFO - 2015-12-16 05:32:08,851 DEBUG : Working with test: kraken 05:32:08 INFO - 2015-12-16 05:32:08,851 DEBUG : Generating results file: kraken 05:32:08 INFO - 2015-12-16 05:32:08,851 INFO : javascript benchmark 05:32:08 INFO - 2015-12-16 05:32:08,852 DEBUG : Working with test: v8_7 05:32:08 INFO - 2015-12-16 05:32:08,852 DEBUG : Generating results file: v8_7 05:32:08 INFO - 2015-12-16 05:32:08,852 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:08 INFO - 2015-12-16 05:32:08,920 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 05:32:08 INFO - 2015-12-16 05:32:08,920 DEBUG : process_Request line: dromaeo_css 6252.58 graph.html#tests=[[72,203,35]] 05:32:08 INFO - 2015-12-16 05:32:08,921 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:08 INFO - 2015-12-16 05:32:08,957 DEBUG : process_Request line: kraken 1531.10 graph.html#tests=[[232,203,35]] 05:32:08 INFO - 2015-12-16 05:32:08,958 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:08 INFO - 2015-12-16 05:32:08,993 DEBUG : process_Request line: v8_7 19702.67 graph.html#tests=[[230,203,35]] 05:32:08 INFO - 2015-12-16 05:32:08,994 INFO : javascript benchmark 05:32:09 INFO - 2015-12-16 05:32:08,998 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2632.973670263297, 2701.743334383234, 2709.390387162888, 2718.4019515706564, 2719.048333083421, 4539.773011349427, 4662.603678687311, 4709.058188362333, 4726.527347265276, 4742.596879265262, 4614.100250451155, 4654.8370807021765, 4699.788509517071, 4705.435347758265, 4755.7622118894005, 4359.367891655708, 4363.6509079273665, 4374.19077470669, 4396.934045989313, 4398.34024896265, 4146.834126634931, 4417.182821178092, 4424.314231294138, 4473.463184417875, 4492.483364413101, 4235.3646952957, 4296.011917259032, 4314.525402205755, 4327.956720432819, 4338.1540599583095, 4388.912221755579, 4398.538153493901, 4404.14119246747, 4410.360497727844, 4458.643308535309, 4151.418801367811, 4247.532771395144, 4372.846950356722, 4378.321360189176, 4432.844850430251, 4567.543245675406, 4594.081183763261, 4704.411948506437, 4707.552782485658, 4742.857714268543, 5030.40574219919, 5034.244863270502, 5047.4447810740785, 5063.0, 5083.05963396769, 4819.5180481951875, 4983.053219888246, 5080.1617733074, 5095.133827249377, 5101.8724531887, 4589.47221069578, 4603.5166307537565, 4630.72215667061, 4721.881952951135, 4741.83403580873, 5230.0, 5230.581553475713, 5242.7378631068295, 5267.499587539178, 5276.868078297996, 5011.473795251519, 5011.824586139541, 5013.899722005613, 5016.498350164954, 5054.696718196847, 4929.556339929351, 4993.90012199754, 5083.593312534988, 5088.185890257541, 5108.6168537359845, 5043.747812609355, 5048.040872234264, 5050.242463630411, 5056.595472362203, 5069.44236134025, 4975.726335051607, 5016.347874776256, 5023.623228257895, 5030.044291584587, 5064.240363945438, 4006.0585762345827, 4107.568705285962, 4109.0549173690215, 4179.9968007677935, 4271.594198551133, 3711.536057992751, 3722.088088418355, 3722.7207959402613, 3742.3825068863875, 3763.2097259575794, 4425.468943726773, 4429.867103986886, 4429.911401771947, 4450.910981780346, 4467.374567560544, 4824.638152138604, 4946.752662366939, 4948.134076536592, 4961.231009193581, 5137.948620513747, 4354.129174165117, 4356.324769660708, 4359.67302452311, 4365.716228445141, 4379.934300985487, 4473.955260447354, 4474.373587697725, 4474.6420286377015, 4479.059397526556, 4513.684042117086, 4647.256438969748, 4691.132140554008, 4766.213574760126, 4771.332013518041, 4826.58973987208, 5070.847874563769, 5090.567301779391, 5090.872728181677, 5094.388673359221, 5119.769610367468, 4847.34560834297, 4850.369451971363, 4854.781534831011, 4858.95141048585, 4878.853634390974, 4813.975930120327, 4907.60739140875, 4911.950880491149, 4911.9754401227765, 5087.974560127176, 5117.078925793393, 5119.180931051014, 5120.48795120485, 5124.718140502308, 5139.100657384868, 4923.753812309442, 4925.458199598113, 4931.087748766489, 4931.802727890844, 4969.35398398206, 4674.182018146878, 4738.620910327235, 4779.187538118459, 4779.283107533898, 4948.0, 4668.369770081132, 4777.689450185727, 4783.04339132168, 4819.927701084416, 4828.975855120702, 5017.523335283142, 5026.824061157842, 5036.439419155179, 5036.571891389126, 5087.974560127176, 4647.3029045643425, 4770.546798054179, 4909.042736666316, 4936.358273424432, 4939.901201975868], "unit": "score", "name": "dojo.html", "value": 4632.403849700151}, {"lowerIsBetter": false, "replicates": [552.0642510943952, 563.6195567991605, 573.6730063863597, 576.4293349583912, 579.7391173971714, 26520.734792652092, 26938.19185424438, 34374.99999999997, 34946.475802862915, 35023.0, 38494.03764905879, 38893.22213555727, 38895.611043889556, 38922.221555568874, 39023.80488097563, 6987.2663370346145, 7933.682652693899, 8110.310623596972, 8112.148224436438, 8121.878171827428, 7092.609906455143, 7187.245339239383, 7189.532680375759, 10126.544305506233, 10432.269741118125, 10005.04952029556, 10167.847482287772, 10174.949125254363, 10177.287589868713, 10177.643782467616, 10078.092971632552, 10188.235882308782, 10190.286679932407, 10195.796084078314, 10196.694099176962, 7185.245549217361, 7362.37419819316, 7367.1527774306105, 7369.4841361104745, 7373.483856130073, 36753.26493470142, 37426.43860342097, 37447.25105497902, 37472.25055498902, 37486.43770343447, 2908.1130255272133, 2934.853257337146, 2935.2661834541364, 3000.5799188113683, 3025.13783571681, 28166.436671266663, 28391.57412638812, 28497.57253641197, 28536.28659283514, 28603.57094643561, 3047.162030441624, 3070.7236348728497, 3091.27355071558, 3121.9687803121906, 3170.0, 207432.9999999985, 207865.0, 207883.0, 208175.0, 209607.0, 51141.0, 51734.22398664023, 51740.22389664158, 51752.482475174766, 51760.0, 55721.442785572435, 55884.72057639686, 55905.720471397384, 56039.43960560424, 56102.719486403126, 12702.872971270353, 14043.1574105554, 14325.212113333866, 14326.785098223534, 14332.785008224884, 9342.439453632804, 9392.060793920553, 9417.670381536613, 11199.888001119885, 11496.94251528737, 17567.73648395275, 17768.200430980636, 17847.375341863233, 17855.107244637715, 17940.461786146436, 7107.786766397016, 7291.4531410144455, 7362.77911662651, 7435.739749108863, 7542.924570754222, 850.8553545897089, 851.1445996773203, 915.3409545127497, 963.4460185393286, 1048.444324508012, 22667.319980400614, 22998.655020174712, 25767.742322576534, 26038.218853434428, 27384.863075684494, 944.617429940875, 979.5983646704817, 987.2940847294219, 1008.909198172168, 1065.5524679634573, 12274.938625306995, 12327.260364378166, 12535.0, 12555.309457979716, 12625.0, 264934.0, 269875.0, 269974.0, 271174.0, 271429.0, 43541.56458435438, 43651.0, 43765.56234437678, 43811.780941095094, 43870.0, 1246.731952630189, 1258.704204511939, 1260.7856664367264, 1263.0211586020723, 1273.5606215855514, 22821.31536053921, 22948.196813111463, 23297.0, 23616.409589760395, 23773.64339534943, 34512.654873451946, 34943.475847861795, 34991.475127873615, 35981.28037439184, 36399.81800090983, 325532.0, 327901.0, 330032.0, 330103.0, 330708.0, 27127.457450851267, 27521.17436476909, 27527.17418477449, 27528.724712753417, 27575.172744817686, 37535.43696844604, 38605.613943860204, 38868.80565597154, 38955.0, 39004.804975976076, 32165.678343217205, 32895.0, 33283.50074748929, 33857.322853543286, 33958.49062264118, 31160.22099447532, 32692.673073269914, 32778.0, 32845.50731738978, 33228.83385583057, 29042.27394315159, 29472.557911630913, 29599.0, 29674.55488167636, 29772.553411699275, 27445.588316175672, 28560.285992850346, 28845.711542884303, 29002.0, 29048.273793155342, 22265.974404973273, 22650.093996240626, 22975.310740677807, 22978.0, 23114.653280201146], "unit": "score", "name": "ext.html", "value": 16665.949195356956}, {"lowerIsBetter": false, "replicates": [335.7616092574272, 335.80187689263346, 335.91731266149867, 336.3525213963121, 343.16097142486615, 12563.371831408438, 12800.295983720891, 14339.498117565887, 14981.400743970242, 16718.41485548006, 9837.114659680645, 10173.084422402, 10178.287519873611, 14778.113313201215, 15183.240837958114, 4403.559644035595, 4508.932366014513, 4514.571115743999, 4515.322701594754, 4519.954800452003, 3459.5848498180126, 3557.92884142317, 4667.953320466803, 5006.424261209971, 5179.404368497633, 5140.691558506483, 5143.485651434845, 5157.948420515784, 5170.482951704837, 5170.844874653766, 5049.2173713074535, 5132.538071573557, 5625.915611265835, 5643.181738647873, 5676.886462270772, 5043.974780126113, 5045.520675535819, 5046.142155833517, 5047.419546752134, 5047.772850221749, 12074.335911524862, 12077.698057548543, 12091.334976576285, 12108.21296615717, 16446.84872058956, 1844.1240410804894, 1852.7684039495064, 1911.206849157612, 1923.951901202467, 1944.7414886473823, 9066.95466522663, 9155.267578593763, 9277.768055798659, 9353.11145441182, 12755.0, 1695.9745603815952, 1730.8788384813067, 1745.7730495035564, 1776.9289228430848, 1794.55136215946, 49071.75464122692, 50974.49025509734, 52235.21647175295, 54278.457215427734, 56542.0, 9308.348415610977, 9692.806143877084, 9971.40171589707, 9974.601015959426, 10027.0, 12641.304728239851, 12653.240805551697, 12671.0, 12672.049596280316, 12703.809442858364, 6940.826479337956, 6983.127109111361, 7003.894941575881, 7013.088298521262, 7014.754483593049, 6553.0, 6582.3746744059235, 6596.505262105361, 6623.768168114189, 6647.700853461509, 4195.7692326922315, 4213.157368526307, 4269.978650106729, 4280.76455794928, 4289.82840686369, 1545.2196640696377, 1643.589102724319, 1673.1634182908547, 1675.304748529371, 1761.709317962522, 860.4407135361939, 861.9913800861912, 862.6635612111281, 874.8337815814975, 944.6268723854176, 15113.848861511464, 15213.695726085416, 15928.362865485482, 15947.60130996711, 16195.271212795453, 737.7823542055106, 787.4684587903142, 807.2815194476921, 858.9398742088118, 920.4063379120564, 8231.0, 8451.873221901677, 8536.957315213509, 8632.91367086321, 8647.697330593399, 489739.0, 490400.0, 492601.0, 506695.0, 516176.0, 69835.30164698287, 72070.27929720741, 73529.26470735332, 73669.47478939101, 74239.0, 1055.1927775251938, 1059.2426415113232, 1074.4735079810994, 1079.9892001080045, 1082.832161015044, 13616.251106189255, 13747.450101995808, 14307.92846035763, 14439.2058436787, 14477.131372117707, 29116.56325155082, 29311.70688293175, 29780.38404047376, 30380.5442918352, 30862.845685771426, 36643.083922901074, 37735.245295093395, 37962.0, 38464.423033655075, 38493.42259866048, 8496.447730897471, 8699.347548933729, 8829.823403532022, 8909.331800115147, 8917.331200159884, 15505.534833955, 15989.1205983672, 16040.759388609413, 16199.43301984425, 16643.750343745094, 12705.872941270469, 12852.550160744702, 13201.20792752438, 13388.598342049754, 13644.795328069888, 12954.28751418681, 13148.934255328662, 13242.271675057964, 13499.190048597116, 13705.177689338672, 9964.352317099365, 12939.223646581235, 13045.282509462071, 13173.077884547989, 13902.374393152535, 8858.557072146496, 9068.863967040632, 9116.863247051433, 9362.344635875423, 9376.765580860532, 13072.673183170496, 13077.738445230852, 13155.0, 13723.519676811264, 14211.076280041763], "unit": "score", "name": "jquery.html", "value": 8008.069456926628}, {"lowerIsBetter": false, "replicates": [1407.2752532445786, 1652.3886162120014, 1687.0, 1713.700102482066, 1738.6435780664965, 5917.88164236715, 7114.217436082034, 7266.30970057845, 7273.599952002638, 7279.563226206431, 7181.605011724353, 7333.376662983653, 7350.705971761123, 7357.0803649543805, 7372.447066470009, 2073.6578464553368, 2110.9577808443823, 2117.3647905628327, 2117.5976564452703, 2118.353902059871, 2086.54096098858, 2110.799474049963, 2118.8516803823663, 2128.861623994443, 2131.5310631661087, 2038.2662241593089, 2064.6696528555435, 2069.9896500517552, 2097.6329142400095, 2100.1809294375207, 2072.8756274623497, 2098.2551194325947, 2101.737282839645, 2105.031685424699, 2106.7998540138738, 1958.8530860185401, 1980.9702854457194, 1994.9202031918705, 1996.371143089922, 1996.550776075386, 7071.0, 7092.50352475327, 7127.322904324081, 7143.642817859086, 7163.534370265916, 4274.508431530352, 4329.935050974238, 4338.175746608166, 4342.761148136851, 4344.543822898581, 2688.8655567221563, 2698.271466703979, 2746.7115952825066, 2758.213909035935, 2775.278427608816, 828.2669837194067, 845.720912099012, 848.7581039403802, 856.1994535109692, 900.4057322167338, 9405.388649737744, 9446.52767361636, 9465.858012129824, 9531.952340238255, 9555.61777528898, 3934.8622798201927, 3955.3473676843, 3998.360262358067, 4000.639942405139, 4032.6773858091283, 8299.253067223979, 8301.29438997692, 8303.626336814857, 8306.584670766437, 8313.08556058833, 4369.060651959844, 4384.69307148503, 4394.231009573312, 4394.824207031683, 4395.780210989437, 3273.459879119966, 3372.1906742381652, 3822.847086116524, 3990.5610382857863, 3997.780122093313, 3450.3271861987173, 3484.7038001769624, 3496.8251587420527, 3522.43641017436, 3538.876139335111, 1117.5306371324064, 1119.1885882734953, 1121.8878112188715, 1124.1512657943201, 1136.63059505661, 1190.5118901250446, 1196.4257156564897, 1197.144042009967, 1209.4678341529698, 1211.8485189351331, 6664.5334826561675, 6731.0, 6732.4950628703045, 6746.257911629717, 6771.695273712695, 433.79177994562156, 438.25715412376354, 444.34237328753625, 446.3884478264798, 447.9417675702138, 5343.385510666323, 5427.6472029317965, 5430.972845135749, 5432.13085906261, 5435.565154787608, 8263.710770123016, 8275.83448331042, 8473.95763021181, 8480.0, 8574.0, 8395.370347223983, 8441.620127094173, 8445.451045682012, 8464.534450605153, 8468.407211495136, 6616.669166541654, 6652.501062420338, 6661.800145995725, 6682.665866706645, 6734.966325168343, 6776.525643204928, 6881.483888708267, 6884.483663725341, 6886.276940921131, 6892.758753443605, 7571.924280757122, 7731.536107833548, 7735.071791385069, 7762.534247945141, 7831.647575858986, 7908.960455197687, 7952.602369881599, 8032.959835200787, 8156.510609363457, 8162.306203972729, 5227.294315267391, 5577.414371490935, 5668.291463567054, 6374.07575901501, 6458.54790164684, 6571.408573228432, 6578.76974305897, 6580.473562115115, 6619.404253617197, 6627.801165965029, 6199.783007594712, 6417.71120299597, 6433.453156481752, 6452.193475815523, 6469.741210351722, 6113.57204995646, 6194.349593292639, 6291.779787707408, 6321.49428045746, 6330.52521060913, 6378.52161087911, 6409.647469389042, 6419.967900160469, 6427.710753016032, 6432.710528026157, 5907.113932910098, 5922.911156332572, 5934.970325148347, 5956.8808623828145, 5963.105534169909, 5955.493783028491, 5991.400859913973, 6009.699515024318, 6026.126211699191, 6029.758809647565], "unit": "score", "name": "mootools.html", "value": 4034.38612222872}, {"lowerIsBetter": false, "replicates": [293.47760985445905, 297.59972836534865, 300.5446748176513, 302.5008735586281, 305.36484113044867, 5269.525742683158, 5337.279467271917, 5383.67697938124, 5452.2094296327, 5476.808311709091, 5341.946580534203, 5397.7031263280505, 5409.702466364349, 5411.702356370398, 5416.593755468346, 3912.6674232690257, 4186.1418409226035, 4201.033762234688, 4202.474690663675, 4204.033072393336, 4025.5974402559655, 4045.1505183911268, 4150.813213405404, 4166.437530933331, 4174.958250417502, 4066.4103704962763, 4108.85619003335, 4112.09533902541, 4117.814698338582, 4120.443740095079, 3858.884233473, 3927.3912543555793, 4006.8597599084183, 4107.603414838954, 4116.526599441057, 3576.159602493412, 3595.4247320428867, 3595.7842529448317, 3609.9819500902327, 3611.7291203159866, 5118.10433174193, 5126.61550383719, 5136.871578210575, 5137.768800403991, 5141.100307446182, 4729.810807567727, 4734.431868175807, 4738.384010078702, 4739.644526660514, 4741.0, 5505.256790333294, 5576.944230557683, 5609.35492418373, 5616.887662246773, 5622.91565626516, 3932.4494570760116, 3933.8623148189677, 3934.5868683788076, 3936.626020528045, 3936.940945885814, 5833.970830145822, 5909.497692696126, 5919.112133180014, 5925.0, 5928.881422371528, 4124.1957818225155, 4125.525564560054, 4131.421600975866, 4131.958680413218, 4133.028738246509, 4093.1404405074672, 4192.559781222928, 4197.286461301586, 4199.097194103282, 4204.705670603028, 4785.0, 4793.520647935178, 4793.688410253392, 4798.064377446364, 4800.807967681323, 5643.71781410936, 5659.660420374791, 5660.26416565852, 5668.659880407189, 5670.8015219467125, 1457.234951650392, 1489.5605796289904, 1491.8209814822292, 1492.7014597080627, 1494.0811400988532, 989.9554520046615, 998.8301988661945, 1018.6943916824923, 1022.6318525330875, 1025.1235193909101, 4972.776225069881, 4987.127252730757, 4987.725675087832, 4988.925166122511, 4990.3762029746285, 5807.070868660994, 5855.707214639251, 5874.236349274567, 5876.7355469004, 5881.823545293648, 4968.950310496921, 4973.925391119136, 4981.12830254704, 4985.252212168204, 4985.326980857611, 3085.3520760640067, 3121.71904528589, 3144.827034513078, 3156.8105913645254, 3156.9684303157132, 5539.307586551681, 5545.972270138624, 5553.305836770403, 5553.8333849984565, 5554.77780888768, 6005.429484198994, 6008.429199226067, 6009.45914867664, 6013.398660134039, 6015.037593984942, 5542.612017158841, 5552.028395030773, 5556.194351818964, 5557.138643510343, 5557.833265002057, 5676.432356764456, 5840.371832675398, 5842.678652674143, 5846.298444186555, 5847.502962248256, 5692.800751973661, 5698.316202055614, 5700.429957004267, 5705.7147142643535, 5708.543316534584, 5539.25220095282, 5546.334439867242, 5548.472895074961, 5549.694766787866, 5556.055470569932, 3993.820278087435, 4084.081081756581, 4086.4891888513935, 4086.959130408658, 4119.588041195856, 5837.737301821513, 5840.0, 5840.415958404125, 5846.444587764156, 5852.7658893643775, 5581.776728930798, 5589.832305030693, 5591.273134492652, 5593.692346920959, 5596.468335508121, 5619.072852979376, 5631.577631677723, 5635.605507614428, 5637.913971830285, 5638.661680299195, 5356.625036247426, 5441.319835020622, 5452.536534394462, 5504.6421982571, 5508.283923089973, 5486.643368181056, 5602.4957753802355, 5607.467290607386, 5628.409017053151, 5653.067243904709, 5448.318960129984, 5493.7802487900035, 5498.670079795225, 5499.240243122163, 5502.119660854244], "unit": "score", "name": "prototype.html", "value": 4238.543196483056}, {"lowerIsBetter": false, "replicates": [666.5300962821211, 697.1355519156248, 737.6717360774455, 738.9741359052427, 742.109468637635, 10316.329438586487, 10622.36265824051, 10631.202659800518, 10634.096101831354, 10657.573697052117, 11665.708357291072, 11682.591109311175, 11713.590024349129, 11723.0621550276, 11730.706732331695, 637.2003136064257, 641.5316818722335, 797.4896066517433, 810.7689308547066, 811.1726039439768, 800.0439474827583, 805.4402190477621, 811.679386642276, 812.0377352836878, 812.9105798362175, 846.6317152038852, 849.2314455417826, 852.6802449081595, 853.5220276645067, 856.8029353248756, 656.6651007985914, 658.9011648252753, 661.5567569728294, 662.4799532367068, 841.2638940926689, 486.2268992302256, 626.4017862940881, 629.6851574212893, 631.7788773929134, 633.6356594957917, 11713.941430292794, 11720.179587428884, 11759.7060073498, 11764.823527647091, 11766.764664706743, 10833.512491937881, 11485.540578376855, 11522.711932201679, 11605.361705106216, 11647.88352116485, 9490.525473726286, 9524.380915240487, 9617.086376794194, 9630.374025688308, 9661.372010819274, 3289.0461766087806, 3300.603927528688, 3324.4680851063713, 3380.6957373836226, 3395.711364534018, 38939.41590876139, 39022.60977390246, 39285.60714392848, 39577.40633890494, 40007.0, 9215.0, 9326.766830829283, 9355.812883742286, 9442.669506567374, 9501.334906556613, 15456.84543154554, 15464.0, 15519.612009699847, 15526.0, 15568.766468502981, 6148.1392605035335, 6232.844178895473, 6250.1874756282305, 6310.05349197624, 6450.9354906450335, 3427.520147179397, 3449.4998225257195, 3519.63043880394, 3563.6080031196548, 3576.213233088716, 2483.3915690655904, 2525.8989640414543, 2530.671012768328, 2534.5944648856093, 2542.995516770865, 423.85800756746835, 427.7989345007904, 431.5878336188932, 433.57509640552433, 438.4234731328293, 535.5233841880729, 577.5264283287664, 589.6933594530819, 610.2737742086903, 613.8066509049635, 6672.933270667231, 7044.894326585106, 7087.362137407658, 8612.612432440555, 8901.910980890108, 425.8105143211241, 475.9952400475951, 544.9999251373695, 578.4533615733176, 616.901295792671, 3610.355236353365, 3630.6913912317223, 3830.6451612903293, 3852.9614703853163, 3896.1038961038553, 47813.28280075802, 48521.0, 48602.0, 48636.27045594319, 48769.512304876494, 42546.787266063475, 42694.146117077486, 43192.56807431886, 43818.0, 44261.77869110634, 39006.804965975556, 39121.80439097843, 39314.41028384576, 39449.80275098606, 39663.60336396657, 7022.613756243456, 7070.893936590853, 7202.49582529218, 7216.386607138242, 7286.599237042014, 33650.83174584111, 34019.0, 34480.65519344775, 37576.62423375731, 38018.239635206584, 41669.1666166681, 42022.36966445445, 42254.15491690087, 43117.568824311355, 43599.56400435955, 10671.893281067401, 10738.624148154777, 10756.085732712807, 10908.7272818177, 11188.776224475629, 10556.947215263874, 10622.575096996343, 10740.62407815754, 11496.54013839437, 12252.877471225174, 10748.838767418338, 10790.460476975963, 11037.282576632493, 11308.660740177807, 11320.490577923849, 10431.63489277902, 10796.244262901522, 10958.45207739594, 10976.506057227603, 11345.886541134483, 10484.580616775549, 10551.366917984946, 10601.310914790514, 10792.244542881923, 10816.459177040959, 9142.3600347975, 9263.86104208424, 9334.53327333617, 9554.856677149988, 9623.5669394876, 9073.546322683971, 9085.318601104811, 9214.216791572524, 9250.444973301623, 9297.72106836796], "unit": "score", "name": "yui.html", "value": 5651.371879321058}], "name": "dromaeo_css", "value": 6252.582290905491}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 107.0, 112.0, 112.0, 114.0, 102.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [157.0, 139.0, 150.0, 175.0, 134.0, 151.0, 155.0, 138.0, 174.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 84.0, 91.0, 72.0, 74.0, 71.0, 114.0, 91.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 128.0, 95.0, 96.0, 96.0, 135.0, 97.0, 96.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 71.0, 72.0, 73.0, 73.0, 73.0, 80.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 85.0, 90.0, 84.0, 84.0, 83.0, 84.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [120.0, 127.0, 119.0, 118.0, 128.0, 128.0, 126.0, 125.0, 128.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [139.0, 150.0, 149.0, 165.0, 141.0, 141.0, 150.0, 161.0, 147.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 69.0, 69.0, 71.0, 70.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1531.1000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.78523489932886], "unit": "score", "name": "Richards", "value": 210.39992}, {"lowerIsBetter": false, "replicates": [186.04651162790697], "unit": "score", "name": "DeltaBlue", "value": 355.38425000000007}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2008.0321285140562], "unit": "score", "name": "RayTrace", "value": 368.51452200000006}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [28000.0], "unit": "score", "name": "RegExp", "value": 32.53517857142855}, {"lowerIsBetter": false, "replicates": [604.9606775559589], "unit": "score", "name": "Splay", "value": 134.70462300000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19702.66834494999}]} 05:32:09 INFO - RETURN: dromaeo_css: 6252.58 05:32:09 INFO - RETURN: kraken: 1531.10 05:32:09 INFO - RETURN: v8_7: 19702.67 05:32:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19702.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1531.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6252.58"}}} 05:32:09 INFO - Return code: 0 05:32:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:32:09 ERROR - # TBPL SUCCESS # 05:32:09 INFO - Running post-action listener: _resource_record_post_action 05:32:09 INFO - Running post-run listener: _resource_record_post_run 05:32:10 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 45056; Write bytes: 515436544; Read time: 188; Write time: 569512 05:32:10 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 238911488; Read time: 0; Write time: 394892 05:32:10 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 45056; Write bytes: 276525056; Read time: 188; Write time: 174620 05:32:10 INFO - Running post-run listener: _upload_blobber_files 05:32:10 INFO - Blob upload gear active. 05:32:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:32:10 INFO - Copying logs to upload dir... 05:32:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.185641 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-16 05:32:10.282799) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:32:10.286919) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009863 build_url: 'https://queue.taskcluster.net/v1/task/ImoexhRoS_q7-BoARN9GQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:32:10.338591) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:32:10.338957) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450271432.389145-1174582110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:32:10.388299) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:32:10.388616) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:32:10.388932) ========= ========= Total master_lag: 0.75 =========