builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1450191677.37 results: success (0) buildid: 20151215054612 builduid: ebe15122e2ad4680820837d73c69a367 revision: cb66ffeb6725e8344818e8e2f707ae2eaeb953b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.373731) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.374205) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.374536) ========= 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=004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.395066) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.395365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.410900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.411164) ========= 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=004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.459955) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.460228) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.460577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.460855) ========= 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=004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 07:01:20-- 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% 25.7M=0s 2015-12-15 07:01:20 (25.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203494 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.676771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.677091) ========= 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=004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.725982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:17.726315) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb66ffeb6725e8344818e8e2f707ae2eaeb953b4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cb66ffeb6725e8344818e8e2f707ae2eaeb953b4 --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=004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 07:01:20,571 truncating revision to first 12 chars 2015-12-15 07:01:20,571 Setting DEBUG logging. 2015-12-15 07:01:20,571 attempt 1/10 2015-12-15 07:01:20,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb66ffeb6725?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 07:01:20,903 unpacking tar archive at: mozilla-central-cb66ffeb6725/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613952 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:18.353205) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:18.353541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:18.362249) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:18.362536) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 07:01:18.362930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-15 07:01:18.363226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:01:21 INFO - MultiFileLogger online at 20151215 07:01:21 in /builds/slave/test 07:01:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:01:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:01:21 INFO - {'append_to_log': False, 07:01:21 INFO - 'base_work_dir': '/builds/slave/test', 07:01:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:01:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:01:21 INFO - 'branch': 'Firefox-Non-PGO', 07:01:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:01:21 INFO - 'config_files': ('talos/linux_config.py',), 07:01:21 INFO - 'default_actions': ('clobber', 07:01:21 INFO - 'read-buildbot-config', 07:01:21 INFO - 'download-and-extract', 07:01:21 INFO - 'populate-webroot', 07:01:21 INFO - 'create-virtualenv', 07:01:21 INFO - 'install', 07:01:21 INFO - 'run-tests'), 07:01:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:01:21 INFO - 'download_minidump_stackwalk': True, 07:01:21 INFO - 'download_symbols': 'ondemand', 07:01:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:01:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:01:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:01:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:01:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:01:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:01:21 INFO - 'installer_path': 'installer.exe', 07:01:21 INFO - 'log_level': 'info', 07:01:21 INFO - 'log_name': 'talos', 07:01:21 INFO - 'log_to_console': True, 07:01:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:01:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:01:21 INFO - 'opt_config_files': (), 07:01:21 INFO - 'pip_index': False, 07:01:21 INFO - 'sps_profile': False, 07:01:21 INFO - 'sps_profile_interval': 0, 07:01:21 INFO - 'suite': 'dromaeojs-e10s', 07:01:21 INFO - 'system_bits': '64', 07:01:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:01:21 INFO - 'title': 'talos-linux64-ix-066', 07:01:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:01:21 INFO - 'use_talos_json': True, 07:01:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:01:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:01:21 INFO - 'work_dir': 'build'} 07:01:21 INFO - ##### 07:01:21 INFO - ##### Running clobber step. 07:01:21 INFO - ##### 07:01:21 INFO - Running pre-action listener: _resource_record_pre_action 07:01:21 INFO - Running main action method: clobber 07:01:21 INFO - rmtree: /builds/slave/test/build 07:01:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:01:22 INFO - Running post-action listener: _resource_record_post_action 07:01:22 INFO - ##### 07:01:22 INFO - ##### Running read-buildbot-config step. 07:01:22 INFO - ##### 07:01:22 INFO - Running pre-action listener: _resource_record_pre_action 07:01:22 INFO - Running main action method: read_buildbot_config 07:01:22 INFO - Using buildbot properties: 07:01:22 INFO - { 07:01:22 INFO - "properties": { 07:01:22 INFO - "buildnumber": 146, 07:01:22 INFO - "product": "firefox", 07:01:22 INFO - "script_repo_revision": "production", 07:01:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:01:22 INFO - "repository": "", 07:01:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:01:22 INFO - "buildid": "20151215054612", 07:01:22 INFO - "slavename": "talos-linux64-ix-066", 07:01:22 INFO - "pgo_build": "False", 07:01:22 INFO - "basedir": "/builds/slave/test", 07:01:22 INFO - "project": "", 07:01:22 INFO - "platform": "ubuntu64_hw", 07:01:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:01:22 INFO - "slavebuilddir": "test", 07:01:22 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:01:22 INFO - "branch": "mozilla-central", 07:01:22 INFO - "repo_path": "mozilla-central", 07:01:22 INFO - "stage_platform": "linux64", 07:01:22 INFO - "builduid": "ebe15122e2ad4680820837d73c69a367", 07:01:22 INFO - "revision": "cb66ffeb6725e8344818e8e2f707ae2eaeb953b4" 07:01:22 INFO - }, 07:01:22 INFO - "sourcestamp": { 07:01:22 INFO - "repository": "", 07:01:22 INFO - "hasPatch": false, 07:01:22 INFO - "project": "", 07:01:22 INFO - "branch": "mozilla-central-linux64-talos", 07:01:22 INFO - "changes": [ 07:01:22 INFO - { 07:01:22 INFO - "category": null, 07:01:22 INFO - "files": [ 07:01:22 INFO - { 07:01:22 INFO - "url": null, 07:01:22 INFO - "name": "https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 07:01:22 INFO - } 07:01:22 INFO - ], 07:01:22 INFO - "repository": "", 07:01:22 INFO - "rev": "cb66ffeb6725e8344818e8e2f707ae2eaeb953b4", 07:01:22 INFO - "who": "cbook@mozilla.com", 07:01:22 INFO - "when": 1450191557, 07:01:22 INFO - "number": 7361976, 07:01:22 INFO - "comments": "Backed out changeset afe3d65b74b6 (bug 1214148) on developers request for causing regressions", 07:01:22 INFO - "project": "", 07:01:22 INFO - "at": "Tue 15 Dec 2015 06:59:17", 07:01:22 INFO - "branch": "mozilla-central-linux64-talos", 07:01:22 INFO - "revlink": "", 07:01:22 INFO - "properties": [ 07:01:22 INFO - [ 07:01:22 INFO - "buildid", 07:01:22 INFO - "20151215054612", 07:01:22 INFO - "Change" 07:01:22 INFO - ], 07:01:22 INFO - [ 07:01:22 INFO - "builduid", 07:01:22 INFO - "ebe15122e2ad4680820837d73c69a367", 07:01:22 INFO - "Change" 07:01:22 INFO - ], 07:01:22 INFO - [ 07:01:22 INFO - "pgo_build", 07:01:22 INFO - "False", 07:01:22 INFO - "Change" 07:01:22 INFO - ] 07:01:22 INFO - ], 07:01:22 INFO - "revision": "cb66ffeb6725e8344818e8e2f707ae2eaeb953b4" 07:01:22 INFO - } 07:01:22 INFO - ], 07:01:22 INFO - "revision": "cb66ffeb6725e8344818e8e2f707ae2eaeb953b4" 07:01:22 INFO - } 07:01:22 INFO - } 07:01:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:01:22 INFO - Running post-action listener: _resource_record_post_action 07:01:22 INFO - ##### 07:01:22 INFO - ##### Running download-and-extract step. 07:01:22 INFO - ##### 07:01:22 INFO - Running pre-action listener: _resource_record_pre_action 07:01:22 INFO - Running main action method: download_and_extract 07:01:22 INFO - mkdir: /builds/slave/test/build/tests 07:01:22 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')]} 07:01:22 INFO - https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/test_packages.json 07:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/test_packages.json 07:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:01:22 INFO - Downloaded 1302 bytes. 07:01:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:01:22 INFO - Using the following test package requirements: 07:01:22 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:22 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:01:22 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:22 INFO - u'jsshell-linux-x86_64.zip'], 07:01:22 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:01:22 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:22 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:01:22 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:01:22 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:01:22 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:22 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:01:22 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:01:22 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')]} 07:01:22 INFO - https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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 07:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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 07:01:23 INFO - Downloaded 21863113 bytes. 07:01:23 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 07:01:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:23 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 07:01:24 INFO - Return code: 0 07:01:24 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 07:01: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')]} 07:01:24 INFO - https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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 07:01:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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 07:01:26 INFO - Downloaded 21863113 bytes. 07:01:26 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 07:01:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:26 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 07:01:27 INFO - Return code: 0 07:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:27 INFO - https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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 07:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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 07:01:29 INFO - Downloaded 11132052 bytes. 07:01:29 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 07:01:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:29 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 07:01:29 INFO - Return code: 0 07:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:29 INFO - https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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 07:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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 07:01:30 INFO - Downloaded 57735216 bytes. 07:01:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:01:30 INFO - mkdir: /builds/slave/test/properties 07:01:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:01:30 INFO - Writing to file /builds/slave/test/properties/build_url 07:01:30 INFO - Contents: 07:01:30 INFO - build_url:https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:01:30 INFO - Running post-action listener: _resource_record_post_action 07:01:30 INFO - Running post-action listener: set_extra_try_arguments 07:01:30 INFO - ##### 07:01:30 INFO - ##### Running populate-webroot step. 07:01:30 INFO - ##### 07:01:30 INFO - Running pre-action listener: _resource_record_pre_action 07:01:30 INFO - Running main action method: populate_webroot 07:01:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:01:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:01:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:01:30 INFO - '--tppagecycles', 07:01:30 INFO - '7'], 07:01:30 INFO - 'tests': ['tsvgm']}}, 07:01:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:01:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:01:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:01:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:01:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:01:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:30 INFO - 'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:01:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:30 INFO - 'tests': ['damp', 'tps']}, 07:01:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:30 INFO - 'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['damp', 'tps']}, 07:01:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:01:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:01:30 INFO - 'other': {'tests': ['a11yr', 07:01:30 INFO - 'ts_paint', 07:01:30 INFO - 'tpaint', 07:01:30 INFO - 'sessionrestore', 07:01:30 INFO - 'sessionrestore_no_auto_restore']}, 07:01:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['a11yr', 07:01:30 INFO - 'ts_paint', 07:01:30 INFO - 'tpaint', 07:01:30 INFO - 'sessionrestore', 07:01:30 INFO - 'sessionrestore_no_auto_restore']}, 07:01:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['a11yr', 07:01:30 INFO - 'ts_paint', 07:01:30 INFO - 'tpaint', 07:01:30 INFO - 'sessionrestore', 07:01:30 INFO - 'sessionrestore_no_auto_restore']}, 07:01:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['a11yr', 07:01:30 INFO - 'ts_paint', 07:01:30 INFO - 'tpaint', 07:01:30 INFO - 'sessionrestore', 07:01:30 INFO - 'sessionrestore_no_auto_restore']}, 07:01:30 INFO - 'other_l64': {'tests': ['a11yr', 07:01:30 INFO - 'ts_paint', 07:01:30 INFO - 'tpaint', 07:01:30 INFO - 'sessionrestore', 07:01:30 INFO - 'sessionrestore_no_auto_restore']}, 07:01:30 INFO - 'other_nol64': {'tests': ['a11yr', 07:01:30 INFO - 'ts_paint', 07:01:30 INFO - 'tpaint', 07:01:30 INFO - 'sessionrestore', 07:01:30 INFO - 'sessionrestore_no_auto_restore']}, 07:01:30 INFO - 'svgr': {'tests': ['tsvgx', 07:01:30 INFO - 'tsvgr_opacity', 07:01:30 INFO - 'tart', 07:01:30 INFO - 'tscrollx', 07:01:30 INFO - 'cart']}, 07:01:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['tsvgx', 07:01:30 INFO - 'tsvgr_opacity', 07:01:30 INFO - 'tart', 07:01:30 INFO - 'tscrollx', 07:01:30 INFO - 'cart']}, 07:01:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:30 INFO - 'tests': ['tp5o']}, 07:01:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:30 INFO - 'talos_options': ['--e10s'], 07:01:30 INFO - 'tests': ['tp5o']}, 07:01:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:30 INFO - 'talos_options': ['--xperf_path', 07:01:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:01:30 INFO - 'tests': ['tp5n']}, 07:01:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:30 INFO - 'talos_options': ['--e10s', 07:01:30 INFO - '--xperf_path', 07:01:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:01:30 INFO - 'tests': ['tp5n']}}, 07:01:30 INFO - 'talos.zip': {'path': '', 07:01:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:01:30 INFO - Running post-action listener: _resource_record_post_action 07:01:30 INFO - ##### 07:01:30 INFO - ##### Running create-virtualenv step. 07:01:30 INFO - ##### 07:01:30 INFO - Running pre-action listener: _resource_record_pre_action 07:01:30 INFO - Running main action method: create_virtualenv 07:01:30 INFO - Creating virtualenv /builds/slave/test/build/venv 07:01:30 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 07:01:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:01:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:01:30 INFO - Using real prefix '/usr' 07:01:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:01:31 INFO - Installing distribute.............................................................................................................................................................................................done. 07:01:33 INFO - Installing pip.................done. 07:01:33 INFO - Return code: 0 07:01:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:01:33 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')]} 07:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:33 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')]} 07:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:33 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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:33 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 07:01:33 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 07:01:33 INFO - Using env: {'DISPLAY': ':0', 07:01:33 INFO - 'HOME': '/home/cltbld', 07:01:33 INFO - 'LANG': 'en_US.UTF-8', 07:01:33 INFO - 'LANGUAGE': 'en_US:en', 07:01:33 INFO - 'LOGNAME': 'cltbld', 07:01:33 INFO - 'MAIL': '/var/mail/cltbld', 07:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:33 INFO - 'MOZ_NO_REMOTE': '1', 07:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:33 INFO - 'NO_EM_RESTART': '1', 07:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:33 INFO - 'PWD': '/builds/slave/test', 07:01:33 INFO - 'SHELL': '/bin/bash', 07:01:33 INFO - 'SHLVL': '1', 07:01:33 INFO - 'TERM': 'linux', 07:01:33 INFO - 'TMOUT': '86400', 07:01:33 INFO - 'USER': 'cltbld', 07:01:33 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:33 INFO - '_': '/tools/buildbot/bin/python'} 07:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:33 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 07:01:33 INFO - Cleaning up... 07:01:33 INFO - Return code: 0 07:01:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:01:33 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')]} 07:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:33 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')]} 07:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:33 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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:33 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 07:01:33 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 07:01:33 INFO - Using env: {'DISPLAY': ':0', 07:01:33 INFO - 'HOME': '/home/cltbld', 07:01:33 INFO - 'LANG': 'en_US.UTF-8', 07:01:33 INFO - 'LANGUAGE': 'en_US:en', 07:01:33 INFO - 'LOGNAME': 'cltbld', 07:01:33 INFO - 'MAIL': '/var/mail/cltbld', 07:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:33 INFO - 'MOZ_NO_REMOTE': '1', 07:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:33 INFO - 'NO_EM_RESTART': '1', 07:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:33 INFO - 'PWD': '/builds/slave/test', 07:01:33 INFO - 'SHELL': '/bin/bash', 07:01:33 INFO - 'SHLVL': '1', 07:01:33 INFO - 'TERM': 'linux', 07:01:33 INFO - 'TMOUT': '86400', 07:01:33 INFO - 'USER': 'cltbld', 07:01:33 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:33 INFO - '_': '/tools/buildbot/bin/python'} 07:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:33 INFO - Downloading/unpacking psutil>=0.7.1 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:01:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:01:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:01:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:01:35 INFO - Installing collected packages: psutil 07:01:35 INFO - Running setup.py install for psutil 07:01:35 INFO - building 'psutil._psutil_linux' extension 07:01:35 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 07:01:35 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 07:01:35 INFO - building 'psutil._psutil_posix' extension 07:01:35 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 07:01:35 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 07:01:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:01:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:01:35 INFO - Successfully installed psutil 07:01:35 INFO - Cleaning up... 07:01:36 INFO - Return code: 0 07:01:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:36 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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:36 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 07:01:36 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 07:01:36 INFO - Using env: {'DISPLAY': ':0', 07:01:36 INFO - 'HOME': '/home/cltbld', 07:01:36 INFO - 'LANG': 'en_US.UTF-8', 07:01:36 INFO - 'LANGUAGE': 'en_US:en', 07:01:36 INFO - 'LOGNAME': 'cltbld', 07:01:36 INFO - 'MAIL': '/var/mail/cltbld', 07:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:36 INFO - 'MOZ_NO_REMOTE': '1', 07:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:36 INFO - 'NO_EM_RESTART': '1', 07:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:36 INFO - 'PWD': '/builds/slave/test', 07:01:36 INFO - 'SHELL': '/bin/bash', 07:01:36 INFO - 'SHLVL': '1', 07:01:36 INFO - 'TERM': 'linux', 07:01:36 INFO - 'TMOUT': '86400', 07:01:36 INFO - 'USER': 'cltbld', 07:01:36 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:36 INFO - '_': '/tools/buildbot/bin/python'} 07:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:01:36 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 07:01:36 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 07:01:36 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 07:01:36 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 07:01:36 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 07:01:36 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 07:01:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:01:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:01:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:01:37 INFO - Installing collected packages: mozsystemmonitor 07:01:37 INFO - Running setup.py install for mozsystemmonitor 07:01:38 INFO - Successfully installed mozsystemmonitor 07:01:38 INFO - Cleaning up... 07:01:38 INFO - Return code: 0 07:01:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:01:38 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')]} 07:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:38 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')]} 07:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:38 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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:38 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 07:01:38 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 07:01:38 INFO - Using env: {'DISPLAY': ':0', 07:01:38 INFO - 'HOME': '/home/cltbld', 07:01:38 INFO - 'LANG': 'en_US.UTF-8', 07:01:38 INFO - 'LANGUAGE': 'en_US:en', 07:01:38 INFO - 'LOGNAME': 'cltbld', 07:01:38 INFO - 'MAIL': '/var/mail/cltbld', 07:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:38 INFO - 'MOZ_NO_REMOTE': '1', 07:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:38 INFO - 'NO_EM_RESTART': '1', 07:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:38 INFO - 'PWD': '/builds/slave/test', 07:01:38 INFO - 'SHELL': '/bin/bash', 07:01:38 INFO - 'SHLVL': '1', 07:01:38 INFO - 'TERM': 'linux', 07:01:38 INFO - 'TMOUT': '86400', 07:01:38 INFO - 'USER': 'cltbld', 07:01:38 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:38 INFO - '_': '/tools/buildbot/bin/python'} 07:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:01:38 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 07:01:38 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 07:01:38 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 07:01:38 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 07:01:38 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 07:01:38 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 07:01:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:01:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:01:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:01:40 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 07:01:40 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 07:01:40 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 07:01:40 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 07:01:40 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 07:01:40 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 07:01:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:01:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:01:40 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 07:01:40 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 07:01:40 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 07:01:40 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 07:01:40 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 07:01:40 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 07:01:40 INFO - Downloading docopt-0.6.1.tar.gz 07:01:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:01:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:01:40 INFO - Running setup.py install for blobuploader 07:01:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:01:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:01:40 INFO - Running setup.py install for requests 07:01:41 INFO - Running setup.py install for docopt 07:01:41 INFO - Successfully installed blobuploader requests docopt 07:01:41 INFO - Cleaning up... 07:01:41 INFO - Return code: 0 07:01:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:41 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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:41 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 07:01:41 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 07:01:41 INFO - Using env: {'DISPLAY': ':0', 07:01:41 INFO - 'HOME': '/home/cltbld', 07:01:41 INFO - 'LANG': 'en_US.UTF-8', 07:01:41 INFO - 'LANGUAGE': 'en_US:en', 07:01:41 INFO - 'LOGNAME': 'cltbld', 07:01:41 INFO - 'MAIL': '/var/mail/cltbld', 07:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:41 INFO - 'MOZ_NO_REMOTE': '1', 07:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:41 INFO - 'NO_EM_RESTART': '1', 07:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:41 INFO - 'PWD': '/builds/slave/test', 07:01:41 INFO - 'SHELL': '/bin/bash', 07:01:41 INFO - 'SHLVL': '1', 07:01:41 INFO - 'TERM': 'linux', 07:01:41 INFO - 'TMOUT': '86400', 07:01:41 INFO - 'USER': 'cltbld', 07:01:41 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:41 INFO - '_': '/tools/buildbot/bin/python'} 07:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:41 INFO - Running setup.py (path:/tmp/pip-zcr5d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:41 INFO - Running setup.py (path:/tmp/pip-Jcuffo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:41 INFO - Running setup.py (path:/tmp/pip-MRqk2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:41 INFO - Running setup.py (path:/tmp/pip-luejk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:41 INFO - Running setup.py (path:/tmp/pip-cNtVXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:41 INFO - Running setup.py (path:/tmp/pip-V8s8Wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:41 INFO - Running setup.py (path:/tmp/pip-Qe5g8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:41 INFO - Running setup.py (path:/tmp/pip-lOtPjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:42 INFO - Running setup.py (path:/tmp/pip-I_M6pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:42 INFO - Running setup.py (path:/tmp/pip-xjSjp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:42 INFO - Running setup.py (path:/tmp/pip-xm8MHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:42 INFO - Running setup.py (path:/tmp/pip-f5flE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:42 INFO - Running setup.py (path:/tmp/pip-iIsWeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:42 INFO - Running setup.py (path:/tmp/pip-Fe3rVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:42 INFO - Running setup.py (path:/tmp/pip-9oLFWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:42 INFO - Running setup.py (path:/tmp/pip-LVUN6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:42 INFO - Running setup.py (path:/tmp/pip-SErFdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:01:42 INFO - Running setup.py install for manifestparser 07:01:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:01:42 INFO - Running setup.py install for mozcrash 07:01:42 INFO - Running setup.py install for mozdebug 07:01:42 INFO - Running setup.py install for mozdevice 07:01:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Running setup.py install for mozfile 07:01:43 INFO - Running setup.py install for mozhttpd 07:01:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Running setup.py install for mozinfo 07:01:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Running setup.py install for mozInstall 07:01:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Running setup.py install for mozleak 07:01:43 INFO - Running setup.py install for mozlog 07:01:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Running setup.py install for moznetwork 07:01:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:01:43 INFO - Running setup.py install for mozprocess 07:01:43 INFO - Running setup.py install for mozprofile 07:01:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:01:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:01:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:01:44 INFO - Running setup.py install for mozrunner 07:01:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:01:44 INFO - Running setup.py install for mozscreenshot 07:01:44 INFO - Running setup.py install for moztest 07:01:44 INFO - Running setup.py install for mozversion 07:01:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:01:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:01:44 INFO - Cleaning up... 07:01:44 INFO - Return code: 0 07:01:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:44 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 07:01:44 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 07:01:44 INFO - Using env: {'DISPLAY': ':0', 07:01:44 INFO - 'HOME': '/home/cltbld', 07:01:44 INFO - 'LANG': 'en_US.UTF-8', 07:01:44 INFO - 'LANGUAGE': 'en_US:en', 07:01:44 INFO - 'LOGNAME': 'cltbld', 07:01:44 INFO - 'MAIL': '/var/mail/cltbld', 07:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:44 INFO - 'MOZ_NO_REMOTE': '1', 07:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:44 INFO - 'NO_EM_RESTART': '1', 07:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:44 INFO - 'PWD': '/builds/slave/test', 07:01:44 INFO - 'SHELL': '/bin/bash', 07:01:44 INFO - 'SHLVL': '1', 07:01:44 INFO - 'TERM': 'linux', 07:01:44 INFO - 'TMOUT': '86400', 07:01:44 INFO - 'USER': 'cltbld', 07:01:44 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:44 INFO - '_': '/tools/buildbot/bin/python'} 07:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:44 INFO - Running setup.py (path:/tmp/pip-k1oZkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:44 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)) 07:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:44 INFO - Running setup.py (path:/tmp/pip-3BbKRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:44 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)) 07:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:44 INFO - Running setup.py (path:/tmp/pip-0f9JuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:44 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)) 07:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:44 INFO - Running setup.py (path:/tmp/pip-3jmv38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:44 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)) 07:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:44 INFO - Running setup.py (path:/tmp/pip-yK6yG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:45 INFO - Running setup.py (path:/tmp/pip-t5TVAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:45 INFO - Running setup.py (path:/tmp/pip-Hj3zMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:45 INFO - Running setup.py (path:/tmp/pip-FZ8oPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:45 INFO - Running setup.py (path:/tmp/pip-1NoiY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:45 INFO - Running setup.py (path:/tmp/pip-7ScQR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:45 INFO - Running setup.py (path:/tmp/pip-92lPNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:45 INFO - Running setup.py (path:/tmp/pip-YeMgfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:45 INFO - Running setup.py (path:/tmp/pip-FpXp7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:45 INFO - Running setup.py (path:/tmp/pip-pDHecw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:45 INFO - Running setup.py (path:/tmp/pip-x9x7vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:45 INFO - Running setup.py (path:/tmp/pip-yyzEwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01:45 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)) 07:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:45 INFO - Running setup.py (path:/tmp/pip-yecYqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01:45 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)) 07:01:45 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)) 07:01:45 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)) 07:01:45 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)) 07:01:45 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)) 07:01:45 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)) 07:01:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:01:45 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 07:01:45 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 07:01:45 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 07:01:45 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 07:01:45 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 07:01:45 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 07:01:47 INFO - Downloading blessings-1.5.1.tar.gz 07:01:47 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 07:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:01:47 INFO - Installing collected packages: blessings 07:01:47 INFO - Running setup.py install for blessings 07:01:47 INFO - Successfully installed blessings 07:01:47 INFO - Cleaning up... 07:01:47 INFO - Return code: 0 07:01:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:01:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:48 INFO - Reading from file tmpfile_stdout 07:01:48 INFO - Current package versions: 07:01:48 INFO - argparse == 1.2.1 07:01:48 INFO - blessings == 1.5.1 07:01:48 INFO - blobuploader == 1.2.4 07:01:48 INFO - docopt == 0.6.1 07:01:48 INFO - manifestparser == 1.1 07:01:48 INFO - mozInstall == 1.12 07:01:48 INFO - mozcrash == 0.16 07:01:48 INFO - mozdebug == 0.1 07:01:48 INFO - mozdevice == 0.47 07:01:48 INFO - mozfile == 1.2 07:01:48 INFO - mozhttpd == 0.7 07:01:48 INFO - mozinfo == 0.9 07:01:48 INFO - mozleak == 0.1 07:01:48 INFO - mozlog == 3.1 07:01:48 INFO - moznetwork == 0.27 07:01:48 INFO - mozprocess == 0.22 07:01:48 INFO - mozprofile == 0.27 07:01:48 INFO - mozrunner == 6.11 07:01:48 INFO - mozscreenshot == 0.1 07:01:48 INFO - mozsystemmonitor == 0.0 07:01:48 INFO - moztest == 0.7 07:01:48 INFO - mozversion == 1.4 07:01:48 INFO - psutil == 3.1.1 07:01:48 INFO - requests == 1.2.3 07:01:48 INFO - wsgiref == 0.1.2 07:01:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:48 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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:48 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 07:01:48 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 07:01:48 INFO - Using env: {'DISPLAY': ':0', 07:01:48 INFO - 'HOME': '/home/cltbld', 07:01:48 INFO - 'LANG': 'en_US.UTF-8', 07:01:48 INFO - 'LANGUAGE': 'en_US:en', 07:01:48 INFO - 'LOGNAME': 'cltbld', 07:01:48 INFO - 'MAIL': '/var/mail/cltbld', 07:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:48 INFO - 'MOZ_NO_REMOTE': '1', 07:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:48 INFO - 'NO_EM_RESTART': '1', 07:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:48 INFO - 'PWD': '/builds/slave/test', 07:01:48 INFO - 'SHELL': '/bin/bash', 07:01:48 INFO - 'SHLVL': '1', 07:01:48 INFO - 'TERM': 'linux', 07:01:48 INFO - 'TMOUT': '86400', 07:01:48 INFO - 'USER': 'cltbld', 07:01:48 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:48 INFO - '_': '/tools/buildbot/bin/python'} 07:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 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)) 07:01:48 INFO - Cleaning up... 07:01:48 INFO - Return code: 0 07:01:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:48 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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:48 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 07:01:48 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 07:01:48 INFO - Using env: {'DISPLAY': ':0', 07:01:48 INFO - 'HOME': '/home/cltbld', 07:01:48 INFO - 'LANG': 'en_US.UTF-8', 07:01:48 INFO - 'LANGUAGE': 'en_US:en', 07:01:48 INFO - 'LOGNAME': 'cltbld', 07:01:48 INFO - 'MAIL': '/var/mail/cltbld', 07:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:48 INFO - 'MOZ_NO_REMOTE': '1', 07:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:48 INFO - 'NO_EM_RESTART': '1', 07:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:48 INFO - 'PWD': '/builds/slave/test', 07:01:48 INFO - 'SHELL': '/bin/bash', 07:01:48 INFO - 'SHLVL': '1', 07:01:48 INFO - 'TERM': 'linux', 07:01:48 INFO - 'TMOUT': '86400', 07:01:48 INFO - 'USER': 'cltbld', 07:01:48 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:48 INFO - '_': '/tools/buildbot/bin/python'} 07:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:48 INFO - Downloading/unpacking jsonschema 07:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:01:50 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 07:01:50 INFO - Downloading/unpacking functools32 (from jsonschema) 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 INFO - Downloading functools32-3.2.3-2.tar.gz 07:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:01:50 INFO - warning: no files found matching '*.txt' 07:01:50 INFO - no previously-included directories found matching 'build' 07:01:50 INFO - no previously-included directories found matching 'dist' 07:01:50 INFO - no previously-included directories found matching '.git*' 07:01:50 INFO - Installing collected packages: jsonschema, functools32 07:01:50 INFO - Running setup.py install for functools32 07:01:50 INFO - warning: no files found matching '*.txt' 07:01:50 INFO - no previously-included directories found matching 'build' 07:01:50 INFO - no previously-included directories found matching 'dist' 07:01:50 INFO - no previously-included directories found matching '.git*' 07:01:50 INFO - Successfully installed jsonschema functools32 07:01:50 INFO - Cleaning up... 07:01:50 INFO - Return code: 0 07:01:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:50 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 0x7f44e2c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, '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': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', '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 07:01:50 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 07:01:50 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 07:01:50 INFO - Using env: {'DISPLAY': ':0', 07:01:50 INFO - 'HOME': '/home/cltbld', 07:01:50 INFO - 'LANG': 'en_US.UTF-8', 07:01:50 INFO - 'LANGUAGE': 'en_US:en', 07:01:50 INFO - 'LOGNAME': 'cltbld', 07:01:50 INFO - 'MAIL': '/var/mail/cltbld', 07:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:50 INFO - 'MOZ_NO_REMOTE': '1', 07:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:50 INFO - 'NO_EM_RESTART': '1', 07:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:50 INFO - 'PWD': '/builds/slave/test', 07:01:50 INFO - 'SHELL': '/bin/bash', 07:01:50 INFO - 'SHLVL': '1', 07:01:50 INFO - 'TERM': 'linux', 07:01:50 INFO - 'TMOUT': '86400', 07:01:50 INFO - 'USER': 'cltbld', 07:01:50 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:50 INFO - '_': '/tools/buildbot/bin/python'} 07:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:50 INFO - Downloading/unpacking flake8 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:01:52 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 07:01:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:01:52 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 07:01:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:52 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 07:01:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:01:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:53 INFO - no previously-included directories found matching 'docs/_build' 07:01:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:01:53 INFO - Running setup.py install for pep8 07:01:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:53 INFO - no previously-included directories found matching 'docs/_build' 07:01:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:01:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:01:53 INFO - Cleaning up... 07:01:53 INFO - Return code: 0 07:01:53 INFO - Running post-action listener: _resource_record_post_action 07:01:53 INFO - Running post-action listener: _start_resource_monitoring 07:01:53 INFO - Starting resource monitoring. 07:01:53 INFO - ##### 07:01:53 INFO - ##### Running install step. 07:01:53 INFO - ##### 07:01:53 INFO - Running pre-action listener: _resource_record_pre_action 07:01:53 INFO - Running main action method: install 07:01:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:53 INFO - Reading from file tmpfile_stdout 07:01:53 INFO - Detecting whether we're running mozinstall >=1.0... 07:01:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:01:53 INFO - Reading from file tmpfile_stdout 07:01:53 INFO - Output received: 07:01:53 INFO - Usage: mozinstall [options] installer 07:01:53 INFO - Options: 07:01:53 INFO - -h, --help show this help message and exit 07:01:53 INFO - -d DEST, --destination=DEST 07:01:53 INFO - Directory to install application into. [default: 07:01:53 INFO - "/builds/slave/test"] 07:01:53 INFO - --app=APP Application being installed. [default: firefox] 07:01:53 INFO - mkdir: /builds/slave/test/build/application 07:01:53 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'] 07:01:53 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 07:02:08 INFO - Reading from file tmpfile_stdout 07:02:08 INFO - Output received: 07:02:08 INFO - /builds/slave/test/build/application/firefox/firefox 07:02:08 INFO - Running post-action listener: _resource_record_post_action 07:02:08 INFO - ##### 07:02:08 INFO - ##### Running run-tests step. 07:02:08 INFO - ##### 07:02:08 INFO - Running pre-action listener: _resource_record_pre_action 07:02:08 INFO - Running main action method: run_tests 07:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:02:08 INFO - Python 2.7.3 07:02:08 INFO - Return code: 0 07:02:08 INFO - grabbing minidump binary from tooltool 07:02: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')]} 07:02:08 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 0xf350b0>, '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 0xf35fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf36440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:02:08 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 07:02:08 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 07:02:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:02:08 INFO - Return code: 0 07:02:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:02:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:02:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:02:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:02:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:02:09 INFO - Return code: 0 07:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] in /builds/slave/test/build 07:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost 07:02:09 INFO - Using env: {'DISPLAY': ':0', 07:02:09 INFO - 'HOME': '/home/cltbld', 07:02:09 INFO - 'LANG': 'en_US.UTF-8', 07:02:09 INFO - 'LANGUAGE': 'en_US:en', 07:02:09 INFO - 'LOGNAME': 'cltbld', 07:02:09 INFO - 'MAIL': '/var/mail/cltbld', 07:02:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:02:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:09 INFO - 'MOZ_NO_REMOTE': '1', 07:02:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:09 INFO - 'NO_EM_RESTART': '1', 07:02:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:09 INFO - 'PWD': '/builds/slave/test', 07:02:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:02:09 INFO - 'SHELL': '/bin/bash', 07:02:09 INFO - 'SHLVL': '1', 07:02:09 INFO - 'TERM': 'linux', 07:02:09 INFO - 'TMOUT': '86400', 07:02:09 INFO - 'USER': 'cltbld', 07:02:09 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611', 07:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:09 INFO - '_': '/tools/buildbot/bin/python'} 07:02:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] with output_timeout 3600 07:02:09 INFO - mozversion INFO | application_buildid: 20151215054612 07:02:09 INFO - mozversion INFO | application_changeset: cb66ffeb6725e8344818e8e2f707ae2eaeb953b4 07:02:09 INFO - mozversion INFO | application_display_name: Nightly 07:02:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:02:09 INFO - mozversion INFO | application_name: Firefox 07:02:09 INFO - mozversion INFO | application_remotingname: firefox 07:02:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:02:09 INFO - mozversion INFO | application_vendor: Mozilla 07:02:09 INFO - mozversion INFO | application_version: 46.0a1 07:02:09 INFO - mozversion INFO | platform_buildid: 20151215054612 07:02:09 INFO - mozversion INFO | platform_changeset: cb66ffeb6725e8344818e8e2f707ae2eaeb953b4 07:02:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:02:09 INFO - mozversion INFO | platform_version: 46.0a1 07:02:09 INFO - 2015-12-15 07:02:09,579 DEBUG : using testdate: 1450191729 07:02:09 INFO - 2015-12-15 07:02:09,579 DEBUG : actual date: 1450191729 07:02:09 INFO - 2015-12-15 07:02:09,587 INFO : starting webserver on 'localhost:50095' 07:02:09 INFO - 2015-12-15 07:02:09,588 INFO : Starting test suite talos-linux64-ix-066.e 07:02:09 INFO - 2015-12-15 07:02:09,588 INFO : Starting test dromaeo_css 07:02:09 INFO - 2015-12-15 07:02:09,588 DEBUG : operating with platform_type : linux_ 07:02:09 INFO - 2015-12-15 07:02:09,589 INFO : Initialising browser for dromaeo_css test... 07:02:09 INFO - 2015-12-15 07:02:09,603 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5sOOZ1/profile http://localhost:50095/getInfo.html 07:02:14 INFO - 2015-12-15 07:02:14,515 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:02:14 INFO - 2015-12-15 07:02:14,515 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:02:14 INFO - 2015-12-15 07:02:14,515 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:02:14 INFO - 2015-12-15 07:02:14,515 DEBUG : BROWSER_OUTPUT: __metrics 07:02:14 INFO - 2015-12-15 07:02:14,652 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] 07:02:15 INFO - 2015-12-15 07:02:15,546 INFO : Browser initialized. 07:02:15 INFO - 2015-12-15 07:02:15,547 INFO : Running cycle 1/1 for dromaeo_css test... 07:02:15 INFO - 2015-12-15 07:02:15,547 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5sOOZ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:02:27 INFO - 2015-12-15 07:02:27,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 143568896 07:02:27 INFO - 2015-12-15 07:02:27,589 DEBUG : BROWSER_OUTPUT: 07:03:17 INFO - 2015-12-15 07:03:17,235 DEBUG : BROWSER_OUTPUT: 1450191797232 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] 07:05:29 INFO - 2015-12-15 07:05:29,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50095/tests/dromaeo/cssquery-ext.html) 07:05:30 INFO - 2015-12-15 07:05:30,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 147501056 07:05:30 INFO - 2015-12-15 07:05:30,430 DEBUG : BROWSER_OUTPUT: 07:08:32 INFO - 2015-12-15 07:08:32,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/dromaeo/cssquery-ext.html (next: http://localhost:50095/tests/dromaeo/cssquery-jquery.html) 07:08:33 INFO - 2015-12-15 07:08:33,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 145211392 07:08:33 INFO - 2015-12-15 07:08:33,115 DEBUG : BROWSER_OUTPUT: 07:11:34 INFO - 2015-12-15 07:11:34,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50095/tests/dromaeo/cssquery-mootools.html) 07:11:35 INFO - 2015-12-15 07:11:35,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 145928192 07:11:35 INFO - 2015-12-15 07:11:35,463 DEBUG : BROWSER_OUTPUT: 07:14:37 INFO - 2015-12-15 07:14:37,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50095/tests/dromaeo/cssquery-prototype.html) 07:14:37 INFO - 2015-12-15 07:14:37,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 144551936 07:14:37 INFO - 2015-12-15 07:14:37,829 DEBUG : BROWSER_OUTPUT: 07:17:40 INFO - 2015-12-15 07:17:40,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50095/tests/dromaeo/cssquery-yui.html) 07:17:41 INFO - 2015-12-15 07:17:41,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 145637376 07:17:41 INFO - 2015-12-15 07:17:41,035 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/dromaeo/cssquery-yui.html (next: http://localhost:50095/tests/dromaeo/cssquery-dojo.html) 07:20:43 INFO - 2015-12-15 07:20:43,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 147963904 07:20:43 INFO - 2015-12-15 07:20:43,630 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,630 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:20:43 INFO - 2015-12-15 07:20:43,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:20:43 INFO - 2015-12-15 07:20:43,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:20:43 INFO - 2015-12-15 07:20:43,631 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:20:43 INFO - 2015-12-15 07:20:43,631 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2652.9469410611778;2678.6963211637994;2692.5288074586942;2708.2958430808;2717.57877528983;4732.290156476531;4829.541193586612;4835;4850.63620228483;4854.490278520749;4805.663603547753;4816.157172494808;4816.783244753986;4924.409070911487;4925.7783399747;4450.376947227391;4504.0316331988615;4567.0409214065085;4584.426946631671;4605.631549476051;4440.111977604492;4471.4187155669715;4491.236489796726;4527.886802829923;4561.042181141947;4295.656347492193;4390.4511936008;4458;4486.327050942368;4530.705504142253;4429.822807087713;4430.313301438282;4454.643628509744;4459.665525085599;4465.464144302672;4397.164538737629;4399.23013472641;4406.581374769392;4417.315316126005;4456.331550267486;4545.499995000548;4671.929921051187;4692.178868697998;4701.952980470186;4703.388559487279;5094.083065048289;5130.384353877558;5176.844694659167;5265;5332.3601167859715;5290.232916227164;5295.947040529584;5298.602604804617;5303.522682958553;5308.761105750251;4666.230072038144;4885.7312847793;4888.560029597354;4897.51024897511;4924.729139897304;5260.868478287997;5296.92054619181;5347.51872331492;5362.839114826562;5392.40683524812;5098.745062746848;5115.309433226466;5118.97440512795;5125.641205115606;5168.3797944246935;4959.082569724613;5059.089363914531;5217.7912883485;5234.97382513085;5236.29310043147;5070.4929507049;5105.438401775802;5109.591232701449;5127.9230811537855;5153.613478989091;5096.770645320969;5122.1804511278015;5124.92312615311;5131.974340128276;5164.66429682077;4280.357946308079;4283.957160428418;4296.2481565725875;4322.935155972663;4329.242382583098;3652.6164752701116;3710.2950439416422;3758.699304055669;3768.717346199046;3798.088458769875;4512.278035514302;4523.479799822997;4542.863714088583;4547.47704014036;4600.2869555218995;5205.349331333583;5263.710495922761;5278.9472105278455;5279.788808447696;5319.175527793198;4309.913801723948;4404.757738324423;4431.8670439886855;4478.641708663299;4523.095380923828;4562.954370456319;4583.106294272585;4616.16908956391;4616.469106052847;4664.043871006435;4819.277108433623;4917.041176970528;4956.950430495649;4972.627052970969;4995.100881841304;5094.955534115572;5111.565516931102;5147.897042059213;5154.458781828004;5179.611529135254;4834.806607735792;4953.851384458472;4959.97520012412;4987.0524600325825;5002.549770520671;4847.587955023862;4964.776585053609;5136.871578210575;5146.511081447256;5158.277841102174;5067.721275329893;5111.182210846247;5135.717535535581;5136.6147538935475;5192.350956130484;5027.2207807789855;5034.219695947134;5039.924401133912;5065;5070.467600901852;4838.467768545527;4949.802007919643;4970.975145124251;4993.151164302005;5029.1953287473825;4871.3667223260745;4893.290472881484;4941.061198372297;4961.454240033666;5011.899762004812;5054.671446355975;5070.41690205631;5076.82231121909;5076.873078173076;5145.691258524501;4715.81136754526;4800.951990480051;4803.663743538059;4814.903701925872;5027.271045698426 07:20:43 INFO - 2015-12-15 07:20:43,631 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.3684604819578;571.1176232720446;571.6312978129107;575.1832397994847;579.0850456279079;35126.824365878165;35731.4640280396;35776.46335304972;35807.46288805664;35947;40679;41088;41098.178036439254;41202.58797412025;41256.58743412565;8011.559364234965;8146.103928567853;8148.266656000958;8149.674013039471;8152.75541733746;7921.128675845653;7928.16754240805;8000.959995200016;8025.077116131662;8037.7588672339925;7985.600719964008;8037.678492860307;8040.959795201015;8045.39659525535;8048.235417635316;7936.2063793620755;8009.919900801005;8019.879701804449;8040.276375126266;8046.517208967481;7902.486338388044;8014.238647328494;8023.839523209562;8042.356611471068;8045.15525869787;36871;37458.62541374579;37473;37474.625253747385;37667.62332376696;2397.724261709891;2934.4277865816175;2967.317516971109;3068.2789544457037;3224.6452890182063;24748.752512474824;27876.303092422648;30488.39023219523;31505.369892602248;31688.524672129937;3012.7137921897383;3039.0882735179357;3048.192229059301;3082.537619357114;3122.78140530163;177905;178352;178478;179134;179646;52329;53022;53168.20247696288;53498;62788.37211627916;55615.72192139013;55686.44313556812;55854.44145558492;56101.43898561044;56212;12972.935135324451;13215.603531893867;13240.404181811842;13250.602481925558;13264.933675331562;9859.654912078044;9990.700278991642;10007.949960250298;10008.249381296431;10025.298229123891;19177.137028833735;19269.4219173425;19442.4167274982;19501.31745388933;19553.608927821362;7424.591647459333;7624.085109786861;7658.655360508679;7672.4629275951265;7737.458377913492;860.445012966633;930.63240020193;937.3579098317674;967.4678926590348;1084.1706094837455;27719.722802771714;27754.444911101666;28001;28139.577906331422;28288.43423131526;955.47926380123;962.6775030364767;1022.1873610479538;1023.8157131716214;1029.5894624364669;13341.599752007456;13384.19694818314;13431.261280629658;13645.044846860625;13660.726785464236;316160;317151;319863;320122;320912;48335.75832120887;48579.75710121497;48788;49051.75474122678;49119.50880491149;1230.1450491908038;1230.6677197156896;1238.721287710258;1239.863615002349;1244.9564265250672;25120.497590047733;25788.484230314913;25809.483810324065;25964;26339.73660263373;38068;38647.806760966014;38686;38727.225455491294;38734.22531549297;250483;251084;252139;252759;253003;29871;42601.36097958471;43438.34842477429;43705.344419834364;44028.119437610425;38082;38124.42813357857;38213.617863821004;38848.640297589445;39123.413148802225;33290.833545832116;33880.83059584686;33943.66056339405;34082.14794630055;34314.82842585771;33111.83444082764;33316.03114394032;33353.66646333506;33409.83295083509;33455.49816752799;33393;33892.49161262534;33924.1518962018;33926.32147357088;33988.15029624279;27923.720762792113;30328.11469018027;30349.393012140074;30529;30668.539971899994;25026.874865625556;25551.6167257495;25832.870835645703;26054.34864128412;27396.726032739418 07:20:43 INFO - 2015-12-15 07:20:43,632 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.6519619595619;334.7271973341726;334.93971085204663;337.3253493013972;338.41116457364166;15151;15586.23239454212;16054.277557509911;16282.51152465428;16713.247903844327;9508.286878484107;9692.903070969289;11843.7631247375;13700;13769.449222031131;4564.680472366936;4682.110399024192;4694.671373003891;4699.412573428322;6496.772612958547;6747.08914296571;6748.02153687715;6754.898676519856;6769.7630582929605;6771.4921380896385;4039.131586708857;4123.422720819072;6418.775342863;6517.087607734921;6719.1936967563715;6718.227403848571;6749.527533072687;6753.527253092286;6791.286914873941;6792.524523283372;6338.524610654174;6389.872202555969;6444;6470.191226096738;6492.350764923517;16468.588285292844;19796.208151673916;20020.799792002184;20721;20851;598.9580729348947;1953.0332485419808;1971.8661769482605;2018.4247489465579;2120.7672977881784;13999.230042347666;14005.719885602231;14034.438622455089;14300.213488258141;14300.642483937881;1833.0101745057652;1848.6857234270205;1899.9240030398767;1908.2462427341122;1912.9426117216506;58839.41160588382;61745;63905;65933.3406665932;67087.3291267086;14935.103893766409;15528.223588820514;15562.688746225012;15604.531864044096;15621;23016;23189.652155217686;23367.298981030595;23385.298441046794;23440.765592343858;7921.683132674743;8023.358131349595;8041.437099402986;8042.396820238506;8067.1529489402765;6558.672066396661;6620.735170593122;6646.601203927683;6648.335166483313;6683.532152749358;7550.735724249735;7619.123800762873;7636;7637.389008879276;7650.961745191238;3048.725614694688;3168.588083549124;3243.3026899216784;3269.4441944869427;3281.6062072551445;378.3719026416136;379.1979962379547;384.5788861196985;386.26802209812246;823.2549542663899;9434.009429009993;9699.981501942335;9795.755106122404;9968.651097211563;10049.196064314838;403.7295012341738;411.868202175301;412.6657407499875;413.2355142985453;432.05164663563176;5022.773975171053;5479.0959491683425;5498.45015498447;5527.585431092684;8890.73327800167;455836;489756;498171;510172;511262;70502.64748676223;71396;74029.25970740331;74339.76980690588;74870.62564687141;1026.58423338548;1044.1698849414581;1044.8798388185303;1060.7719340341864;1066.5680399438086;14280;14471.638209044859;14542.40417737957;14682.706345873235;14710.926445367704;33707.15732106717;33782.49326260059;34346.14134646554;34438.48342274818;34820.65179348276;44057;44784.552154479345;45369;45691.77154114208;47351.52648473471;8818.11818818113;8839.46963182211;8881.866771998297;8977.551122443982;9031.05173956725;10455.372677639367;10471.842922356323;10553.841692374774;10714.89285107139;10800.24398292112;11398;13040.478380864659;13138.73722525525;13764.587062388144;14087.295635217994;13113.803292950422;13310.134841235289;13353.866461335263;13628.454861805416;13632.250226237653;13662.180269183484;13665.863341366858;13807.861921380658;14135.929320353744;14138.575842724735;7697.692092316244;8825.823483530165;8883.156100170474;8946.194842464209;8971.28229741606;8543.957280213559;8618.396712230084;11311.717207069889;13462.461501539829;13710.794338084737 07:20:43 INFO - 2015-12-15 07:20:43,636 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1508.336332013913;1605.1893793634217;1670.7159782836916;1685.8904171228874;1697.117498900571;6813.148356455443;7242.275772422755;7287.708491660327;7301.598412087333;7367.4474414419;7114.928850711492;7148.392386647129;7168.211496735355;7183.461240406978;7202.8559428811395;1991.4822146242009;2010.9698354524694;2024.736784218057;2026.5136367271896;2033.5017920609398;1790.0423273548588;1806.7199584064426;1819.8271164239377;1835.155828318975;1851.3797877710915;1695.4489790817972;1747.8951262924265;2017.6368253714325;2028.239410221167;2065.783092775252;2041.7754047054812;2052.733144691188;2057.4342055934662;2057.722207501983;2069.6791997240452;2061.4537147655883;2065.308121779206;2091.8640288381207;2095.779943105967;2096.3396530093123;6976.5814051157095;7137.678804453812;7137.785866424016;7138.964305178492;7162.391196748283;4075.2460794753065;4150.626443620058;4159.272127377697;4162.91674166515;4177.12280421112;2695.460907818444;2753;2756.145594865598;2815.5635876439183;2831.886724531016;868.3704314372093;1691.805442374118;1721.079222615907;1724.1206984437902;1735.2364959417941;9737.951310243403;9778.119969202735;9802.117809397188;9833.311668183302;9920.950395247977;3814.122751767109;3847.153626202231;3854.5952674969285;3896.162325100117;3901.9804900975314;7614.771556853303;7666.693332266647;7677.347425468786;7679.884801727979;7681.1934746850775;4171.5828417158045;4181.435506206623;4209.431726716854;4211.642010429148;4214.873553793391;3820.980895095562;3836.1368692044625;3853.4412510186426;3871.9806400967814;3873.8450461981206;3140.7016333448287;3157.0844455107763;3160.1309639848764;3168.6197656280933;3178.984105079506;916.6883259691604;916.7204002779083;946.4274114160971;954.8949615542285;957.7701351675687;946.5693109635099;972.1250874213265;979.7256768104942;986.753311672082;1028.7736697926443;6571.57284776488;6598;6646.534742567974;6648.335166483313;6688.431483323972;1031.566741968375;1043.984340234897;1048.7168464514539;1052.126734810121;1054.9683509494728;5407.351117865881;5409.404965453797;5415.566754659618;5429.647072940246;5439.075357189287;8144.714934977247;8160.6327715252955;8352.540610266493;8397;8470.15298470148;8181.222783835526;8271.875921861178;8284.668613255402;8298.253157215879;8302.70940517079;6634.402903738686;6643.40209381158;6697.564658297195;6730.697118629576;6750.32496750321;6609.107770450928;6623.801285961429;6627.105340778933;6630.071789949508;6661.666916654051;7421.740239091606;7546.698132074655;7561.7731468056045;7659.042619672541;7686.9231307686205;7554.584497852671;7698.230176982481;7750.728724494616;7788.104367997753;7804.219578042151;5879.588428809942;5929.851753706192;5947.613405128653;5983.132445795422;5994.490468310068;6880.415164710856;6947.5831450113155;6959.61722105289;6960.990656354901;6976.825579360557;6595.241547222131;6640;6664.533482656361;6671.733130674718;6758.459323254227;5351.518363347317;6323.019931910561;6364.77723279683;6393.93606063952;6485.675716214076;6347.0479428086155;6421.550491465552;6429.6142231466265;6439.356064393523;6468.288488266381;5823.475887170175;5918.496927761016;5936;5969.134475500941;5969.8806023878415;5963.493103086286;5972.790952316648;5975.611585246945;5993.101034844808;6017.037274036134 07:20:43 INFO - 2015-12-15 07:20:43,637 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.3780385582565;297.97020297970204;303.58560564829014;303.917942155618;308.4986896293523;5599.832005039851;5616.522595579376;5666.8583285417835;5674.716264186794;5808.506276966453;5573.6098473106895;5601.579881508883;5610.046292130338;5660.632058916178;5675.212308122938;4030.637242648161;4269.060806622546;4295.591918767712;4295.656347492193;4298.032942587908;4115.691323150776;4205.558416366283;4254.63835573975;4269.124829409979;4319.2441322768545;4230;4252.277112890801;4261.573842615745;4263.3178691409385;4264.296391095481;4236.618704316611;4252.957470425287;4261.808218630138;4266.31738921771;4270.423492828475;3696.85212591496;3699.445083237509;3700.4634328022285;3701.167237371597;3704.8888533344043;5275.709835959021;5368.489993450616;5376.327959005124;5376.596755243333;5385.2999110115825;4888.902221955576;4894.3147959285725;4895.192293271606;4897.657163998521;4900.387451568554;5857.70711464425;5858.56060795442;5875.412458754133;5886.234789477383;5895.4694077532795;3978.204359128186;3983.7609743415196;3989.601039896016;3998.1603863188475;4003.559608443069;5973.1936188614845;6185.226846644169;6187.876242475125;6190.288116866528;6211.9999999999545;4109.321961876317;4115.279826030433;4115.794210289533;4122.299209134454;4122.628963393249;4145.253854306254;4159.625633692982;4177.749335039907;4180.435641188462;4198.097409057067;4835.879103022453;4837.733924634109;4847.975760121177;4851.56335929768;4862.610991120702;5630.8029218977135;5756.079027355603;5835.124731290341;5840.211571437886;5851.063829787214;1441.8774404175763;1465.0916431812132;1469.8383177850428;1469.8530146985215;1470.3309993952726;954.6610953111546;978.6183388478499;981.4896253947907;996.0537489385113;1003.2024540490328;5140.331756871583;5150.227465880148;5158.252053452228;5162.716050617177;5171.198464238049;6008.399160083956;6122.602030867979;6137.324894261627;6200.56596038273;6208.565400421927;5181.4041385240425;5201.635885487979;5207.635465517377;5213.452587478336;5218.504242096995;3257.478803391446;3294.061192560157;3317.2370354818527;3320;3326.434506133963;5690.6301090429815;5805.506531944832;5823.330317013513;5846.123081537803;5849.181114643953;6330.905036424458;6340.302566717657;6355.968220158869;6365.681715914186;6366.649834259068;5831.329397119385;5839.824805255764;5840.620359676607;5841.153032810219;5848.4151584842875;6155.907661385172;6174.8147555573405;6177.9691101546005;6186.10301506288;6189.164462797465;5877.4122587740885;5957.821265362046;6021.759129634941;6022.518198544193;6038.788642397495;5797.739101740347;5822.796202132905;5828.94171058284;5831.271091113611;5839.0949402842625;4080.7347522410946;4105.137921036616;4114.794260286913;4124.257633625856;4124.319487284564;6009.699515024318;6129.969350153221;6144.41628045335;6153.353897840662;6188.257409110935;5909.497692695997;5942.465178133989;5945.316288626863;5953.672548009901;5960.403959604005;5922.911156332572;5932.940670593239;5940.198073260054;5943.643381396957;5954.612950158399;5662.405447427961;5770.6249093808765;5801.970990145022;5804.506616937608;5808.273965754281;5903.203067585821;5950.16697662319;5958.374370691015;5969.164316995711;5973.313068997121;5806.071028635567;5818.214541036906;5820.388859169896;5824.126381042877;5827.76688932438 07:20:43 INFO - 2015-12-15 07:20:43,641 DEBUG : BROWSER_OUTPUT: |5;yui.html;663.439393712313;700.145822097042;712.8895021271703;740.0453415094528;747.6112421540801;10798.2441229114;11012.614558490455;11018.393988330648;11029.558817647285;11112.16658750595;10522.684319470409;13049.347532623355;13228.206307621549;13269.867301327007;13272.535461258858;768.5388766739967;780.7696729464807;789.8143936174994;791.2759824760337;792.5601291283335;790.5414859381574;792.8295416485455;798.7164556582417;800.1078797141175;803.04036676172;806.3468590441761;810.2586133687669;812.0661239574507;812.4597142899964;814.267159556401;803.333233416263;805.122416565943;805.5851236613149;805.6374631415887;806.9314108300772;601.1313651773189;601.5879122800852;602.5601311042919;604.3080672629858;604.3261763134118;11072.944635276852;11188.66434006981;11198.328100313925;11203.775924481546;11207.103431725523;10937.398443085627;11014.229003969725;11058.22592418531;11242.49408776607;11450.255733377304;8974.730758077269;8998.685046023358;9133.315001374856;9329.067093290685;9472.479013654247;3193.4890417533315;3235.6117265928237;3261.396641621284;3265.232670322472;3265.5264986576813;39655.8017209915;39842.20315593701;40018.799906000284;40105.39841902374;40348.596514034776;8436.746897593082;8497.192766687154;8559.22966932979;8685.39202255836;8777.780555486164;15503.209422304093;15538.223088845512;15567.065976041475;15578.376864925503;15604;6185.567010309307;6272.5922815016875;6373.840653983595;6429.485641148697;6458.6770661466735;3409.4374428219066;3474.617792042873;3493.123380506299;3579.158897659048;3589.6769290763436;2841.8010739248466;2845.4593627210766;2855.8572071396347;2876.6404199475064;2894.884204631833;512.8102602037195;513.1225604216756;514.1798830864765;515.7988384530037;522.4305506997391;485.96598238122994;547.698765678875;570.164708701754;575.9136129580596;589.1222079102107;7028.578285302899;7256.550567183239;7525.58609276495;7618.314351708373;7666.8849967250535;488.73608251543766;489.21969458713295;515.4639175257765;542.1867199201198;572.8882867840731;3464.1512829356466;3554.0937061049785;3603.891883243507;3713.3687273163628;3786.413105968579;46488.767556162005;46824.531754682015;46986;48368;48429.27356089662;43317.566824331356;43367.56632433635;43649.127017459476;44388.77805611016;44451.55548444474;40229.597704023174;40594.391084133764;40918.795406023375;41038.179236415104;41073.79463102725;7453.217412171643;7571.621418928921;7681.07827060734;7841.5687137208;7881.290683838482;30098.699013010464;30224.09327720172;30492.84753576218;30789.384212316076;31273.218169545944;38372.23255534929;40315.1936961265;40472.79763601163;40608.59391406048;40623.59376406198;9718.522927361444;9739.366941148803;10235.283530152818;10248.846267306146;10364.274500784873;10787.568497260021;10797.29817561856;10892.237543371888;11156.832647510457;11557.653270401901;10408.219383546415;10525.263231573716;10955.34267943926;10997.61508347204;11086.833697494705;10778.407187604756;10855.968682975104;10905.509252083833;10933;10947.83578246311;10047.598096076075;10351.482425878827;10429.895701042893;10492.842607360742;10729.463526823783;8864.645414183618;9266.258699304175;9347.579358928728;9392.624295028123;9601.183899368632;8848.336374771789;8955.552222388986;8992.46045237288;8995.460272383678;9058.36591438593 07:20:43 INFO - 2015-12-15 07:20:43,641 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:20:43 INFO - 2015-12-15 07:20:43,641 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:20:43 INFO - 2015-12-15 07:20:43,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,323 07:20:43 INFO - 2015-12-15 07:20:43,642 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:20:43 INFO - 2015-12-15 07:20:43,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1450192843627__endTimestamp 07:20:43 INFO - 2015-12-15 07:20:43,642 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,642 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:20:43 INFO - 2015-12-15 07:20:43,642 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:20:43 INFO - 2015-12-15 07:20:43,642 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,643 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4772.93 Median:4917.04 stddev:511.89 (10.4%) stddev-sans-first:485.69 07:20:43 INFO - 2015-12-15 07:20:43,644 DEBUG : BROWSER_OUTPUT: Values: 2652.9 2678.7 2692.5 2708.3 2717.6 4732.3 4829.5 4835.0 4850.6 4854.5 4805.7 4816.2 4816.8 4924.4 4925.8 4450.4 4504.0 4567.0 4584.4 4605.6 4440.1 4471.4 4491.2 4527.9 4561.0 4295.7 4390.5 4458.0 4486.3 4530.7 4429.8 4430.3 4454.6 4459.7 4465.5 4397.2 4399.2 4406.6 4417.3 4456.3 4545.5 4671.9 4692.2 4702.0 4703.4 5094.1 5130.4 5176.8 5265.0 5332.4 5290.2 5295.9 5298.6 5303.5 5308.8 4666.2 4885.7 4888.6 4897.5 4924.7 5260.9 5296.9 5347.5 5362.8 5392.4 5098.7 5115.3 5119.0 5125.6 5168.4 4959.1 5059.1 5217.8 5235.0 5236.3 5070.5 5105.4 5109.6 5127.9 5153.6 5096.8 5122.2 5124.9 5132.0 5164.7 4280.4 4284.0 4296.2 4322.9 4329.2 3652.6 3710.3 3758.7 3768.7 3798.1 4512.3 4523.5 4542.9 4547.5 4600.3 5205.3 5263.7 5278.9 5279.8 5319.2 4309.9 4404.8 4431.9 4478.6 4523.1 4563.0 4583.1 4616.2 4616.5 4664.0 4819.3 4917.0 4957.0 4972.6 4995.1 5095.0 5111.6 5147.9 5154.5 5179.6 4834.8 4953.9 4960.0 4987.1 5002.5 4847.6 4964.8 5136.9 5146.5 5158.3 5067.7 5111.2 5135.7 5136.6 5192.4 5027.2 5034.2 5039.9 5065.0 5070.5 4838.5 4949.8 4971.0 4993.2 5029.2 4871.4 4893.3 4941.1 4961.5 5011.9 5054.7 5070.4 5076.8 5076.9 5145.7 4715.8 4801.0 4803.7 4814.9 5027.3 07:20:43 INFO - 2015-12-15 07:20:43,644 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,644 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41516.17 Median:34035.15 stddev:67077.65 (197.1%) stddev-sans-first:67195.34 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: Values: 561.4 571.1 571.6 575.2 579.1 35126.8 35731.5 35776.5 35807.5 35947.0 40679.0 41088.0 41098.2 41202.6 41256.6 8011.6 8146.1 8148.3 8149.7 8152.8 7921.1 7928.2 8001.0 8025.1 8037.8 7985.6 8037.7 8041.0 8045.4 8048.2 7936.2 8009.9 8019.9 8040.3 8046.5 7902.5 8014.2 8023.8 8042.4 8045.2 36871.0 37458.6 37473.0 37474.6 37667.6 2397.7 2934.4 2967.3 3068.3 3224.6 24748.8 27876.3 30488.4 31505.4 31688.5 3012.7 3039.1 3048.2 3082.5 3122.8 177905.0 178352.0 178478.0 179134.0 179646.0 52329.0 53022.0 53168.2 53498.0 62788.4 55615.7 55686.4 55854.4 56101.4 56212.0 12972.9 13215.6 13240.4 13250.6 13264.9 9859.7 9990.7 10007.9 10008.2 10025.3 19177.1 19269.4 19442.4 19501.3 19553.6 7424.6 7624.1 7658.7 7672.5 7737.5 860.4 930.6 937.4 967.5 1084.2 27719.7 27754.4 28001.0 28139.6 28288.4 955.5 962.7 1022.2 1023.8 1029.6 13341.6 13384.2 13431.3 13645.0 13660.7 316160.0 317151.0 319863.0 320122.0 320912.0 48335.8 48579.8 48788.0 49051.8 49119.5 1230.1 1230.7 1238.7 1239.9 1245.0 25120.5 25788.5 25809.5 25964.0 26339.7 38068.0 38647.8 38686.0 38727.2 38734.2 250483.0 251084.0 252139.0 252759.0 253003.0 29871.0 42601.4 43438.3 43705.3 44028.1 38082.0 38124.4 38213.6 38848.6 39123.4 33290.8 33880.8 33943.7 34082.1 34314.8 33111.8 33316.0 33353.7 33409.8 33455.5 33393.0 33892.5 33924.2 33926.3 33988.2 27923.7 30328.1 30349.4 30529.0 30668.5 25026.9 25551.6 25832.9 26054.3 27396.7 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27258.62 Median:2221.43 stddev:80637.77 (3630.0%) stddev-sans-first:80838.64 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: Values: 334.7 334.7 334.9 337.3 338.4 15151.0 15586.2 16054.3 16282.5 16713.2 9508.3 9692.9 11843.8 13700.0 13769.4 4564.7 4682.1 4694.7 4699.4 6496.8 6747.1 6748.0 6754.9 6769.8 6771.5 4039.1 4123.4 6418.8 6517.1 6719.2 6718.2 6749.5 6753.5 6791.3 6792.5 6338.5 6389.9 6444.0 6470.2 6492.4 16468.6 19796.2 20020.8 20721.0 20851.0 599.0 1953.0 1971.9 2018.4 2120.8 13999.2 14005.7 14034.4 14300.2 14300.6 1833.0 1848.7 1899.9 1908.2 1912.9 58839.4 61745.0 63905.0 65933.3 67087.3 14935.1 15528.2 15562.7 15604.5 15621.0 23016.0 23189.7 23367.3 23385.3 23440.8 7921.7 8023.4 8041.4 8042.4 8067.2 6558.7 6620.7 6646.6 6648.3 6683.5 7550.7 7619.1 7636.0 7637.4 7651.0 3048.7 3168.6 3243.3 3269.4 3281.6 378.4 379.2 384.6 386.3 823.3 9434.0 9700.0 9795.8 9968.7 10049.2 403.7 411.9 412.7 413.2 432.1 5022.8 5479.1 5498.5 5527.6 8890.7 455836.0 489756.0 498171.0 510172.0 511262.0 70502.6 71396.0 74029.3 74339.8 74870.6 1026.6 1044.2 1044.9 1060.8 1066.6 14280.0 14471.6 14542.4 14682.7 14710.9 33707.2 33782.5 34346.1 34438.5 34820.7 44057.0 44784.6 45369.0 45691.8 47351.5 8818.1 8839.5 8881.9 8977.6 9031.1 10455.4 10471.8 10553.8 10714.9 10800.2 11398.0 13040.5 13138.7 13764.6 14087.3 13113.8 13310.1 13353.9 13628.5 13632.3 13662.2 13665.9 13807.9 14135.9 14138.6 7697.7 8825.8 8883.2 8946.2 8971.3 8544.0 8618.4 11311.7 13462.5 13710.8 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4952.50 Median:6170.03 stddev:2539.48 (41.2%) stddev-sans-first:2533.41 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: Values: 1508.3 1605.2 1670.7 1685.9 1697.1 6813.1 7242.3 7287.7 7301.6 7367.4 7114.9 7148.4 7168.2 7183.5 7202.9 1991.5 2011.0 2024.7 2026.5 2033.5 1790.0 1806.7 1819.8 1835.2 1851.4 1695.4 1747.9 2017.6 2028.2 2065.8 2041.8 2052.7 2057.4 2057.7 2069.7 2061.5 2065.3 2091.9 2095.8 2096.3 6976.6 7137.7 7137.8 7139.0 7162.4 4075.2 4150.6 4159.3 4162.9 4177.1 2695.5 2753.0 2756.1 2815.6 2831.9 868.4 1691.8 1721.1 1724.1 1735.2 9738.0 9778.1 9802.1 9833.3 9921.0 3814.1 3847.2 3854.6 3896.2 3902.0 7614.8 7666.7 7677.3 7679.9 7681.2 4171.6 4181.4 4209.4 4211.6 4214.9 3821.0 3836.1 3853.4 3872.0 3873.8 3140.7 3157.1 3160.1 3168.6 3179.0 916.7 916.7 946.4 954.9 957.8 946.6 972.1 979.7 986.8 1028.8 6571.6 6598.0 6646.5 6648.3 6688.4 1031.6 1044.0 1048.7 1052.1 1055.0 5407.4 5409.4 5415.6 5429.6 5439.1 8144.7 8160.6 8352.5 8397.0 8470.2 8181.2 8271.9 8284.7 8298.3 8302.7 6634.4 6643.4 6697.6 6730.7 6750.3 6609.1 6623.8 6627.1 6630.1 6661.7 7421.7 7546.7 7561.8 7659.0 7686.9 7554.6 7698.2 7750.7 7788.1 7804.2 5879.6 5929.9 5947.6 5983.1 5994.5 6880.4 6947.6 6959.6 6961.0 6976.8 6595.2 6640.0 6664.5 6671.7 6758.5 5351.5 6323.0 6364.8 6393.9 6485.7 6347.0 6421.6 6429.6 6439.4 6468.3 5823.5 5918.5 5936.0 5969.1 5969.9 5963.5 5972.8 5975.6 5993.1 6017.0 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,648 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4870.81 Median:5623.66 stddev:1464.44 (26.0%) stddev-sans-first:1427.67 07:20:43 INFO - 2015-12-15 07:20:43,649 DEBUG : BROWSER_OUTPUT: Values: 293.4 298.0 303.6 303.9 308.5 5599.8 5616.5 5666.9 5674.7 5808.5 5573.6 5601.6 5610.0 5660.6 5675.2 4030.6 4269.1 4295.6 4295.7 4298.0 4115.7 4205.6 4254.6 4269.1 4319.2 4230.0 4252.3 4261.6 4263.3 4264.3 4236.6 4253.0 4261.8 4266.3 4270.4 3696.9 3699.4 3700.5 3701.2 3704.9 5275.7 5368.5 5376.3 5376.6 5385.3 4888.9 4894.3 4895.2 4897.7 4900.4 5857.7 5858.6 5875.4 5886.2 5895.5 3978.2 3983.8 3989.6 3998.2 4003.6 5973.2 6185.2 6187.9 6190.3 6212.0 4109.3 4115.3 4115.8 4122.3 4122.6 4145.3 4159.6 4177.7 4180.4 4198.1 4835.9 4837.7 4848.0 4851.6 4862.6 5630.8 5756.1 5835.1 5840.2 5851.1 1441.9 1465.1 1469.8 1469.9 1470.3 954.7 978.6 981.5 996.1 1003.2 5140.3 5150.2 5158.3 5162.7 5171.2 6008.4 6122.6 6137.3 6200.6 6208.6 5181.4 5201.6 5207.6 5213.5 5218.5 3257.5 3294.1 3317.2 3320.0 3326.4 5690.6 5805.5 5823.3 5846.1 5849.2 6330.9 6340.3 6356.0 6365.7 6366.6 5831.3 5839.8 5840.6 5841.2 5848.4 6155.9 6174.8 6178.0 6186.1 6189.2 5877.4 5957.8 6021.8 6022.5 6038.8 5797.7 5822.8 5828.9 5831.3 5839.1 4080.7 4105.1 4114.8 4124.3 4124.3 6009.7 6130.0 6144.4 6153.4 6188.3 5909.5 5942.5 5945.3 5953.7 5960.4 5922.9 5932.9 5940.2 5943.6 5954.6 5662.4 5770.6 5802.0 5804.5 5808.3 5903.2 5950.2 5958.4 5969.2 5973.3 5806.1 5818.2 5820.4 5824.1 5827.8 07:20:43 INFO - 2015-12-15 07:20:43,649 DEBUG : BROWSER_OUTPUT: 07:20:43 INFO - 2015-12-15 07:20:43,649 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12061.93 Median:44018.95 stddev:13583.70 (30.9%) stddev-sans-first:13594.84 07:20:43 INFO - 2015-12-15 07:20:43,649 DEBUG : BROWSER_OUTPUT: Values: 663.4 700.1 712.9 740.0 747.6 10798.2 11012.6 11018.4 11029.6 11112.2 10522.7 13049.3 13228.2 13269.9 13272.5 768.5 780.8 789.8 791.3 792.6 790.5 792.8 798.7 800.1 803.0 806.3 810.3 812.1 812.5 814.3 803.3 805.1 805.6 805.6 806.9 601.1 601.6 602.6 604.3 604.3 11072.9 11188.7 11198.3 11203.8 11207.1 10937.4 11014.2 11058.2 11242.5 11450.3 8974.7 8998.7 9133.3 9329.1 9472.5 3193.5 3235.6 3261.4 3265.2 3265.5 39655.8 39842.2 40018.8 40105.4 40348.6 8436.7 8497.2 8559.2 8685.4 8777.8 15503.2 15538.2 15567.1 15578.4 15604.0 6185.6 6272.6 6373.8 6429.5 6458.7 3409.4 3474.6 3493.1 3579.2 3589.7 2841.8 2845.5 2855.9 2876.6 2894.9 512.8 513.1 514.2 515.8 522.4 486.0 547.7 570.2 575.9 589.1 7028.6 7256.6 7525.6 7618.3 7666.9 488.7 489.2 515.5 542.2 572.9 3464.2 3554.1 3603.9 3713.4 3786.4 46488.8 46824.5 46986.0 48368.0 48429.3 43317.6 43367.6 43649.1 44388.8 44451.6 40229.6 40594.4 40918.8 41038.2 41073.8 7453.2 7571.6 7681.1 7841.6 7881.3 30098.7 30224.1 30492.8 30789.4 31273.2 38372.2 40315.2 40472.8 40608.6 40623.6 9718.5 9739.4 10235.3 10248.8 10364.3 10787.6 10797.3 10892.2 11156.8 11557.7 10408.2 10525.3 10955.3 10997.6 11086.8 10778.4 10856.0 10905.5 10933.0 10947.8 10047.6 10351.5 10429.9 10492.8 10729.5 8864.6 9266.3 9347.6 9392.6 9601.2 8848.3 8955.6 8992.5 8995.5 9058.4 07:20:43 INFO - 2015-12-15 07:20:43,649 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:20:43 INFO - 2015-12-15 07:20:43,649 DEBUG : BROWSER_OUTPUT: 07:20:44 INFO - 2015-12-15 07:20:44,390 INFO : Browser exited with error code: 0 07:20:44 INFO - 2015-12-15 07:20:44,409 INFO : Completed test dromaeo_css (00:18:34) 07:20:44 INFO - 2015-12-15 07:20:44,409 INFO : Starting test kraken 07:20:44 INFO - 2015-12-15 07:20:44,409 DEBUG : operating with platform_type : linux_ 07:20:44 INFO - 2015-12-15 07:20:44,409 INFO : Initialising browser for kraken test... 07:20:44 INFO - 2015-12-15 07:20:44,415 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpea42_j/profile http://localhost:50095/getInfo.html 07:20:49 INFO - 2015-12-15 07:20:49,207 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:20:49 INFO - 2015-12-15 07:20:49,207 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:20:49 INFO - 2015-12-15 07:20:49,208 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:20:49 INFO - 2015-12-15 07:20:49,208 DEBUG : BROWSER_OUTPUT: __metrics 07:20:49 INFO - 2015-12-15 07:20:49,324 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] 07:20:50 INFO - 2015-12-15 07:20:50,318 INFO : Browser initialized. 07:20:50 INFO - 2015-12-15 07:20:50,319 INFO : Running cycle 1/1 for kraken test... 07:20:50 INFO - 2015-12-15 07:20:50,319 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpea42_j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:21:02 INFO - 2015-12-15 07:21:02,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 143872000 07:21:02 INFO - 2015-12-15 07:21:02,449 DEBUG : BROWSER_OUTPUT: 07:21:05 INFO - 2015-12-15 07:21:05,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50095/tests/kraken/driver.html?testName=audio-beat-detection) 07:21:05 INFO - 2015-12-15 07:21:05,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 143286272 07:21:05 INFO - 2015-12-15 07:21:05,678 DEBUG : BROWSER_OUTPUT: 07:21:08 INFO - 2015-12-15 07:21:08,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50095/tests/kraken/driver.html?testName=audio-dft) 07:21:09 INFO - 2015-12-15 07:21:09,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 143515648 07:21:09 INFO - 2015-12-15 07:21:09,045 DEBUG : BROWSER_OUTPUT: 07:21:11 INFO - 2015-12-15 07:21:11,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50095/tests/kraken/driver.html?testName=audio-fft) 07:21:12 INFO - 2015-12-15 07:21:12,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 138788864 07:21:12 INFO - 2015-12-15 07:21:12,510 DEBUG : BROWSER_OUTPUT: 07:21:14 INFO - 2015-12-15 07:21:14,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50095/tests/kraken/driver.html?testName=audio-oscillator) 07:21:15 INFO - 2015-12-15 07:21:15,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 140005376 07:21:15 INFO - 2015-12-15 07:21:15,226 DEBUG : BROWSER_OUTPUT: 07:21:17 INFO - 2015-12-15 07:21:17,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50095/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:21:18 INFO - 2015-12-15 07:21:18,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 140619776 07:21:18 INFO - 2015-12-15 07:21:18,082 DEBUG : BROWSER_OUTPUT: 07:21:21 INFO - 2015-12-15 07:21:21,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50095/tests/kraken/driver.html?testName=imaging-darkroom) 07:21:21 INFO - 2015-12-15 07:21:21,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 139956224 07:21:21 INFO - 2015-12-15 07:21:21,805 DEBUG : BROWSER_OUTPUT: 07:21:25 INFO - 2015-12-15 07:21:25,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50095/tests/kraken/driver.html?testName=imaging-desaturate) 07:21:25 INFO - 2015-12-15 07:21:25,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 139194368 07:21:25 INFO - 2015-12-15 07:21:25,909 DEBUG : BROWSER_OUTPUT: 07:21:28 INFO - 2015-12-15 07:21:28,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50095/tests/kraken/driver.html?testName=json-parse-financial) 07:21:29 INFO - 2015-12-15 07:21:29,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 138555392 07:21:29 INFO - 2015-12-15 07:21:29,381 DEBUG : BROWSER_OUTPUT: 07:21:31 INFO - 2015-12-15 07:21:31,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50095/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:21:31 INFO - 2015-12-15 07:21:31,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 140558336 07:21:31 INFO - 2015-12-15 07:21:31,714 DEBUG : BROWSER_OUTPUT: 07:21:33 INFO - 2015-12-15 07:21:33,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50095/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:21:34 INFO - 2015-12-15 07:21:34,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 141721600 07:21:34 INFO - 2015-12-15 07:21:34,223 DEBUG : BROWSER_OUTPUT: 07:21:36 INFO - 2015-12-15 07:21:36,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50095/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:21:36 INFO - 2015-12-15 07:21:36,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 141217792 07:21:36 INFO - 2015-12-15 07:21:36,965 DEBUG : BROWSER_OUTPUT: 07:21:39 INFO - 2015-12-15 07:21:39,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:21:40 INFO - 2015-12-15 07:21:40,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 141434880 07:21:40 INFO - 2015-12-15 07:21:40,122 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-12-15 07:21:42,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:21:43 INFO - 2015-12-15 07:21:43,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 140795904 07:21:43 INFO - 2015-12-15 07:21:43,328 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50095/tests/kraken/driver.html?testName=ai-astar) 07:21:45 INFO - 2015-12-15 07:21:45,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 140804096 07:21:45 INFO - 2015-12-15 07:21:45,333 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,336 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:21:45 INFO - 2015-12-15 07:21:45,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:21:45 INFO - 2015-12-15 07:21:45,337 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:21:45 INFO - 2015-12-15 07:21:45,337 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:21:45 INFO - 2015-12-15 07:21:45,337 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;114;119;111;123;114;113;112;114 07:21:45 INFO - 2015-12-15 07:21:45,337 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;133;153;167;136;154;162;144;164;143 07:21:45 INFO - 2015-12-15 07:21:45,337 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;164;163;165;168;165;163;165;161 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;73;73;73;136;73;72;74 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;143;94;96;94;141;96;96;136 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;110;110;110;110;110 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;147;148;148;148;149;149;147;150 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;97;96;98;96;96;97;96;96 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;73;71;72;71;70;72;71;69 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;71;69;68;68;69;68;68;70;68 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;86;86;85;84;85;93;86;85 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;120;128;122;126;132;124;120;120;131 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;149;146;146;146;145;146;147;159;142 07:21:45 INFO - 2015-12-15 07:21:45,338 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;70;69;71;71;71;70;69;69 07:21:45 INFO - 2015-12-15 07:21:45,339 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:21:45 INFO - 2015-12-15 07:21:45,339 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:21:45 INFO - 2015-12-15 07:21:45,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,789 07:21:45 INFO - 2015-12-15 07:21:45,339 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:21:45 INFO - 2015-12-15 07:21:45,339 DEBUG : BROWSER_OUTPUT: __startTimestamp1450192905335__endTimestamp 07:21:45 INFO - 2015-12-15 07:21:45,339 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,342 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:21:45 INFO - 2015-12-15 07:21:45,342 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:21:45 INFO - 2015-12-15 07:21:45,342 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,342 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.01 (3.5%) stddev-sans-first:4.24 07:21:45 INFO - 2015-12-15 07:21:45,342 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 114.0 119.0 111.0 123.0 114.0 113.0 112.0 114.0 07:21:45 INFO - 2015-12-15 07:21:45,342 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.50 Median:156.50 stddev:11.94 (7.6%) stddev-sans-first:12.35 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: Values: 159.0 133.0 153.0 167.0 136.0 154.0 162.0 144.0 164.0 143.0 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:1.85 (1.1%) stddev-sans-first:1.96 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 164.0 163.0 165.0 168.0 165.0 163.0 165.0 161.0 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:73.00 stddev:20.00 (27.4%) stddev-sans-first:21.05 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 73.0 73.0 73.0 136.0 73.0 72.0 74.0 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.50 stddev:21.68 (22.7%) stddev-sans-first:22.50 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 143.0 94.0 96.0 94.0 141.0 96.0 96.0 136.0 07:21:45 INFO - 2015-12-15 07:21:45,343 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:0.97 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 147.0 148.0 148.0 148.0 149.0 149.0 147.0 150.0 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 97.0 96.0 98.0 96.0 96.0 97.0 96.0 96.0 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:71.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 73.0 71.0 72.0 71.0 70.0 72.0 71.0 69.0 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,344 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:1.06 (1.5%) stddev-sans-first:1.09 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 69.0 68.0 68.0 69.0 68.0 68.0 70.0 68.0 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.70 (3.2%) stddev-sans-first:2.67 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 86.0 86.0 85.0 84.0 85.0 93.0 86.0 85.0 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:4.48 (3.6%) stddev-sans-first:4.74 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: Values: 126.0 120.0 128.0 122.0 126.0 132.0 124.0 120.0 120.0 131.0 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,345 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:146.00 stddev:5.36 (3.7%) stddev-sans-first:4.74 07:21:45 INFO - 2015-12-15 07:21:45,346 DEBUG : BROWSER_OUTPUT: Values: 138.0 149.0 146.0 146.0 146.0 145.0 146.0 147.0 159.0 142.0 07:21:45 INFO - 2015-12-15 07:21:45,346 DEBUG : BROWSER_OUTPUT: 07:21:45 INFO - 2015-12-15 07:21:45,346 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 07:21:45 INFO - 2015-12-15 07:21:45,346 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 69.0 71.0 71.0 71.0 70.0 69.0 69.0 07:21:45 INFO - 2015-12-15 07:21:45,346 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:21:45 INFO - 2015-12-15 07:21:45,346 DEBUG : BROWSER_OUTPUT: 07:21:46 INFO - 2015-12-15 07:21:46,234 INFO : Browser exited with error code: 0 07:21:46 INFO - 2015-12-15 07:21:46,288 INFO : Completed test kraken (00:01:01) 07:21:46 INFO - 2015-12-15 07:21:46,288 INFO : Starting test v8_7 07:21:46 INFO - 2015-12-15 07:21:46,288 DEBUG : operating with platform_type : linux_ 07:21:46 INFO - 2015-12-15 07:21:46,288 INFO : Initialising browser for v8_7 test... 07:21:46 INFO - 2015-12-15 07:21:46,294 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0IatXj/profile http://localhost:50095/getInfo.html 07:21:51 INFO - 2015-12-15 07:21:51,222 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:21:51 INFO - 2015-12-15 07:21:51,222 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:21:51 INFO - 2015-12-15 07:21:51,222 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:21:51 INFO - 2015-12-15 07:21:51,223 DEBUG : BROWSER_OUTPUT: __metrics 07:21:51 INFO - 2015-12-15 07:21:51,347 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] 07:21:52 INFO - 2015-12-15 07:21:52,258 INFO : Browser initialized. 07:21:52 INFO - 2015-12-15 07:21:52,259 INFO : Running cycle 1/1 for v8_7 test... 07:21:52 INFO - 2015-12-15 07:21:52,259 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0IatXj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:22:04 INFO - 2015-12-15 07:22:04,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 143253504 07:22:04 INFO - 2015-12-15 07:22:04,320 DEBUG : BROWSER_OUTPUT: 07:22:25 INFO - 2015-12-15 07:22:25,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50095/tests/v8_7/run.html (next: http://localhost:50095/tests/v8_7/run.html) 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 138780672 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: |0;Richards;166.19577862722286 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.59762435040832 07:22:26 INFO - 2015-12-15 07:22:26,066 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1085.7763300760043 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: |5;Earley;717.5627240143369 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: |6;Boyer;12746.835443037975 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: |7;RegExp;26315.78947368421 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: |8;Splay;593.491124260355 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4873.78640776699 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: __startTimestamp1450192946063__endTimestamp 07:22:26 INFO - 2015-12-15 07:22:26,067 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: Values: 166.2 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.60 Median:185.60 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: Values: 185.6 07:22:26 INFO - 2015-12-15 07:22:26,068 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: Values: 280.4 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: Values: 5196.9 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: Values: 1085.8 07:22:26 INFO - 2015-12-15 07:22:26,069 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.56 Median:717.56 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: Values: 717.6 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12746.84 Median:12746.84 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: Values: 12746.8 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26315.79 Median:26315.79 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: Values: 26315.8 07:22:26 INFO - 2015-12-15 07:22:26,070 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,071 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:593.49 Median:593.49 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,071 DEBUG : BROWSER_OUTPUT: Values: 593.5 07:22:26 INFO - 2015-12-15 07:22:26,071 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,071 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 07:22:26 INFO - 2015-12-15 07:22:26,071 DEBUG : BROWSER_OUTPUT: Values: 4873.8 07:22:26 INFO - 2015-12-15 07:22:26,071 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:22:26 INFO - 2015-12-15 07:22:26,071 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-12-15 07:22:26,990 INFO : Browser exited with error code: 0 07:22:27 INFO - 2015-12-15 07:22:27,005 INFO : Completed test v8_7 (00:00:40) 07:22:27 INFO - 2015-12-15 07:22:27,089 INFO : Completed test suite (00:20:17) 07:22:27 INFO - 2015-12-15 07:22:27,089 DEBUG : Working with test: dromaeo_css 07:22:27 INFO - 2015-12-15 07:22:27,089 DEBUG : Generating results file: dromaeo_css 07:22:27 INFO - 2015-12-15 07:22:27,090 DEBUG : Working with test: kraken 07:22:27 INFO - 2015-12-15 07:22:27,090 DEBUG : Generating results file: kraken 07:22:27 INFO - 2015-12-15 07:22:27,091 INFO : javascript benchmark 07:22:27 INFO - 2015-12-15 07:22:27,091 DEBUG : Working with test: v8_7 07:22:27 INFO - 2015-12-15 07:22:27,091 DEBUG : Generating results file: v8_7 07:22:27 INFO - 2015-12-15 07:22:27,091 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:27 INFO - 2015-12-15 07:22:27,149 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 07:22:27 INFO - 2015-12-15 07:22:27,149 DEBUG : process_Request line: dromaeo_css 6420.36 graph.html#tests=[[72,94,43]] 07:22:27 INFO - 2015-12-15 07:22:27,149 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:27 INFO - 2015-12-15 07:22:27,181 DEBUG : process_Request line: kraken 1539.20 graph.html#tests=[[232,94,43]] 07:22:27 INFO - 2015-12-15 07:22:27,181 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:27 INFO - 2015-12-15 07:22:27,219 DEBUG : process_Request line: v8_7 21203.15 graph.html#tests=[[230,94,43]] 07:22:27 INFO - 2015-12-15 07:22:27,220 INFO : javascript benchmark 07:22:27 INFO - 2015-12-15 07:22:27,224 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2652.9469410611778, 2678.6963211637994, 2692.5288074586942, 2708.2958430808, 2717.57877528983, 4732.290156476531, 4829.541193586612, 4835.0, 4850.63620228483, 4854.490278520749, 4805.663603547753, 4816.157172494808, 4816.783244753986, 4924.409070911487, 4925.7783399747, 4450.376947227391, 4504.0316331988615, 4567.0409214065085, 4584.426946631671, 4605.631549476051, 4440.111977604492, 4471.4187155669715, 4491.236489796726, 4527.886802829923, 4561.042181141947, 4295.656347492193, 4390.4511936008, 4458.0, 4486.327050942368, 4530.705504142253, 4429.822807087713, 4430.313301438282, 4454.643628509744, 4459.665525085599, 4465.464144302672, 4397.164538737629, 4399.23013472641, 4406.581374769392, 4417.315316126005, 4456.331550267486, 4545.499995000548, 4671.929921051187, 4692.178868697998, 4701.952980470186, 4703.388559487279, 5094.083065048289, 5130.384353877558, 5176.844694659167, 5265.0, 5332.3601167859715, 5290.232916227164, 5295.947040529584, 5298.602604804617, 5303.522682958553, 5308.761105750251, 4666.230072038144, 4885.7312847793, 4888.560029597354, 4897.51024897511, 4924.729139897304, 5260.868478287997, 5296.92054619181, 5347.51872331492, 5362.839114826562, 5392.40683524812, 5098.745062746848, 5115.309433226466, 5118.97440512795, 5125.641205115606, 5168.3797944246935, 4959.082569724613, 5059.089363914531, 5217.7912883485, 5234.97382513085, 5236.29310043147, 5070.4929507049, 5105.438401775802, 5109.591232701449, 5127.9230811537855, 5153.613478989091, 5096.770645320969, 5122.1804511278015, 5124.92312615311, 5131.974340128276, 5164.66429682077, 4280.357946308079, 4283.957160428418, 4296.2481565725875, 4322.935155972663, 4329.242382583098, 3652.6164752701116, 3710.2950439416422, 3758.699304055669, 3768.717346199046, 3798.088458769875, 4512.278035514302, 4523.479799822997, 4542.863714088583, 4547.47704014036, 4600.2869555218995, 5205.349331333583, 5263.710495922761, 5278.9472105278455, 5279.788808447696, 5319.175527793198, 4309.913801723948, 4404.757738324423, 4431.8670439886855, 4478.641708663299, 4523.095380923828, 4562.954370456319, 4583.106294272585, 4616.16908956391, 4616.469106052847, 4664.043871006435, 4819.277108433623, 4917.041176970528, 4956.950430495649, 4972.627052970969, 4995.100881841304, 5094.955534115572, 5111.565516931102, 5147.897042059213, 5154.458781828004, 5179.611529135254, 4834.806607735792, 4953.851384458472, 4959.97520012412, 4987.0524600325825, 5002.549770520671, 4847.587955023862, 4964.776585053609, 5136.871578210575, 5146.511081447256, 5158.277841102174, 5067.721275329893, 5111.182210846247, 5135.717535535581, 5136.6147538935475, 5192.350956130484, 5027.2207807789855, 5034.219695947134, 5039.924401133912, 5065.0, 5070.467600901852, 4838.467768545527, 4949.802007919643, 4970.975145124251, 4993.151164302005, 5029.1953287473825, 4871.3667223260745, 4893.290472881484, 4941.061198372297, 4961.454240033666, 5011.899762004812, 5054.671446355975, 5070.41690205631, 5076.82231121909, 5076.873078173076, 5145.691258524501, 4715.81136754526, 4800.951990480051, 4803.663743538059, 4814.903701925872, 5027.271045698426], "unit": "score", "name": "dojo.html", "value": 4739.70665852751}, {"lowerIsBetter": false, "replicates": [561.3684604819578, 571.1176232720446, 571.6312978129107, 575.1832397994847, 579.0850456279079, 35126.824365878165, 35731.4640280396, 35776.46335304972, 35807.46288805664, 35947.0, 40679.0, 41088.0, 41098.178036439254, 41202.58797412025, 41256.58743412565, 8011.559364234965, 8146.103928567853, 8148.266656000958, 8149.674013039471, 8152.75541733746, 7921.128675845653, 7928.16754240805, 8000.959995200016, 8025.077116131662, 8037.7588672339925, 7985.600719964008, 8037.678492860307, 8040.959795201015, 8045.39659525535, 8048.235417635316, 7936.2063793620755, 8009.919900801005, 8019.879701804449, 8040.276375126266, 8046.517208967481, 7902.486338388044, 8014.238647328494, 8023.839523209562, 8042.356611471068, 8045.15525869787, 36871.0, 37458.62541374579, 37473.0, 37474.625253747385, 37667.62332376696, 2397.724261709891, 2934.4277865816175, 2967.317516971109, 3068.2789544457037, 3224.6452890182063, 24748.752512474824, 27876.303092422648, 30488.39023219523, 31505.369892602248, 31688.524672129937, 3012.7137921897383, 3039.0882735179357, 3048.192229059301, 3082.537619357114, 3122.78140530163, 177905.0, 178352.0, 178478.0, 179134.0, 179646.0, 52329.0, 53022.0, 53168.20247696288, 53498.0, 62788.37211627916, 55615.72192139013, 55686.44313556812, 55854.44145558492, 56101.43898561044, 56212.0, 12972.935135324451, 13215.603531893867, 13240.404181811842, 13250.602481925558, 13264.933675331562, 9859.654912078044, 9990.700278991642, 10007.949960250298, 10008.249381296431, 10025.298229123891, 19177.137028833735, 19269.4219173425, 19442.4167274982, 19501.31745388933, 19553.608927821362, 7424.591647459333, 7624.085109786861, 7658.655360508679, 7672.4629275951265, 7737.458377913492, 860.445012966633, 930.63240020193, 937.3579098317674, 967.4678926590348, 1084.1706094837455, 27719.722802771714, 27754.444911101666, 28001.0, 28139.577906331422, 28288.43423131526, 955.47926380123, 962.6775030364767, 1022.1873610479538, 1023.8157131716214, 1029.5894624364669, 13341.599752007456, 13384.19694818314, 13431.261280629658, 13645.044846860625, 13660.726785464236, 316160.0, 317151.0, 319863.0, 320122.0, 320912.0, 48335.75832120887, 48579.75710121497, 48788.0, 49051.75474122678, 49119.50880491149, 1230.1450491908038, 1230.6677197156896, 1238.721287710258, 1239.863615002349, 1244.9564265250672, 25120.497590047733, 25788.484230314913, 25809.483810324065, 25964.0, 26339.73660263373, 38068.0, 38647.806760966014, 38686.0, 38727.225455491294, 38734.22531549297, 250483.0, 251084.0, 252139.0, 252759.0, 253003.0, 29871.0, 42601.36097958471, 43438.34842477429, 43705.344419834364, 44028.119437610425, 38082.0, 38124.42813357857, 38213.617863821004, 38848.640297589445, 39123.413148802225, 33290.833545832116, 33880.83059584686, 33943.66056339405, 34082.14794630055, 34314.82842585771, 33111.83444082764, 33316.03114394032, 33353.66646333506, 33409.83295083509, 33455.49816752799, 33393.0, 33892.49161262534, 33924.1518962018, 33926.32147357088, 33988.15029624279, 27923.720762792113, 30328.11469018027, 30349.393012140074, 30529.0, 30668.539971899994, 25026.874865625556, 25551.6167257495, 25832.870835645703, 26054.34864128412, 27396.726032739418], "unit": "score", "name": "ext.html", "value": 17086.960396438313}, {"lowerIsBetter": false, "replicates": [334.6519619595619, 334.7271973341726, 334.93971085204663, 337.3253493013972, 338.41116457364166, 15151.0, 15586.23239454212, 16054.277557509911, 16282.51152465428, 16713.247903844327, 9508.286878484107, 9692.903070969289, 11843.7631247375, 13700.0, 13769.449222031131, 4564.680472366936, 4682.110399024192, 4694.671373003891, 4699.412573428322, 6496.772612958547, 6747.08914296571, 6748.02153687715, 6754.898676519856, 6769.7630582929605, 6771.4921380896385, 4039.131586708857, 4123.422720819072, 6418.775342863, 6517.087607734921, 6719.1936967563715, 6718.227403848571, 6749.527533072687, 6753.527253092286, 6791.286914873941, 6792.524523283372, 6338.524610654174, 6389.872202555969, 6444.0, 6470.191226096738, 6492.350764923517, 16468.588285292844, 19796.208151673916, 20020.799792002184, 20721.0, 20851.0, 598.9580729348947, 1953.0332485419808, 1971.8661769482605, 2018.4247489465579, 2120.7672977881784, 13999.230042347666, 14005.719885602231, 14034.438622455089, 14300.213488258141, 14300.642483937881, 1833.0101745057652, 1848.6857234270205, 1899.9240030398767, 1908.2462427341122, 1912.9426117216506, 58839.41160588382, 61745.0, 63905.0, 65933.3406665932, 67087.3291267086, 14935.103893766409, 15528.223588820514, 15562.688746225012, 15604.531864044096, 15621.0, 23016.0, 23189.652155217686, 23367.298981030595, 23385.298441046794, 23440.765592343858, 7921.683132674743, 8023.358131349595, 8041.437099402986, 8042.396820238506, 8067.1529489402765, 6558.672066396661, 6620.735170593122, 6646.601203927683, 6648.335166483313, 6683.532152749358, 7550.735724249735, 7619.123800762873, 7636.0, 7637.389008879276, 7650.961745191238, 3048.725614694688, 3168.588083549124, 3243.3026899216784, 3269.4441944869427, 3281.6062072551445, 378.3719026416136, 379.1979962379547, 384.5788861196985, 386.26802209812246, 823.2549542663899, 9434.009429009993, 9699.981501942335, 9795.755106122404, 9968.651097211563, 10049.196064314838, 403.7295012341738, 411.868202175301, 412.6657407499875, 413.2355142985453, 432.05164663563176, 5022.773975171053, 5479.0959491683425, 5498.45015498447, 5527.585431092684, 8890.73327800167, 455836.0, 489756.0, 498171.0, 510172.0, 511262.0, 70502.64748676223, 71396.0, 74029.25970740331, 74339.76980690588, 74870.62564687141, 1026.58423338548, 1044.1698849414581, 1044.8798388185303, 1060.7719340341864, 1066.5680399438086, 14280.0, 14471.638209044859, 14542.40417737957, 14682.706345873235, 14710.926445367704, 33707.15732106717, 33782.49326260059, 34346.14134646554, 34438.48342274818, 34820.65179348276, 44057.0, 44784.552154479345, 45369.0, 45691.77154114208, 47351.52648473471, 8818.11818818113, 8839.46963182211, 8881.866771998297, 8977.551122443982, 9031.05173956725, 10455.372677639367, 10471.842922356323, 10553.841692374774, 10714.89285107139, 10800.24398292112, 11398.0, 13040.478380864659, 13138.73722525525, 13764.587062388144, 14087.295635217994, 13113.803292950422, 13310.134841235289, 13353.866461335263, 13628.454861805416, 13632.250226237653, 13662.180269183484, 13665.863341366858, 13807.861921380658, 14135.929320353744, 14138.575842724735, 7697.692092316244, 8825.823483530165, 8883.156100170474, 8946.194842464209, 8971.28229741606, 8543.957280213559, 8618.396712230084, 11311.717207069889, 13462.461501539829, 13710.794338084737], "unit": "score", "name": "jquery.html", "value": 8513.895420914692}, {"lowerIsBetter": false, "replicates": [1508.336332013913, 1605.1893793634217, 1670.7159782836916, 1685.8904171228874, 1697.117498900571, 6813.148356455443, 7242.275772422755, 7287.708491660327, 7301.598412087333, 7367.4474414419, 7114.928850711492, 7148.392386647129, 7168.211496735355, 7183.461240406978, 7202.8559428811395, 1991.4822146242009, 2010.9698354524694, 2024.736784218057, 2026.5136367271896, 2033.5017920609398, 1790.0423273548588, 1806.7199584064426, 1819.8271164239377, 1835.155828318975, 1851.3797877710915, 1695.4489790817972, 1747.8951262924265, 2017.6368253714325, 2028.239410221167, 2065.783092775252, 2041.7754047054812, 2052.733144691188, 2057.4342055934662, 2057.722207501983, 2069.6791997240452, 2061.4537147655883, 2065.308121779206, 2091.8640288381207, 2095.779943105967, 2096.3396530093123, 6976.5814051157095, 7137.678804453812, 7137.785866424016, 7138.964305178492, 7162.391196748283, 4075.2460794753065, 4150.626443620058, 4159.272127377697, 4162.91674166515, 4177.12280421112, 2695.460907818444, 2753.0, 2756.145594865598, 2815.5635876439183, 2831.886724531016, 868.3704314372093, 1691.805442374118, 1721.079222615907, 1724.1206984437902, 1735.2364959417941, 9737.951310243403, 9778.119969202735, 9802.117809397188, 9833.311668183302, 9920.950395247977, 3814.122751767109, 3847.153626202231, 3854.5952674969285, 3896.162325100117, 3901.9804900975314, 7614.771556853303, 7666.693332266647, 7677.347425468786, 7679.884801727979, 7681.1934746850775, 4171.5828417158045, 4181.435506206623, 4209.431726716854, 4211.642010429148, 4214.873553793391, 3820.980895095562, 3836.1368692044625, 3853.4412510186426, 3871.9806400967814, 3873.8450461981206, 3140.7016333448287, 3157.0844455107763, 3160.1309639848764, 3168.6197656280933, 3178.984105079506, 916.6883259691604, 916.7204002779083, 946.4274114160971, 954.8949615542285, 957.7701351675687, 946.5693109635099, 972.1250874213265, 979.7256768104942, 986.753311672082, 1028.7736697926443, 6571.57284776488, 6598.0, 6646.534742567974, 6648.335166483313, 6688.431483323972, 1031.566741968375, 1043.984340234897, 1048.7168464514539, 1052.126734810121, 1054.9683509494728, 5407.351117865881, 5409.404965453797, 5415.566754659618, 5429.647072940246, 5439.075357189287, 8144.714934977247, 8160.6327715252955, 8352.540610266493, 8397.0, 8470.15298470148, 8181.222783835526, 8271.875921861178, 8284.668613255402, 8298.253157215879, 8302.70940517079, 6634.402903738686, 6643.40209381158, 6697.564658297195, 6730.697118629576, 6750.32496750321, 6609.107770450928, 6623.801285961429, 6627.105340778933, 6630.071789949508, 6661.666916654051, 7421.740239091606, 7546.698132074655, 7561.7731468056045, 7659.042619672541, 7686.9231307686205, 7554.584497852671, 7698.230176982481, 7750.728724494616, 7788.104367997753, 7804.219578042151, 5879.588428809942, 5929.851753706192, 5947.613405128653, 5983.132445795422, 5994.490468310068, 6880.415164710856, 6947.5831450113155, 6959.61722105289, 6960.990656354901, 6976.825579360557, 6595.241547222131, 6640.0, 6664.533482656361, 6671.733130674718, 6758.459323254227, 5351.518363347317, 6323.019931910561, 6364.77723279683, 6393.93606063952, 6485.675716214076, 6347.0479428086155, 6421.550491465552, 6429.6142231466265, 6439.356064393523, 6468.288488266381, 5823.475887170175, 5918.496927761016, 5936.0, 5969.134475500941, 5969.8806023878415, 5963.493103086286, 5972.790952316648, 5975.611585246945, 5993.101034844808, 6017.037274036134], "unit": "score", "name": "mootools.html", "value": 4099.225985045545}, {"lowerIsBetter": false, "replicates": [293.3780385582565, 297.97020297970204, 303.58560564829014, 303.917942155618, 308.4986896293523, 5599.832005039851, 5616.522595579376, 5666.8583285417835, 5674.716264186794, 5808.506276966453, 5573.6098473106895, 5601.579881508883, 5610.046292130338, 5660.632058916178, 5675.212308122938, 4030.637242648161, 4269.060806622546, 4295.591918767712, 4295.656347492193, 4298.032942587908, 4115.691323150776, 4205.558416366283, 4254.63835573975, 4269.124829409979, 4319.2441322768545, 4230.0, 4252.277112890801, 4261.573842615745, 4263.3178691409385, 4264.296391095481, 4236.618704316611, 4252.957470425287, 4261.808218630138, 4266.31738921771, 4270.423492828475, 3696.85212591496, 3699.445083237509, 3700.4634328022285, 3701.167237371597, 3704.8888533344043, 5275.709835959021, 5368.489993450616, 5376.327959005124, 5376.596755243333, 5385.2999110115825, 4888.902221955576, 4894.3147959285725, 4895.192293271606, 4897.657163998521, 4900.387451568554, 5857.70711464425, 5858.56060795442, 5875.412458754133, 5886.234789477383, 5895.4694077532795, 3978.204359128186, 3983.7609743415196, 3989.601039896016, 3998.1603863188475, 4003.559608443069, 5973.1936188614845, 6185.226846644169, 6187.876242475125, 6190.288116866528, 6211.9999999999545, 4109.321961876317, 4115.279826030433, 4115.794210289533, 4122.299209134454, 4122.628963393249, 4145.253854306254, 4159.625633692982, 4177.749335039907, 4180.435641188462, 4198.097409057067, 4835.879103022453, 4837.733924634109, 4847.975760121177, 4851.56335929768, 4862.610991120702, 5630.8029218977135, 5756.079027355603, 5835.124731290341, 5840.211571437886, 5851.063829787214, 1441.8774404175763, 1465.0916431812132, 1469.8383177850428, 1469.8530146985215, 1470.3309993952726, 954.6610953111546, 978.6183388478499, 981.4896253947907, 996.0537489385113, 1003.2024540490328, 5140.331756871583, 5150.227465880148, 5158.252053452228, 5162.716050617177, 5171.198464238049, 6008.399160083956, 6122.602030867979, 6137.324894261627, 6200.56596038273, 6208.565400421927, 5181.4041385240425, 5201.635885487979, 5207.635465517377, 5213.452587478336, 5218.504242096995, 3257.478803391446, 3294.061192560157, 3317.2370354818527, 3320.0, 3326.434506133963, 5690.6301090429815, 5805.506531944832, 5823.330317013513, 5846.123081537803, 5849.181114643953, 6330.905036424458, 6340.302566717657, 6355.968220158869, 6365.681715914186, 6366.649834259068, 5831.329397119385, 5839.824805255764, 5840.620359676607, 5841.153032810219, 5848.4151584842875, 6155.907661385172, 6174.8147555573405, 6177.9691101546005, 6186.10301506288, 6189.164462797465, 5877.4122587740885, 5957.821265362046, 6021.759129634941, 6022.518198544193, 6038.788642397495, 5797.739101740347, 5822.796202132905, 5828.94171058284, 5831.271091113611, 5839.0949402842625, 4080.7347522410946, 4105.137921036616, 4114.794260286913, 4124.257633625856, 4124.319487284564, 6009.699515024318, 6129.969350153221, 6144.41628045335, 6153.353897840662, 6188.257409110935, 5909.497692695997, 5942.465178133989, 5945.316288626863, 5953.672548009901, 5960.403959604005, 5922.911156332572, 5932.940670593239, 5940.198073260054, 5943.643381396957, 5954.612950158399, 5662.405447427961, 5770.6249093808765, 5801.970990145022, 5804.506616937608, 5808.273965754281, 5903.203067585821, 5950.16697662319, 5958.374370691015, 5969.164316995711, 5973.313068997121, 5806.071028635567, 5818.214541036906, 5820.388859169896, 5824.126381042877, 5827.76688932438], "unit": "score", "name": "prototype.html", "value": 4391.25505584657}, {"lowerIsBetter": false, "replicates": [663.439393712313, 700.145822097042, 712.8895021271703, 740.0453415094528, 747.6112421540801, 10798.2441229114, 11012.614558490455, 11018.393988330648, 11029.558817647285, 11112.16658750595, 10522.684319470409, 13049.347532623355, 13228.206307621549, 13269.867301327007, 13272.535461258858, 768.5388766739967, 780.7696729464807, 789.8143936174994, 791.2759824760337, 792.5601291283335, 790.5414859381574, 792.8295416485455, 798.7164556582417, 800.1078797141175, 803.04036676172, 806.3468590441761, 810.2586133687669, 812.0661239574507, 812.4597142899964, 814.267159556401, 803.333233416263, 805.122416565943, 805.5851236613149, 805.6374631415887, 806.9314108300772, 601.1313651773189, 601.5879122800852, 602.5601311042919, 604.3080672629858, 604.3261763134118, 11072.944635276852, 11188.66434006981, 11198.328100313925, 11203.775924481546, 11207.103431725523, 10937.398443085627, 11014.229003969725, 11058.22592418531, 11242.49408776607, 11450.255733377304, 8974.730758077269, 8998.685046023358, 9133.315001374856, 9329.067093290685, 9472.479013654247, 3193.4890417533315, 3235.6117265928237, 3261.396641621284, 3265.232670322472, 3265.5264986576813, 39655.8017209915, 39842.20315593701, 40018.799906000284, 40105.39841902374, 40348.596514034776, 8436.746897593082, 8497.192766687154, 8559.22966932979, 8685.39202255836, 8777.780555486164, 15503.209422304093, 15538.223088845512, 15567.065976041475, 15578.376864925503, 15604.0, 6185.567010309307, 6272.5922815016875, 6373.840653983595, 6429.485641148697, 6458.6770661466735, 3409.4374428219066, 3474.617792042873, 3493.123380506299, 3579.158897659048, 3589.6769290763436, 2841.8010739248466, 2845.4593627210766, 2855.8572071396347, 2876.6404199475064, 2894.884204631833, 512.8102602037195, 513.1225604216756, 514.1798830864765, 515.7988384530037, 522.4305506997391, 485.96598238122994, 547.698765678875, 570.164708701754, 575.9136129580596, 589.1222079102107, 7028.578285302899, 7256.550567183239, 7525.58609276495, 7618.314351708373, 7666.8849967250535, 488.73608251543766, 489.21969458713295, 515.4639175257765, 542.1867199201198, 572.8882867840731, 3464.1512829356466, 3554.0937061049785, 3603.891883243507, 3713.3687273163628, 3786.413105968579, 46488.767556162005, 46824.531754682015, 46986.0, 48368.0, 48429.27356089662, 43317.566824331356, 43367.56632433635, 43649.127017459476, 44388.77805611016, 44451.55548444474, 40229.597704023174, 40594.391084133764, 40918.795406023375, 41038.179236415104, 41073.79463102725, 7453.217412171643, 7571.621418928921, 7681.07827060734, 7841.5687137208, 7881.290683838482, 30098.699013010464, 30224.09327720172, 30492.84753576218, 30789.384212316076, 31273.218169545944, 38372.23255534929, 40315.1936961265, 40472.79763601163, 40608.59391406048, 40623.59376406198, 9718.522927361444, 9739.366941148803, 10235.283530152818, 10248.846267306146, 10364.274500784873, 10787.568497260021, 10797.29817561856, 10892.237543371888, 11156.832647510457, 11557.653270401901, 10408.219383546415, 10525.263231573716, 10955.34267943926, 10997.61508347204, 11086.833697494705, 10778.407187604756, 10855.968682975104, 10905.509252083833, 10933.0, 10947.83578246311, 10047.598096076075, 10351.482425878827, 10429.895701042893, 10492.842607360742, 10729.463526823783, 8864.645414183618, 9266.258699304175, 9347.579358928728, 9392.624295028123, 9601.183899368632, 8848.336374771789, 8955.552222388986, 8992.46045237288, 8995.460272383678, 9058.36591438593], "unit": "score", "name": "yui.html", "value": 5642.55890790089}], "name": "dromaeo_css", "value": 6420.357357459744}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 114.0, 119.0, 111.0, 123.0, 114.0, 113.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [159.0, 133.0, 153.0, 167.0, 136.0, 154.0, 162.0, 144.0, 164.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 164.0, 163.0, 165.0, 168.0, 165.0, 163.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 73.0, 73.0, 73.0, 136.0, 73.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 143.0, 94.0, 96.0, 94.0, 141.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 71.0, 72.0, 71.0, 70.0, 72.0, 71.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 86.0, 85.0, 84.0, 85.0, 93.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [126.0, 120.0, 128.0, 122.0, 126.0, 132.0, 124.0, 120.0, 120.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 159.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 71.0, 71.0, 71.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1539.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [185.59762435040832], "unit": "score", "name": "DeltaBlue", "value": 356.2437839999999}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [717.5627240143369], "unit": "score", "name": "Earley", "value": 928.7870979020979}, {"lowerIsBetter": false, "replicates": [12746.835443037975], "unit": "score", "name": "Boyer", "value": 52.28458490566033}, {"lowerIsBetter": false, "replicates": [26315.78947368421], "unit": "score", "name": "RegExp", "value": 34.61742999999998}, {"lowerIsBetter": false, "replicates": [593.491124260355], "unit": "score", "name": "Splay", "value": 137.3078664007976}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 21203.148424883515}]} 07:22:27 INFO - RETURN: dromaeo_css: 6420.36 07:22:27 INFO - RETURN: kraken: 1539.20 07:22:27 INFO - RETURN: v8_7: 21203.15 07:22:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21203.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1539.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6420.36"}}} 07:22:27 INFO - Return code: 0 07:22:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:22:27 INFO - # TBPL SUCCESS # 07:22:27 INFO - Running post-action listener: _resource_record_post_action 07:22:27 INFO - Running post-run listener: _resource_record_post_run 07:22:28 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 522567680; Read time: 80; Write time: 766668 07:22:28 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 249475072; Read time: 0; Write time: 533480 07:22:28 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 273092608; Read time: 80; Write time: 233188 07:22:28 INFO - Running post-run listener: _upload_blobber_files 07:22:28 INFO - Blob upload gear active. 07:22:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:22:28 INFO - Copying logs to upload dir... 07:22:28 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.286027 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-15 07:22:25.644379) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 07:22:25.647935) ========= 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=004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010168 build_url: 'https://queue.taskcluster.net/v1/task/_HufQovSQ1Gtb6KP9uvuYQ/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-15 07:22:25.699750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:22:25.700083) ========= 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=004b26eee9c3b360c8654f40000001e1-1450184817.986627-1504613611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004746 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:22:25.749447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 07:22:25.749801) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 07:22:25.750102) ========= ========= Total master_lag: 0.19 =========