builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1450807515.93 results: success (0) buildid: 20151214025632 builduid: b66ad645f9ea46ce986289e656b5de0c revision: 99137d6d4061f408ae0869122649d8bdf489cc30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:15.933482) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:15.934021) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:15.934360) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006197 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:15.957446) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:15.957810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:15.972507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:15.973228) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:16.026288) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:16.026878) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:16.027588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:16.027908) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 10:05:16-- 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% 222M=0s 2015-12-22 10:05:16 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:16.147472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:16.147842) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022678 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:16.198208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 10:05:16.198591) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 99137d6d4061f408ae0869122649d8bdf489cc30 --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 99137d6d4061f408ae0869122649d8bdf489cc30 --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=23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 10:05:16,558 truncating revision to first 12 chars 2015-12-22 10:05:16,558 Setting DEBUG logging. 2015-12-22 10:05:16,559 attempt 1/10 2015-12-22 10:05:16,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/99137d6d4061?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 10:05:17,286 unpacking tar archive at: mozilla-central-99137d6d4061/testing/mozharness/ program finished with exit code 0 elapsedTime=1.028324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 10:05:17.239598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:17.239911) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:17.247702) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:17.247965) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 10:05:17.248353) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-22 10:05:17.248630) ========= /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=23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:17 INFO - MultiFileLogger online at 20151222 10:05:17 in /builds/slave/test 10:05:17 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 10:05:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:17 INFO - {'append_to_log': False, 10:05:17 INFO - 'base_work_dir': '/builds/slave/test', 10:05:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:05:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:17 INFO - 'branch': 'Firefox-Non-PGO', 10:05:17 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:17 INFO - 'config_files': ('talos/linux_config.py',), 10:05:17 INFO - 'default_actions': ('clobber', 10:05:17 INFO - 'read-buildbot-config', 10:05:17 INFO - 'download-and-extract', 10:05:17 INFO - 'populate-webroot', 10:05:17 INFO - 'create-virtualenv', 10:05:17 INFO - 'install', 10:05:17 INFO - 'run-tests'), 10:05:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:17 INFO - 'download_minidump_stackwalk': True, 10:05:17 INFO - 'download_symbols': 'ondemand', 10:05:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:17 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:17 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:17 INFO - 'installer_path': 'installer.exe', 10:05:17 INFO - 'log_level': 'info', 10:05:17 INFO - 'log_name': 'talos', 10:05:17 INFO - 'log_to_console': True, 10:05:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:17 INFO - 'opt_config_files': (), 10:05:17 INFO - 'pip_index': False, 10:05:17 INFO - 'sps_profile': False, 10:05:17 INFO - 'sps_profile_interval': 0, 10:05:17 INFO - 'suite': 'dromaeojs-e10s', 10:05:17 INFO - 'system_bits': '64', 10:05:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:17 INFO - 'title': 'talos-linux64-ix-030', 10:05:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:17 INFO - 'use_talos_json': True, 10:05:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:17 INFO - 'work_dir': 'build'} 10:05:17 INFO - ##### 10:05:17 INFO - ##### Running clobber step. 10:05:17 INFO - ##### 10:05:17 INFO - Running pre-action listener: _resource_record_pre_action 10:05:17 INFO - Running main action method: clobber 10:05:17 INFO - rmtree: /builds/slave/test/build 10:05:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:18 INFO - Running post-action listener: _resource_record_post_action 10:05:18 INFO - ##### 10:05:18 INFO - ##### Running read-buildbot-config step. 10:05:18 INFO - ##### 10:05:18 INFO - Running pre-action listener: _resource_record_pre_action 10:05:18 INFO - Running main action method: read_buildbot_config 10:05:18 INFO - Using buildbot properties: 10:05:18 INFO - { 10:05:18 INFO - "properties": { 10:05:18 INFO - "buildnumber": 187, 10:05:18 INFO - "product": "firefox", 10:05:18 INFO - "script_repo_revision": "production", 10:05:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:05:18 INFO - "repository": "", 10:05:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:05:18 INFO - "buildid": "20151214025632", 10:05:18 INFO - "slavename": "talos-linux64-ix-030", 10:05:18 INFO - "pgo_build": "False", 10:05:18 INFO - "basedir": "/builds/slave/test", 10:05:18 INFO - "project": "", 10:05:18 INFO - "platform": "ubuntu64_hw", 10:05:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:05:18 INFO - "slavebuilddir": "test", 10:05:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:05:18 INFO - "branch": "mozilla-central", 10:05:18 INFO - "repo_path": "mozilla-central", 10:05:18 INFO - "stage_platform": "linux64", 10:05:18 INFO - "builduid": "b66ad645f9ea46ce986289e656b5de0c", 10:05:18 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 10:05:18 INFO - }, 10:05:18 INFO - "sourcestamp": { 10:05:18 INFO - "repository": "", 10:05:18 INFO - "hasPatch": false, 10:05:18 INFO - "project": "", 10:05:18 INFO - "branch": "mozilla-central-linux64-talos", 10:05:18 INFO - "changes": [ 10:05:18 INFO - { 10:05:18 INFO - "category": null, 10:05:18 INFO - "files": [ 10:05:18 INFO - { 10:05:18 INFO - "url": null, 10:05:18 INFO - "name": "https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:05:18 INFO - } 10:05:18 INFO - ], 10:05:18 INFO - "repository": "", 10:05:18 INFO - "rev": "99137d6d4061f408ae0869122649d8bdf489cc30", 10:05:18 INFO - "who": "cbook@mozilla.com", 10:05:18 INFO - "when": 1450094876, 10:05:18 INFO - "number": 7357083, 10:05:18 INFO - "comments": "Merge m-c to b-i", 10:05:18 INFO - "project": "", 10:05:18 INFO - "at": "Mon 14 Dec 2015 04:07:56", 10:05:18 INFO - "branch": "mozilla-central-linux64-talos", 10:05:18 INFO - "revlink": "", 10:05:18 INFO - "properties": [ 10:05:18 INFO - [ 10:05:18 INFO - "buildid", 10:05:18 INFO - "20151214025632", 10:05:18 INFO - "Change" 10:05:18 INFO - ], 10:05:18 INFO - [ 10:05:18 INFO - "builduid", 10:05:18 INFO - "b66ad645f9ea46ce986289e656b5de0c", 10:05:18 INFO - "Change" 10:05:18 INFO - ], 10:05:18 INFO - [ 10:05:18 INFO - "pgo_build", 10:05:18 INFO - "False", 10:05:18 INFO - "Change" 10:05:18 INFO - ] 10:05:18 INFO - ], 10:05:18 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 10:05:18 INFO - } 10:05:18 INFO - ], 10:05:18 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 10:05:18 INFO - } 10:05:18 INFO - } 10:05:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:05:18 INFO - Running post-action listener: _resource_record_post_action 10:05:18 INFO - ##### 10:05:18 INFO - ##### Running download-and-extract step. 10:05:18 INFO - ##### 10:05:18 INFO - Running pre-action listener: _resource_record_pre_action 10:05:18 INFO - Running main action method: download_and_extract 10:05:18 INFO - mkdir: /builds/slave/test/build/tests 10:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:18 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json 10:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json 10:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:05:19 INFO - Downloaded 1302 bytes. 10:05:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:05:19 INFO - Using the following test package requirements: 10:05:19 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:19 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:19 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:19 INFO - u'jsshell-linux-x86_64.zip'], 10:05:19 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:19 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:19 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:19 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:19 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:19 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:19 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:19 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:19 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:05:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:05:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:05:21 INFO - Downloaded 21869728 bytes. 10:05:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:05:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:05:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:05:23 INFO - Return code: 0 10:05:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:05:23 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')]} 10:05:23 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:05:24 INFO - Downloaded 21869728 bytes. 10:05:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:05:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:05:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:05:25 INFO - Return code: 0 10:05:25 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')]} 10:05:25 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:05:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:05:26 INFO - Downloaded 11132038 bytes. 10:05:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 10:05:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:05:26 INFO - Return code: 0 10:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:26 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:05:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:05:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:05:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:05:27 INFO - Downloaded 57739813 bytes. 10:05:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:05:27 INFO - mkdir: /builds/slave/test/properties 10:05:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:27 INFO - Contents: 10:05:27 INFO - build_url:https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:05:27 INFO - Running post-action listener: _resource_record_post_action 10:05:27 INFO - Running post-action listener: set_extra_try_arguments 10:05:27 INFO - ##### 10:05:27 INFO - ##### Running populate-webroot step. 10:05:27 INFO - ##### 10:05:27 INFO - Running pre-action listener: _resource_record_pre_action 10:05:27 INFO - Running main action method: populate_webroot 10:05:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:27 INFO - '--tppagecycles', 10:05:27 INFO - '7'], 10:05:27 INFO - 'tests': ['tsvgm']}}, 10:05:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:05:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:05:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:05:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:27 INFO - 'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:27 INFO - 'tests': ['damp', 'tps']}, 10:05:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:27 INFO - 'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['damp', 'tps']}, 10:05:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:05:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:27 INFO - 'other': {'tests': ['a11yr', 10:05:27 INFO - 'ts_paint', 10:05:27 INFO - 'tpaint', 10:05:27 INFO - 'sessionrestore', 10:05:27 INFO - 'sessionrestore_no_auto_restore']}, 10:05:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['a11yr', 10:05:27 INFO - 'ts_paint', 10:05:27 INFO - 'tpaint', 10:05:27 INFO - 'sessionrestore', 10:05:27 INFO - 'sessionrestore_no_auto_restore']}, 10:05:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['a11yr', 10:05:27 INFO - 'ts_paint', 10:05:27 INFO - 'tpaint', 10:05:27 INFO - 'sessionrestore', 10:05:27 INFO - 'sessionrestore_no_auto_restore']}, 10:05:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['a11yr', 10:05:27 INFO - 'ts_paint', 10:05:27 INFO - 'tpaint', 10:05:27 INFO - 'sessionrestore', 10:05:27 INFO - 'sessionrestore_no_auto_restore']}, 10:05:27 INFO - 'other_l64': {'tests': ['a11yr', 10:05:27 INFO - 'ts_paint', 10:05:27 INFO - 'tpaint', 10:05:27 INFO - 'sessionrestore', 10:05:27 INFO - 'sessionrestore_no_auto_restore']}, 10:05:27 INFO - 'other_nol64': {'tests': ['a11yr', 10:05:27 INFO - 'ts_paint', 10:05:27 INFO - 'tpaint', 10:05:27 INFO - 'sessionrestore', 10:05:27 INFO - 'sessionrestore_no_auto_restore']}, 10:05:27 INFO - 'svgr': {'tests': ['tsvgx', 10:05:27 INFO - 'tsvgr_opacity', 10:05:27 INFO - 'tart', 10:05:27 INFO - 'tscrollx', 10:05:27 INFO - 'cart']}, 10:05:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['tsvgx', 10:05:27 INFO - 'tsvgr_opacity', 10:05:27 INFO - 'tart', 10:05:27 INFO - 'tscrollx', 10:05:27 INFO - 'cart']}, 10:05:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:27 INFO - 'tests': ['tp5o']}, 10:05:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:27 INFO - 'talos_options': ['--e10s'], 10:05:27 INFO - 'tests': ['tp5o']}, 10:05:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:27 INFO - 'talos_options': ['--xperf_path', 10:05:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:27 INFO - 'tests': ['tp5n']}, 10:05:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:27 INFO - 'talos_options': ['--e10s', 10:05:27 INFO - '--xperf_path', 10:05:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:27 INFO - 'tests': ['tp5n']}}, 10:05:27 INFO - 'talos.zip': {'path': '', 10:05:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:27 INFO - Running post-action listener: _resource_record_post_action 10:05:27 INFO - ##### 10:05:27 INFO - ##### Running create-virtualenv step. 10:05:27 INFO - ##### 10:05:27 INFO - Running pre-action listener: _resource_record_pre_action 10:05:27 INFO - Running main action method: create_virtualenv 10:05:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:27 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 10:05:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:27 INFO - Using real prefix '/usr' 10:05:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:30 INFO - Installing pip.................done. 10:05:30 INFO - Return code: 0 10:05:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:30 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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05:30 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 10:05:30 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 10:05:30 INFO - Using env: {'DISPLAY': ':0', 10:05:30 INFO - 'HOME': '/home/cltbld', 10:05:30 INFO - 'LANG': 'en_US.UTF-8', 10:05:30 INFO - 'LANGUAGE': 'en_US:en', 10:05:30 INFO - 'LOGNAME': 'cltbld', 10:05:30 INFO - 'MAIL': '/var/mail/cltbld', 10:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:30 INFO - 'MOZ_NO_REMOTE': '1', 10:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:30 INFO - 'NO_EM_RESTART': '1', 10:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:30 INFO - 'PWD': '/builds/slave/test', 10:05:30 INFO - 'SHELL': '/bin/bash', 10:05:30 INFO - 'SHLVL': '1', 10:05:30 INFO - 'TERM': 'linux', 10:05:30 INFO - 'TMOUT': '86400', 10:05:30 INFO - 'USER': 'cltbld', 10:05:30 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:30 INFO - '_': '/tools/buildbot/bin/python'} 10:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:30 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 10:05:30 INFO - Cleaning up... 10:05:30 INFO - Return code: 0 10:05:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:30 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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05:30 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 10:05:30 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 10:05:30 INFO - Using env: {'DISPLAY': ':0', 10:05:30 INFO - 'HOME': '/home/cltbld', 10:05:30 INFO - 'LANG': 'en_US.UTF-8', 10:05:30 INFO - 'LANGUAGE': 'en_US:en', 10:05:30 INFO - 'LOGNAME': 'cltbld', 10:05:30 INFO - 'MAIL': '/var/mail/cltbld', 10:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:30 INFO - 'MOZ_NO_REMOTE': '1', 10:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:30 INFO - 'NO_EM_RESTART': '1', 10:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:30 INFO - 'PWD': '/builds/slave/test', 10:05:30 INFO - 'SHELL': '/bin/bash', 10:05:30 INFO - 'SHLVL': '1', 10:05:30 INFO - 'TERM': 'linux', 10:05:30 INFO - 'TMOUT': '86400', 10:05:30 INFO - 'USER': 'cltbld', 10:05:30 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:30 INFO - '_': '/tools/buildbot/bin/python'} 10:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:30 INFO - Downloading/unpacking psutil>=0.7.1 10:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:32 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:05:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:32 INFO - Installing collected packages: psutil 10:05:32 INFO - Running setup.py install for psutil 10:05:32 INFO - building 'psutil._psutil_linux' extension 10:05:32 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 10:05:32 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 10:05:32 INFO - building 'psutil._psutil_posix' extension 10:05:32 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 10:05:33 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 10:05:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:33 INFO - Successfully installed psutil 10:05:33 INFO - Cleaning up... 10:05:33 INFO - Return code: 0 10:05:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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', '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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:05: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 mozsystemmonitor==0.0.0 10:05:33 INFO - Using env: {'DISPLAY': ':0', 10:05:33 INFO - 'HOME': '/home/cltbld', 10:05:33 INFO - 'LANG': 'en_US.UTF-8', 10:05:33 INFO - 'LANGUAGE': 'en_US:en', 10:05:33 INFO - 'LOGNAME': 'cltbld', 10:05:33 INFO - 'MAIL': '/var/mail/cltbld', 10:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:33 INFO - 'MOZ_NO_REMOTE': '1', 10:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:33 INFO - 'NO_EM_RESTART': '1', 10:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:33 INFO - 'PWD': '/builds/slave/test', 10:05:33 INFO - 'SHELL': '/bin/bash', 10:05:33 INFO - 'SHLVL': '1', 10:05:33 INFO - 'TERM': 'linux', 10:05:33 INFO - 'TMOUT': '86400', 10:05:33 INFO - 'USER': 'cltbld', 10:05:33 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:33 INFO - '_': '/tools/buildbot/bin/python'} 10:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:05:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:05:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:05:35 INFO - Installing collected packages: mozsystemmonitor 10:05:35 INFO - Running setup.py install for mozsystemmonitor 10:05:35 INFO - Successfully installed mozsystemmonitor 10:05:35 INFO - Cleaning up... 10:05:35 INFO - Return code: 0 10:05:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05:35 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 10:05:35 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 10:05:35 INFO - Using env: {'DISPLAY': ':0', 10:05:35 INFO - 'HOME': '/home/cltbld', 10:05:35 INFO - 'LANG': 'en_US.UTF-8', 10:05:35 INFO - 'LANGUAGE': 'en_US:en', 10:05:35 INFO - 'LOGNAME': 'cltbld', 10:05:35 INFO - 'MAIL': '/var/mail/cltbld', 10:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:35 INFO - 'MOZ_NO_REMOTE': '1', 10:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:35 INFO - 'NO_EM_RESTART': '1', 10:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:35 INFO - 'PWD': '/builds/slave/test', 10:05:35 INFO - 'SHELL': '/bin/bash', 10:05:35 INFO - 'SHLVL': '1', 10:05:35 INFO - 'TERM': 'linux', 10:05:35 INFO - 'TMOUT': '86400', 10:05:35 INFO - 'USER': 'cltbld', 10:05:35 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:35 INFO - '_': '/tools/buildbot/bin/python'} 10:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:35 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:35 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 10:05:35 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 10:05:35 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 10:05:35 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 10:05:35 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 10:05:35 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 10:05:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:37 INFO - Downloading docopt-0.6.1.tar.gz 10:05:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:37 INFO - Running setup.py install for blobuploader 10:05:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:37 INFO - Running setup.py install for requests 10:05:38 INFO - Running setup.py install for docopt 10:05:38 INFO - Successfully installed blobuploader requests docopt 10:05:38 INFO - Cleaning up... 10:05:38 INFO - Return code: 0 10:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:38 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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05:38 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 10:05:38 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 10:05:38 INFO - Using env: {'DISPLAY': ':0', 10:05:38 INFO - 'HOME': '/home/cltbld', 10:05:38 INFO - 'LANG': 'en_US.UTF-8', 10:05:38 INFO - 'LANGUAGE': 'en_US:en', 10:05:38 INFO - 'LOGNAME': 'cltbld', 10:05:38 INFO - 'MAIL': '/var/mail/cltbld', 10:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:38 INFO - 'MOZ_NO_REMOTE': '1', 10:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:38 INFO - 'NO_EM_RESTART': '1', 10:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:38 INFO - 'PWD': '/builds/slave/test', 10:05:38 INFO - 'SHELL': '/bin/bash', 10:05:38 INFO - 'SHLVL': '1', 10:05:38 INFO - 'TERM': 'linux', 10:05:38 INFO - 'TMOUT': '86400', 10:05:38 INFO - 'USER': 'cltbld', 10:05:38 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:38 INFO - '_': '/tools/buildbot/bin/python'} 10:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:38 INFO - Running setup.py (path:/tmp/pip-HZ9Sbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:38 INFO - Running setup.py (path:/tmp/pip-QclpGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:38 INFO - Running setup.py (path:/tmp/pip-2tmEM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:38 INFO - Running setup.py (path:/tmp/pip-zRtTi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:38 INFO - Running setup.py (path:/tmp/pip-aahpdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:38 INFO - Running setup.py (path:/tmp/pip-1hRkox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:39 INFO - Running setup.py (path:/tmp/pip-j_75xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:39 INFO - Running setup.py (path:/tmp/pip-BAjud6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:39 INFO - Running setup.py (path:/tmp/pip-wTigJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:39 INFO - Running setup.py (path:/tmp/pip-ocE_O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:39 INFO - Running setup.py (path:/tmp/pip-S21OFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:39 INFO - Running setup.py (path:/tmp/pip-zbSvq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:39 INFO - Running setup.py (path:/tmp/pip-JNBUSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:39 INFO - Running setup.py (path:/tmp/pip-72EXnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:39 INFO - Running setup.py (path:/tmp/pip-YWm5Yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:39 INFO - Running setup.py (path:/tmp/pip-8jqhUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:39 INFO - Running setup.py (path:/tmp/pip-RAh9Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:39 INFO - Running setup.py install for manifestparser 10:05:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:39 INFO - Running setup.py install for mozcrash 10:05:40 INFO - Running setup.py install for mozdebug 10:05:40 INFO - Running setup.py install for mozdevice 10:05:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Running setup.py install for mozfile 10:05:40 INFO - Running setup.py install for mozhttpd 10:05:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Running setup.py install for mozinfo 10:05:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Running setup.py install for mozInstall 10:05:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Running setup.py install for mozleak 10:05:40 INFO - Running setup.py install for mozlog 10:05:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Running setup.py install for moznetwork 10:05:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:40 INFO - Running setup.py install for mozprocess 10:05:41 INFO - Running setup.py install for mozprofile 10:05:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:41 INFO - Running setup.py install for mozrunner 10:05:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:41 INFO - Running setup.py install for mozscreenshot 10:05:41 INFO - Running setup.py install for moztest 10:05:41 INFO - Running setup.py install for mozversion 10:05:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:41 INFO - Cleaning up... 10:05:41 INFO - Return code: 0 10:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05:41 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 10:05:41 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 10:05:41 INFO - Using env: {'DISPLAY': ':0', 10:05:41 INFO - 'HOME': '/home/cltbld', 10:05:41 INFO - 'LANG': 'en_US.UTF-8', 10:05:41 INFO - 'LANGUAGE': 'en_US:en', 10:05:41 INFO - 'LOGNAME': 'cltbld', 10:05:41 INFO - 'MAIL': '/var/mail/cltbld', 10:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:41 INFO - 'MOZ_NO_REMOTE': '1', 10:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:41 INFO - 'NO_EM_RESTART': '1', 10:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:41 INFO - 'PWD': '/builds/slave/test', 10:05:41 INFO - 'SHELL': '/bin/bash', 10:05:41 INFO - 'SHLVL': '1', 10:05:41 INFO - 'TERM': 'linux', 10:05:41 INFO - 'TMOUT': '86400', 10:05:41 INFO - 'USER': 'cltbld', 10:05:41 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:41 INFO - '_': '/tools/buildbot/bin/python'} 10:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:41 INFO - Running setup.py (path:/tmp/pip-OyOcU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:41 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)) 10:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:41 INFO - Running setup.py (path:/tmp/pip-sCY2bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:41 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)) 10:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:41 INFO - Running setup.py (path:/tmp/pip-NJwOhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:42 INFO - Running setup.py (path:/tmp/pip-farAHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:42 INFO - Running setup.py (path:/tmp/pip-_eeHg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:42 INFO - Running setup.py (path:/tmp/pip-cSBwVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:42 INFO - Running setup.py (path:/tmp/pip-64Rjlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:42 INFO - Running setup.py (path:/tmp/pip-nzUOJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:42 INFO - Running setup.py (path:/tmp/pip-u_Dgvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:42 INFO - Running setup.py (path:/tmp/pip-mUKtXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:42 INFO - Running setup.py (path:/tmp/pip-UHBxQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:42 INFO - Running setup.py (path:/tmp/pip-TGV_6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:42 INFO - Running setup.py (path:/tmp/pip-xJqSkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:42 INFO - Running setup.py (path:/tmp/pip-EtM9Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:42 INFO - Running setup.py (path:/tmp/pip-DRKKWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:42 INFO - Running setup.py (path:/tmp/pip-Mf9u_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:42 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)) 10:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:43 INFO - Running setup.py (path:/tmp/pip-3lgaFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:43 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)) 10:05:43 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)) 10:05:43 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)) 10:05:43 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)) 10:05:43 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)) 10:05:43 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)) 10:05:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:44 INFO - Downloading blessings-1.5.1.tar.gz 10:05:44 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 10:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:44 INFO - Installing collected packages: blessings 10:05:44 INFO - Running setup.py install for blessings 10:05:44 INFO - Successfully installed blessings 10:05:44 INFO - Cleaning up... 10:05:44 INFO - Return code: 0 10:05:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:45 INFO - Reading from file tmpfile_stdout 10:05:45 INFO - Current package versions: 10:05:45 INFO - argparse == 1.2.1 10:05:45 INFO - blessings == 1.5.1 10:05:45 INFO - blobuploader == 1.2.4 10:05:45 INFO - docopt == 0.6.1 10:05:45 INFO - manifestparser == 1.1 10:05:45 INFO - mozInstall == 1.12 10:05:45 INFO - mozcrash == 0.16 10:05:45 INFO - mozdebug == 0.1 10:05:45 INFO - mozdevice == 0.47 10:05:45 INFO - mozfile == 1.2 10:05:45 INFO - mozhttpd == 0.7 10:05:45 INFO - mozinfo == 0.9 10:05:45 INFO - mozleak == 0.1 10:05:45 INFO - mozlog == 3.1 10:05:45 INFO - moznetwork == 0.27 10:05:45 INFO - mozprocess == 0.22 10:05:45 INFO - mozprofile == 0.27 10:05:45 INFO - mozrunner == 6.11 10:05:45 INFO - mozscreenshot == 0.1 10:05:45 INFO - mozsystemmonitor == 0.0 10:05:45 INFO - moztest == 0.7 10:05:45 INFO - mozversion == 1.4 10:05:45 INFO - psutil == 3.1.1 10:05:45 INFO - requests == 1.2.3 10:05:45 INFO - wsgiref == 0.1.2 10:05:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:45 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')]} 10:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:45 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')]} 10:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:45 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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05:45 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 10:05:45 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 10:05:45 INFO - Using env: {'DISPLAY': ':0', 10:05:45 INFO - 'HOME': '/home/cltbld', 10:05:45 INFO - 'LANG': 'en_US.UTF-8', 10:05:45 INFO - 'LANGUAGE': 'en_US:en', 10:05:45 INFO - 'LOGNAME': 'cltbld', 10:05:45 INFO - 'MAIL': '/var/mail/cltbld', 10:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:45 INFO - 'MOZ_NO_REMOTE': '1', 10:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:45 INFO - 'NO_EM_RESTART': '1', 10:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:45 INFO - 'PWD': '/builds/slave/test', 10:05:45 INFO - 'SHELL': '/bin/bash', 10:05:45 INFO - 'SHLVL': '1', 10:05:45 INFO - 'TERM': 'linux', 10:05:45 INFO - 'TMOUT': '86400', 10:05:45 INFO - 'USER': 'cltbld', 10:05:45 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:45 INFO - '_': '/tools/buildbot/bin/python'} 10:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:45 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)) 10:05:45 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)) 10:05:45 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)) 10:05:45 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)) 10:05:45 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)) 10:05:45 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)) 10:05:45 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)) 10:05:45 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)) 10:05: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:05:45 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)) 10:05:45 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)) 10:05:45 INFO - Cleaning up... 10:05:45 INFO - Return code: 0 10:05:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:45 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')]} 10:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:45 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')]} 10:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:45 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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05:45 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 10:05:45 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 10:05:45 INFO - Using env: {'DISPLAY': ':0', 10:05:45 INFO - 'HOME': '/home/cltbld', 10:05:45 INFO - 'LANG': 'en_US.UTF-8', 10:05:45 INFO - 'LANGUAGE': 'en_US:en', 10:05:45 INFO - 'LOGNAME': 'cltbld', 10:05:45 INFO - 'MAIL': '/var/mail/cltbld', 10:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:45 INFO - 'MOZ_NO_REMOTE': '1', 10:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:45 INFO - 'NO_EM_RESTART': '1', 10:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:45 INFO - 'PWD': '/builds/slave/test', 10:05:45 INFO - 'SHELL': '/bin/bash', 10:05:45 INFO - 'SHLVL': '1', 10:05:45 INFO - 'TERM': 'linux', 10:05:45 INFO - 'TMOUT': '86400', 10:05:45 INFO - 'USER': 'cltbld', 10:05:45 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:45 INFO - '_': '/tools/buildbot/bin/python'} 10:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:45 INFO - Downloading/unpacking jsonschema 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:47 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 10:05:47 INFO - Downloading/unpacking functools32 (from jsonschema) 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:47 INFO - warning: no files found matching '*.txt' 10:05:47 INFO - no previously-included directories found matching 'build' 10:05:47 INFO - no previously-included directories found matching 'dist' 10:05:47 INFO - no previously-included directories found matching '.git*' 10:05:47 INFO - Installing collected packages: jsonschema, functools32 10:05:47 INFO - Running setup.py install for functools32 10:05:47 INFO - warning: no files found matching '*.txt' 10:05:47 INFO - no previously-included directories found matching 'build' 10:05:47 INFO - no previously-included directories found matching 'dist' 10:05:47 INFO - no previously-included directories found matching '.git*' 10:05:47 INFO - Successfully installed jsonschema functools32 10:05:47 INFO - Cleaning up... 10:05:47 INFO - Return code: 0 10:05:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:05:47 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')]} 10:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 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')]} 10:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 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 0x7fa3a7eedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', '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 10:05:47 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 10:05:47 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 10:05:47 INFO - Using env: {'DISPLAY': ':0', 10:05:47 INFO - 'HOME': '/home/cltbld', 10:05:47 INFO - 'LANG': 'en_US.UTF-8', 10:05:47 INFO - 'LANGUAGE': 'en_US:en', 10:05:47 INFO - 'LOGNAME': 'cltbld', 10:05:47 INFO - 'MAIL': '/var/mail/cltbld', 10:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:47 INFO - 'MOZ_NO_REMOTE': '1', 10:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:47 INFO - 'NO_EM_RESTART': '1', 10:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:47 INFO - 'PWD': '/builds/slave/test', 10:05:47 INFO - 'SHELL': '/bin/bash', 10:05:47 INFO - 'SHLVL': '1', 10:05:47 INFO - 'TERM': 'linux', 10:05:47 INFO - 'TMOUT': '86400', 10:05:47 INFO - 'USER': 'cltbld', 10:05:47 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:47 INFO - '_': '/tools/buildbot/bin/python'} 10:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:47 INFO - Downloading/unpacking flake8 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:05:49 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 10:05:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:49 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 10:05:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:50 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 10:05:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:50 INFO - no previously-included directories found matching 'docs/_build' 10:05:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:50 INFO - Running setup.py install for pep8 10:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:50 INFO - no previously-included directories found matching 'docs/_build' 10:05:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:05:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:50 INFO - Cleaning up... 10:05:50 INFO - Return code: 0 10:05:50 INFO - Running post-action listener: _resource_record_post_action 10:05:50 INFO - Running post-action listener: _start_resource_monitoring 10:05:50 INFO - Starting resource monitoring. 10:05:50 INFO - ##### 10:05:50 INFO - ##### Running install step. 10:05:50 INFO - ##### 10:05:50 INFO - Running pre-action listener: _resource_record_pre_action 10:05:50 INFO - Running main action method: install 10:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:50 INFO - Reading from file tmpfile_stdout 10:05:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:50 INFO - Reading from file tmpfile_stdout 10:05:50 INFO - Output received: 10:05:50 INFO - Usage: mozinstall [options] installer 10:05:50 INFO - Options: 10:05:50 INFO - -h, --help show this help message and exit 10:05:50 INFO - -d DEST, --destination=DEST 10:05:50 INFO - Directory to install application into. [default: 10:05:50 INFO - "/builds/slave/test"] 10:05:50 INFO - --app=APP Application being installed. [default: firefox] 10:05:50 INFO - mkdir: /builds/slave/test/build/application 10:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:06:05 INFO - Reading from file tmpfile_stdout 10:06:05 INFO - Output received: 10:06:05 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:05 INFO - Running post-action listener: _resource_record_post_action 10:06:05 INFO - ##### 10:06:05 INFO - ##### Running run-tests step. 10:06:05 INFO - ##### 10:06:05 INFO - Running pre-action listener: _resource_record_pre_action 10:06:05 INFO - Running main action method: run_tests 10:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:05 INFO - Python 2.7.3 10:06:05 INFO - Return code: 0 10:06:05 INFO - grabbing minidump binary from tooltool 10:06:05 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')]} 10:06:05 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 0x10720b0>, '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 0x1072fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:05 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 10:06:05 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 10:06:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:05 INFO - Return code: 0 10:06:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:06:06 INFO - Return code: 0 10:06:06 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/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 10:06:06 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/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 10:06:06 INFO - Using env: {'DISPLAY': ':0', 10:06:06 INFO - 'HOME': '/home/cltbld', 10:06:06 INFO - 'LANG': 'en_US.UTF-8', 10:06:06 INFO - 'LANGUAGE': 'en_US:en', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MAIL': '/var/mail/cltbld', 10:06:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test', 10:06:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SHLVL': '1', 10:06:06 INFO - 'TERM': 'linux', 10:06:06 INFO - 'TMOUT': '86400', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - '_': '/tools/buildbot/bin/python'} 10:06:06 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/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 10:06:06 INFO - mozversion INFO | application_buildid: 20151214025632 10:06:06 INFO - mozversion INFO | application_changeset: 99137d6d4061f408ae0869122649d8bdf489cc30 10:06:06 INFO - mozversion INFO | application_display_name: Nightly 10:06:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:06 INFO - mozversion INFO | application_name: Firefox 10:06:06 INFO - mozversion INFO | application_remotingname: firefox 10:06:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 10:06:06 INFO - mozversion INFO | application_vendor: Mozilla 10:06:06 INFO - mozversion INFO | application_version: 45.0a1 10:06:06 INFO - mozversion INFO | platform_buildid: 20151214025632 10:06:06 INFO - mozversion INFO | platform_changeset: 99137d6d4061f408ae0869122649d8bdf489cc30 10:06:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 10:06:06 INFO - mozversion INFO | platform_version: 45.0a1 10:06:06 INFO - 2015-12-22 10:06:06,696 DEBUG : using testdate: 1450807566 10:06:06 INFO - 2015-12-22 10:06:06,697 DEBUG : actual date: 1450807566 10:06:06 INFO - 2015-12-22 10:06:06,716 INFO : starting webserver on 'localhost:59159' 10:06:06 INFO - 2015-12-22 10:06:06,717 INFO : Starting test suite talos-linux64-ix-030.e 10:06:06 INFO - 2015-12-22 10:06:06,717 INFO : Starting test dromaeo_css 10:06:06 INFO - 2015-12-22 10:06:06,718 DEBUG : operating with platform_type : linux_ 10:06:06 INFO - 2015-12-22 10:06:06,718 INFO : Initialising browser for dromaeo_css test... 10:06:06 INFO - 2015-12-22 10:06:06,732 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5VuPeK/profile http://localhost:59159/getInfo.html 10:06:11 INFO - 2015-12-22 10:06:11,756 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:06:11 INFO - 2015-12-22 10:06:11,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:06:11 INFO - 2015-12-22 10:06:11,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:06:11 INFO - 2015-12-22 10:06:11,756 DEBUG : BROWSER_OUTPUT: __metrics 10:06:11 INFO - 2015-12-22 10:06:11,898 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] 10:06:12 INFO - 2015-12-22 10:06:12,866 INFO : Browser initialized. 10:06:12 INFO - 2015-12-22 10:06:12,867 INFO : Running cycle 1/1 for dromaeo_css test... 10:06:12 INFO - 2015-12-22 10:06:12,867 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5VuPeK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:06:24 INFO - 2015-12-22 10:06:24,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 143249408 10:06:24 INFO - 2015-12-22 10:06:24,879 DEBUG : BROWSER_OUTPUT: 10:07:14 INFO - 2015-12-22 10:07:14,499 DEBUG : BROWSER_OUTPUT: 1450807634498 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] 10:09:26 INFO - 2015-12-22 10:09:26,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59159/tests/dromaeo/cssquery-ext.html) 10:09:27 INFO - 2015-12-22 10:09:27,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 146968576 10:09:27 INFO - 2015-12-22 10:09:27,805 DEBUG : BROWSER_OUTPUT: 10:12:29 INFO - 2015-12-22 10:12:29,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-ext.html (next: http://localhost:59159/tests/dromaeo/cssquery-jquery.html) 10:12:30 INFO - 2015-12-22 10:12:30,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 144748544 10:12:30 INFO - 2015-12-22 10:12:30,465 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2015-12-22 10:15:32,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59159/tests/dromaeo/cssquery-mootools.html) 10:15:32 INFO - 2015-12-22 10:15:32,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 145010688 10:15:32 INFO - 2015-12-22 10:15:32,875 DEBUG : BROWSER_OUTPUT: 10:18:34 INFO - 2015-12-22 10:18:34,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59159/tests/dromaeo/cssquery-prototype.html) 10:18:35 INFO - 2015-12-22 10:18:35,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 144617472 10:18:35 INFO - 2015-12-22 10:18:35,181 DEBUG : BROWSER_OUTPUT: 10:21:37 INFO - 2015-12-22 10:21:37,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59159/tests/dromaeo/cssquery-yui.html) 10:21:38 INFO - 2015-12-22 10:21:38,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 145108992 10:21:38 INFO - 2015-12-22 10:21:38,527 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-yui.html (next: http://localhost:59159/tests/dromaeo/cssquery-dojo.html) 10:24:41 INFO - 2015-12-22 10:24:41,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 147185664 10:24:41 INFO - 2015-12-22 10:24:41,259 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,259 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:24:41 INFO - 2015-12-22 10:24:41,259 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:24:41 INFO - 2015-12-22 10:24:41,259 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:24:41 INFO - 2015-12-22 10:24:41,259 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:24:41 INFO - 2015-12-22 10:24:41,261 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2696.4876673432045;2715.891364345426;2759.751622353988;2772.7920405969544;2789.7070807565206;4711.034237981215;4753.78607962642;4836.755754303573;4867.3915760529935;4926;4705.200115980283;4729.716217026981;4808.3268342432;4839.830605928793;4854.393200849894;4402.361657559652;4512.706674066183;4559.977200114012;4568.47462541807;4595.2188128018315;4337.414449049369;4516.683832131752;4523.479799823013;4549.818007279721;4647.930281045787;4359.869203923871;4403.273459879116;4495.258282383403;4516.864494065183;4537.659675524349;4488.41650585425;4507.323901414814;4522.23122069249;4526.818927242906;4527.275635898241;4276.615104640566;4387.517373088957;4453.665975051852;4479.574440428154;4497.572730590588;4664.836730714409;4737.24204127338;4760.476347601796;4775.617950563947;4783.760811959388;5183.170692689189;5201.843944681666;5206.062908676437;5208.5572726318305;5262.131748261532;5080.085584594772;5187.533122018998;5198.402183748842;5227.712475813829;5230.163173892159;4839.758012099452;4845.1278769821065;4870.14772414826;4882.487338829443;4908.092002979461;5355.357357117171;5358.142697168434;5366.2755528004;5370.812021579226;5371.328583927009;4960.50394960501;5079.8984020319385;5085.211792172219;5086.694798312114;5151.7681704323395;5016.097102521581;5116;5146.433892271847;5155.278261043457;5159.690418574897;5169.844904652867;5173.974130129325;5177.559907407837;5179.041877252645;5245.318108645852;4858.198397264412;5085.78218136799;5135.666181698178;5150.227465880148;5151.665141765773;4202.663786897041;4211.347241177622;4289.227938971015;4305.547917468683;4337.6963612546815;3806.2958352704836;3808.333541630204;3816.751911125768;3829.923401531954;3837.2901013312626;4317.611414972667;4415;4548.863534093983;4566.977165114153;4596.47140578831;5113.616478764107;5184.5593124584075;5186.118359878829;5188.688678679291;5224.608154388436;4494.752788596593;4507.301368287921;4526.456825180933;4532.206863798822;4584.564466375689;4412.9117417652105;4541.931871021938;4571.519990401027;4609.216433206363;4676.251799712029;4908.337374454403;4932.753362331798;4941.65408421407;4944.357233559686;4962.776675049631;5200.193969934666;5219.76511057011;5225.477452254744;5225.869353266046;5255.658382205297;4754.096721622881;4828.758562071812;4853.587445067209;4907.214845624683;4950.6782059166035;5128.3076784633595;5160.458151894147;5162.716050617252;5167.147420675697;5167.741612919414;5230.34620672416;5243.501867322599;5246.291750613618;5267.762950667153;5300;4831.275308703723;4943.950560494349;4958.305837182869;5065.797368105234;5083.949160508348;5068.087744206078;5078.492150784892;5088.1604535252745;5091.643584949018;5134.7175905324075;4936.062148191832;4937.407511098548;4967.552920237196;4993.925091123709;5013.548780609763;4845.466998630219;4970.62720295972;4977.576905963034;5039.647224694383;5088.262201980618;4996.50034996512;5008;5025.74871256443;5052.469490703424;5074.517920797518 10:24:41 INFO - 2015-12-22 10:24:41,262 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.4780126184542;580.3268208877703;582.4583137681957;583.6556431705293;587.8765459253558;35340.76307329241;36523.269534609324;36581.26837463249;36659;36687.26625467489;40237.7988110059;41173.38239926403;41250.17499650013;41282.38076428856;41360.58639413605;7947.927029850968;8019.478733882308;8104.959475202616;8106.959465202695;8119.3910456715685;7832.843343133134;7849.5682737449415;7874.645640946172;7953.562554059525;7969.521828690297;7853.842923141534;7904.762857114296;7916.089649690273;7964.8407031859615;7980.760577182694;7897.802554936144;8005.3195478384405;8021.478603890729;8030.317423019051;8058.315043221333;7847.803804904866;7927.3658107351275;7929.801754956115;7933.841323173562;7955.124936257007;36945.44581831275;37426.625733742585;37504.81247593772;37526.24947501034;37758.43362349567;2977.344984103494;2988.4120768817916;2991.5961345218334;3065.2183693158327;3347.681970212826;27664.58503122455;27747.306317342027;27819.165425037078;28063.0177943773;28618.570721439195;3406.795592264472;3415.8975230742867;3416.7437442191936;3482.3035392921515;3515.5410504640545;218088;218385;218801;218967;219782;49550.75224623854;53018.20472692913;53057;53404;53429.465705343224;44502.33246501305;61820.38179618236;63620.68189659022;63705.36294637087;63709.68145159245;12693.746125077447;12844.422001009976;12946.158499697489;12966.935165324114;12999.285039322927;9437.339386242897;9528.571214295373;9534.713958581253;9557.139857412867;9571.952140239255;18361.908190458962;18652.253909843726;18720;18730.90634546846;18744;7110.1112360954885;7310.268973102648;7363.190049094595;7413.851722965618;7448.5158464699625;857.8198578298502;873.9257163141077;953.2374100719396;1011.4487604255698;1021.4382089850552;26076.34809129787;26527.07155249557;26624.467510650065;26684.866575667387;27009.459810804066;890.2966656341417;920.6087412849512;932.3147486597345;1009.5255230041869;1049.0925349572565;11814.350210738492;12096.939515302367;12108.394580270951;12201.145919785708;12345.93827030859;202015;204385;205516;206435;206704;40126;40377.39433908494;40547.59452405497;40577;40656;1202.5490441084594;1230.3048777440897;1232.6918270432393;1241;1241.5716577780652;23418.18036368719;25939;26647.60028599611;26808.32979175536;26811.597826032234;37398.439023414125;37556.43665344967;37670;37728.81135594304;37768.811155944044;167417;167770.16114919347;169042;169100;169606;24447;25108.874455627603;26559.07043253477;28850.134495965154;28965.275868103465;33924.83037584796;34063.829680851435;34294.31411371809;34354.312913742084;34438.13904652404;31355;31407.52888706717;32070;32426.35147297088;32674.183145420604;31881.36237275288;38801.417978730904;40482.595174047885;41266.58733412628;42715;34461;34709.65290347165;34948.47577286292;35101.297974039866;36213.27573448569;35562.82218588891;36274;36901;37262.62737372592;37465.625343746215;29262;31268.061958141294;31720.206994825316;31796.523052153774;32630.51054234141 10:24:41 INFO - 2015-12-22 10:24:41,263 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.17958910873807;335.9059463350262;337.4617485111248;338.5801606008549;339.14535370865434;15402.768958465633;15434.922825385871;15967;16628.50114496564;17050.40323588673;9755.365901216433;9993.700188994324;10289.485525723721;10715.678529644103;10749.946250268738;4522.479914809798;4640.69835460694;4647;4647.512011238805;4650.069986002796;4765.332853400527;5103.5917126629965;5104.974475127619;5106.310648062501;5115.10485665009;3570.1431656402538;3674.393725035366;4989.226669866177;5065.468125846788;5067.1385864402955;5167.844964651066;5199.870003249911;5206.609504287194;5211.817586384477;5228.5555727763185;4977.552020318189;4996.150654388763;5020.548150666421;5134.0758663440565;5135.3837539495125;17988.91005544964;18365;18381.172847221773;18532.629347412978;18565.721514177163;1778.7954385245603;1840.4938641873457;1844.6771814932467;1867.7105048717472;1903.3243198664552;10306.381617102923;12844;12987.155834870704;13063.477460901648;13135.671608209776;1784.4111443223705;1805.729140628903;1818.6453641539906;1927.633749587574;2020.2727018273556;58413;58750;59763.701181493816;60109.39890601126;60464.39535604632;10011.849822252672;10045.29682922203;10054.34646747959;10074.093331600192;10135.797284054277;12492.81260781089;12528.373581320897;12530.874691252971;12567.308798016014;12653.17754345983;7082.079329687108;7089.149302083783;7114.679839407239;7115.324044215791;7160.964195178991;6685.097511835937;6719.731210751613;6745.696443660047;6752.088468056848;6780;4274.273373526508;4275.722078064916;4298.871033868989;4317.395564620955;4324.243257429937;1795.757572727665;1806.151108978778;1826.9451916442529;1838.8620853436046;1873.1196337721249;726.1504040272894;794.6900708723603;812.4117350579603;867.6355930509201;907.1155623267393;15243.542693719206;15485.148316842457;15528.223588820514;16114.516564503083;16118.838811611968;838.5304229631304;864.0797550608708;866.787637028932;877.5085951866974;894.181823631383;9022.323325750463;9345.439273643604;9387.389819661701;9414.905850941539;9503.619855205714;534630;548735;555543;556397;565864;70249.64875175693;71838.64080679564;72564.63717681378;73424.96162711103;76556;1108.3294606762954;1115.765689205276;1120.075937351688;1120.2438354111105;1122.4387806097116;14620.488282910048;14649.707005860037;14693.853061469676;14728;15047.172405517364;34172.48741268833;34455.827720861234;34834.47748283727;34845.30309393747;35233.82383088068;43050.78474607607;43804.78097609492;44908.326375103745;45160.54839451564;45393;8763.167499087576;8778.34162437807;8850.468971861708;9048.049954754655;9080.954595226982;10591.152707783513;10598.523066461874;10715.35707857531;10756.731081723019;11931.82102268484;13592.11651242666;13665.658358540719;13848.09987350819;13853.30733463343;13942.442302307794;13179;13615.931920340336;13913.791293130409;14073.356676351454;14386.928065359607;13723.382447790073;13884.58346249614;14165.079269847427;14263.572092837232;14536.273186340852;9013.332533481327;9108.026710751716;9129.5891684873;9177.678781242625;9200.309976751636;9434;9548.904510954802;9598.95200523993;14031.158130512202;14046.55572465765 10:24:41 INFO - 2015-12-22 10:24:41,264 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1374.3540535948107;1405.8383285922123;1422.7865820126985;1643.2523201943118;1733.2113888180875;7075.716971321147;7168.96415517923;7329.52358096724;7349.448791340657;7402.6668799904;7308.415326773858;7382.7785166444955;7410.2589741026;7410.407167426606;7416.814579635512;2058.084152552115;2072.9585408291823;2089.1747759634936;2089.676100204463;2091.8640288381284;2071.7410323709537;2085.1138266236862;2107.9894600527055;2138.6043581937315;2143.635581951064;2090.1743811194647;2093.8638988465777;2109.4093653776968;2128.31893793986;2129.84026198035;2102.096098677568;2115.4394085567337;2131;2132.4242454537266;2136.423165745248;2081.157131361801;2103.5582527669208;2112.0495776900457;2118.4280244333945;2129.0951345678027;7185.209626941085;7246;7259.382952449048;7262.419006479469;7273.927260727378;4223.176480586287;4277.764722940237;4283.100548884738;4306.5262821089655;4318.546552611993;2625;2664.147472808702;2770.7783377329765;2771.3210263485576;2772.3207814085677;853.4793775796759;876.5704804645678;877.7015814622995;883.924866386358;895.0333639669207;9700.563474643657;9705.660301889471;9707;9732.513374331254;9764.658236961672;3801.4487899255005;3828.4257361395457;3859.7877116758286;3863.092173339263;3864.2271545690974;7938.24586664266;7944.364450843918;7956.562389068541;7995.400344974034;8022.759317220492;4226.767527786002;4240.427542281815;4261.914761704748;4262.978685106555;4284.785760712014;3301.5873015873017;3418.077119177808;3878;3917.4515567820526;3941.586133456003;3179.0462861141564;3207.2142325130494;3216.6461689214166;3291.440455122587;3296.7032967033083;928.3547934185676;944.8252073366449;944.8866136063716;950.458238803889;952.7522844060455;837.7193640130624;839.7816567692444;850.9574521273912;851.1616058182685;996.3125443444001;6827.385535301747;6858.725650973905;6873.621950792754;6881.827954301082;6887.552309099892;418.8785252276867;424.17074619119546;425.3704517314392;430.5328718340573;430.7759964818277;5129.769160387791;5140.897182056413;5152.149895267314;5163.793448262028;5177.145770947752;8260.876086858701;8298.875516867252;8402.873956890651;8427.28368088707;8437.831243375098;8260.256576908107;8297.751067467985;8298.543580103153;8300.501969881827;8324.167583241628;6414.358564143548;6517.674116294166;6591.373819487141;6597.47220222381;6605.174353205849;6728.293529179561;6792.0830687856505;6797.966010169917;6800.82997925036;6809.489288303496;7753.883691744515;7811.062672479339;7904.288614024766;7915.168907264884;7984.041914970008;7892.644830982505;8040.2361775631225;8142.267195952156;8170.3055240302865;8218.424710270223;5351.438098999549;5442.564594832483;6217.906731399123;6250.06249062626;6278.591891527036;6511.218653761579;6644.667766611747;6697.564658297195;6705.731770729116;6717.529772916045;6329.49364050884;6411.166548348685;6427.485801135991;6476.481881449567;6534.869302614016;6236.594621349598;6297.2128483939505;6333;6366;6487.935120648733;6355.459785918249;6368.936310636835;6400.967995159995;6407.583507072025;6410.1025856381075;5978.671173085348;6027.517798576016;6065.2418447694035;6077.756889724362;6087.543434242361;6088.482478989158;6088.817335479943;6108.328083910677;6119.479844213113;6119.908201376894 10:24:41 INFO - 2015-12-22 10:24:41,265 DEBUG : BROWSER_OUTPUT: |4;prototype.html;308.1218527197487;316.78616933569833;318.29338867713665;318.8437665543884;322.0933073398385;5575.526080283175;5707.200991861143;5813.6802475863815;5841.269841269841;5859.79490717825;5653.8586535336535;5697.1169468732305;5713.428657134285;5716.799912003081;5718.142278658203;4101.856435024774;4219.599138081892;4224.809883555232;4373.103513779675;4383.408239887606;4326.567343265664;4351;4353.912921741563;4357.3899654048455;4375.562443755615;4305.67707421943;4308.6983911126235;4310.97844510777;4313.805878735465;4323.2490841209365;4324.913501729963;4325.070109926381;4329.242382583036;4331.0255192581735;4342.978285108586;3610.7472476926628;3771.9434208486896;3772.2078363543415;3773.2453509297975;3774.9245015099546;5352.9732351338;5459.044667183227;5464.644798088111;5472.835814925558;5481.260029895992;4884.413870335547;4945.357103576512;4947.777350019258;4952.4057113146655;4958.603311735053;5934.080217566284;5940.673262970535;5945.791897283574;5950.553708471882;5987.700614969234;3931.5478719947287;4051.817668204938;4060.939085913714;4065.918681626351;4085.59144085592;6225.128482012522;6281.685915704242;6296.842578935518;6300.810975670737;6305.211848518935;4195.30777421722;4196.559361267084;4197.664186865043;4197.895052623709;4205.726627769185;4248.702590818675;4256.1487702459635;4256.7445953242905;4262.424572682648;4273.529911709709;4734.928976065362;4908.9263661045115;4917.483664215278;4919.409670839522;4924.975375123101;5977.491913187341;5983.640981541122;5994.190784244159;5994.340622531518;5997.070454079625;1483.525271912999;1511.2821409830242;1512.7428337182705;1512.8411516790798;1513.1904431129292;981.3277904635347;996.0885789502524;999.6155324874956;1000.1648623399398;1001.2740762946951;5199.324087868628;5210.062188805976;5218.9562087582635;5229.215617657382;5244.396894357122;6176;6190.473809726133;6207.782727604603;6208;6217;5204;5209.791608335624;5209.947900520946;5222.033923724123;5231.110711179109;3266.6570010149067;3334.733221342335;3368.882089126869;3399.3201359728155;3402.302527981758;5769.798057067983;5901.3508514063415;5909.349971503131;5914.083317085772;5914.319853216935;6430.517711171681;6450.193725784277;6455.9677201613695;6462.612243265419;6465;5879.706014699248;5880.206172166788;5880.8235752927485;5882.294124705063;5887.646741195542;6081.604695694766;6157.753689852535;6189.442950134509;6201.782937597162;6215.223097112861;6054.757809687563;6100.694965251809;6101.572889897665;6109.847253818512;6112.205413296243;5782.7686892523825;5858.648481091148;5866.941330586639;5868.882622347614;5872.500837428866;4154.958450415457;4233.449651545279;4233.597808208216;4243.533211346811;4248.383984322318;6085.817425477243;6243.406876346739;6244.718987645476;6247.468965138014;6258.874822503615;5992.910106348496;5993.250843644544;6005.489533389711;6011.458968692838;6016.789412370546;5987.850303742267;6012;6016.398360163948;6016.819495415145;6020.066889632114;5785.710714464344;5818.0981947798155;5852.7658893643775;5871.060630299132;5882.617629854046;6003.979323514925;6018.7291571878495;6032.6983650818165;6041.75832966694;6062.666553339609;5897.705114744332;5902;5903.675297858487;5905.763769449346;5909.438603332676 10:24:41 INFO - 2015-12-22 10:24:41,266 DEBUG : BROWSER_OUTPUT: |5;yui.html;718.9820254493637;740.8814589665653;752.8343764371837;757.4889242162235;762.4357975098426;11782;11802.114841386887;12018.15872888898;12053.216540924834;12077.698057548554;11629.534818607246;11727.061835053197;11731.648050558475;11743.236689615169;11767.470463829126;414.41981226283144;419.24326590504126;786.4376970466116;800.0399520575304;811.4238890387832;808.8018435483315;811.3103861717552;813.3615112136944;814.5560669435172;814.8940637717088;850.9659613615479;851.9957400212991;861.2550144125349;862.5730263519566;865.355310293832;838.5136620759945;841.3563623827777;842.8862103616025;843.5318398288947;843.6625349860044;628.1770880147022;633.6958260035209;635.0601110356652;636.3000699230855;640.0495264532166;11456.656300311004;11640.301581905112;11658.941705291503;11669.70825729355;11732.061435085172;10772.892271077268;11384.373859437728;11402.72938733546;11406.429678516124;11532.942335288353;9235.861462078074;9392.389494682824;9393.718188454357;9396.859047114298;9470.763230919214;3228.903132905993;3287.96712032879;3301.5873015873017;3335.6164041135094;3342.498625206214;38312.61687383118;38446.42330365047;38544;38704;38715.41926871099;8619.525926074126;8805.955970220108;8855.778605534913;9065.954670226607;9119.133682300171;16492.587685307724;16669.666606667797;16722.74915876263;16757.83242167587;16771;6218.657973811393;6346.174997250328;6390.552661313756;6489.221293444817;6545.4436372907885;3365.3774051800497;3474.8745600239445;3554.680078792921;3574.088607405095;3610.6389361064207;2588.145911849085;2616.882240299191;2635.0908936416904;2639.2214296782495;2648.6291919131336;472.0605994071772;476.5782282679853;479.4318732302233;490.9558139767438;494.07854351633944;494.8020791683355;577.2322810661893;592.9445586855404;593.1932571702481;599.0355527600559;8025.23760242776;8383.245507904317;8644.95677521621;8665.13348665141;8680.392372533863;470.1490302552391;505.27997603414985;556.9832905012856;566.9454814045871;611.437477520682;3631.3463576556474;3780.243951209769;3816.713746469026;3845.692344612424;3947.3092208863336;45263.32105018428;45631.31553026707;46020.53979460229;46051;46202.76898615553;41624.1675166501;41878.79060604677;42017.369739453934;42494.362584561255;43125.13749724988;39622.80188599038;40132;40144.59855401467;40224;40312.39531406973;7916.84166316682;8009.118996910219;8162.142974987541;8239.473958049339;8300.667973281243;31120.844395777876;31478.685213147575;31839.363212735152;33592.664073359934;33726.3254734899;37297.6270237305;37836;38083.428748568236;38283.23433531258;38450.807745961094;10243.875617936303;10287.84568231492;10387.53256103462;10456.895431045896;10956.726081848017;10262.794744105226;10326.380417174994;11428.48571814287;11545.711357216136;12164.635060948185;10475.738106547396;10660.200484963503;11015.559377624806;11022.724431889266;11105.38920359388;10117.797644047225;10268.486575671037;10447.216458765472;10494.05553500158;10738.40938748345;9882.50587470638;10263.846042309222;10361.533730981973;10627.309224900357;10670.30643008233;9090.13643703847;9406.858897116412;9541.278916175923;9799.216062715108;9881.604735810775;8880.236011641558;9280.814383712423;9339.813203736023;9460.95269523648;9499.905000950179 10:24:41 INFO - 2015-12-22 10:24:41,266 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:24:41 INFO - 2015-12-22 10:24:41,266 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:24:41 INFO - 2015-12-22 10:24:41,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,318 10:24:41 INFO - 2015-12-22 10:24:41,266 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:24:41 INFO - 2015-12-22 10:24:41,266 DEBUG : BROWSER_OUTPUT: __startTimestamp1450808681257__endTimestamp 10:24:41 INFO - 2015-12-22 10:24:41,266 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,266 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:24:41 INFO - 2015-12-22 10:24:41,267 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:24:41 INFO - 2015-12-22 10:24:41,267 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,267 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4786.81 Median:4926.00 stddev:501.56 (10.2%) stddev-sans-first:475.54 10:24:41 INFO - 2015-12-22 10:24:41,268 DEBUG : BROWSER_OUTPUT: Values: 2696.5 2715.9 2759.8 2772.8 2789.7 4711.0 4753.8 4836.8 4867.4 4926.0 4705.2 4729.7 4808.3 4839.8 4854.4 4402.4 4512.7 4560.0 4568.5 4595.2 4337.4 4516.7 4523.5 4549.8 4647.9 4359.9 4403.3 4495.3 4516.9 4537.7 4488.4 4507.3 4522.2 4526.8 4527.3 4276.6 4387.5 4453.7 4479.6 4497.6 4664.8 4737.2 4760.5 4775.6 4783.8 5183.2 5201.8 5206.1 5208.6 5262.1 5080.1 5187.5 5198.4 5227.7 5230.2 4839.8 4845.1 4870.1 4882.5 4908.1 5355.4 5358.1 5366.3 5370.8 5371.3 4960.5 5079.9 5085.2 5086.7 5151.8 5016.1 5116.0 5146.4 5155.3 5159.7 5169.8 5174.0 5177.6 5179.0 5245.3 4858.2 5085.8 5135.7 5150.2 5151.7 4202.7 4211.3 4289.2 4305.5 4337.7 3806.3 3808.3 3816.8 3829.9 3837.3 4317.6 4415.0 4548.9 4567.0 4596.5 5113.6 5184.6 5186.1 5188.7 5224.6 4494.8 4507.3 4526.5 4532.2 4584.6 4412.9 4541.9 4571.5 4609.2 4676.3 4908.3 4932.8 4941.7 4944.4 4962.8 5200.2 5219.8 5225.5 5225.9 5255.7 4754.1 4828.8 4853.6 4907.2 4950.7 5128.3 5160.5 5162.7 5167.1 5167.7 5230.3 5243.5 5246.3 5267.8 5300.0 4831.3 4944.0 4958.3 5065.8 5083.9 5068.1 5078.5 5088.2 5091.6 5134.7 4936.1 4937.4 4967.6 4993.9 5013.5 4845.5 4970.6 4977.6 5039.6 5088.3 4996.5 5008.0 5025.7 5052.5 5074.5 10:24:41 INFO - 2015-12-22 10:24:41,268 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,268 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36762.81 Median:35888.05 stddev:51463.01 (143.4%) stddev-sans-first:51535.62 10:24:41 INFO - 2015-12-22 10:24:41,268 DEBUG : BROWSER_OUTPUT: Values: 570.5 580.3 582.5 583.7 587.9 35340.8 36523.3 36581.3 36659.0 36687.3 40237.8 41173.4 41250.2 41282.4 41360.6 7947.9 8019.5 8105.0 8107.0 8119.4 7832.8 7849.6 7874.6 7953.6 7969.5 7853.8 7904.8 7916.1 7964.8 7980.8 7897.8 8005.3 8021.5 8030.3 8058.3 7847.8 7927.4 7929.8 7933.8 7955.1 36945.4 37426.6 37504.8 37526.2 37758.4 2977.3 2988.4 2991.6 3065.2 3347.7 27664.6 27747.3 27819.2 28063.0 28618.6 3406.8 3415.9 3416.7 3482.3 3515.5 218088.0 218385.0 218801.0 218967.0 219782.0 49550.8 53018.2 53057.0 53404.0 53429.5 44502.3 61820.4 63620.7 63705.4 63709.7 12693.7 12844.4 12946.2 12966.9 12999.3 9437.3 9528.6 9534.7 9557.1 9572.0 18361.9 18652.3 18720.0 18730.9 18744.0 7110.1 7310.3 7363.2 7413.9 7448.5 857.8 873.9 953.2 1011.4 1021.4 26076.3 26527.1 26624.5 26684.9 27009.5 890.3 920.6 932.3 1009.5 1049.1 11814.4 12096.9 12108.4 12201.1 12345.9 202015.0 204385.0 205516.0 206435.0 206704.0 40126.0 40377.4 40547.6 40577.0 40656.0 1202.5 1230.3 1232.7 1241.0 1241.6 23418.2 25939.0 26647.6 26808.3 26811.6 37398.4 37556.4 37670.0 37728.8 37768.8 167417.0 167770.2 169042.0 169100.0 169606.0 24447.0 25108.9 26559.1 28850.1 28965.3 33924.8 34063.8 34294.3 34354.3 34438.1 31355.0 31407.5 32070.0 32426.4 32674.2 31881.4 38801.4 40482.6 41266.6 42715.0 34461.0 34709.7 34948.5 35101.3 36213.3 35562.8 36274.0 36901.0 37262.6 37465.6 29262.0 31268.1 31720.2 31796.5 32630.5 10:24:41 INFO - 2015-12-22 10:24:41,268 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,268 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28241.67 Median:3622.27 stddev:90207.04 (2490.3%) stddev-sans-first:90435.75 10:24:41 INFO - 2015-12-22 10:24:41,268 DEBUG : BROWSER_OUTPUT: Values: 334.2 335.9 337.5 338.6 339.1 15402.8 15434.9 15967.0 16628.5 17050.4 9755.4 9993.7 10289.5 10715.7 10749.9 4522.5 4640.7 4647.0 4647.5 4650.1 4765.3 5103.6 5105.0 5106.3 5115.1 3570.1 3674.4 4989.2 5065.5 5067.1 5167.8 5199.9 5206.6 5211.8 5228.6 4977.6 4996.2 5020.5 5134.1 5135.4 17988.9 18365.0 18381.2 18532.6 18565.7 1778.8 1840.5 1844.7 1867.7 1903.3 10306.4 12844.0 12987.2 13063.5 13135.7 1784.4 1805.7 1818.6 1927.6 2020.3 58413.0 58750.0 59763.7 60109.4 60464.4 10011.8 10045.3 10054.3 10074.1 10135.8 12492.8 12528.4 12530.9 12567.3 12653.2 7082.1 7089.1 7114.7 7115.3 7161.0 6685.1 6719.7 6745.7 6752.1 6780.0 4274.3 4275.7 4298.9 4317.4 4324.2 1795.8 1806.2 1826.9 1838.9 1873.1 726.2 794.7 812.4 867.6 907.1 15243.5 15485.1 15528.2 16114.5 16118.8 838.5 864.1 866.8 877.5 894.2 9022.3 9345.4 9387.4 9414.9 9503.6 534630.0 548735.0 555543.0 556397.0 565864.0 70249.6 71838.6 72564.6 73425.0 76556.0 1108.3 1115.8 1120.1 1120.2 1122.4 14620.5 14649.7 14693.9 14728.0 15047.2 34172.5 34455.8 34834.5 34845.3 35233.8 43050.8 43804.8 44908.3 45160.5 45393.0 8763.2 8778.3 8850.5 9048.0 9081.0 10591.2 10598.5 10715.4 10756.7 11931.8 13592.1 13665.7 13848.1 13853.3 13942.4 13179.0 13615.9 13913.8 14073.4 14386.9 13723.4 13884.6 14165.1 14263.6 14536.3 9013.3 9108.0 9129.6 9177.7 9200.3 9434.0 9548.9 9599.0 14031.2 14046.6 10:24:41 INFO - 2015-12-22 10:24:41,268 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,269 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4962.61 Median:6367.47 stddev:2620.71 (41.2%) stddev-sans-first:2614.18 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: Values: 1374.4 1405.8 1422.8 1643.3 1733.2 7075.7 7169.0 7329.5 7349.4 7402.7 7308.4 7382.8 7410.3 7410.4 7416.8 2058.1 2073.0 2089.2 2089.7 2091.9 2071.7 2085.1 2108.0 2138.6 2143.6 2090.2 2093.9 2109.4 2128.3 2129.8 2102.1 2115.4 2131.0 2132.4 2136.4 2081.2 2103.6 2112.0 2118.4 2129.1 7185.2 7246.0 7259.4 7262.4 7273.9 4223.2 4277.8 4283.1 4306.5 4318.5 2625.0 2664.1 2770.8 2771.3 2772.3 853.5 876.6 877.7 883.9 895.0 9700.6 9705.7 9707.0 9732.5 9764.7 3801.4 3828.4 3859.8 3863.1 3864.2 7938.2 7944.4 7956.6 7995.4 8022.8 4226.8 4240.4 4261.9 4263.0 4284.8 3301.6 3418.1 3878.0 3917.5 3941.6 3179.0 3207.2 3216.6 3291.4 3296.7 928.4 944.8 944.9 950.5 952.8 837.7 839.8 851.0 851.2 996.3 6827.4 6858.7 6873.6 6881.8 6887.6 418.9 424.2 425.4 430.5 430.8 5129.8 5140.9 5152.1 5163.8 5177.1 8260.9 8298.9 8402.9 8427.3 8437.8 8260.3 8297.8 8298.5 8300.5 8324.2 6414.4 6517.7 6591.4 6597.5 6605.2 6728.3 6792.1 6798.0 6800.8 6809.5 7753.9 7811.1 7904.3 7915.2 7984.0 7892.6 8040.2 8142.3 8170.3 8218.4 5351.4 5442.6 6217.9 6250.1 6278.6 6511.2 6644.7 6697.6 6705.7 6717.5 6329.5 6411.2 6427.5 6476.5 6534.9 6236.6 6297.2 6333.0 6366.0 6487.9 6355.5 6368.9 6401.0 6407.6 6410.1 5978.7 6027.5 6065.2 6077.8 6087.5 6088.5 6088.8 6108.3 6119.5 6119.9 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4939.28 Median:5710.31 stddev:1479.80 (25.9%) stddev-sans-first:1442.55 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: Values: 308.1 316.8 318.3 318.8 322.1 5575.5 5707.2 5813.7 5841.3 5859.8 5653.9 5697.1 5713.4 5716.8 5718.1 4101.9 4219.6 4224.8 4373.1 4383.4 4326.6 4351.0 4353.9 4357.4 4375.6 4305.7 4308.7 4311.0 4313.8 4323.2 4324.9 4325.1 4329.2 4331.0 4343.0 3610.7 3771.9 3772.2 3773.2 3774.9 5353.0 5459.0 5464.6 5472.8 5481.3 4884.4 4945.4 4947.8 4952.4 4958.6 5934.1 5940.7 5945.8 5950.6 5987.7 3931.5 4051.8 4060.9 4065.9 4085.6 6225.1 6281.7 6296.8 6300.8 6305.2 4195.3 4196.6 4197.7 4197.9 4205.7 4248.7 4256.1 4256.7 4262.4 4273.5 4734.9 4908.9 4917.5 4919.4 4925.0 5977.5 5983.6 5994.2 5994.3 5997.1 1483.5 1511.3 1512.7 1512.8 1513.2 981.3 996.1 999.6 1000.2 1001.3 5199.3 5210.1 5219.0 5229.2 5244.4 6176.0 6190.5 6207.8 6208.0 6217.0 5204.0 5209.8 5209.9 5222.0 5231.1 3266.7 3334.7 3368.9 3399.3 3402.3 5769.8 5901.4 5909.3 5914.1 5914.3 6430.5 6450.2 6456.0 6462.6 6465.0 5879.7 5880.2 5880.8 5882.3 5887.6 6081.6 6157.8 6189.4 6201.8 6215.2 6054.8 6100.7 6101.6 6109.8 6112.2 5782.8 5858.6 5866.9 5868.9 5872.5 4155.0 4233.4 4233.6 4243.5 4248.4 6085.8 6243.4 6244.7 6247.5 6258.9 5992.9 5993.3 6005.5 6011.5 6016.8 5987.9 6012.0 6016.4 6016.8 6020.1 5785.7 5818.1 5852.8 5871.1 5882.6 6004.0 6018.7 6032.7 6041.8 6062.7 5897.7 5902.0 5903.7 5905.8 5909.4 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12029.19 Median:41751.48 stddev:13182.60 (31.6%) stddev-sans-first:13192.22 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: Values: 719.0 740.9 752.8 757.5 762.4 11782.0 11802.1 12018.2 12053.2 12077.7 11629.5 11727.1 11731.6 11743.2 11767.5 414.4 419.2 786.4 800.0 811.4 808.8 811.3 813.4 814.6 814.9 851.0 852.0 861.3 862.6 865.4 838.5 841.4 842.9 843.5 843.7 628.2 633.7 635.1 636.3 640.0 11456.7 11640.3 11658.9 11669.7 11732.1 10772.9 11384.4 11402.7 11406.4 11532.9 9235.9 9392.4 9393.7 9396.9 9470.8 3228.9 3288.0 3301.6 3335.6 3342.5 38312.6 38446.4 38544.0 38704.0 38715.4 8619.5 8806.0 8855.8 9066.0 9119.1 16492.6 16669.7 16722.7 16757.8 16771.0 6218.7 6346.2 6390.6 6489.2 6545.4 3365.4 3474.9 3554.7 3574.1 3610.6 2588.1 2616.9 2635.1 2639.2 2648.6 472.1 476.6 479.4 491.0 494.1 494.8 577.2 592.9 593.2 599.0 8025.2 8383.2 8645.0 8665.1 8680.4 470.1 505.3 557.0 566.9 611.4 3631.3 3780.2 3816.7 3845.7 3947.3 45263.3 45631.3 46020.5 46051.0 46202.8 41624.2 41878.8 42017.4 42494.4 43125.1 39622.8 40132.0 40144.6 40224.0 40312.4 7916.8 8009.1 8162.1 8239.5 8300.7 31120.8 31478.7 31839.4 33592.7 33726.3 37297.6 37836.0 38083.4 38283.2 38450.8 10243.9 10287.8 10387.5 10456.9 10956.7 10262.8 10326.4 11428.5 11545.7 12164.6 10475.7 10660.2 11015.6 11022.7 11105.4 10117.8 10268.5 10447.2 10494.1 10738.4 9882.5 10263.8 10361.5 10627.3 10670.3 9090.1 9406.9 9541.3 9799.2 9881.6 8880.2 9280.8 9339.8 9461.0 9499.9 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:24:41 INFO - 2015-12-22 10:24:41,270 DEBUG : BROWSER_OUTPUT: 10:24:42 INFO - 2015-12-22 10:24:42,007 INFO : Browser exited with error code: 0 10:24:42 INFO - 2015-12-22 10:24:42,025 INFO : Completed test dromaeo_css (00:18:35) 10:24:42 INFO - 2015-12-22 10:24:42,025 INFO : Starting test kraken 10:24:42 INFO - 2015-12-22 10:24:42,025 DEBUG : operating with platform_type : linux_ 10:24:42 INFO - 2015-12-22 10:24:42,026 INFO : Initialising browser for kraken test... 10:24:42 INFO - 2015-12-22 10:24:42,032 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqb0TWH/profile http://localhost:59159/getInfo.html 10:24:46 INFO - 2015-12-22 10:24:46,733 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:24:46 INFO - 2015-12-22 10:24:46,733 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:24:46 INFO - 2015-12-22 10:24:46,733 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:24:46 INFO - 2015-12-22 10:24:46,733 DEBUG : BROWSER_OUTPUT: __metrics 10:24:46 INFO - 2015-12-22 10:24:46,870 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] 10:24:47 INFO - 2015-12-22 10:24:47,826 INFO : Browser initialized. 10:24:47 INFO - 2015-12-22 10:24:47,827 INFO : Running cycle 1/1 for kraken test... 10:24:47 INFO - 2015-12-22 10:24:47,827 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqb0TWH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:24:59 INFO - 2015-12-22 10:24:59,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 143650816 10:24:59 INFO - 2015-12-22 10:24:59,789 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-12-22 10:25:02,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:03 INFO - 2015-12-22 10:25:03,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 144392192 10:25:03 INFO - 2015-12-22 10:25:03,012 DEBUG : BROWSER_OUTPUT: 10:25:05 INFO - 2015-12-22 10:25:05,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-dft) 10:25:06 INFO - 2015-12-22 10:25:06,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 144609280 10:25:06 INFO - 2015-12-22 10:25:06,358 DEBUG : BROWSER_OUTPUT: 10:25:09 INFO - 2015-12-22 10:25:09,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-fft) 10:25:09 INFO - 2015-12-22 10:25:09,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 139472896 10:25:09 INFO - 2015-12-22 10:25:09,876 DEBUG : BROWSER_OUTPUT: 10:25:11 INFO - 2015-12-22 10:25:11,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-oscillator) 10:25:12 INFO - 2015-12-22 10:25:12,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 139530240 10:25:12 INFO - 2015-12-22 10:25:12,567 DEBUG : BROWSER_OUTPUT: 10:25:14 INFO - 2015-12-22 10:25:14,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:15 INFO - 2015-12-22 10:25:15,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 140795904 10:25:15 INFO - 2015-12-22 10:25:15,428 DEBUG : BROWSER_OUTPUT: 10:25:18 INFO - 2015-12-22 10:25:18,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:19 INFO - 2015-12-22 10:25:19,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 140169216 10:25:19 INFO - 2015-12-22 10:25:19,117 DEBUG : BROWSER_OUTPUT: 10:25:22 INFO - 2015-12-22 10:25:22,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:23 INFO - 2015-12-22 10:25:23,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 138842112 10:25:23 INFO - 2015-12-22 10:25:23,186 DEBUG : BROWSER_OUTPUT: 10:25:26 INFO - 2015-12-22 10:25:26,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59159/tests/kraken/driver.html?testName=json-parse-financial) 10:25:26 INFO - 2015-12-22 10:25:26,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 138059776 10:25:26 INFO - 2015-12-22 10:25:26,674 DEBUG : BROWSER_OUTPUT: 10:25:28 INFO - 2015-12-22 10:25:28,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:29 INFO - 2015-12-22 10:25:29,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 140980224 10:25:29 INFO - 2015-12-22 10:25:29,024 DEBUG : BROWSER_OUTPUT: 10:25:30 INFO - 2015-12-22 10:25:30,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:31 INFO - 2015-12-22 10:25:31,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 141729792 10:25:31 INFO - 2015-12-22 10:25:31,514 DEBUG : BROWSER_OUTPUT: 10:25:33 INFO - 2015-12-22 10:25:33,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:34 INFO - 2015-12-22 10:25:34,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 141422592 10:25:34 INFO - 2015-12-22 10:25:34,293 DEBUG : BROWSER_OUTPUT: 10:25:36 INFO - 2015-12-22 10:25:36,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:37 INFO - 2015-12-22 10:25:37,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 142094336 10:25:37 INFO - 2015-12-22 10:25:37,483 DEBUG : BROWSER_OUTPUT: 10:25:40 INFO - 2015-12-22 10:25:40,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:40 INFO - 2015-12-22 10:25:40,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 141537280 10:25:40 INFO - 2015-12-22 10:25:40,711 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59159/tests/kraken/driver.html?testName=ai-astar) 10:25:42 INFO - 2015-12-22 10:25:42,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 141758464 10:25:42 INFO - 2015-12-22 10:25:42,758 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,758 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:25:42 INFO - 2015-12-22 10:25:42,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:25:42 INFO - 2015-12-22 10:25:42,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:25:42 INFO - 2015-12-22 10:25:42,758 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:25:42 INFO - 2015-12-22 10:25:42,759 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;110;115;115;116;124;114;113;114;113 10:25:42 INFO - 2015-12-22 10:25:42,759 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;136;159;170;131;156;156;135;168;136 10:25:42 INFO - 2015-12-22 10:25:42,759 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;164;162;162;166;169;162;167;162 10:25:42 INFO - 2015-12-22 10:25:42,759 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;73;74;158;74;78;75;74;149 10:25:42 INFO - 2015-12-22 10:25:42,759 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;137;98;95;95;137;96;95;131 10:25:42 INFO - 2015-12-22 10:25:42,759 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;110 10:25:42 INFO - 2015-12-22 10:25:42,759 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;151;147;149;148;148;148;148;147;147 10:25:42 INFO - 2015-12-22 10:25:42,760 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;97 10:25:42 INFO - 2015-12-22 10:25:42,760 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;73;72;74;72;73;73;75;73 10:25:42 INFO - 2015-12-22 10:25:42,760 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;67;68;69;68;68;70 10:25:42 INFO - 2015-12-22 10:25:42,760 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;86;84;84;84;85;94;103 10:25:42 INFO - 2015-12-22 10:25:42,760 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;121;120;118;141;126;122;120;128;129 10:25:42 INFO - 2015-12-22 10:25:42,760 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;150;158;155;150;135;141;157;152;143 10:25:42 INFO - 2015-12-22 10:25:42,760 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;77;72;72;71;71;71;70;71 10:25:42 INFO - 2015-12-22 10:25:42,760 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:25:42 INFO - 2015-12-22 10:25:42,761 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:25:42 INFO - 2015-12-22 10:25:42,761 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,817 10:25:42 INFO - 2015-12-22 10:25:42,761 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:25:42 INFO - 2015-12-22 10:25:42,761 DEBUG : BROWSER_OUTPUT: __startTimestamp1450808742753__endTimestamp 10:25:42 INFO - 2015-12-22 10:25:42,761 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.70 Median:114.50 stddev:3.65 (3.2%) stddev-sans-first:3.82 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 115.0 115.0 116.0 124.0 114.0 113.0 114.0 113.0 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.60 Median:157.50 stddev:14.65 (9.3%) stddev-sans-first:15.22 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: Values: 159.0 136.0 159.0 170.0 131.0 156.0 156.0 135.0 168.0 136.0 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.54 (1.5%) stddev-sans-first:2.69 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 164.0 162.0 162.0 166.0 169.0 162.0 167.0 162.0 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,765 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.20 Median:74.00 stddev:33.46 (45.2%) stddev-sans-first:34.97 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 74.0 158.0 74.0 78.0 75.0 74.0 149.0 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:95.00 stddev:19.14 (20.1%) stddev-sans-first:19.77 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 137.0 98.0 95.0 95.0 137.0 96.0 95.0 131.0 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: Values: 148.0 151.0 147.0 149.0 148.0 148.0 148.0 148.0 147.0 147.0 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:25:42 INFO - 2015-12-22 10:25:42,766 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.20 Median:73.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 72.0 74.0 72.0 73.0 73.0 75.0 73.0 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 67.0 68.0 69.0 68.0 68.0 70.0 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:85.00 stddev:6.26 (7.4%) stddev-sans-first:6.51 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 86.0 84.0 84.0 84.0 85.0 94.0 103.0 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:127.00 stddev:6.78 (5.3%) stddev-sans-first:7.12 10:25:42 INFO - 2015-12-22 10:25:42,767 DEBUG : BROWSER_OUTPUT: Values: 128.0 121.0 120.0 118.0 141.0 126.0 122.0 120.0 128.0 129.0 10:25:42 INFO - 2015-12-22 10:25:42,768 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,768 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:151.00 stddev:8.43 (5.6%) stddev-sans-first:7.81 10:25:42 INFO - 2015-12-22 10:25:42,768 DEBUG : BROWSER_OUTPUT: Values: 136.0 150.0 158.0 155.0 150.0 135.0 141.0 157.0 152.0 143.0 10:25:42 INFO - 2015-12-22 10:25:42,768 DEBUG : BROWSER_OUTPUT: 10:25:42 INFO - 2015-12-22 10:25:42,768 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:71.50 stddev:2.00 (2.8%) stddev-sans-first:2.03 10:25:42 INFO - 2015-12-22 10:25:42,768 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 77.0 72.0 72.0 71.0 71.0 71.0 70.0 71.0 10:25:42 INFO - 2015-12-22 10:25:42,768 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:25:42 INFO - 2015-12-22 10:25:42,768 DEBUG : BROWSER_OUTPUT: 10:25:43 INFO - 2015-12-22 10:25:43,667 INFO : Browser exited with error code: 0 10:25:43 INFO - 2015-12-22 10:25:43,718 INFO : Completed test kraken (00:01:01) 10:25:43 INFO - 2015-12-22 10:25:43,719 INFO : Starting test v8_7 10:25:43 INFO - 2015-12-22 10:25:43,719 DEBUG : operating with platform_type : linux_ 10:25:43 INFO - 2015-12-22 10:25:43,719 INFO : Initialising browser for v8_7 test... 10:25:43 INFO - 2015-12-22 10:25:43,725 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZKXqny/profile http://localhost:59159/getInfo.html 10:25:48 INFO - 2015-12-22 10:25:48,591 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:25:48 INFO - 2015-12-22 10:25:48,591 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:25:48 INFO - 2015-12-22 10:25:48,591 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:25:48 INFO - 2015-12-22 10:25:48,592 DEBUG : BROWSER_OUTPUT: __metrics 10:25:48 INFO - 2015-12-22 10:25:48,728 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] 10:25:49 INFO - 2015-12-22 10:25:49,750 INFO : Browser initialized. 10:25:49 INFO - 2015-12-22 10:25:49,751 INFO : Running cycle 1/1 for v8_7 test... 10:25:49 INFO - 2015-12-22 10:25:49,751 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZKXqny/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:26:01 INFO - 2015-12-22 10:26:01,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 143491072 10:26:01 INFO - 2015-12-22 10:26:01,792 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59159/tests/v8_7/run.html (next: http://localhost:59159/tests/v8_7/run.html) 10:26:23 INFO - 2015-12-22 10:26:23,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 138469376 10:26:23 INFO - 2015-12-22 10:26:23,503 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,505 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:26:23 INFO - 2015-12-22 10:26:23,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:26:23 INFO - 2015-12-22 10:26:23,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:26:23 INFO - 2015-12-22 10:26:23,505 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:26:23 INFO - 2015-12-22 10:26:23,505 DEBUG : BROWSER_OUTPUT: |0;Richards;166.11295681063123 10:26:23 INFO - 2015-12-22 10:26:23,505 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.125748502994 10:26:23 INFO - 2015-12-22 10:26:23,506 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 10:26:23 INFO - 2015-12-22 10:26:23,506 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 10:26:23 INFO - 2015-12-22 10:26:23,506 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1072.961373390558 10:26:23 INFO - 2015-12-22 10:26:23,506 DEBUG : BROWSER_OUTPUT: |5;Earley;715.307582260372 10:26:23 INFO - 2015-12-22 10:26:23,506 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 10:26:23 INFO - 2015-12-22 10:26:23,506 DEBUG : BROWSER_OUTPUT: |7;RegExp;26315.78947368421 10:26:23 INFO - 2015-12-22 10:26:23,506 DEBUG : BROWSER_OUTPUT: |8;Splay;595.2522255192879 10:26:23 INFO - 2015-12-22 10:26:23,507 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 10:26:23 INFO - 2015-12-22 10:26:23,507 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:26:23 INFO - 2015-12-22 10:26:23,507 DEBUG : BROWSER_OUTPUT: __startTimestamp1450808783504__endTimestamp 10:26:23 INFO - 2015-12-22 10:26:23,507 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,507 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:26:23 INFO - 2015-12-22 10:26:23,508 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:26:23 INFO - 2015-12-22 10:26:23,508 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,508 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,508 DEBUG : BROWSER_OUTPUT: Values: 166.1 10:26:23 INFO - 2015-12-22 10:26:23,508 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,509 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.13 Median:187.13 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,509 DEBUG : BROWSER_OUTPUT: Values: 187.1 10:26:23 INFO - 2015-12-22 10:26:23,510 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,510 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,510 DEBUG : BROWSER_OUTPUT: Values: 277.6 10:26:23 INFO - 2015-12-22 10:26:23,510 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,511 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,511 DEBUG : BROWSER_OUTPUT: Values: 5208.3 10:26:23 INFO - 2015-12-22 10:26:23,511 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,511 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,511 DEBUG : BROWSER_OUTPUT: Values: 1073.0 10:26:23 INFO - 2015-12-22 10:26:23,511 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,511 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.31 Median:715.31 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,511 DEBUG : BROWSER_OUTPUT: Values: 715.3 10:26:23 INFO - 2015-12-22 10:26:23,512 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,512 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,512 DEBUG : BROWSER_OUTPUT: Values: 12207.3 10:26:23 INFO - 2015-12-22 10:26:23,512 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,512 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26315.79 Median:26315.79 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,512 DEBUG : BROWSER_OUTPUT: Values: 26315.8 10:26:23 INFO - 2015-12-22 10:26:23,512 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,513 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.25 Median:595.25 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,513 DEBUG : BROWSER_OUTPUT: Values: 595.3 10:26:23 INFO - 2015-12-22 10:26:23,513 DEBUG : BROWSER_OUTPUT: 10:26:23 INFO - 2015-12-22 10:26:23,513 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:26:23 INFO - 2015-12-22 10:26:23,513 DEBUG : BROWSER_OUTPUT: Values: 4840.6 10:26:23 INFO - 2015-12-22 10:26:23,513 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:26:23 INFO - 2015-12-22 10:26:23,513 DEBUG : BROWSER_OUTPUT: 10:26:24 INFO - 2015-12-22 10:26:24,515 INFO : Browser exited with error code: 0 10:26:24 INFO - 2015-12-22 10:26:24,527 INFO : Completed test v8_7 (00:00:40) 10:26:25 INFO - 2015-12-22 10:26:25,027 INFO : Completed test suite (00:20:18) 10:26:25 INFO - 2015-12-22 10:26:25,027 DEBUG : Working with test: dromaeo_css 10:26:25 INFO - 2015-12-22 10:26:25,027 DEBUG : Generating results file: dromaeo_css 10:26:25 INFO - 2015-12-22 10:26:25,028 DEBUG : Working with test: kraken 10:26:25 INFO - 2015-12-22 10:26:25,028 DEBUG : Generating results file: kraken 10:26:25 INFO - 2015-12-22 10:26:25,029 INFO : javascript benchmark 10:26:25 INFO - 2015-12-22 10:26:25,029 DEBUG : Working with test: v8_7 10:26:25 INFO - 2015-12-22 10:26:25,029 DEBUG : Generating results file: v8_7 10:26:25 INFO - 2015-12-22 10:26:25,029 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:25 INFO - 2015-12-22 10:26:25,081 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 10:26:25 INFO - 2015-12-22 10:26:25,081 DEBUG : process_Request line: dromaeo_css 6350.18 graph.html#tests=[[72,94,43]] 10:26:25 INFO - 2015-12-22 10:26:25,081 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:25 INFO - 2015-12-22 10:26:25,111 DEBUG : process_Request line: kraken 1554.70 graph.html#tests=[[232,94,43]] 10:26:25 INFO - 2015-12-22 10:26:25,111 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:25 INFO - 2015-12-22 10:26:25,140 DEBUG : process_Request line: v8_7 21334.61 graph.html#tests=[[230,94,43]] 10:26:25 INFO - 2015-12-22 10:26:25,141 INFO : javascript benchmark 10:26:25 INFO - 2015-12-22 10:26:25,145 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2696.4876673432045, 2715.891364345426, 2759.751622353988, 2772.7920405969544, 2789.7070807565206, 4711.034237981215, 4753.78607962642, 4836.755754303573, 4867.3915760529935, 4926.0, 4705.200115980283, 4729.716217026981, 4808.3268342432, 4839.830605928793, 4854.393200849894, 4402.361657559652, 4512.706674066183, 4559.977200114012, 4568.47462541807, 4595.2188128018315, 4337.414449049369, 4516.683832131752, 4523.479799823013, 4549.818007279721, 4647.930281045787, 4359.869203923871, 4403.273459879116, 4495.258282383403, 4516.864494065183, 4537.659675524349, 4488.41650585425, 4507.323901414814, 4522.23122069249, 4526.818927242906, 4527.275635898241, 4276.615104640566, 4387.517373088957, 4453.665975051852, 4479.574440428154, 4497.572730590588, 4664.836730714409, 4737.24204127338, 4760.476347601796, 4775.617950563947, 4783.760811959388, 5183.170692689189, 5201.843944681666, 5206.062908676437, 5208.5572726318305, 5262.131748261532, 5080.085584594772, 5187.533122018998, 5198.402183748842, 5227.712475813829, 5230.163173892159, 4839.758012099452, 4845.1278769821065, 4870.14772414826, 4882.487338829443, 4908.092002979461, 5355.357357117171, 5358.142697168434, 5366.2755528004, 5370.812021579226, 5371.328583927009, 4960.50394960501, 5079.8984020319385, 5085.211792172219, 5086.694798312114, 5151.7681704323395, 5016.097102521581, 5116.0, 5146.433892271847, 5155.278261043457, 5159.690418574897, 5169.844904652867, 5173.974130129325, 5177.559907407837, 5179.041877252645, 5245.318108645852, 4858.198397264412, 5085.78218136799, 5135.666181698178, 5150.227465880148, 5151.665141765773, 4202.663786897041, 4211.347241177622, 4289.227938971015, 4305.547917468683, 4337.6963612546815, 3806.2958352704836, 3808.333541630204, 3816.751911125768, 3829.923401531954, 3837.2901013312626, 4317.611414972667, 4415.0, 4548.863534093983, 4566.977165114153, 4596.47140578831, 5113.616478764107, 5184.5593124584075, 5186.118359878829, 5188.688678679291, 5224.608154388436, 4494.752788596593, 4507.301368287921, 4526.456825180933, 4532.206863798822, 4584.564466375689, 4412.9117417652105, 4541.931871021938, 4571.519990401027, 4609.216433206363, 4676.251799712029, 4908.337374454403, 4932.753362331798, 4941.65408421407, 4944.357233559686, 4962.776675049631, 5200.193969934666, 5219.76511057011, 5225.477452254744, 5225.869353266046, 5255.658382205297, 4754.096721622881, 4828.758562071812, 4853.587445067209, 4907.214845624683, 4950.6782059166035, 5128.3076784633595, 5160.458151894147, 5162.716050617252, 5167.147420675697, 5167.741612919414, 5230.34620672416, 5243.501867322599, 5246.291750613618, 5267.762950667153, 5300.0, 4831.275308703723, 4943.950560494349, 4958.305837182869, 5065.797368105234, 5083.949160508348, 5068.087744206078, 5078.492150784892, 5088.1604535252745, 5091.643584949018, 5134.7175905324075, 4936.062148191832, 4937.407511098548, 4967.552920237196, 4993.925091123709, 5013.548780609763, 4845.466998630219, 4970.62720295972, 4977.576905963034, 5039.647224694383, 5088.262201980618, 4996.50034996512, 5008.0, 5025.74871256443, 5052.469490703424, 5074.517920797518], "unit": "ms", "name": "dojo.html", "value": 4755.29846003825}, {"lowerIsBetter": false, "replicates": [570.4780126184542, 580.3268208877703, 582.4583137681957, 583.6556431705293, 587.8765459253558, 35340.76307329241, 36523.269534609324, 36581.26837463249, 36659.0, 36687.26625467489, 40237.7988110059, 41173.38239926403, 41250.17499650013, 41282.38076428856, 41360.58639413605, 7947.927029850968, 8019.478733882308, 8104.959475202616, 8106.959465202695, 8119.3910456715685, 7832.843343133134, 7849.5682737449415, 7874.645640946172, 7953.562554059525, 7969.521828690297, 7853.842923141534, 7904.762857114296, 7916.089649690273, 7964.8407031859615, 7980.760577182694, 7897.802554936144, 8005.3195478384405, 8021.478603890729, 8030.317423019051, 8058.315043221333, 7847.803804904866, 7927.3658107351275, 7929.801754956115, 7933.841323173562, 7955.124936257007, 36945.44581831275, 37426.625733742585, 37504.81247593772, 37526.24947501034, 37758.43362349567, 2977.344984103494, 2988.4120768817916, 2991.5961345218334, 3065.2183693158327, 3347.681970212826, 27664.58503122455, 27747.306317342027, 27819.165425037078, 28063.0177943773, 28618.570721439195, 3406.795592264472, 3415.8975230742867, 3416.7437442191936, 3482.3035392921515, 3515.5410504640545, 218088.0, 218385.0, 218801.0, 218967.0, 219782.0, 49550.75224623854, 53018.20472692913, 53057.0, 53404.0, 53429.465705343224, 44502.33246501305, 61820.38179618236, 63620.68189659022, 63705.36294637087, 63709.68145159245, 12693.746125077447, 12844.422001009976, 12946.158499697489, 12966.935165324114, 12999.285039322927, 9437.339386242897, 9528.571214295373, 9534.713958581253, 9557.139857412867, 9571.952140239255, 18361.908190458962, 18652.253909843726, 18720.0, 18730.90634546846, 18744.0, 7110.1112360954885, 7310.268973102648, 7363.190049094595, 7413.851722965618, 7448.5158464699625, 857.8198578298502, 873.9257163141077, 953.2374100719396, 1011.4487604255698, 1021.4382089850552, 26076.34809129787, 26527.07155249557, 26624.467510650065, 26684.866575667387, 27009.459810804066, 890.2966656341417, 920.6087412849512, 932.3147486597345, 1009.5255230041869, 1049.0925349572565, 11814.350210738492, 12096.939515302367, 12108.394580270951, 12201.145919785708, 12345.93827030859, 202015.0, 204385.0, 205516.0, 206435.0, 206704.0, 40126.0, 40377.39433908494, 40547.59452405497, 40577.0, 40656.0, 1202.5490441084594, 1230.3048777440897, 1232.6918270432393, 1241.0, 1241.5716577780652, 23418.18036368719, 25939.0, 26647.60028599611, 26808.32979175536, 26811.597826032234, 37398.439023414125, 37556.43665344967, 37670.0, 37728.81135594304, 37768.811155944044, 167417.0, 167770.16114919347, 169042.0, 169100.0, 169606.0, 24447.0, 25108.874455627603, 26559.07043253477, 28850.134495965154, 28965.275868103465, 33924.83037584796, 34063.829680851435, 34294.31411371809, 34354.312913742084, 34438.13904652404, 31355.0, 31407.52888706717, 32070.0, 32426.35147297088, 32674.183145420604, 31881.36237275288, 38801.417978730904, 40482.595174047885, 41266.58733412628, 42715.0, 34461.0, 34709.65290347165, 34948.47577286292, 35101.297974039866, 36213.27573448569, 35562.82218588891, 36274.0, 36901.0, 37262.62737372592, 37465.625343746215, 29262.0, 31268.061958141294, 31720.206994825316, 31796.523052153774, 32630.51054234141], "unit": "ms", "name": "ext.html", "value": 16578.03960788115}, {"lowerIsBetter": false, "replicates": [334.17958910873807, 335.9059463350262, 337.4617485111248, 338.5801606008549, 339.14535370865434, 15402.768958465633, 15434.922825385871, 15967.0, 16628.50114496564, 17050.40323588673, 9755.365901216433, 9993.700188994324, 10289.485525723721, 10715.678529644103, 10749.946250268738, 4522.479914809798, 4640.69835460694, 4647.0, 4647.512011238805, 4650.069986002796, 4765.332853400527, 5103.5917126629965, 5104.974475127619, 5106.310648062501, 5115.10485665009, 3570.1431656402538, 3674.393725035366, 4989.226669866177, 5065.468125846788, 5067.1385864402955, 5167.844964651066, 5199.870003249911, 5206.609504287194, 5211.817586384477, 5228.5555727763185, 4977.552020318189, 4996.150654388763, 5020.548150666421, 5134.0758663440565, 5135.3837539495125, 17988.91005544964, 18365.0, 18381.172847221773, 18532.629347412978, 18565.721514177163, 1778.7954385245603, 1840.4938641873457, 1844.6771814932467, 1867.7105048717472, 1903.3243198664552, 10306.381617102923, 12844.0, 12987.155834870704, 13063.477460901648, 13135.671608209776, 1784.4111443223705, 1805.729140628903, 1818.6453641539906, 1927.633749587574, 2020.2727018273556, 58413.0, 58750.0, 59763.701181493816, 60109.39890601126, 60464.39535604632, 10011.849822252672, 10045.29682922203, 10054.34646747959, 10074.093331600192, 10135.797284054277, 12492.81260781089, 12528.373581320897, 12530.874691252971, 12567.308798016014, 12653.17754345983, 7082.079329687108, 7089.149302083783, 7114.679839407239, 7115.324044215791, 7160.964195178991, 6685.097511835937, 6719.731210751613, 6745.696443660047, 6752.088468056848, 6780.0, 4274.273373526508, 4275.722078064916, 4298.871033868989, 4317.395564620955, 4324.243257429937, 1795.757572727665, 1806.151108978778, 1826.9451916442529, 1838.8620853436046, 1873.1196337721249, 726.1504040272894, 794.6900708723603, 812.4117350579603, 867.6355930509201, 907.1155623267393, 15243.542693719206, 15485.148316842457, 15528.223588820514, 16114.516564503083, 16118.838811611968, 838.5304229631304, 864.0797550608708, 866.787637028932, 877.5085951866974, 894.181823631383, 9022.323325750463, 9345.439273643604, 9387.389819661701, 9414.905850941539, 9503.619855205714, 534630.0, 548735.0, 555543.0, 556397.0, 565864.0, 70249.64875175693, 71838.64080679564, 72564.63717681378, 73424.96162711103, 76556.0, 1108.3294606762954, 1115.765689205276, 1120.075937351688, 1120.2438354111105, 1122.4387806097116, 14620.488282910048, 14649.707005860037, 14693.853061469676, 14728.0, 15047.172405517364, 34172.48741268833, 34455.827720861234, 34834.47748283727, 34845.30309393747, 35233.82383088068, 43050.78474607607, 43804.78097609492, 44908.326375103745, 45160.54839451564, 45393.0, 8763.167499087576, 8778.34162437807, 8850.468971861708, 9048.049954754655, 9080.954595226982, 10591.152707783513, 10598.523066461874, 10715.35707857531, 10756.731081723019, 11931.82102268484, 13592.11651242666, 13665.658358540719, 13848.09987350819, 13853.30733463343, 13942.442302307794, 13179.0, 13615.931920340336, 13913.791293130409, 14073.356676351454, 14386.928065359607, 13723.382447790073, 13884.58346249614, 14165.079269847427, 14263.572092837232, 14536.273186340852, 9013.332533481327, 9108.026710751716, 9129.5891684873, 9177.678781242625, 9200.309976751636, 9434.0, 9548.904510954802, 9598.95200523993, 14031.158130512202, 14046.55572465765], "unit": "ms", "name": "jquery.html", "value": 8253.90460390125}, {"lowerIsBetter": false, "replicates": [1374.3540535948107, 1405.8383285922123, 1422.7865820126985, 1643.2523201943118, 1733.2113888180875, 7075.716971321147, 7168.96415517923, 7329.52358096724, 7349.448791340657, 7402.6668799904, 7308.415326773858, 7382.7785166444955, 7410.2589741026, 7410.407167426606, 7416.814579635512, 2058.084152552115, 2072.9585408291823, 2089.1747759634936, 2089.676100204463, 2091.8640288381284, 2071.7410323709537, 2085.1138266236862, 2107.9894600527055, 2138.6043581937315, 2143.635581951064, 2090.1743811194647, 2093.8638988465777, 2109.4093653776968, 2128.31893793986, 2129.84026198035, 2102.096098677568, 2115.4394085567337, 2131.0, 2132.4242454537266, 2136.423165745248, 2081.157131361801, 2103.5582527669208, 2112.0495776900457, 2118.4280244333945, 2129.0951345678027, 7185.209626941085, 7246.0, 7259.382952449048, 7262.419006479469, 7273.927260727378, 4223.176480586287, 4277.764722940237, 4283.100548884738, 4306.5262821089655, 4318.546552611993, 2625.0, 2664.147472808702, 2770.7783377329765, 2771.3210263485576, 2772.3207814085677, 853.4793775796759, 876.5704804645678, 877.7015814622995, 883.924866386358, 895.0333639669207, 9700.563474643657, 9705.660301889471, 9707.0, 9732.513374331254, 9764.658236961672, 3801.4487899255005, 3828.4257361395457, 3859.7877116758286, 3863.092173339263, 3864.2271545690974, 7938.24586664266, 7944.364450843918, 7956.562389068541, 7995.400344974034, 8022.759317220492, 4226.767527786002, 4240.427542281815, 4261.914761704748, 4262.978685106555, 4284.785760712014, 3301.5873015873017, 3418.077119177808, 3878.0, 3917.4515567820526, 3941.586133456003, 3179.0462861141564, 3207.2142325130494, 3216.6461689214166, 3291.440455122587, 3296.7032967033083, 928.3547934185676, 944.8252073366449, 944.8866136063716, 950.458238803889, 952.7522844060455, 837.7193640130624, 839.7816567692444, 850.9574521273912, 851.1616058182685, 996.3125443444001, 6827.385535301747, 6858.725650973905, 6873.621950792754, 6881.827954301082, 6887.552309099892, 418.8785252276867, 424.17074619119546, 425.3704517314392, 430.5328718340573, 430.7759964818277, 5129.769160387791, 5140.897182056413, 5152.149895267314, 5163.793448262028, 5177.145770947752, 8260.876086858701, 8298.875516867252, 8402.873956890651, 8427.28368088707, 8437.831243375098, 8260.256576908107, 8297.751067467985, 8298.543580103153, 8300.501969881827, 8324.167583241628, 6414.358564143548, 6517.674116294166, 6591.373819487141, 6597.47220222381, 6605.174353205849, 6728.293529179561, 6792.0830687856505, 6797.966010169917, 6800.82997925036, 6809.489288303496, 7753.883691744515, 7811.062672479339, 7904.288614024766, 7915.168907264884, 7984.041914970008, 7892.644830982505, 8040.2361775631225, 8142.267195952156, 8170.3055240302865, 8218.424710270223, 5351.438098999549, 5442.564594832483, 6217.906731399123, 6250.06249062626, 6278.591891527036, 6511.218653761579, 6644.667766611747, 6697.564658297195, 6705.731770729116, 6717.529772916045, 6329.49364050884, 6411.166548348685, 6427.485801135991, 6476.481881449567, 6534.869302614016, 6236.594621349598, 6297.2128483939505, 6333.0, 6366.0, 6487.935120648733, 6355.459785918249, 6368.936310636835, 6400.967995159995, 6407.583507072025, 6410.1025856381075, 5978.671173085348, 6027.517798576016, 6065.2418447694035, 6077.756889724362, 6087.543434242361, 6088.482478989158, 6088.817335479943, 6108.328083910677, 6119.479844213113, 6119.908201376894], "unit": "ms", "name": "mootools.html", "value": 3967.490194760907}, {"lowerIsBetter": false, "replicates": [308.1218527197487, 316.78616933569833, 318.29338867713665, 318.8437665543884, 322.0933073398385, 5575.526080283175, 5707.200991861143, 5813.6802475863815, 5841.269841269841, 5859.79490717825, 5653.8586535336535, 5697.1169468732305, 5713.428657134285, 5716.799912003081, 5718.142278658203, 4101.856435024774, 4219.599138081892, 4224.809883555232, 4373.103513779675, 4383.408239887606, 4326.567343265664, 4351.0, 4353.912921741563, 4357.3899654048455, 4375.562443755615, 4305.67707421943, 4308.6983911126235, 4310.97844510777, 4313.805878735465, 4323.2490841209365, 4324.913501729963, 4325.070109926381, 4329.242382583036, 4331.0255192581735, 4342.978285108586, 3610.7472476926628, 3771.9434208486896, 3772.2078363543415, 3773.2453509297975, 3774.9245015099546, 5352.9732351338, 5459.044667183227, 5464.644798088111, 5472.835814925558, 5481.260029895992, 4884.413870335547, 4945.357103576512, 4947.777350019258, 4952.4057113146655, 4958.603311735053, 5934.080217566284, 5940.673262970535, 5945.791897283574, 5950.553708471882, 5987.700614969234, 3931.5478719947287, 4051.817668204938, 4060.939085913714, 4065.918681626351, 4085.59144085592, 6225.128482012522, 6281.685915704242, 6296.842578935518, 6300.810975670737, 6305.211848518935, 4195.30777421722, 4196.559361267084, 4197.664186865043, 4197.895052623709, 4205.726627769185, 4248.702590818675, 4256.1487702459635, 4256.7445953242905, 4262.424572682648, 4273.529911709709, 4734.928976065362, 4908.9263661045115, 4917.483664215278, 4919.409670839522, 4924.975375123101, 5977.491913187341, 5983.640981541122, 5994.190784244159, 5994.340622531518, 5997.070454079625, 1483.525271912999, 1511.2821409830242, 1512.7428337182705, 1512.8411516790798, 1513.1904431129292, 981.3277904635347, 996.0885789502524, 999.6155324874956, 1000.1648623399398, 1001.2740762946951, 5199.324087868628, 5210.062188805976, 5218.9562087582635, 5229.215617657382, 5244.396894357122, 6176.0, 6190.473809726133, 6207.782727604603, 6208.0, 6217.0, 5204.0, 5209.791608335624, 5209.947900520946, 5222.033923724123, 5231.110711179109, 3266.6570010149067, 3334.733221342335, 3368.882089126869, 3399.3201359728155, 3402.302527981758, 5769.798057067983, 5901.3508514063415, 5909.349971503131, 5914.083317085772, 5914.319853216935, 6430.517711171681, 6450.193725784277, 6455.9677201613695, 6462.612243265419, 6465.0, 5879.706014699248, 5880.206172166788, 5880.8235752927485, 5882.294124705063, 5887.646741195542, 6081.604695694766, 6157.753689852535, 6189.442950134509, 6201.782937597162, 6215.223097112861, 6054.757809687563, 6100.694965251809, 6101.572889897665, 6109.847253818512, 6112.205413296243, 5782.7686892523825, 5858.648481091148, 5866.941330586639, 5868.882622347614, 5872.500837428866, 4154.958450415457, 4233.449651545279, 4233.597808208216, 4243.533211346811, 4248.383984322318, 6085.817425477243, 6243.406876346739, 6244.718987645476, 6247.468965138014, 6258.874822503615, 5992.910106348496, 5993.250843644544, 6005.489533389711, 6011.458968692838, 6016.789412370546, 5987.850303742267, 6012.0, 6016.398360163948, 6016.819495415145, 6020.066889632114, 5785.710714464344, 5818.0981947798155, 5852.7658893643775, 5871.060630299132, 5882.617629854046, 6003.979323514925, 6018.7291571878495, 6032.6983650818165, 6041.75832966694, 6062.666553339609, 5897.705114744332, 5902.0, 5903.675297858487, 5905.763769449346, 5909.438603332676], "unit": "ms", "name": "prototype.html", "value": 4459.099085664037}, {"lowerIsBetter": false, "replicates": [718.9820254493637, 740.8814589665653, 752.8343764371837, 757.4889242162235, 762.4357975098426, 11782.0, 11802.114841386887, 12018.15872888898, 12053.216540924834, 12077.698057548554, 11629.534818607246, 11727.061835053197, 11731.648050558475, 11743.236689615169, 11767.470463829126, 414.41981226283144, 419.24326590504126, 786.4376970466116, 800.0399520575304, 811.4238890387832, 808.8018435483315, 811.3103861717552, 813.3615112136944, 814.5560669435172, 814.8940637717088, 850.9659613615479, 851.9957400212991, 861.2550144125349, 862.5730263519566, 865.355310293832, 838.5136620759945, 841.3563623827777, 842.8862103616025, 843.5318398288947, 843.6625349860044, 628.1770880147022, 633.6958260035209, 635.0601110356652, 636.3000699230855, 640.0495264532166, 11456.656300311004, 11640.301581905112, 11658.941705291503, 11669.70825729355, 11732.061435085172, 10772.892271077268, 11384.373859437728, 11402.72938733546, 11406.429678516124, 11532.942335288353, 9235.861462078074, 9392.389494682824, 9393.718188454357, 9396.859047114298, 9470.763230919214, 3228.903132905993, 3287.96712032879, 3301.5873015873017, 3335.6164041135094, 3342.498625206214, 38312.61687383118, 38446.42330365047, 38544.0, 38704.0, 38715.41926871099, 8619.525926074126, 8805.955970220108, 8855.778605534913, 9065.954670226607, 9119.133682300171, 16492.587685307724, 16669.666606667797, 16722.74915876263, 16757.83242167587, 16771.0, 6218.657973811393, 6346.174997250328, 6390.552661313756, 6489.221293444817, 6545.4436372907885, 3365.3774051800497, 3474.8745600239445, 3554.680078792921, 3574.088607405095, 3610.6389361064207, 2588.145911849085, 2616.882240299191, 2635.0908936416904, 2639.2214296782495, 2648.6291919131336, 472.0605994071772, 476.5782282679853, 479.4318732302233, 490.9558139767438, 494.07854351633944, 494.8020791683355, 577.2322810661893, 592.9445586855404, 593.1932571702481, 599.0355527600559, 8025.23760242776, 8383.245507904317, 8644.95677521621, 8665.13348665141, 8680.392372533863, 470.1490302552391, 505.27997603414985, 556.9832905012856, 566.9454814045871, 611.437477520682, 3631.3463576556474, 3780.243951209769, 3816.713746469026, 3845.692344612424, 3947.3092208863336, 45263.32105018428, 45631.31553026707, 46020.53979460229, 46051.0, 46202.76898615553, 41624.1675166501, 41878.79060604677, 42017.369739453934, 42494.362584561255, 43125.13749724988, 39622.80188599038, 40132.0, 40144.59855401467, 40224.0, 40312.39531406973, 7916.84166316682, 8009.118996910219, 8162.142974987541, 8239.473958049339, 8300.667973281243, 31120.844395777876, 31478.685213147575, 31839.363212735152, 33592.664073359934, 33726.3254734899, 37297.6270237305, 37836.0, 38083.428748568236, 38283.23433531258, 38450.807745961094, 10243.875617936303, 10287.84568231492, 10387.53256103462, 10456.895431045896, 10956.726081848017, 10262.794744105226, 10326.380417174994, 11428.48571814287, 11545.711357216136, 12164.635060948185, 10475.738106547396, 10660.200484963503, 11015.559377624806, 11022.724431889266, 11105.38920359388, 10117.797644047225, 10268.486575671037, 10447.216458765472, 10494.05553500158, 10738.40938748345, 9882.50587470638, 10263.846042309222, 10361.533730981973, 10627.309224900357, 10670.30643008233, 9090.13643703847, 9406.858897116412, 9541.278916175923, 9799.216062715108, 9881.604735810775, 8880.236011641558, 9280.814383712423, 9339.813203736023, 9460.95269523648, 9499.905000950179], "unit": "ms", "name": "yui.html", "value": 5695.61114351168}], "name": "dromaeo_css", "value": 6350.18095705404}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 115.0, 115.0, 116.0, 124.0, 114.0, 113.0, 114.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [159.0, 136.0, 159.0, 170.0, 131.0, 156.0, 156.0, 135.0, 168.0, 136.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 162.0, 162.0, 166.0, 169.0, 162.0, 167.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 74.0, 158.0, 74.0, 78.0, 75.0, 74.0, 149.0], "unit": "ms", "name": "audio-fft", "value": 90.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 137.0, 98.0, 95.0, 95.0, 137.0, 96.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 72.0, 74.0, 72.0, 73.0, 73.0, 75.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 73.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 86.0, 84.0, 84.0, 84.0, 85.0, 94.0, 103.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [128.0, 121.0, 120.0, 118.0, 141.0, 126.0, 122.0, 120.0, 128.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [136.0, 150.0, 158.0, 155.0, 150.0, 135.0, 141.0, 157.0, 152.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 77.0, 72.0, 72.0, 71.0, 71.0, 71.0, 70.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1554.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [187.125748502994], "unit": "score", "name": "DeltaBlue", "value": 353.33459199999993}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [715.307582260372], "unit": "score", "name": "Earley", "value": 931.7152739999998}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26315.78947368421], "unit": "score", "name": "RegExp", "value": 34.61742999999998}, {"lowerIsBetter": false, "replicates": [595.2522255192879], "unit": "score", "name": "Splay", "value": 136.90163010967092}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21334.613511355292}]} 10:26:25 INFO - RETURN: dromaeo_css: 6350.18 10:26:25 INFO - RETURN: kraken: 1554.70 10:26:25 INFO - RETURN: v8_7: 21334.61 10:26:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21334.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1554.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6350.18"}}} 10:26:25 INFO - Return code: 0 10:26:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:26:25 INFO - # TBPL SUCCESS # 10:26:25 INFO - Running post-action listener: _resource_record_post_action 10:26:25 INFO - Running post-run listener: _resource_record_post_run 10:26:26 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520028160; Read time: 16; Write time: 621788 10:26:26 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 245694464; Read time: 0; Write time: 428748 10:26:26 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274042880; Read time: 16; Write time: 193012 10:26:26 INFO - Running post-run listener: _upload_blobber_files 10:26:26 INFO - Blob upload gear active. 10:26:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:26:26 INFO - Copying logs to upload dir... 10:26:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.848503 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-22 10:26:26.120481) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-22 10:26:26.123757) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010187 build_url: 'https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-22 10:26:26.175225) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:26:26.175550) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450807515.555226-2035449091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004703 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:26:26.225320) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 10:26:26.225832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 10:26:26.226352) ========= ========= Total master_lag: 0.23 =========