builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1466131345.52 results: success (0) buildid: 20160616163918 builduid: 33b8ff5c1cca4c00b8eae3034b4275b2 revision: 5f95858f8ddf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:25.520181) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:25.520655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:25.521075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:25.572895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:25.573242) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 19:42:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2016-06-16 19:42:26 (109 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075983 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:25.676155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:25.676479) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023112 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:25.746145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 19:42:25.746524) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f95858f8ddf --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 5f95858f8ddf --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=5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 19:42:26,270 Setting DEBUG logging. 2016-06-16 19:42:26,270 attempt 1/10 2016-06-16 19:42:26,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f95858f8ddf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 19:42:27,071 unpacking tar archive at: mozilla-central-5f95858f8ddf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140892 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 19:42:26.908376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:26.908734) ========= script_repo_revision: 5f95858f8ddf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:26.909192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:26.909835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 19:42:26.918608) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-06-16 19:42:26.918916) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:42:27 INFO - MultiFileLogger online at 20160616 19:42:27 in /builds/slave/test 19:42:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:42:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:42:27 INFO - {'append_to_log': False, 19:42:27 INFO - 'base_work_dir': '/builds/slave/test', 19:42:27 INFO - 'blob_upload_branch': 'Firefox', 19:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:42:27 INFO - 'branch': 'Firefox', 19:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:42:27 INFO - 'config_files': ('talos/linux_config.py',), 19:42:27 INFO - 'default_actions': ('clobber', 19:42:27 INFO - 'read-buildbot-config', 19:42:27 INFO - 'download-and-extract', 19:42:27 INFO - 'populate-webroot', 19:42:27 INFO - 'create-virtualenv', 19:42:27 INFO - 'install', 19:42:27 INFO - 'run-tests'), 19:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:42:27 INFO - 'download_minidump_stackwalk': True, 19:42:27 INFO - 'download_symbols': 'ondemand', 19:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:42:27 INFO - 'installer_path': 'installer.exe', 19:42:27 INFO - 'log_level': 'info', 19:42:27 INFO - 'log_name': 'talos', 19:42:27 INFO - 'log_to_console': True, 19:42:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:42:27 INFO - 'opt_config_files': (), 19:42:27 INFO - 'pip_index': False, 19:42:27 INFO - 'sps_profile': False, 19:42:27 INFO - 'sps_profile_interval': 0, 19:42:27 INFO - 'suite': 'dromaeojs-e10s', 19:42:27 INFO - 'system_bits': '32', 19:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:42:27 INFO - 'title': 'talos-linux64-ix-051', 19:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:42:27 INFO - 'use_talos_json': True, 19:42:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:42:27 INFO - 'work_dir': 'build'} 19:42:27 INFO - ##### 19:42:27 INFO - ##### Running clobber step. 19:42:27 INFO - ##### 19:42:27 INFO - Running pre-action listener: _resource_record_pre_action 19:42:27 INFO - Running main action method: clobber 19:42:27 INFO - rmtree: /builds/slave/test/build 19:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:42:27 INFO - Running post-action listener: _resource_record_post_action 19:42:27 INFO - ##### 19:42:27 INFO - ##### Finished clobber step (success) 19:42:27 INFO - ##### 19:42:27 INFO - ##### 19:42:27 INFO - ##### Running read-buildbot-config step. 19:42:27 INFO - ##### 19:42:28 INFO - Running pre-action listener: _resource_record_pre_action 19:42:28 INFO - Running main action method: read_buildbot_config 19:42:28 INFO - Using buildbot properties: 19:42:28 INFO - { 19:42:28 INFO - "project": "", 19:42:28 INFO - "product": "firefox", 19:42:28 INFO - "script_repo_revision": "production", 19:42:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:42:28 INFO - "repository": "", 19:42:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:42:28 INFO - "buildid": "20160616163918", 19:42:28 INFO - "stage_platform": "linux64-pgo", 19:42:28 INFO - "basedir": "/builds/slave/test", 19:42:28 INFO - "nightly_build": "True", 19:42:28 INFO - "buildnumber": 253, 19:42:28 INFO - "slavename": "talos-linux64-ix-051", 19:42:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:42:28 INFO - "platform": "ubuntu64_hw", 19:42:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:42:28 INFO - "branch": "mozilla-central", 19:42:28 INFO - "repo_path": "mozilla-central", 19:42:28 INFO - "revision": "5f95858f8ddf", 19:42:28 INFO - "pgo_build": "True", 19:42:28 INFO - "builduid": "33b8ff5c1cca4c00b8eae3034b4275b2", 19:42:28 INFO - "slavebuilddir": "test" 19:42:28 INFO - } 19:42:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:42:28 INFO - Running post-action listener: _resource_record_post_action 19:42:28 INFO - ##### 19:42:28 INFO - ##### Finished read-buildbot-config step (success) 19:42:28 INFO - ##### 19:42:28 INFO - ##### 19:42:28 INFO - ##### Running download-and-extract step. 19:42:28 INFO - ##### 19:42:28 INFO - Running pre-action listener: _resource_record_pre_action 19:42:28 INFO - Running main action method: download_and_extract 19:42:28 INFO - mkdir: /builds/slave/test/build/tests 19:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:28 INFO - https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:42:28 INFO - retry: attempt #1 caught exception: '' 19:42:28 INFO - retry: Failed, sleeping 30 seconds before retrying 19:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #2 19:43:04 INFO - Downloaded 1361 bytes. 19:43:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:43:04 INFO - Using the following test package requirements: 19:43:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:43:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:43:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:43:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:04 INFO - u'jsshell-linux-x86_64.zip'], 19:43:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:43:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:43:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:43:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:43:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:43:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:43:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:43:04 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')]} 19:43:04 INFO - https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:43:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:43:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:43:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:10 INFO - Downloaded 24220784 bytes. 19:43:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:43:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:43:11 INFO - Return code: 0 19:43:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:11 INFO - https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:43:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:43:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:43:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:43:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:13 INFO - Downloaded 24220784 bytes. 19:43:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:43:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:43:15 INFO - Return code: 0 19:43:15 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')]} 19:43:15 INFO - https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:43:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:43:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:43:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:43:16 INFO - Downloaded 14405384 bytes. 19:43:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:43:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:43:16 INFO - Return code: 0 19:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:16 INFO - https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:43:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:43:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:43:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:43:18 INFO - Downloaded 59424279 bytes. 19:43:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:43:18 INFO - mkdir: /builds/slave/test/properties 19:43:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:43:18 INFO - Writing to file /builds/slave/test/properties/build_url 19:43:18 INFO - Contents: 19:43:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:43:18 INFO - Running post-action listener: _resource_record_post_action 19:43:18 INFO - Running post-action listener: set_extra_try_arguments 19:43:18 INFO - ##### 19:43:18 INFO - ##### Finished download-and-extract step (success) 19:43:18 INFO - ##### 19:43:18 INFO - ##### 19:43:18 INFO - ##### Running populate-webroot step. 19:43:18 INFO - ##### 19:43:18 INFO - Running pre-action listener: _resource_record_pre_action 19:43:18 INFO - Running main action method: populate_webroot 19:43:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:43:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:43:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:43:18 INFO - '--tppagecycles', 19:43:18 INFO - '7'], 19:43:18 INFO - 'tests': ['tsvgm']}}, 19:43:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:43:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:43:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:43:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:43:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:18 INFO - 'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:18 INFO - 'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['damp', 'tps']}, 19:43:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:18 INFO - 'tests': ['damp', 'tps']}, 19:43:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['dromaeo_dom']}, 19:43:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:43:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['basic_compositor_video']}, 19:43:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:43:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['a11yr', 19:43:18 INFO - 'ts_paint', 19:43:18 INFO - 'tpaint', 19:43:18 INFO - 'sessionrestore', 19:43:18 INFO - 'sessionrestore_no_auto_restore', 19:43:18 INFO - 'tabpaint']}, 19:43:18 INFO - 'other-e10s': {'tests': ['a11yr', 19:43:18 INFO - 'ts_paint', 19:43:18 INFO - 'tpaint', 19:43:18 INFO - 'sessionrestore', 19:43:18 INFO - 'sessionrestore_no_auto_restore', 19:43:18 INFO - 'tabpaint']}, 19:43:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:43:18 INFO - 'ts_paint', 19:43:18 INFO - 'tpaint', 19:43:18 INFO - 'sessionrestore', 19:43:18 INFO - 'sessionrestore_no_auto_restore', 19:43:18 INFO - 'tabpaint']}, 19:43:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:43:18 INFO - 'ts_paint', 19:43:18 INFO - 'tpaint', 19:43:18 INFO - 'sessionrestore', 19:43:18 INFO - 'sessionrestore_no_auto_restore', 19:43:18 INFO - 'tabpaint']}, 19:43:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['a11yr', 19:43:18 INFO - 'ts_paint', 19:43:18 INFO - 'tpaint', 19:43:18 INFO - 'sessionrestore', 19:43:18 INFO - 'sessionrestore_no_auto_restore', 19:43:18 INFO - 'tabpaint']}, 19:43:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['a11yr', 19:43:18 INFO - 'ts_paint', 19:43:18 INFO - 'tpaint', 19:43:18 INFO - 'sessionrestore', 19:43:18 INFO - 'sessionrestore_no_auto_restore', 19:43:18 INFO - 'tabpaint']}, 19:43:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['tsvgx', 19:43:18 INFO - 'tsvgr_opacity', 19:43:18 INFO - 'tart', 19:43:18 INFO - 'tscrollx', 19:43:18 INFO - 'cart']}, 19:43:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:43:18 INFO - 'tsvgr_opacity', 19:43:18 INFO - 'tart', 19:43:18 INFO - 'tscrollx', 19:43:18 INFO - 'cart']}, 19:43:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:18 INFO - 'talos_options': ['--disable-e10s'], 19:43:18 INFO - 'tests': ['tp5o']}, 19:43:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:18 INFO - 'tests': ['tp5o']}, 19:43:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:18 INFO - 'talos_options': ['--disable-e10s', 19:43:18 INFO - '--xperf_path', 19:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:18 INFO - 'tests': ['tp5n']}, 19:43:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:18 INFO - 'talos_options': ['--xperf_path', 19:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:18 INFO - 'tests': ['tp5n']}}, 19:43:18 INFO - 'talos.zip': {'path': '', 19:43:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:43:18 INFO - Running post-action listener: _resource_record_post_action 19:43:18 INFO - ##### 19:43:18 INFO - ##### Finished populate-webroot step (success) 19:43:18 INFO - ##### 19:43:18 INFO - ##### 19:43:18 INFO - ##### Running create-virtualenv step. 19:43:18 INFO - ##### 19:43:18 INFO - Running pre-action listener: _resource_record_pre_action 19:43:18 INFO - Running main action method: create_virtualenv 19:43:18 INFO - Creating virtualenv /builds/slave/test/build/venv 19:43:18 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 19:43:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:43:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:43:18 INFO - Using real prefix '/usr' 19:43:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:43:19 INFO - Installing distribute.............................................................................................................................................................................................done. 19:43:21 INFO - Installing pip.................done. 19:43:21 INFO - Return code: 0 19:43:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:43:21 INFO - Using env: {'DISPLAY': ':0', 19:43:21 INFO - 'HOME': '/home/cltbld', 19:43:21 INFO - 'LANG': 'en_US.UTF-8', 19:43:21 INFO - 'LANGUAGE': 'en_US:en', 19:43:21 INFO - 'LOGNAME': 'cltbld', 19:43:21 INFO - 'MAIL': '/var/mail/cltbld', 19:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:21 INFO - 'MOZ_NO_REMOTE': '1', 19:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:21 INFO - 'NO_EM_RESTART': '1', 19:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:21 INFO - 'PWD': '/builds/slave/test', 19:43:21 INFO - 'SHELL': '/bin/bash', 19:43:21 INFO - 'SHLVL': '1', 19:43:21 INFO - 'TERM': 'linux', 19:43:21 INFO - 'TMOUT': '86400', 19:43:21 INFO - 'USER': 'cltbld', 19:43:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:21 INFO - '_': '/tools/buildbot/bin/python'} 19:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:21 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 19:43:21 INFO - Cleaning up... 19:43:21 INFO - Return code: 0 19:43:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 19:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 19:43:21 INFO - Using env: {'DISPLAY': ':0', 19:43:21 INFO - 'HOME': '/home/cltbld', 19:43:21 INFO - 'LANG': 'en_US.UTF-8', 19:43:21 INFO - 'LANGUAGE': 'en_US:en', 19:43:21 INFO - 'LOGNAME': 'cltbld', 19:43:21 INFO - 'MAIL': '/var/mail/cltbld', 19:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:21 INFO - 'MOZ_NO_REMOTE': '1', 19:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:21 INFO - 'NO_EM_RESTART': '1', 19:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:21 INFO - 'PWD': '/builds/slave/test', 19:43:21 INFO - 'SHELL': '/bin/bash', 19:43:21 INFO - 'SHLVL': '1', 19:43:21 INFO - 'TERM': 'linux', 19:43:21 INFO - 'TMOUT': '86400', 19:43:21 INFO - 'USER': 'cltbld', 19:43:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:21 INFO - '_': '/tools/buildbot/bin/python'} 19:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:21 INFO - Downloading/unpacking psutil>=3.1.1 19:43:21 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 19:43:21 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 19:43:21 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 19:43:21 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 19:43:21 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 19:43:21 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 19:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:43:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:23 INFO - Installing collected packages: psutil 19:43:23 INFO - Running setup.py install for psutil 19:43:23 INFO - building 'psutil._psutil_linux' extension 19:43:23 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 19:43:24 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 19:43:24 INFO - building 'psutil._psutil_posix' extension 19:43:24 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 19:43:24 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 19:43:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:24 INFO - Successfully installed psutil 19:43:24 INFO - Cleaning up... 19:43:24 INFO - Return code: 0 19:43:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 19:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 19:43:24 INFO - Using env: {'DISPLAY': ':0', 19:43:24 INFO - 'HOME': '/home/cltbld', 19:43:24 INFO - 'LANG': 'en_US.UTF-8', 19:43:24 INFO - 'LANGUAGE': 'en_US:en', 19:43:24 INFO - 'LOGNAME': 'cltbld', 19:43:24 INFO - 'MAIL': '/var/mail/cltbld', 19:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:24 INFO - 'MOZ_NO_REMOTE': '1', 19:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:24 INFO - 'NO_EM_RESTART': '1', 19:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:24 INFO - 'PWD': '/builds/slave/test', 19:43:24 INFO - 'SHELL': '/bin/bash', 19:43:24 INFO - 'SHLVL': '1', 19:43:24 INFO - 'TERM': 'linux', 19:43:24 INFO - 'TMOUT': '86400', 19:43:24 INFO - 'USER': 'cltbld', 19:43:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:24 INFO - '_': '/tools/buildbot/bin/python'} 19:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:43:26 INFO - Installing collected packages: mozsystemmonitor 19:43:26 INFO - Running setup.py install for mozsystemmonitor 19:43:26 INFO - Successfully installed mozsystemmonitor 19:43:26 INFO - Cleaning up... 19:43:26 INFO - Return code: 0 19:43:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 19:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 19:43:26 INFO - Using env: {'DISPLAY': ':0', 19:43:26 INFO - 'HOME': '/home/cltbld', 19:43:26 INFO - 'LANG': 'en_US.UTF-8', 19:43:26 INFO - 'LANGUAGE': 'en_US:en', 19:43:26 INFO - 'LOGNAME': 'cltbld', 19:43:26 INFO - 'MAIL': '/var/mail/cltbld', 19:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:26 INFO - 'MOZ_NO_REMOTE': '1', 19:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:26 INFO - 'NO_EM_RESTART': '1', 19:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:26 INFO - 'PWD': '/builds/slave/test', 19:43:26 INFO - 'SHELL': '/bin/bash', 19:43:26 INFO - 'SHLVL': '1', 19:43:26 INFO - 'TERM': 'linux', 19:43:26 INFO - 'TMOUT': '86400', 19:43:26 INFO - 'USER': 'cltbld', 19:43:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:26 INFO - '_': '/tools/buildbot/bin/python'} 19:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:26 INFO - Downloading/unpacking jsonschema==2.5.1 19:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:43:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:28 INFO - Downloading functools32-3.2.3-2.tar.gz 19:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:43:29 INFO - warning: no files found matching '*.txt' 19:43:29 INFO - no previously-included directories found matching 'build' 19:43:29 INFO - no previously-included directories found matching 'dist' 19:43:29 INFO - no previously-included directories found matching '.git*' 19:43:29 INFO - Installing collected packages: jsonschema, functools32 19:43:29 INFO - Running setup.py install for functools32 19:43:29 INFO - warning: no files found matching '*.txt' 19:43:29 INFO - no previously-included directories found matching 'build' 19:43:29 INFO - no previously-included directories found matching 'dist' 19:43:29 INFO - no previously-included directories found matching '.git*' 19:43:29 INFO - Successfully installed jsonschema functools32 19:43:29 INFO - Cleaning up... 19:43:29 INFO - Return code: 0 19:43:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:43:29 INFO - Using env: {'DISPLAY': ':0', 19:43:29 INFO - 'HOME': '/home/cltbld', 19:43:29 INFO - 'LANG': 'en_US.UTF-8', 19:43:29 INFO - 'LANGUAGE': 'en_US:en', 19:43:29 INFO - 'LOGNAME': 'cltbld', 19:43:29 INFO - 'MAIL': '/var/mail/cltbld', 19:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:29 INFO - 'MOZ_NO_REMOTE': '1', 19:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:29 INFO - 'NO_EM_RESTART': '1', 19:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:29 INFO - 'PWD': '/builds/slave/test', 19:43:29 INFO - 'SHELL': '/bin/bash', 19:43:29 INFO - 'SHLVL': '1', 19:43:29 INFO - 'TERM': 'linux', 19:43:29 INFO - 'TMOUT': '86400', 19:43:29 INFO - 'USER': 'cltbld', 19:43:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:29 INFO - '_': '/tools/buildbot/bin/python'} 19:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:29 INFO - Downloading/unpacking blobuploader==1.2.4 19:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:31 INFO - Downloading blobuploader-1.2.4.tar.gz 19:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:43:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:43:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:32 INFO - Downloading docopt-0.6.1.tar.gz 19:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:43:32 INFO - Installing collected packages: blobuploader, requests, docopt 19:43:32 INFO - Running setup.py install for blobuploader 19:43:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:43:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:43:32 INFO - Running setup.py install for requests 19:43:32 INFO - Running setup.py install for docopt 19:43:32 INFO - Successfully installed blobuploader requests docopt 19:43:32 INFO - Cleaning up... 19:43:32 INFO - Return code: 0 19:43:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 19:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 19:43:32 INFO - Using env: {'DISPLAY': ':0', 19:43:32 INFO - 'HOME': '/home/cltbld', 19:43:32 INFO - 'LANG': 'en_US.UTF-8', 19:43:32 INFO - 'LANGUAGE': 'en_US:en', 19:43:32 INFO - 'LOGNAME': 'cltbld', 19:43:32 INFO - 'MAIL': '/var/mail/cltbld', 19:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:32 INFO - 'MOZ_NO_REMOTE': '1', 19:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:32 INFO - 'NO_EM_RESTART': '1', 19:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:32 INFO - 'PWD': '/builds/slave/test', 19:43:32 INFO - 'SHELL': '/bin/bash', 19:43:32 INFO - 'SHLVL': '1', 19:43:32 INFO - 'TERM': 'linux', 19:43:32 INFO - 'TMOUT': '86400', 19:43:32 INFO - 'USER': 'cltbld', 19:43:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:32 INFO - '_': '/tools/buildbot/bin/python'} 19:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:33 INFO - Running setup.py (path:/tmp/pip-iDuge5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:33 INFO - Running setup.py (path:/tmp/pip-IVavnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:33 INFO - Running setup.py (path:/tmp/pip-3KCYNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:33 INFO - Running setup.py (path:/tmp/pip-AJ1Ksu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:33 INFO - Running setup.py (path:/tmp/pip-tXB2aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:33 INFO - Running setup.py (path:/tmp/pip-3UdZqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:33 INFO - Running setup.py (path:/tmp/pip-AeXXvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:33 INFO - Running setup.py (path:/tmp/pip-SsMlIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:33 INFO - Running setup.py (path:/tmp/pip-X1fyhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:33 INFO - Running setup.py (path:/tmp/pip-P8mPk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:33 INFO - Running setup.py (path:/tmp/pip-gKrkZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:33 INFO - Running setup.py (path:/tmp/pip-ri_nNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:33 INFO - Running setup.py (path:/tmp/pip-ctLohI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:34 INFO - Running setup.py (path:/tmp/pip-UvHRp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:34 INFO - Running setup.py (path:/tmp/pip-wuvC3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:34 INFO - Running setup.py (path:/tmp/pip-mtV51v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:34 INFO - Running setup.py (path:/tmp/pip-uz7EHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:43:34 INFO - Running setup.py install for manifestparser 19:43:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:43:34 INFO - Running setup.py install for mozcrash 19:43:34 INFO - Running setup.py install for mozdebug 19:43:34 INFO - Running setup.py install for mozdevice 19:43:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:43:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:43:34 INFO - Running setup.py install for mozfile 19:43:34 INFO - Running setup.py install for mozhttpd 19:43:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:43:34 INFO - Running setup.py install for mozinfo 19:43:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Running setup.py install for mozInstall 19:43:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Running setup.py install for mozleak 19:43:35 INFO - Running setup.py install for mozlog 19:43:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Running setup.py install for moznetwork 19:43:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Running setup.py install for mozprocess 19:43:35 INFO - Running setup.py install for mozprofile 19:43:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Running setup.py install for mozrunner 19:43:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:43:35 INFO - Running setup.py install for mozscreenshot 19:43:35 INFO - Running setup.py install for moztest 19:43:35 INFO - Running setup.py install for mozversion 19:43:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:43:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:43:36 INFO - Cleaning up... 19:43:36 INFO - Return code: 0 19:43:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:43:36 INFO - Using env: {'DISPLAY': ':0', 19:43:36 INFO - 'HOME': '/home/cltbld', 19:43:36 INFO - 'LANG': 'en_US.UTF-8', 19:43:36 INFO - 'LANGUAGE': 'en_US:en', 19:43:36 INFO - 'LOGNAME': 'cltbld', 19:43:36 INFO - 'MAIL': '/var/mail/cltbld', 19:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:36 INFO - 'MOZ_NO_REMOTE': '1', 19:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:36 INFO - 'NO_EM_RESTART': '1', 19:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:36 INFO - 'PWD': '/builds/slave/test', 19:43:36 INFO - 'SHELL': '/bin/bash', 19:43:36 INFO - 'SHLVL': '1', 19:43:36 INFO - 'TERM': 'linux', 19:43:36 INFO - 'TMOUT': '86400', 19:43:36 INFO - 'USER': 'cltbld', 19:43:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:36 INFO - '_': '/tools/buildbot/bin/python'} 19:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:36 INFO - Running setup.py (path:/tmp/pip-rQq4h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:36 INFO - Running setup.py (path:/tmp/pip-SfnzTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:36 INFO - Running setup.py (path:/tmp/pip-_14aKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:36 INFO - Running setup.py (path:/tmp/pip-a2gRRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:36 INFO - Running setup.py (path:/tmp/pip-XB8d4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:36 INFO - Running setup.py (path:/tmp/pip-CcgBdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:36 INFO - Running setup.py (path:/tmp/pip-iMY_DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:36 INFO - Running setup.py (path:/tmp/pip-0gKpa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:36 INFO - Running setup.py (path:/tmp/pip-rv9PDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:36 INFO - Running setup.py (path:/tmp/pip-nbH0bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:37 INFO - Running setup.py (path:/tmp/pip-ZTSfF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:37 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)) 19:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:37 INFO - Running setup.py (path:/tmp/pip-zK37bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:37 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)) 19:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:37 INFO - Running setup.py (path:/tmp/pip-tLMncW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 19:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:37 INFO - Running setup.py (path:/tmp/pip-wISxi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:37 INFO - Running setup.py (path:/tmp/pip-LCdlEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:37 INFO - Running setup.py (path:/tmp/pip-59ckT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:37 INFO - Running setup.py (path:/tmp/pip-_ICvYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:43:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43:39 INFO - Downloading blessings-1.6.tar.gz 19:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:43:39 INFO - Installing collected packages: blessings 19:43:39 INFO - Running setup.py install for blessings 19:43:39 INFO - Successfully installed blessings 19:43:39 INFO - Cleaning up... 19:43:39 INFO - Return code: 0 19:43:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:43:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:39 INFO - Reading from file tmpfile_stdout 19:43:39 INFO - Current package versions: 19:43:39 INFO - argparse == 1.2.1 19:43:39 INFO - blessings == 1.6 19:43:39 INFO - blobuploader == 1.2.4 19:43:39 INFO - docopt == 0.6.1 19:43:39 INFO - functools32 == 3.2.3-2 19:43:39 INFO - jsonschema == 2.5.1 19:43:39 INFO - manifestparser == 1.1 19:43:39 INFO - mozInstall == 1.12 19:43:39 INFO - mozcrash == 0.17 19:43:39 INFO - mozdebug == 0.1 19:43:39 INFO - mozdevice == 0.48 19:43:39 INFO - mozfile == 1.2 19:43:39 INFO - mozhttpd == 0.7 19:43:39 INFO - mozinfo == 0.9 19:43:39 INFO - mozleak == 0.1 19:43:39 INFO - mozlog == 3.2 19:43:39 INFO - moznetwork == 0.27 19:43:39 INFO - mozprocess == 0.22 19:43:39 INFO - mozprofile == 0.28 19:43:39 INFO - mozrunner == 6.11 19:43:39 INFO - mozscreenshot == 0.1 19:43:39 INFO - mozsystemmonitor == 0.3 19:43:39 INFO - moztest == 0.7 19:43:39 INFO - mozversion == 1.4 19:43:39 INFO - psutil == 3.1.1 19:43:39 INFO - requests == 1.2.3 19:43:39 INFO - wsgiref == 0.1.2 19:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:43:39 INFO - Using env: {'DISPLAY': ':0', 19:43:39 INFO - 'HOME': '/home/cltbld', 19:43:39 INFO - 'LANG': 'en_US.UTF-8', 19:43:39 INFO - 'LANGUAGE': 'en_US:en', 19:43:39 INFO - 'LOGNAME': 'cltbld', 19:43:39 INFO - 'MAIL': '/var/mail/cltbld', 19:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:39 INFO - 'MOZ_NO_REMOTE': '1', 19:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:39 INFO - 'NO_EM_RESTART': '1', 19:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:39 INFO - 'PWD': '/builds/slave/test', 19:43:39 INFO - 'SHELL': '/bin/bash', 19:43:39 INFO - 'SHLVL': '1', 19:43:39 INFO - 'TERM': 'linux', 19:43:39 INFO - 'TMOUT': '86400', 19:43:39 INFO - 'USER': 'cltbld', 19:43:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:39 INFO - '_': '/tools/buildbot/bin/python'} 19:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:43:40 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 2)) 19:43:40 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 3)) 19:43:40 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 4)) 19:43:40 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 5)) 19:43:40 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 6)) 19:43:40 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 7)) 19:43:40 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 8)) 19:43:40 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 9)) 19:43:40 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:43:40 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 4)) 19:43:40 INFO - Cleaning up... 19:43:40 INFO - Return code: 0 19:43:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:43:40 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')]} 19:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:40 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')]} 19:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:43:40 INFO - Using env: {'DISPLAY': ':0', 19:43:40 INFO - 'HOME': '/home/cltbld', 19:43:40 INFO - 'LANG': 'en_US.UTF-8', 19:43:40 INFO - 'LANGUAGE': 'en_US:en', 19:43:40 INFO - 'LOGNAME': 'cltbld', 19:43:40 INFO - 'MAIL': '/var/mail/cltbld', 19:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:40 INFO - 'MOZ_NO_REMOTE': '1', 19:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:40 INFO - 'NO_EM_RESTART': '1', 19:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:40 INFO - 'PWD': '/builds/slave/test', 19:43:40 INFO - 'SHELL': '/bin/bash', 19:43:40 INFO - 'SHLVL': '1', 19:43:40 INFO - 'TERM': 'linux', 19:43:40 INFO - 'TMOUT': '86400', 19:43:40 INFO - 'USER': 'cltbld', 19:43:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:40 INFO - '_': '/tools/buildbot/bin/python'} 19:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:43:40 INFO - Cleaning up... 19:43:40 INFO - Return code: 0 19:43:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:43:40 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')]} 19:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:40 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')]} 19:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fd657673f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', '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 19:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:43:40 INFO - Using env: {'DISPLAY': ':0', 19:43:40 INFO - 'HOME': '/home/cltbld', 19:43:40 INFO - 'LANG': 'en_US.UTF-8', 19:43:40 INFO - 'LANGUAGE': 'en_US:en', 19:43:40 INFO - 'LOGNAME': 'cltbld', 19:43:40 INFO - 'MAIL': '/var/mail/cltbld', 19:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:40 INFO - 'MOZ_NO_REMOTE': '1', 19:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:40 INFO - 'NO_EM_RESTART': '1', 19:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:40 INFO - 'PWD': '/builds/slave/test', 19:43:40 INFO - 'SHELL': '/bin/bash', 19:43:40 INFO - 'SHLVL': '1', 19:43:40 INFO - 'TERM': 'linux', 19:43:40 INFO - 'TMOUT': '86400', 19:43:40 INFO - 'USER': 'cltbld', 19:43:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:40 INFO - '_': '/tools/buildbot/bin/python'} 19:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:40 INFO - Downloading/unpacking flake8 19:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:43:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:43:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:43:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:43:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:43:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:43:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:43:43 INFO - no previously-included directories found matching 'docs/_build' 19:43:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:43:43 INFO - Running setup.py install for pep8 19:43:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:43:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:43:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:43:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:43:43 INFO - no previously-included directories found matching 'docs/_build' 19:43:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:43:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:43:43 INFO - Cleaning up... 19:43:43 INFO - Return code: 0 19:43:43 INFO - Running post-action listener: _resource_record_post_action 19:43:43 INFO - Running post-action listener: _start_resource_monitoring 19:43:43 INFO - Starting resource monitoring. 19:43:43 INFO - ##### 19:43:43 INFO - ##### Finished create-virtualenv step (success) 19:43:43 INFO - ##### 19:43:43 INFO - ##### 19:43:43 INFO - ##### Running install step. 19:43:43 INFO - ##### 19:43:43 INFO - Running pre-action listener: _resource_record_pre_action 19:43:43 INFO - Running main action method: install 19:43:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:43 INFO - Reading from file tmpfile_stdout 19:43:43 INFO - Detecting whether we're running mozinstall >=1.0... 19:43:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:43:43 INFO - Reading from file tmpfile_stdout 19:43:43 INFO - Output received: 19:43:43 INFO - Usage: mozinstall [options] installer 19:43:43 INFO - Options: 19:43:43 INFO - -h, --help show this help message and exit 19:43:43 INFO - -d DEST, --destination=DEST 19:43:43 INFO - Directory to install application into. [default: 19:43:43 INFO - "/builds/slave/test"] 19:43:43 INFO - --app=APP Application being installed. [default: firefox] 19:43:43 INFO - mkdir: /builds/slave/test/build/application 19:43:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:44:00 INFO - Reading from file tmpfile_stdout 19:44:00 INFO - Output received: 19:44:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:44:00 INFO - Running post-action listener: _resource_record_post_action 19:44:00 INFO - ##### 19:44:00 INFO - ##### Finished install step (success) 19:44:00 INFO - ##### 19:44:00 INFO - ##### 19:44:00 INFO - ##### Running run-tests step. 19:44:00 INFO - ##### 19:44:00 INFO - Running pre-action listener: _resource_record_pre_action 19:44:00 INFO - Running main action method: run_tests 19:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:44:00 INFO - Python 2.7.3 19:44:00 INFO - Return code: 0 19:44:00 INFO - grabbing minidump binary from tooltool 19:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d56110>, '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 0x2cc2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc26c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:44:00 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 19:44:00 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 19:44:00 INFO - Calling ['/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'] with output_timeout 600 19:44:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:44:00 INFO - Return code: 0 19:44:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:44:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:44:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:44:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:44:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:44:01 INFO - Return code: 0 19:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:44:01 INFO - Using env: {'DISPLAY': ':0', 19:44:01 INFO - 'HOME': '/home/cltbld', 19:44:01 INFO - 'LANG': 'en_US.UTF-8', 19:44:01 INFO - 'LANGUAGE': 'en_US:en', 19:44:01 INFO - 'LOGNAME': 'cltbld', 19:44:01 INFO - 'MAIL': '/var/mail/cltbld', 19:44:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:44:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:01 INFO - 'MOZ_NO_REMOTE': '1', 19:44:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:01 INFO - 'NO_EM_RESTART': '1', 19:44:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:01 INFO - 'PWD': '/builds/slave/test', 19:44:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:44:01 INFO - 'SHELL': '/bin/bash', 19:44:01 INFO - 'SHLVL': '1', 19:44:01 INFO - 'TERM': 'linux', 19:44:01 INFO - 'TMOUT': '86400', 19:44:01 INFO - 'USER': 'cltbld', 19:44:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880', 19:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:01 INFO - '_': '/tools/buildbot/bin/python'} 19:44:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:44:01 INFO - mozversion application_buildid: 20160616163918 19:44:01 INFO - mozversion application_changeset: 5f95858f8ddf21ea2271a12810332efd09eff138 19:44:01 INFO - mozversion application_display_name: Nightly 19:44:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:44:01 INFO - mozversion application_name: Firefox 19:44:01 INFO - mozversion application_remotingname: firefox 19:44:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:44:01 INFO - mozversion application_vendor: Mozilla 19:44:01 INFO - mozversion application_version: 50.0a1 19:44:01 INFO - mozversion platform_buildid: 20160616163918 19:44:01 INFO - mozversion platform_changeset: 5f95858f8ddf21ea2271a12810332efd09eff138 19:44:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:44:01 INFO - mozversion platform_version: 50.0a1 19:44:01 INFO - using testdate: 1466131441 19:44:01 INFO - actual date: 1466131441 19:44:01 INFO - starting webserver on 'localhost:43967' 19:44:01 INFO - SUITE-START | Running 2 tests 19:44:01 INFO - TEST-START | dromaeo_css 19:44:01 INFO - operating with platform_type : linux_ 19:44:01 INFO - Initialising browser for dromaeo_css test... 19:44:01 INFO - TEST-INFO | started process 30381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuuh3Zz/profile http://localhost:43967/getInfo.html) 19:44:06 INFO - PROCESS | 30381 | __metrics Screen width/height:1600/1200 19:44:06 INFO - PROCESS | 30381 | colorDepth:24 19:44:06 INFO - PROCESS | 30381 | Browser inner width/height: 1024/697 19:44:06 INFO - PROCESS | 30381 | __metrics 19:44:06 ERROR - PROCESS | 30381 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 19:44:07 INFO - TEST-INFO | 30381: exit 0 19:44:07 INFO - Browser initialized. 19:44:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:44:07 INFO - TEST-INFO | started process 30499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuuh3Zz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:44:19 INFO - PROCESS | 30499 | RSS: Main: 184889344 19:44:19 INFO - PROCESS | 30499 | 19:45:09 INFO - PROCESS | 30499 | 1466131509542 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] 19:47:17 INFO - PROCESS | 30499 | Cycle 1(1): loaded http://localhost:43967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43967/tests/dromaeo/cssquery-ext.html) 19:47:18 INFO - PROCESS | 30499 | RSS: Main: 188264448 19:47:18 INFO - PROCESS | 30499 | 19:50:20 INFO - PROCESS | 30499 | Cycle 1(1): loaded http://localhost:43967/tests/dromaeo/cssquery-ext.html (next: http://localhost:43967/tests/dromaeo/cssquery-jquery.html) 19:50:21 INFO - PROCESS | 30499 | RSS: Main: 187351040 19:50:21 INFO - PROCESS | 30499 | 19:53:23 INFO - PROCESS | 30499 | Cycle 1(1): loaded http://localhost:43967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43967/tests/dromaeo/cssquery-mootools.html) 19:53:23 INFO - PROCESS | 30499 | RSS: Main: 188813312 19:53:23 INFO - PROCESS | 30499 | 19:56:25 INFO - PROCESS | 30499 | Cycle 1(1): loaded http://localhost:43967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43967/tests/dromaeo/cssquery-prototype.html) 19:56:26 INFO - PROCESS | 30499 | RSS: Main: 186499072 19:56:26 INFO - PROCESS | 30499 | 19:59:28 INFO - PROCESS | 30499 | Cycle 1(1): loaded http://localhost:43967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43967/tests/dromaeo/cssquery-yui.html) 19:59:29 INFO - PROCESS | 30499 | RSS: Main: 188444672 19:59:29 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | Cycle 1(1): loaded http://localhost:43967/tests/dromaeo/cssquery-yui.html (next: http://localhost:43967/tests/dromaeo/cssquery-dojo.html) 20:02:32 INFO - PROCESS | 30499 | RSS: Main: 189358080 20:02:32 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | __start_tp_report 20:02:32 INFO - PROCESS | 30499 | _x_x_mozilla_page_load 20:02:32 INFO - PROCESS | 30499 | _x_x_mozilla_page_load_details 20:02:32 INFO - PROCESS | 30499 | |i|pagename|runs| 20:02:32 INFO - PROCESS | 30499 | |0;dojo.html;3125.390548842975;3165.256164801273;3171.12793981655;3193.5369371441157;3205.5832741743584;5343.038253114442;5435.864103397417;5454.263674403959;5505.284313039299;5519.448055194479;5376.758045887935;5480.451954804517;5505.944940550593;5537.280153580029;5575.080111781551;4936.679115857467;4962.15643340633;5053.1157047516535;5118.923216151742;5166.5608423283875;567.2791720616729;4927.704337739729;4950.455449900508;5050.898982020358;5110.386753589574;4981.476944920785;4989.052080104769;5025.221090730943;5031.748412579393;5060.089183946888;5020.472850350697;5047.318611987372;5062.873428164288;5082.618803589746;5086.745662716849;4874.53691899269;4919.606431485473;4969.776360063805;4997.625178111656;5038.370203724535;5467;5502.174673798922;5508.476694714036;5515.944840551583;5544.417836127189;5954.434328738763;5976.73104710289;5989.251343582052;5992.951233534114;6000.489958353545;5829.358770535237;5895.675737834417;5928.258967629046;6003.909941350883;6017.63894166347;5576.665400076008;5591.552675785927;5605.047141985872;5612.15817627355;5615.129654903456;6017.458428741435;6118.388161183846;6129.96935015331;6135.846603834851;6137.140800287963;5791.102379131242;5808.30300363959;5856.590038697335;5858.179854820329;5906.26171728534;5942.168096466498;5945.881082378328;5969.104634304889;5972;5984.551158663117;5677.403872593401;5819.88360232793;5907.350191478934;5943.821685349447;5972.074328479092;5918.171455996164;5922.407759224043;5931.673757943355;5949.405059494016;5956.076808094752;4483.596476317147;4486.663500237495;4497.550244975476;4531.093781243699;4536.931946020813;3959.544652364957;3960.2871483132735;3977.5226972763453;4007.318755811461;4013.177298653827;5475.233467314579;5590.776368945278;5591.245181900473;5624.71876406178;5683.2895888014;5972.46247837688;5980.43185897339;5986.880262394728;5994.850128746816;6008.549358798107;5459.07195776711;5608.887822243532;5654.858628534237;5670.659760414388;5697.316322041382;5128.743562821918;5169.53474187325;5170.224466330005;5173;5178.430372659004;6190.535709821781;6243.313235544087;6244.344343843922;6247.843803904939;6248.062790581358;5761.798337058099;5922.466977972003;5957.523398128226;6003.729832157476;6063.969680151571;6156.78451254204;6192.907106393318;6219.844503887258;6254.874902501833;6273.529485288713;5726.370099289158;5906.143609176731;5916.733746981482;5941.465268125889;5958.225430693982;5904.9075920954765;5934.851628709317;5937.821865344046;5983.341832398346;6015.157877897185;5776.537876969748;5789.768409263583;5820.185174075717;5821.70891455417;5825.242718446575;5486.862828429321;5732.742026608896;5783.7397317119985;5783.8554036149435;5791.449812267828;5598.3282006159525;5637.238972738628;5648;5651.180578816131;5700.25896633435;5748.39641837601;5773.16289138081;5832.096025116114;5837.241158649348;5868.119782032729;5550.611457197957;5619.662820230799;5655.943440565707;5714.914276285942;5732.914006289826 20:02:32 INFO - PROCESS | 30499 | |1;ext.html;564.5963136357506;616.623859445738;623.5323507369473;643.4048505132754;649.8342922554748;39132.80433597832;43192.78403607985;43386;43534.78232608837;43811.342829857575;43173.35239971403;43840.3423948641;43913.560864391424;43938.56061439385;43964.340534892;8886.155815197562;9052.140046695586;9060.864087038699;9067.183953444188;9083.409578377385;8855.114488551159;8945;8953.552322383888;8955.596998135099;8974.641014359418;9041.502717350542;9052.094790520961;9054.592543335566;9069.138431848964;9084.182423581877;8895.599698013604;8964;8989.415687980325;9004.639814407448;9028.68399606014;8751.343649226334;8882.733517994471;8908.51003194824;8909.643614255421;8933.508657023862;34518;34567;34584.65415345864;34624.826875865714;34675.826620866734;2976.9106926792233;3507.91230219244;3515.3848076586496;3529.170644898447;3548.27260411615;30680.53979190314;30866.691333086605;30934.690653093632;31150.84424577885;31197.8440107798;4139.730917490354;4182.91634167318;4201.873943781691;4256.44666193396;4290.14197160566;289853.65219521726;290247;291688;294926;296162;34496.310073798886;34644.65355346465;34684.47973280403;34761.82619086889;34792.47811282833;35534.466982995276;36065.09837254037;36113.45829812555;36115.27769444596;36321.273574528364;15351.539453816404;15613.219339033003;15614.219289035504;15954.60113497172;16006.519804405887;13329.133606315558;13335;13337.799933001013;13358.666033349244;13426.798598021038;19462.31058442565;19511.658710919008;19532.20805375829;19590.6695861701;19677.606447870963;7269.818254543678;7336.33972942427;7369.7052117915755;7404.666789994463;7548.245175482518;955.8183945050419;1000.7548150703125;1019.454591793387;1042.2287507244585;1120.3949867071854;32781.83609081939;32888.34223315568;32937.17657058593;33274.18715305303;33607.663923360946;1091.3833683968533;1107.972300692473;1120.4509790202742;1144.4849817582121;1246.9064820138344;17026;17210.827891721172;17333.653326933392;17378.217980190922;17527.912360438117;547833;555176;557182;558103;559416;59416;59566;59768.70115649394;59799;59924;1226.926384416938;1284.1973766396002;1295.7538067767282;1300.856905740368;1343.9987209528963;31561.8421907889;32194.517082243317;32298.83850580826;32410.67589324171;32829.995680002154;50999.74500127476;51227.2315915269;51407.48592514027;51485.48514514957;51723.482765171866;464349;464391;464780;464853;466677;27932.720672793825;28150.2962425941;28554.571681425212;28559.571606425503;28762.568561471177;49292;49556;49976;50381.74809125931;50566.2415063767;41178.38232426576;41365.104442688724;41699;42468.362974556025;42799.7860010698;41113.79443102885;41654.37518437165;41766.37350439685;41893.79053104715;42179.367309491;36786.8160659195;40884.59115408927;41550.792246038574;41791.7910410446;41906;36909.446358305184;37373.4393984085;37379.81310093432;37912.62087379091;38025.239495210495;28506.42987140204;28653.713462865104;28832.135035948955;28834.567481487375;29019 20:02:32 INFO - PROCESS | 30499 | |2;jquery.html;384.39265959783546;386.9110104675923;387.30672096946483;395.778364116095;412.18181908910805;13897.235652039133;18241.54396140097;19137.90431047846;19958.401247962567;20002.799972000295;18434.539136521595;18848;19161.52096197596;19250.807491925076;19311.806881931177;5736.913946290799;5761.596688231825;5784.392638772932;5904.261967254093;5954.761809527614;5355.08963476208;5641.633293835908;5799.942000579982;5813.6802475863815;5860.560457965648;5599.32808063033;5633.15502674598;5678.233438485793;5697.487226149646;5729.197912292261;5328.254044433782;5603.299587551535;5612.943870561304;5696.3733989261145;5710.571707121941;5451.781928722847;5508.9724551377385;5533.944660553423;5538.529225015838;5559.138333558305;20632.658877172937;21357.572848542943;21668.891655541778;22819.885900570393;22832.885835570884;2302.804261637763;2407.9398015049587;2427.320350301918;2515.9748402515925;2549.872506374674;9687.32188746788;9847.556859941249;10215.693529194135;10233.283670143093;10233.89766102337;1924.3457224543583;1942.873713208637;1954.775200851906;1995.7804641489424;2026.9087891044937;81232.18767812305;86448;94095.52952235263;95652.52173739087;99249.50375248077;16004.359825606845;16929.238184281738;17485.562860928578;17880.642387152184;17898.463046108638;30556.236094097825;30778.384432311675;30977;31236.843815780776;31249.8437507811;9810.509474526245;10303.845442318372;10381.584736610603;10442.582296708046;10471.581136754445;8515.872261915953;8642.740717778477;8697.304215662733;8952.104789520996;9027.909720902708;8679.392442529088;8704.303655707528;8879.644814207359;8986.236169925498;9114.498702571289;3445.2937147884622;3509.350770107538;3538.522299489536;3685.7235707322056;3733.4586484959527;938.6949241496541;951.4006176109007;986.1420564109271;1032.043196242759;1047.9685609431729;18908;19092.427227183205;19183;19301.324453644334;19531.609367812565;957.8132264208551;986.7434467038622;990.64336838738;997.3018886779139;1060.8090543702053;10061.346012509164;10607.84088238677;10611.893881061245;10617.726051924768;10780.622678206226;497047;499080;502216;512486;522116;82667.58666206751;86425.56787216023;88401.55799221092;94178;97300.51349743348;1003.3628645809817;1004.2066767253933;1020.0411613083826;1024.3853687787416;1025.6051420203275;17048.31806727717;17092.40176593813;17429.302827886742;17601.207945642735;17625.559361016076;40919.590804091575;41711;42090;42431.3635295477;43806;59294.70352648209;59396.703016484644;60153.398466014776;60323.69838150781;61275;8172.591370431336;8245.340372770284;8254.958725206576;8336.458130221516;8469.788255293666;12747.936260318638;12774.552890648783;12837.614871553867;13487.460501579826;13519.729605408034;11854.644360669194;11934.403279836148;12034.819477708017;12081.395930203631;12239.144943271765;11868.881311186778;11946.462409191434;11951.820722689341;11995.280283183038;12049.457774400349;11976.221545599508;12005.339706316236;12144.14990950625;12311.384430778604;12411.441485133371;7477.289657482531;7664.11862635804;7697.846043079219;7916.168802275678;8064.3548516119745;10082.29423940317;11580.247283926517;11833.940830295793;11990.940045299718;12085.214461060003 20:02:32 INFO - PROCESS | 30499 | |3;mootools.html;1416.8016477693125;1464.53134996801;1582.4619629326035;1709.2393884721305;1759.3754217252874;7674.424418168632;8487.618057187427;8519.616617252223;9121.042290559488;9136.086391360861;8682.86975695365;8765.7808554786;8785.077566855469;8803.119688031195;8813.779655508599;2308.134449581407;2344.542814151241;2348.154664320843;2352.0591763294647;2353.9293821185393;2342.5666251743482;2346.894389752465;2405.9879700601473;2410.7348191698898;2411.6020856558735;2303.7235531736214;2329.173143534038;2341.227394959668;2343.156463673085;2364.598018336887;2267.648514480258;2273.4089136824464;2302.746697863225;2304.3893368257427;2319.0839618350824;2257.604919139144;2258.2999270226283;2263.026898433673;2268.7164104486938;2269.727632684072;8712.956435217784;8832.60253288597;8904.955475222647;8944.463332200088;8963.551822408854;5032.547070763612;5169.198774190007;5171.637985341028;5175.0943584872875;5190.351206099238;3249.3014001989686;3392.86428542858;3407.4718418645148;3511.525943997579;3524.030891504831;1127.746257092156;1133.472935085181;1165.6153469355093;1181.864085630155;1189.4052973513244;12060.879391206063;12064.638060858188;12152.331621760799;12171.2697238166;12199.14605977582;4540.387047748512;4611.123886461562;4680.08738296029;4722.693024953367;4730.314104454835;10115.443650599287;10225;10231.846522302172;10243.795124097476;10278;5211.1662134059125;5241.31862857826;5243.370795504487;5248.3701955765555;5255.76349064293;4260.424842646203;4659.767011649404;4710.128626204163;4746.667733258639;4769.475357710649;4066.1054567995584;4080.713757848959;4121.752694838319;4135.069609337875;4150.315197992298;1256.761215369077;1295.2487557216791;1295.5206573567652;1307.8692130786844;1310.128764371682;991.3902949686036;996.2528103922059;1021.4790456867051;1030.0883717909703;1034.2191645307744;6099.2985806632805;6192.659403732838;6264.874702505925;6276.968615156895;6340.651264180422;437.62145743931904;437.9321205213197;444.65539207114097;446.2814868062417;452.4999875137991;4145.17096580685;4195.370694395804;4201.4538110046105;4214.5881129821855;4218.915621687611;10642.308249963728;11033.337999720043;11093.889061109447;11171.72070698239;11176.608818691308;10869.184811139196;10888.67333979982;10929.945350273358;10976.560937562568;11016.504257308441;7785.649645765954;8033.517988920684;8046.637901294339;8080.474769139987;8163.469374490758;5782.884342313046;5854.209681693087;5866.911996320144;5967.104934259895;6019.909701354396;9551.904480955101;9819.754506137404;9835.557399916877;9927.652532161339;9976.700698979042;9709.36889102206;9893.65372211969;10289.794204116026;10451.111655509063;10543.051125398752;7523.3981281498445;7961.164077771982;8254.628541715518;8323.375746818892;8449.45078569891;8659.740207793777;8689.13108689126;8691.913510811148;8703.042665306937;8725.694600688945;7586.165521792709;7610.8097297568;7717.961410192913;7829.49108307981;7881.724139655084;7453.068366454193;7478.6260686966525;7604.695812167452;7616.3906887449975;7617.961910190414;7015.158181018311;7039;7084.716611335489;7095.9645201773665;7133.678984445816;5264.710440925785;5367.651102678469;5444.183372494158;5508.173773933942;5568.832935011957;5450.345958485007;5522.861928451821;5534.86162845916;5576.637518561442;5679.091345384719 20:02:32 INFO - PROCESS | 30499 | |4;prototype.html;310.580716033355;317.1010186122343;317.65217087289426;325.07840272826536;329.27559369387336;5416.485433883785;5580;5591.440855914417;5652.3499797523245;5720.570957178213;5565.6104072714925;5578.972105139469;5583.79948311114;5653.038983372826;5672.744726487308;4307.698461107731;4312.849050283241;4314.697971142022;4328.761918094504;4332.263515202408;4095.6313931746135;4300.655947524207;4301.139772045603;4356.934645980313;4372.584604462571;4236.237477254093;4239.427677263561;4247;4279.315309550472;4301.49447693308;4288.6140247377725;4313.978430107845;4315.5900189481945;4319;4327.459067616548;3543.309054734302;3769.6230376962358;3769.924601507982;3777.9055523611855;3781.3382658034734;5365.436629153922;5438.293021907166;5475.288212532385;5482.369527504348;5509.118541033416;4902.975485122587;4905.6320775941595;4925.3597032385915;4940.357753492059;4943.714634195135;5547.472990065938;5856.00447923854;5900.911486327708;5913.733881975321;5925.970370148165;4088.9591104088877;4091.3862920561855;4099.3031184698675;4099.426080348753;4114.362273847529;6088.695565221721;6100.938990610081;6126.326104128542;6135.202423684892;6136.662483563402;4127.958720412757;4160.895977600524;4170.562090980404;4224.831006759757;4227.556106608823;4219.71298753883;4238.067625122468;4249.298865687127;4254.0431401555015;4259.169461954889;4870.5388383484815;4937.456879743226;4946.554810067111;4958.578520825698;4983.700977941335;5819.188431577324;5910.497607703393;5924.496417804448;5924.703764811742;5935.703214839241;1445.638590352412;1447.7538818400897;1452.375478544236;1453;1460.3428457194304;898.3127907151035;909.6043221198668;915.4919019943995;923.690563661181;932.9207017403596;4919.548733123737;4945.752712364368;4979.228219625964;5029.396472423259;5065;5299.284596579412;5310.230016647642;5365;5386.973065134649;5462.296163399143;5017.623678224148;5024.321716568216;5058.608882557326;5110.233464980282;5690.9146362804595;3195.2905195720177;3196.3926853897683;3205.5512228288057;3219.2917558137174;3230.8046022971653;6020.337762846083;6195.597286176384;6200.286966998763;6210.441060304594;6249.281332646713;6041.124037014608;6069.514438844882;6091.634501929899;6105.297890742621;6119.5104391648565;6148.323684394713;6177.96911015442;6183.186650074205;6199.597026193283;6294.937050629526;5854.795082172103;5991.910121348271;6009.489193418608;6028.668423236764;6064.848378790565;5896.970515147397;5900.43945825146;5990.281166259902;5998.640081595118;6015.879682406415;5927.8221653350465;6177.505799536116;6195.721192546436;6213.068039794067;6232.470240029467;4166.187593419375;4181.560936101787;4204.285271503791;4217.135487225173;4225.957740422679;6050.366401071598;6059.454649081604;6060.424259695322;6064.211652485149;6078.54410919174;5602.579806514609;5787.565932554991;5883.705814709333;5917.970410147922;5957.582969192115;5790.768369265183;5807.186993820784;5832.912506312494;5838.591298609056;5841.269841269841;5620.498877999251;5710.5146062585145;5711.857203569944;5736.942630573641;5740.856478588069;5857.121431785266;5887.911681324869;5900.498457631149;5902.970485147547;5903.704814759159;5738.540916726568;5750.223719797774;5784.8553786154;5810.227880496489;5817.069268916953 20:02:32 INFO - PROCESS | 30499 | |5;yui.html;745.4930647159932;773.2615352338518;782.0537150048441;786.2687700438591;842.4355681693265;12724.61826145216;13275.734485310288;13351.666208344795;13362.799558006625;13373.197608143519;15162.924185379057;15293.158876261828;15300.31148598313;15301.158436286;15379.69240615187;657.9046038324452;790.4664351562701;807.5518087461456;807.5962018990505;815.8449894520022;800.0918956983807;804.1235053791366;804.5936801915025;805.9677612895478;807.7859367267679;852;855.9529225892574;859.7764581208868;860.2129051917519;860.4622111180512;851.0978362935277;851.476342049635;853.0957185383452;857.100044952797;857.588357588358;625.2309659119263;626.5175814622716;627.3005598757353;628.522323034497;629.8708764703225;14536.055156414905;14573.854261457356;14602.634934126625;14621.92689036548;14664.486742963945;14820.925895370561;14841.183734894577;14842.257887105601;14853.108813471226;14868.776968345483;12434;12524;12597.307148106851;12638.747225055447;12864.742705145938;3948.8420463181724;3993.1813978134414;4025.456563363967;4031.7379370341127;4180.623743863067;76416.61791691062;78132.21867781364;78694.60652696757;78741;78830.6058469704;11717.355545444912;11723.4138293085;11801.881981180079;12092.939535302266;12168.81746773799;22643.773562264498;22733;22737.545249094925;22747.658785118238;23025.654615180785;8781.20969112783;8799.164079412445;8937.46375217489;9269.165775080275;9378.624855005859;4721.8947274165575;4775.6657034007985;4879.56083952446;4893.681910675866;4920.21276595743;3607.494950706903;3672.3756961316108;3709.795961222105;3725.739198256096;3745.700343972476;589.6727316339473;598.2581598817435;610.6671863834221;613.3529126771299;631.2645767680692;576.5531712922518;635.1711017122607;652.6051738698019;708.2492557888654;725.7205975699394;9355.812883742423;9451.432914025043;9463.56224927572;9727.817335850492;9734.561944712505;672.1195234243157;672.4250765595345;688.3495097133161;695.006141218063;718.647862547348;4747.548982846624;4788.832390866372;4806.50998190555;4809.5430934061205;4840.75796210188;112152;113510.43244783889;113995;115557;115582.42208788902;99469;100925;101076.49461752645;101277;101622.44321448862;63311;83934.16065839386;84400.57799710962;84619;84770.72843907346;8962.283017358464;9085.954570227106;9199.77000574991;9238.769030774285;9477.952610236905;37121.25757484889;49818;51055.48944510656;51355.74322128366;51901.22148167705;71698.64150679213;73368;76460;76826.23173768414;79421.60289198517;11609.187356884937;11735.941320293345;11828.70428239301;11945.701357466132;12232.510699571918;13623.18260904349;13687.931560342533;14727.410903563738;14862.702745944804;15279.770803437736;13935.442582296595;14049.719005620034;14309.141451512942;14353.92823035878;14467.27663616836;13475.797863032258;13784.070230167985;14437.927810360881;14450.421983120557;14920.850791491946;13704.177749335071;14250.216238107003;14384.784228236795;14502.492412765503;14574.34415451286;10410.219233557666;10684.25210235276;10805.297655652357;10933.436563238016;10935.726606834893;10866.61966831157;11080.168987325822;11120.666380008613;11323.943380283046;11390.886091138982 20:02:32 INFO - PROCESS | 30499 | __end_tp_report 20:02:32 INFO - PROCESS | 30499 | __start_cc_report 20:02:32 INFO - PROCESS | 30499 | _x_x_mozilla_cycle_collect,392 20:02:32 INFO - PROCESS | 30499 | __end_cc_report 20:02:32 INFO - PROCESS | 30499 | __startTimestamp1466132552547__endTimestamp 20:02:32 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | ------- Summary: start ------- 20:02:32 INFO - PROCESS | 30499 | Number of tests: 6 20:02:32 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | [#0] dojo.html Cycles:165 Average:5478.69 Median:5683.29 stddev:751.07 (13.2%) stddev-sans-first:730.33 20:02:32 INFO - PROCESS | 30499 | Values: 3125.4 3165.3 3171.1 3193.5 3205.6 5343.0 5435.9 5454.3 5505.3 5519.4 5376.8 5480.5 5505.9 5537.3 5575.1 4936.7 4962.2 5053.1 5118.9 5166.6 567.3 4927.7 4950.5 5050.9 5110.4 4981.5 4989.1 5025.2 5031.7 5060.1 5020.5 5047.3 5062.9 5082.6 5086.7 4874.5 4919.6 4969.8 4997.6 5038.4 5467.0 5502.2 5508.5 5515.9 5544.4 5954.4 5976.7 5989.3 5993.0 6000.5 5829.4 5895.7 5928.3 6003.9 6017.6 5576.7 5591.6 5605.0 5612.2 5615.1 6017.5 6118.4 6130.0 6135.8 6137.1 5791.1 5808.3 5856.6 5858.2 5906.3 5942.2 5945.9 5969.1 5972.0 5984.6 5677.4 5819.9 5907.4 5943.8 5972.1 5918.2 5922.4 5931.7 5949.4 5956.1 4483.6 4486.7 4497.6 4531.1 4536.9 3959.5 3960.3 3977.5 4007.3 4013.2 5475.2 5590.8 5591.2 5624.7 5683.3 5972.5 5980.4 5986.9 5994.9 6008.5 5459.1 5608.9 5654.9 5670.7 5697.3 5128.7 5169.5 5170.2 5173.0 5178.4 6190.5 6243.3 6244.3 6247.8 6248.1 5761.8 5922.5 5957.5 6003.7 6064.0 6156.8 6192.9 6219.8 6254.9 6273.5 5726.4 5906.1 5916.7 5941.5 5958.2 5904.9 5934.9 5937.8 5983.3 6015.2 5776.5 5789.8 5820.2 5821.7 5825.2 5486.9 5732.7 5783.7 5783.9 5791.4 5598.3 5637.2 5648.0 5651.2 5700.3 5748.4 5773.2 5832.1 5837.2 5868.1 5550.6 5619.7 5655.9 5714.9 5732.9 20:02:32 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | [#1] ext.html Cycles:180 Average:58636.85 Median:40008.70 stddev:120023.29 (300.0%) stddev-sans-first:120280.79 20:02:32 INFO - PROCESS | 30499 | Values: 564.6 616.6 623.5 643.4 649.8 39132.8 43192.8 43386.0 43534.8 43811.3 43173.4 43840.3 43913.6 43938.6 43964.3 8886.2 9052.1 9060.9 9067.2 9083.4 8855.1 8945.0 8953.6 8955.6 8974.6 9041.5 9052.1 9054.6 9069.1 9084.2 8895.6 8964.0 8989.4 9004.6 9028.7 8751.3 8882.7 8908.5 8909.6 8933.5 34518.0 34567.0 34584.7 34624.8 34675.8 2976.9 3507.9 3515.4 3529.2 3548.3 30680.5 30866.7 30934.7 31150.8 31197.8 4139.7 4182.9 4201.9 4256.4 4290.1 289853.7 290247.0 291688.0 294926.0 296162.0 34496.3 34644.7 34684.5 34761.8 34792.5 35534.5 36065.1 36113.5 36115.3 36321.3 15351.5 15613.2 15614.2 15954.6 16006.5 13329.1 13335.0 13337.8 13358.7 13426.8 19462.3 19511.7 19532.2 19590.7 19677.6 7269.8 7336.3 7369.7 7404.7 7548.2 955.8 1000.8 1019.5 1042.2 1120.4 32781.8 32888.3 32937.2 33274.2 33607.7 1091.4 1108.0 1120.5 1144.5 1246.9 17026.0 17210.8 17333.7 17378.2 17527.9 547833.0 555176.0 557182.0 558103.0 559416.0 59416.0 59566.0 59768.7 59799.0 59924.0 1226.9 1284.2 1295.8 1300.9 1344.0 31561.8 32194.5 32298.8 32410.7 32830.0 50999.7 51227.2 51407.5 51485.5 51723.5 464349.0 464391.0 464780.0 464853.0 466677.0 27932.7 28150.3 28554.6 28559.6 28762.6 49292.0 49556.0 49976.0 50381.7 50566.2 41178.4 41365.1 41699.0 42468.4 42799.8 41113.8 41654.4 41766.4 41893.8 42179.4 36786.8 40884.6 41550.8 41791.8 41906.0 36909.4 37373.4 37379.8 37912.6 38025.2 28506.4 28653.7 28832.1 28834.6 29019.0 20:02:32 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | [#2] jquery.html Cycles:180 Average:30524.24 Median:3477.32 stddev:83512.34 (2401.6%) stddev-sans-first:83715.95 20:02:32 INFO - PROCESS | 30499 | Values: 384.4 386.9 387.3 395.8 412.2 13897.2 18241.5 19137.9 19958.4 20002.8 18434.5 18848.0 19161.5 19250.8 19311.8 5736.9 5761.6 5784.4 5904.3 5954.8 5355.1 5641.6 5799.9 5813.7 5860.6 5599.3 5633.2 5678.2 5697.5 5729.2 5328.3 5603.3 5612.9 5696.4 5710.6 5451.8 5509.0 5533.9 5538.5 5559.1 20632.7 21357.6 21668.9 22819.9 22832.9 2302.8 2407.9 2427.3 2516.0 2549.9 9687.3 9847.6 10215.7 10233.3 10233.9 1924.3 1942.9 1954.8 1995.8 2026.9 81232.2 86448.0 94095.5 95652.5 99249.5 16004.4 16929.2 17485.6 17880.6 17898.5 30556.2 30778.4 30977.0 31236.8 31249.8 9810.5 10303.8 10381.6 10442.6 10471.6 8515.9 8642.7 8697.3 8952.1 9027.9 8679.4 8704.3 8879.6 8986.2 9114.5 3445.3 3509.4 3538.5 3685.7 3733.5 938.7 951.4 986.1 1032.0 1048.0 18908.0 19092.4 19183.0 19301.3 19531.6 957.8 986.7 990.6 997.3 1060.8 10061.3 10607.8 10611.9 10617.7 10780.6 497047.0 499080.0 502216.0 512486.0 522116.0 82667.6 86425.6 88401.6 94178.0 97300.5 1003.4 1004.2 1020.0 1024.4 1025.6 17048.3 17092.4 17429.3 17601.2 17625.6 40919.6 41711.0 42090.0 42431.4 43806.0 59294.7 59396.7 60153.4 60323.7 61275.0 8172.6 8245.3 8255.0 8336.5 8469.8 12747.9 12774.6 12837.6 13487.5 13519.7 11854.6 11934.4 12034.8 12081.4 12239.1 11868.9 11946.5 11951.8 11995.3 12049.5 11976.2 12005.3 12144.1 12311.4 12411.4 7477.3 7664.1 7697.8 7916.2 8064.4 10082.3 11580.2 11833.9 11990.9 12085.2 20:02:32 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | [#3] mootools.html Cycles:180 Average:5814.95 Median:4695.11 stddev:3295.94 (70.2%) stddev-sans-first:3288.61 20:02:32 INFO - PROCESS | 30499 | Values: 1416.8 1464.5 1582.5 1709.2 1759.4 7674.4 8487.6 8519.6 9121.0 9136.1 8682.9 8765.8 8785.1 8803.1 8813.8 2308.1 2344.5 2348.2 2352.1 2353.9 2342.6 2346.9 2406.0 2410.7 2411.6 2303.7 2329.2 2341.2 2343.2 2364.6 2267.6 2273.4 2302.7 2304.4 2319.1 2257.6 2258.3 2263.0 2268.7 2269.7 8713.0 8832.6 8905.0 8944.5 8963.6 5032.5 5169.2 5171.6 5175.1 5190.4 3249.3 3392.9 3407.5 3511.5 3524.0 1127.7 1133.5 1165.6 1181.9 1189.4 12060.9 12064.6 12152.3 12171.3 12199.1 4540.4 4611.1 4680.1 4722.7 4730.3 10115.4 10225.0 10231.8 10243.8 10278.0 5211.2 5241.3 5243.4 5248.4 5255.8 4260.4 4659.8 4710.1 4746.7 4769.5 4066.1 4080.7 4121.8 4135.1 4150.3 1256.8 1295.2 1295.5 1307.9 1310.1 991.4 996.3 1021.5 1030.1 1034.2 6099.3 6192.7 6264.9 6277.0 6340.7 437.6 437.9 444.7 446.3 452.5 4145.2 4195.4 4201.5 4214.6 4218.9 10642.3 11033.3 11093.9 11171.7 11176.6 10869.2 10888.7 10929.9 10976.6 11016.5 7785.6 8033.5 8046.6 8080.5 8163.5 5782.9 5854.2 5866.9 5967.1 6019.9 9551.9 9819.8 9835.6 9927.7 9976.7 9709.4 9893.7 10289.8 10451.1 10543.1 7523.4 7961.2 8254.6 8323.4 8449.5 8659.7 8689.1 8691.9 8703.0 8725.7 7586.2 7610.8 7718.0 7829.5 7881.7 7453.1 7478.6 7604.7 7616.4 7618.0 7015.2 7039.0 7084.7 7096.0 7133.7 5264.7 5367.7 5444.2 5508.2 5568.8 5450.3 5522.9 5534.9 5576.6 5679.1 20:02:32 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | [#4] prototype.html Cycles:180 Average:4863.36 Median:5556.54 stddev:1453.80 (26.2%) stddev-sans-first:1417.14 20:02:32 INFO - PROCESS | 30499 | Values: 310.6 317.1 317.7 325.1 329.3 5416.5 5580.0 5591.4 5652.3 5720.6 5565.6 5579.0 5583.8 5653.0 5672.7 4307.7 4312.8 4314.7 4328.8 4332.3 4095.6 4300.7 4301.1 4356.9 4372.6 4236.2 4239.4 4247.0 4279.3 4301.5 4288.6 4314.0 4315.6 4319.0 4327.5 3543.3 3769.6 3769.9 3777.9 3781.3 5365.4 5438.3 5475.3 5482.4 5509.1 4903.0 4905.6 4925.4 4940.4 4943.7 5547.5 5856.0 5900.9 5913.7 5926.0 4089.0 4091.4 4099.3 4099.4 4114.4 6088.7 6100.9 6126.3 6135.2 6136.7 4128.0 4160.9 4170.6 4224.8 4227.6 4219.7 4238.1 4249.3 4254.0 4259.2 4870.5 4937.5 4946.6 4958.6 4983.7 5819.2 5910.5 5924.5 5924.7 5935.7 1445.6 1447.8 1452.4 1453.0 1460.3 898.3 909.6 915.5 923.7 932.9 4919.5 4945.8 4979.2 5029.4 5065.0 5299.3 5310.2 5365.0 5387.0 5462.3 5017.6 5024.3 5058.6 5110.2 5690.9 3195.3 3196.4 3205.6 3219.3 3230.8 6020.3 6195.6 6200.3 6210.4 6249.3 6041.1 6069.5 6091.6 6105.3 6119.5 6148.3 6178.0 6183.2 6199.6 6294.9 5854.8 5991.9 6009.5 6028.7 6064.8 5897.0 5900.4 5990.3 5998.6 6015.9 5927.8 6177.5 6195.7 6213.1 6232.5 4166.2 4181.6 4204.3 4217.1 4226.0 6050.4 6059.5 6060.4 6064.2 6078.5 5602.6 5787.6 5883.7 5918.0 5957.6 5790.8 5807.2 5832.9 5838.6 5841.3 5620.5 5710.5 5711.9 5736.9 5740.9 5857.1 5887.9 5900.5 5903.0 5903.7 5738.5 5750.2 5784.9 5810.2 5817.1 20:02:32 INFO - PROCESS | 30499 | 20:02:32 INFO - PROCESS | 30499 | [#5] yui.html Cycles:180 Average:20699.63 Median:4734.72 stddev:29744.96 (628.2%) stddev-sans-first:29790.67 20:02:32 INFO - PROCESS | 30499 | Values: 745.5 773.3 782.1 786.3 842.4 12724.6 13275.7 13351.7 13362.8 13373.2 15162.9 15293.2 15300.3 15301.2 15379.7 657.9 790.5 807.6 807.6 815.8 800.1 804.1 804.6 806.0 807.8 852.0 856.0 859.8 860.2 860.5 851.1 851.5 853.1 857.1 857.6 625.2 626.5 627.3 628.5 629.9 14536.1 14573.9 14602.6 14621.9 14664.5 14820.9 14841.2 14842.3 14853.1 14868.8 12434.0 12524.0 12597.3 12638.7 12864.7 3948.8 3993.2 4025.5 4031.7 4180.6 76416.6 78132.2 78694.6 78741.0 78830.6 11717.4 11723.4 11801.9 12092.9 12168.8 22643.8 22733.0 22737.5 22747.7 23025.7 8781.2 8799.2 8937.5 9269.2 9378.6 4721.9 4775.7 4879.6 4893.7 4920.2 3607.5 3672.4 3709.8 3725.7 3745.7 589.7 598.3 610.7 613.4 631.3 576.6 635.2 652.6 708.2 725.7 9355.8 9451.4 9463.6 9727.8 9734.6 672.1 672.4 688.3 695.0 718.6 4747.5 4788.8 4806.5 4809.5 4840.8 112152.0 113510.4 113995.0 115557.0 115582.4 99469.0 100925.0 101076.5 101277.0 101622.4 63311.0 83934.2 84400.6 84619.0 84770.7 8962.3 9086.0 9199.8 9238.8 9478.0 37121.3 49818.0 51055.5 51355.7 51901.2 71698.6 73368.0 76460.0 76826.2 79421.6 11609.2 11735.9 11828.7 11945.7 12232.5 13623.2 13687.9 14727.4 14862.7 15279.8 13935.4 14049.7 14309.1 14353.9 14467.3 13475.8 13784.1 14437.9 14450.4 14920.9 13704.2 14250.2 14384.8 14502.5 14574.3 10410.2 10684.3 10805.3 10933.4 10935.7 10866.6 11080.2 11120.7 11323.9 11390.9 20:02:32 INFO - PROCESS | 30499 | -------- Summary: end -------- 20:02:32 INFO - PROCESS | 30499 | 20:02:33 INFO - TEST-INFO | 30499: exit 0 20:02:33 INFO - TEST-OK | dromaeo_css | took 1111422ms 20:02:33 INFO - TEST-START | kraken 20:02:33 INFO - operating with platform_type : linux_ 20:02:33 INFO - Initialising browser for kraken test... 20:02:33 INFO - TEST-INFO | started process 30736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6hj5XP/profile http://localhost:43967/getInfo.html) 20:02:37 INFO - PROCESS | 30736 | __metrics Screen width/height:1600/1200 20:02:37 INFO - PROCESS | 30736 | colorDepth:24 20:02:37 INFO - PROCESS | 30736 | Browser inner width/height: 1024/697 20:02:37 INFO - PROCESS | 30736 | __metrics 20:02:38 ERROR - PROCESS | 30736 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 20:02:39 INFO - TEST-INFO | 30736: exit 0 20:02:39 INFO - Browser initialized. 20:02:39 INFO - Running cycle 1/1 for kraken test... 20:02:39 INFO - TEST-INFO | started process 30852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6hj5XP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:51 INFO - PROCESS | 30852 | RSS: Main: 185245696 20:02:51 INFO - PROCESS | 30852 | 20:02:53 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43967/tests/kraken/driver.html?testName=audio-beat-detection) 20:02:54 INFO - PROCESS | 30852 | RSS: Main: 191246336 20:02:54 INFO - PROCESS | 30852 | 20:02:57 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43967/tests/kraken/driver.html?testName=audio-dft) 20:02:57 INFO - PROCESS | 30852 | RSS: Main: 189943808 20:02:57 INFO - PROCESS | 30852 | 20:03:00 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43967/tests/kraken/driver.html?testName=audio-fft) 20:03:01 INFO - PROCESS | 30852 | RSS: Main: 185425920 20:03:01 INFO - PROCESS | 30852 | 20:03:03 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43967/tests/kraken/driver.html?testName=audio-oscillator) 20:03:04 INFO - PROCESS | 30852 | RSS: Main: 185511936 20:03:04 INFO - PROCESS | 30852 | 20:03:06 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:03:06 INFO - PROCESS | 30852 | RSS: Main: 186486784 20:03:06 INFO - PROCESS | 30852 | 20:03:10 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43967/tests/kraken/driver.html?testName=imaging-darkroom) 20:03:10 INFO - PROCESS | 30852 | RSS: Main: 186609664 20:03:10 INFO - PROCESS | 30852 | 20:03:14 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43967/tests/kraken/driver.html?testName=imaging-desaturate) 20:03:14 INFO - PROCESS | 30852 | RSS: Main: 183820288 20:03:14 INFO - PROCESS | 30852 | 20:03:17 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43967/tests/kraken/driver.html?testName=json-parse-financial) 20:03:18 INFO - PROCESS | 30852 | RSS: Main: 185524224 20:03:18 INFO - PROCESS | 30852 | 20:03:19 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:03:20 INFO - PROCESS | 30852 | RSS: Main: 186056704 20:03:20 INFO - PROCESS | 30852 | 20:03:22 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43967/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:03:22 INFO - PROCESS | 30852 | RSS: Main: 186560512 20:03:22 INFO - PROCESS | 30852 | 20:03:24 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:03:25 INFO - PROCESS | 30852 | RSS: Main: 186769408 20:03:25 INFO - PROCESS | 30852 | 20:03:28 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:03:28 INFO - PROCESS | 30852 | RSS: Main: 186830848 20:03:28 INFO - PROCESS | 30852 | 20:03:31 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:03:32 INFO - PROCESS | 30852 | RSS: Main: 186552320 20:03:32 INFO - PROCESS | 30852 | 20:03:33 INFO - PROCESS | 30852 | Cycle 1(1): loaded http://localhost:43967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43967/tests/kraken/driver.html?testName=ai-astar) 20:03:34 INFO - PROCESS | 30852 | RSS: Main: 187375616 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | __start_tp_report 20:03:34 INFO - PROCESS | 30852 | _x_x_mozilla_page_load 20:03:34 INFO - PROCESS | 30852 | _x_x_mozilla_page_load_details 20:03:34 INFO - PROCESS | 30852 | |i|pagename|runs| 20:03:34 INFO - PROCESS | 30852 | |0;ai-astar;111;106;113;110;109;111;109;111;111;111 20:03:34 INFO - PROCESS | 30852 | |1;audio-beat-detection;153;133;161;184;136;161;155;126;198;127 20:03:34 INFO - PROCESS | 30852 | |2;audio-dft;163;163;163;164;164;174;164;163;162;164 20:03:34 INFO - PROCESS | 30852 | |3;audio-fft;76;76;75;154;76;78;75;75;165;76 20:03:34 INFO - PROCESS | 30852 | |4;audio-oscillator;85;84;150;85;86;84;143;85;85;144 20:03:34 INFO - PROCESS | 30852 | |5;imaging-gaussian-blur;117;118;117;118;117;118;118;118;117;118 20:03:34 INFO - PROCESS | 30852 | |6;imaging-darkroom;150;145;146;147;147;146;146;147;148;147 20:03:34 INFO - PROCESS | 30852 | |7;imaging-desaturate;98;97;96;96;96;96;95;96;96;96 20:03:34 INFO - PROCESS | 30852 | |8;json-parse-financial;54;55;55;54;55;54;55;56;53;55 20:03:34 INFO - PROCESS | 30852 | |9;json-stringify-tinderbox;62;62;61;63;61;61;61;62;62;63 20:03:34 INFO - PROCESS | 30852 | |10;stanford-crypto-aes;82;85;79;80;84;80;81;82;103;79 20:03:34 INFO - PROCESS | 30852 | |11;stanford-crypto-ccm;126;133;125;121;128;132;140;122;127;123 20:03:34 INFO - PROCESS | 30852 | |12;stanford-crypto-pbkdf2;169;161;164;164;158;164;160;161;161;162 20:03:34 INFO - PROCESS | 30852 | |13;stanford-crypto-sha256-iterative;63;64;65;64;63;65;64;63;62;63 20:03:34 INFO - PROCESS | 30852 | __end_tp_report 20:03:34 INFO - PROCESS | 30852 | __start_cc_report 20:03:34 INFO - PROCESS | 30852 | _x_x_mozilla_cycle_collect,925 20:03:34 INFO - PROCESS | 30852 | __end_cc_report 20:03:34 INFO - PROCESS | 30852 | __startTimestamp1466132614185__endTimestamp 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | ------- Summary: start ------- 20:03:34 INFO - PROCESS | 30852 | Number of tests: 14 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.96 20:03:34 INFO - PROCESS | 30852 | Values: 111.0 106.0 113.0 110.0 109.0 111.0 109.0 111.0 111.0 111.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:158.00 stddev:24.06 (15.2%) stddev-sans-first:25.52 20:03:34 INFO - PROCESS | 30852 | Values: 153.0 133.0 161.0 184.0 136.0 161.0 155.0 126.0 198.0 127.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.44 (2.1%) stddev-sans-first:3.61 20:03:34 INFO - PROCESS | 30852 | Values: 163.0 163.0 163.0 164.0 164.0 174.0 164.0 163.0 162.0 164.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:35.37 (46.5%) stddev-sans-first:37.00 20:03:34 INFO - PROCESS | 30852 | Values: 76.0 76.0 75.0 154.0 76.0 78.0 75.0 75.0 165.0 76.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:85.00 stddev:29.43 (34.6%) stddev-sans-first:30.48 20:03:34 INFO - PROCESS | 30852 | Values: 85.0 84.0 150.0 85.0 86.0 84.0 143.0 85.0 85.0 144.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:03:34 INFO - PROCESS | 30852 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.37 (0.9%) stddev-sans-first:0.88 20:03:34 INFO - PROCESS | 30852 | Values: 150.0 145.0 146.0 147.0 147.0 146.0 146.0 147.0 148.0 147.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 20:03:34 INFO - PROCESS | 30852 | Values: 98.0 97.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.84 (1.5%) stddev-sans-first:0.87 20:03:34 INFO - PROCESS | 30852 | Values: 54.0 55.0 55.0 54.0 55.0 54.0 55.0 56.0 53.0 55.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 20:03:34 INFO - PROCESS | 30852 | Values: 62.0 62.0 61.0 63.0 61.0 61.0 61.0 62.0 62.0 63.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:81.50 stddev:7.14 (8.8%) stddev-sans-first:7.55 20:03:34 INFO - PROCESS | 30852 | Values: 82.0 85.0 79.0 80.0 84.0 80.0 81.0 82.0 103.0 79.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:5.85 (4.6%) stddev-sans-first:6.17 20:03:34 INFO - PROCESS | 30852 | Values: 126.0 133.0 125.0 121.0 128.0 132.0 140.0 122.0 127.0 123.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:3.03 (1.9%) stddev-sans-first:2.06 20:03:34 INFO - PROCESS | 30852 | Values: 169.0 161.0 164.0 164.0 158.0 164.0 160.0 161.0 161.0 162.0 20:03:34 INFO - PROCESS | 30852 | 20:03:34 INFO - PROCESS | 30852 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 20:03:34 INFO - PROCESS | 30852 | Values: 63.0 64.0 65.0 64.0 63.0 65.0 64.0 63.0 62.0 63.0 20:03:34 INFO - PROCESS | 30852 | -------- Summary: end -------- 20:03:34 INFO - PROCESS | 30852 | 20:03:35 INFO - TEST-INFO | 30852: exit 0 20:03:35 INFO - TEST-OK | kraken | took 61870ms 20:03:35 INFO - SUITE-END | took 1173s 20:03:35 INFO - Completed test suite (00:19:33) 20:03:35 INFO - javascript benchmark 20:03:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7367.258478689877, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.390548842975, 3165.256164801273, 3171.12793981655, 3193.5369371441157, 3205.5832741743584, 5343.038253114442, 5435.864103397417, 5454.263674403959, 5505.284313039299, 5519.448055194479, 5376.758045887935, 5480.451954804517, 5505.944940550593, 5537.280153580029, 5575.080111781551, 4936.679115857467, 4962.15643340633, 5053.1157047516535, 5118.923216151742, 5166.5608423283875, 567.2791720616729, 4927.704337739729, 4950.455449900508, 5050.898982020358, 5110.386753589574, 4981.476944920785, 4989.052080104769, 5025.221090730943, 5031.748412579393, 5060.089183946888, 5020.472850350697, 5047.318611987372, 5062.873428164288, 5082.618803589746, 5086.745662716849, 4874.53691899269, 4919.606431485473, 4969.776360063805, 4997.625178111656, 5038.370203724535, 5467.0, 5502.174673798922, 5508.476694714036, 5515.944840551583, 5544.417836127189, 5954.434328738763, 5976.73104710289, 5989.251343582052, 5992.951233534114, 6000.489958353545, 5829.358770535237, 5895.675737834417, 5928.258967629046, 6003.909941350883, 6017.63894166347, 5576.665400076008, 5591.552675785927, 5605.047141985872, 5612.15817627355, 5615.129654903456, 6017.458428741435, 6118.388161183846, 6129.96935015331, 6135.846603834851, 6137.140800287963, 5791.102379131242, 5808.30300363959, 5856.590038697335, 5858.179854820329, 5906.26171728534, 5942.168096466498, 5945.881082378328, 5969.104634304889, 5972.0, 5984.551158663117, 5677.403872593401, 5819.88360232793, 5907.350191478934, 5943.821685349447, 5972.074328479092, 5918.171455996164, 5922.407759224043, 5931.673757943355, 5949.405059494016, 5956.076808094752, 4483.596476317147, 4486.663500237495, 4497.550244975476, 4531.093781243699, 4536.931946020813, 3959.544652364957, 3960.2871483132735, 3977.5226972763453, 4007.318755811461, 4013.177298653827, 5475.233467314579, 5590.776368945278, 5591.245181900473, 5624.71876406178, 5683.2895888014, 5972.46247837688, 5980.43185897339, 5986.880262394728, 5994.850128746816, 6008.549358798107, 5459.07195776711, 5608.887822243532, 5654.858628534237, 5670.659760414388, 5697.316322041382, 5128.743562821918, 5169.53474187325, 5170.224466330005, 5173.0, 5178.430372659004, 6190.535709821781, 6243.313235544087, 6244.344343843922, 6247.843803904939, 6248.062790581358, 5761.798337058099, 5922.466977972003, 5957.523398128226, 6003.729832157476, 6063.969680151571, 6156.78451254204, 6192.907106393318, 6219.844503887258, 6254.874902501833, 6273.529485288713, 5726.370099289158, 5906.143609176731, 5916.733746981482, 5941.465268125889, 5958.225430693982, 5904.9075920954765, 5934.851628709317, 5937.821865344046, 5983.341832398346, 6015.157877897185, 5776.537876969748, 5789.768409263583, 5820.185174075717, 5821.70891455417, 5825.242718446575, 5486.862828429321, 5732.742026608896, 5783.7397317119985, 5783.8554036149435, 5791.449812267828, 5598.3282006159525, 5637.238972738628, 5648.0, 5651.180578816131, 5700.25896633435, 5748.39641837601, 5773.16289138081, 5832.096025116114, 5837.241158649348, 5868.119782032729, 5550.611457197957, 5619.662820230799, 5655.943440565707, 5714.914276285942, 5732.914006289826], "value": 5428.371001577354, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5963136357506, 616.623859445738, 623.5323507369473, 643.4048505132754, 649.8342922554748, 39132.80433597832, 43192.78403607985, 43386.0, 43534.78232608837, 43811.342829857575, 43173.35239971403, 43840.3423948641, 43913.560864391424, 43938.56061439385, 43964.340534892, 8886.155815197562, 9052.140046695586, 9060.864087038699, 9067.183953444188, 9083.409578377385, 8855.114488551159, 8945.0, 8953.552322383888, 8955.596998135099, 8974.641014359418, 9041.502717350542, 9052.094790520961, 9054.592543335566, 9069.138431848964, 9084.182423581877, 8895.599698013604, 8964.0, 8989.415687980325, 9004.639814407448, 9028.68399606014, 8751.343649226334, 8882.733517994471, 8908.51003194824, 8909.643614255421, 8933.508657023862, 34518.0, 34567.0, 34584.65415345864, 34624.826875865714, 34675.826620866734, 2976.9106926792233, 3507.91230219244, 3515.3848076586496, 3529.170644898447, 3548.27260411615, 30680.53979190314, 30866.691333086605, 30934.690653093632, 31150.84424577885, 31197.8440107798, 4139.730917490354, 4182.91634167318, 4201.873943781691, 4256.44666193396, 4290.14197160566, 289853.65219521726, 290247.0, 291688.0, 294926.0, 296162.0, 34496.310073798886, 34644.65355346465, 34684.47973280403, 34761.82619086889, 34792.47811282833, 35534.466982995276, 36065.09837254037, 36113.45829812555, 36115.27769444596, 36321.273574528364, 15351.539453816404, 15613.219339033003, 15614.219289035504, 15954.60113497172, 16006.519804405887, 13329.133606315558, 13335.0, 13337.799933001013, 13358.666033349244, 13426.798598021038, 19462.31058442565, 19511.658710919008, 19532.20805375829, 19590.6695861701, 19677.606447870963, 7269.818254543678, 7336.33972942427, 7369.7052117915755, 7404.666789994463, 7548.245175482518, 955.8183945050419, 1000.7548150703125, 1019.454591793387, 1042.2287507244585, 1120.3949867071854, 32781.83609081939, 32888.34223315568, 32937.17657058593, 33274.18715305303, 33607.663923360946, 1091.3833683968533, 1107.972300692473, 1120.4509790202742, 1144.4849817582121, 1246.9064820138344, 17026.0, 17210.827891721172, 17333.653326933392, 17378.217980190922, 17527.912360438117, 547833.0, 555176.0, 557182.0, 558103.0, 559416.0, 59416.0, 59566.0, 59768.70115649394, 59799.0, 59924.0, 1226.926384416938, 1284.1973766396002, 1295.7538067767282, 1300.856905740368, 1343.9987209528963, 31561.8421907889, 32194.517082243317, 32298.83850580826, 32410.67589324171, 32829.995680002154, 50999.74500127476, 51227.2315915269, 51407.48592514027, 51485.48514514957, 51723.482765171866, 464349.0, 464391.0, 464780.0, 464853.0, 466677.0, 27932.720672793825, 28150.2962425941, 28554.571681425212, 28559.571606425503, 28762.568561471177, 49292.0, 49556.0, 49976.0, 50381.74809125931, 50566.2415063767, 41178.38232426576, 41365.104442688724, 41699.0, 42468.362974556025, 42799.7860010698, 41113.79443102885, 41654.37518437165, 41766.37350439685, 41893.79053104715, 42179.367309491, 36786.8160659195, 40884.59115408927, 41550.792246038574, 41791.7910410446, 41906.0, 36909.446358305184, 37373.4393984085, 37379.81310093432, 37912.62087379091, 38025.239495210495, 28506.42987140204, 28653.713462865104, 28832.135035948955, 28834.567481487375, 29019.0], "value": 19503.40618733958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.39265959783546, 386.9110104675923, 387.30672096946483, 395.778364116095, 412.18181908910805, 13897.235652039133, 18241.54396140097, 19137.90431047846, 19958.401247962567, 20002.799972000295, 18434.539136521595, 18848.0, 19161.52096197596, 19250.807491925076, 19311.806881931177, 5736.913946290799, 5761.596688231825, 5784.392638772932, 5904.261967254093, 5954.761809527614, 5355.08963476208, 5641.633293835908, 5799.942000579982, 5813.6802475863815, 5860.560457965648, 5599.32808063033, 5633.15502674598, 5678.233438485793, 5697.487226149646, 5729.197912292261, 5328.254044433782, 5603.299587551535, 5612.943870561304, 5696.3733989261145, 5710.571707121941, 5451.781928722847, 5508.9724551377385, 5533.944660553423, 5538.529225015838, 5559.138333558305, 20632.658877172937, 21357.572848542943, 21668.891655541778, 22819.885900570393, 22832.885835570884, 2302.804261637763, 2407.9398015049587, 2427.320350301918, 2515.9748402515925, 2549.872506374674, 9687.32188746788, 9847.556859941249, 10215.693529194135, 10233.283670143093, 10233.89766102337, 1924.3457224543583, 1942.873713208637, 1954.775200851906, 1995.7804641489424, 2026.9087891044937, 81232.18767812305, 86448.0, 94095.52952235263, 95652.52173739087, 99249.50375248077, 16004.359825606845, 16929.238184281738, 17485.562860928578, 17880.642387152184, 17898.463046108638, 30556.236094097825, 30778.384432311675, 30977.0, 31236.843815780776, 31249.8437507811, 9810.509474526245, 10303.845442318372, 10381.584736610603, 10442.582296708046, 10471.581136754445, 8515.872261915953, 8642.740717778477, 8697.304215662733, 8952.104789520996, 9027.909720902708, 8679.392442529088, 8704.303655707528, 8879.644814207359, 8986.236169925498, 9114.498702571289, 3445.2937147884622, 3509.350770107538, 3538.522299489536, 3685.7235707322056, 3733.4586484959527, 938.6949241496541, 951.4006176109007, 986.1420564109271, 1032.043196242759, 1047.9685609431729, 18908.0, 19092.427227183205, 19183.0, 19301.324453644334, 19531.609367812565, 957.8132264208551, 986.7434467038622, 990.64336838738, 997.3018886779139, 1060.8090543702053, 10061.346012509164, 10607.84088238677, 10611.893881061245, 10617.726051924768, 10780.622678206226, 497047.0, 499080.0, 502216.0, 512486.0, 522116.0, 82667.58666206751, 86425.56787216023, 88401.55799221092, 94178.0, 97300.51349743348, 1003.3628645809817, 1004.2066767253933, 1020.0411613083826, 1024.3853687787416, 1025.6051420203275, 17048.31806727717, 17092.40176593813, 17429.302827886742, 17601.207945642735, 17625.559361016076, 40919.590804091575, 41711.0, 42090.0, 42431.3635295477, 43806.0, 59294.70352648209, 59396.703016484644, 60153.398466014776, 60323.69838150781, 61275.0, 8172.591370431336, 8245.340372770284, 8254.958725206576, 8336.458130221516, 8469.788255293666, 12747.936260318638, 12774.552890648783, 12837.614871553867, 13487.460501579826, 13519.729605408034, 11854.644360669194, 11934.403279836148, 12034.819477708017, 12081.395930203631, 12239.144943271765, 11868.881311186778, 11946.462409191434, 11951.820722689341, 11995.280283183038, 12049.457774400349, 11976.221545599508, 12005.339706316236, 12144.14990950625, 12311.384430778604, 12411.441485133371, 7477.289657482531, 7664.11862635804, 7697.846043079219, 7916.168802275678, 8064.3548516119745, 10082.29423940317, 11580.247283926517, 11833.940830295793, 11990.940045299718, 12085.214461060003], "value": 9941.945384306202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.8016477693125, 1464.53134996801, 1582.4619629326035, 1709.2393884721305, 1759.3754217252874, 7674.424418168632, 8487.618057187427, 8519.616617252223, 9121.042290559488, 9136.086391360861, 8682.86975695365, 8765.7808554786, 8785.077566855469, 8803.119688031195, 8813.779655508599, 2308.134449581407, 2344.542814151241, 2348.154664320843, 2352.0591763294647, 2353.9293821185393, 2342.5666251743482, 2346.894389752465, 2405.9879700601473, 2410.7348191698898, 2411.6020856558735, 2303.7235531736214, 2329.173143534038, 2341.227394959668, 2343.156463673085, 2364.598018336887, 2267.648514480258, 2273.4089136824464, 2302.746697863225, 2304.3893368257427, 2319.0839618350824, 2257.604919139144, 2258.2999270226283, 2263.026898433673, 2268.7164104486938, 2269.727632684072, 8712.956435217784, 8832.60253288597, 8904.955475222647, 8944.463332200088, 8963.551822408854, 5032.547070763612, 5169.198774190007, 5171.637985341028, 5175.0943584872875, 5190.351206099238, 3249.3014001989686, 3392.86428542858, 3407.4718418645148, 3511.525943997579, 3524.030891504831, 1127.746257092156, 1133.472935085181, 1165.6153469355093, 1181.864085630155, 1189.4052973513244, 12060.879391206063, 12064.638060858188, 12152.331621760799, 12171.2697238166, 12199.14605977582, 4540.387047748512, 4611.123886461562, 4680.08738296029, 4722.693024953367, 4730.314104454835, 10115.443650599287, 10225.0, 10231.846522302172, 10243.795124097476, 10278.0, 5211.1662134059125, 5241.31862857826, 5243.370795504487, 5248.3701955765555, 5255.76349064293, 4260.424842646203, 4659.767011649404, 4710.128626204163, 4746.667733258639, 4769.475357710649, 4066.1054567995584, 4080.713757848959, 4121.752694838319, 4135.069609337875, 4150.315197992298, 1256.761215369077, 1295.2487557216791, 1295.5206573567652, 1307.8692130786844, 1310.128764371682, 991.3902949686036, 996.2528103922059, 1021.4790456867051, 1030.0883717909703, 1034.2191645307744, 6099.2985806632805, 6192.659403732838, 6264.874702505925, 6276.968615156895, 6340.651264180422, 437.62145743931904, 437.9321205213197, 444.65539207114097, 446.2814868062417, 452.4999875137991, 4145.17096580685, 4195.370694395804, 4201.4538110046105, 4214.5881129821855, 4218.915621687611, 10642.308249963728, 11033.337999720043, 11093.889061109447, 11171.72070698239, 11176.608818691308, 10869.184811139196, 10888.67333979982, 10929.945350273358, 10976.560937562568, 11016.504257308441, 7785.649645765954, 8033.517988920684, 8046.637901294339, 8080.474769139987, 8163.469374490758, 5782.884342313046, 5854.209681693087, 5866.911996320144, 5967.104934259895, 6019.909701354396, 9551.904480955101, 9819.754506137404, 9835.557399916877, 9927.652532161339, 9976.700698979042, 9709.36889102206, 9893.65372211969, 10289.794204116026, 10451.111655509063, 10543.051125398752, 7523.3981281498445, 7961.164077771982, 8254.628541715518, 8323.375746818892, 8449.45078569891, 8659.740207793777, 8689.13108689126, 8691.913510811148, 8703.042665306937, 8725.694600688945, 7586.165521792709, 7610.8097297568, 7717.961410192913, 7829.49108307981, 7881.724139655084, 7453.068366454193, 7478.6260686966525, 7604.695812167452, 7616.3906887449975, 7617.961910190414, 7015.158181018311, 7039.0, 7084.716611335489, 7095.9645201773665, 7133.678984445816, 5264.710440925785, 5367.651102678469, 5444.183372494158, 5508.173773933942, 5568.832935011957, 5450.345958485007, 5522.861928451821, 5534.86162845916, 5576.637518561442, 5679.091345384719], "value": 4585.190386240883, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.580716033355, 317.1010186122343, 317.65217087289426, 325.07840272826536, 329.27559369387336, 5416.485433883785, 5580.0, 5591.440855914417, 5652.3499797523245, 5720.570957178213, 5565.6104072714925, 5578.972105139469, 5583.79948311114, 5653.038983372826, 5672.744726487308, 4307.698461107731, 4312.849050283241, 4314.697971142022, 4328.761918094504, 4332.263515202408, 4095.6313931746135, 4300.655947524207, 4301.139772045603, 4356.934645980313, 4372.584604462571, 4236.237477254093, 4239.427677263561, 4247.0, 4279.315309550472, 4301.49447693308, 4288.6140247377725, 4313.978430107845, 4315.5900189481945, 4319.0, 4327.459067616548, 3543.309054734302, 3769.6230376962358, 3769.924601507982, 3777.9055523611855, 3781.3382658034734, 5365.436629153922, 5438.293021907166, 5475.288212532385, 5482.369527504348, 5509.118541033416, 4902.975485122587, 4905.6320775941595, 4925.3597032385915, 4940.357753492059, 4943.714634195135, 5547.472990065938, 5856.00447923854, 5900.911486327708, 5913.733881975321, 5925.970370148165, 4088.9591104088877, 4091.3862920561855, 4099.3031184698675, 4099.426080348753, 4114.362273847529, 6088.695565221721, 6100.938990610081, 6126.326104128542, 6135.202423684892, 6136.662483563402, 4127.958720412757, 4160.895977600524, 4170.562090980404, 4224.831006759757, 4227.556106608823, 4219.71298753883, 4238.067625122468, 4249.298865687127, 4254.0431401555015, 4259.169461954889, 4870.5388383484815, 4937.456879743226, 4946.554810067111, 4958.578520825698, 4983.700977941335, 5819.188431577324, 5910.497607703393, 5924.496417804448, 5924.703764811742, 5935.703214839241, 1445.638590352412, 1447.7538818400897, 1452.375478544236, 1453.0, 1460.3428457194304, 898.3127907151035, 909.6043221198668, 915.4919019943995, 923.690563661181, 932.9207017403596, 4919.548733123737, 4945.752712364368, 4979.228219625964, 5029.396472423259, 5065.0, 5299.284596579412, 5310.230016647642, 5365.0, 5386.973065134649, 5462.296163399143, 5017.623678224148, 5024.321716568216, 5058.608882557326, 5110.233464980282, 5690.9146362804595, 3195.2905195720177, 3196.3926853897683, 3205.5512228288057, 3219.2917558137174, 3230.8046022971653, 6020.337762846083, 6195.597286176384, 6200.286966998763, 6210.441060304594, 6249.281332646713, 6041.124037014608, 6069.514438844882, 6091.634501929899, 6105.297890742621, 6119.5104391648565, 6148.323684394713, 6177.96911015442, 6183.186650074205, 6199.597026193283, 6294.937050629526, 5854.795082172103, 5991.910121348271, 6009.489193418608, 6028.668423236764, 6064.848378790565, 5896.970515147397, 5900.43945825146, 5990.281166259902, 5998.640081595118, 6015.879682406415, 5927.8221653350465, 6177.505799536116, 6195.721192546436, 6213.068039794067, 6232.470240029467, 4166.187593419375, 4181.560936101787, 4204.285271503791, 4217.135487225173, 4225.957740422679, 6050.366401071598, 6059.454649081604, 6060.424259695322, 6064.211652485149, 6078.54410919174, 5602.579806514609, 5787.565932554991, 5883.705814709333, 5917.970410147922, 5957.582969192115, 5790.768369265183, 5807.186993820784, 5832.912506312494, 5838.591298609056, 5841.269841269841, 5620.498877999251, 5710.5146062585145, 5711.857203569944, 5736.942630573641, 5740.856478588069, 5857.121431785266, 5887.911681324869, 5900.498457631149, 5902.970485147547, 5903.704814759159, 5738.540916726568, 5750.223719797774, 5784.8553786154, 5810.227880496489, 5817.069268916953], "value": 4387.494876739181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.4930647159932, 773.2615352338518, 782.0537150048441, 786.2687700438591, 842.4355681693265, 12724.61826145216, 13275.734485310288, 13351.666208344795, 13362.799558006625, 13373.197608143519, 15162.924185379057, 15293.158876261828, 15300.31148598313, 15301.158436286, 15379.69240615187, 657.9046038324452, 790.4664351562701, 807.5518087461456, 807.5962018990505, 815.8449894520022, 800.0918956983807, 804.1235053791366, 804.5936801915025, 805.9677612895478, 807.7859367267679, 852.0, 855.9529225892574, 859.7764581208868, 860.2129051917519, 860.4622111180512, 851.0978362935277, 851.476342049635, 853.0957185383452, 857.100044952797, 857.588357588358, 625.2309659119263, 626.5175814622716, 627.3005598757353, 628.522323034497, 629.8708764703225, 14536.055156414905, 14573.854261457356, 14602.634934126625, 14621.92689036548, 14664.486742963945, 14820.925895370561, 14841.183734894577, 14842.257887105601, 14853.108813471226, 14868.776968345483, 12434.0, 12524.0, 12597.307148106851, 12638.747225055447, 12864.742705145938, 3948.8420463181724, 3993.1813978134414, 4025.456563363967, 4031.7379370341127, 4180.623743863067, 76416.61791691062, 78132.21867781364, 78694.60652696757, 78741.0, 78830.6058469704, 11717.355545444912, 11723.4138293085, 11801.881981180079, 12092.939535302266, 12168.81746773799, 22643.773562264498, 22733.0, 22737.545249094925, 22747.658785118238, 23025.654615180785, 8781.20969112783, 8799.164079412445, 8937.46375217489, 9269.165775080275, 9378.624855005859, 4721.8947274165575, 4775.6657034007985, 4879.56083952446, 4893.681910675866, 4920.21276595743, 3607.494950706903, 3672.3756961316108, 3709.795961222105, 3725.739198256096, 3745.700343972476, 589.6727316339473, 598.2581598817435, 610.6671863834221, 613.3529126771299, 631.2645767680692, 576.5531712922518, 635.1711017122607, 652.6051738698019, 708.2492557888654, 725.7205975699394, 9355.812883742423, 9451.432914025043, 9463.56224927572, 9727.817335850492, 9734.561944712505, 672.1195234243157, 672.4250765595345, 688.3495097133161, 695.006141218063, 718.647862547348, 4747.548982846624, 4788.832390866372, 4806.50998190555, 4809.5430934061205, 4840.75796210188, 112152.0, 113510.43244783889, 113995.0, 115557.0, 115582.42208788902, 99469.0, 100925.0, 101076.49461752645, 101277.0, 101622.44321448862, 63311.0, 83934.16065839386, 84400.57799710962, 84619.0, 84770.72843907346, 8962.283017358464, 9085.954570227106, 9199.77000574991, 9238.769030774285, 9477.952610236905, 37121.25757484889, 49818.0, 51055.48944510656, 51355.74322128366, 51901.22148167705, 71698.64150679213, 73368.0, 76460.0, 76826.23173768414, 79421.60289198517, 11609.187356884937, 11735.941320293345, 11828.70428239301, 11945.701357466132, 12232.510699571918, 13623.18260904349, 13687.931560342533, 14727.410903563738, 14862.702745944804, 15279.770803437736, 13935.442582296595, 14049.719005620034, 14309.141451512942, 14353.92823035878, 14467.27663616836, 13475.797863032258, 13784.070230167985, 14437.927810360881, 14450.421983120557, 14920.850791491946, 13704.177749335071, 14250.216238107003, 14384.784228236795, 14502.492412765503, 14574.34415451286, 10410.219233557666, 10684.25210235276, 10805.297655652357, 10933.436563238016, 10935.726606834893, 10866.61966831157, 11080.168987325822, 11120.666380008613, 11323.943380283046, 11390.886091138982], "value": 7550.341900536183, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 113.0, 110.0, 109.0, 111.0, 109.0, 111.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 133.0, 161.0, 184.0, 136.0, 161.0, 155.0, 126.0, 198.0, 127.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 164.0, 174.0, 164.0, 163.0, 162.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 154.0, 76.0, 78.0, 75.0, 75.0, 165.0, 76.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 150.0, 85.0, 86.0, 84.0, 143.0, 85.0, 85.0, 144.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 56.0, 53.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 63.0, 61.0, 61.0, 61.0, 62.0, 62.0, 63.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 79.0, 80.0, 84.0, 80.0, 81.0, 82.0, 103.0, 79.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 125.0, 121.0, 128.0, 132.0, 140.0, 122.0, 127.0, 123.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 161.0, 164.0, 164.0, 158.0, 164.0, 160.0, 161.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 63.0, 65.0, 64.0, 63.0, 62.0, 63.0], "value": 63.6, "unit": "score"}]}]} 20:03:35 INFO - Return code: 0 20:03:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:03:35 ERROR - # TBPL SUCCESS # 20:03:35 INFO - Running post-action listener: _resource_record_post_action 20:03:35 INFO - ##### 20:03:35 INFO - ##### Finished run-tests step (success) 20:03:35 INFO - ##### 20:03:35 INFO - Running post-run listener: _resource_record_post_run 20:03:35 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 550096896; Read time: 224; Write time: 405096 20:03:35 INFO - TinderboxPrint: CPU usage
13.5% 20:03:35 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 224 20:03:35 INFO - TinderboxPrint: I/O write bytes / time
550,096,896 / 405,096 20:03:35 INFO - TinderboxPrint: CPU idle
8,219.7 (86.5%) 20:03:35 INFO - TinderboxPrint: CPU user
1,223.3 (12.9%) 20:03:35 INFO - TinderboxPrint: Swap in / out
0 / 0 20:03:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255320064; Read time: 140; Write time: 217600 20:03:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294776832; Read time: 84; Write time: 187496 20:03:36 INFO - Running post-run listener: _upload_blobber_files 20:03:36 INFO - Blob upload gear active. 20:03:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:03:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:03:36 INFO - (blobuploader) - INFO - Open directory for files ... 20:03:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:03:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:03:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:37 INFO - (blobuploader) - INFO - Done attempting. 20:03:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:03:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:40 INFO - (blobuploader) - INFO - Done attempting. 20:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:41 INFO - (blobuploader) - INFO - Done attempting. 20:03:41 INFO - (blobuploader) - INFO - Iteration through files over. 20:03:41 INFO - Return code: 0 20:03:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:03:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:03:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fef06ae7fa2cd7f28b08e2abc0580c59308d41f0a8d7a67c8029724ff8d25925a45af60674df56ff3655900ba6cad0e3639df32dcdc0531df8118e8e4ac6a2f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/274d89c03fb6376ccf7593ad1350cacc03caea7b18e0aecfcb58e2ce1e2b96e370352a7a3e3df2658473637e660ef505dfd4753289ee67ca95d0e49a3d8e8956", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e0f0128d530ba6df3d5393f487b9eefa73ea74731267c87f2da45e31158efea417bb9dccab5e3f9961ad7737eb7ae98d2ae10205775bc82638ae526274bed8"} 20:03:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:03:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:03:41 INFO - Contents: 20:03:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fef06ae7fa2cd7f28b08e2abc0580c59308d41f0a8d7a67c8029724ff8d25925a45af60674df56ff3655900ba6cad0e3639df32dcdc0531df8118e8e4ac6a2f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/274d89c03fb6376ccf7593ad1350cacc03caea7b18e0aecfcb58e2ce1e2b96e370352a7a3e3df2658473637e660ef505dfd4753289ee67ca95d0e49a3d8e8956", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e0f0128d530ba6df3d5393f487b9eefa73ea74731267c87f2da45e31158efea417bb9dccab5e3f9961ad7737eb7ae98d2ae10205775bc82638ae526274bed8"} 20:03:41 INFO - Running post-run listener: copy_logs_to_upload_dir 20:03:41 INFO - Copying logs to upload dir... 20:03:41 INFO - mkdir: /builds/slave/test/build/upload/logs 20:03:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.109510 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-06-16 20:03:41.043403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 20:03:41.046960) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fef06ae7fa2cd7f28b08e2abc0580c59308d41f0a8d7a67c8029724ff8d25925a45af60674df56ff3655900ba6cad0e3639df32dcdc0531df8118e8e4ac6a2f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/274d89c03fb6376ccf7593ad1350cacc03caea7b18e0aecfcb58e2ce1e2b96e370352a7a3e3df2658473637e660ef505dfd4753289ee67ca95d0e49a3d8e8956", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e0f0128d530ba6df3d5393f487b9eefa73ea74731267c87f2da45e31158efea417bb9dccab5e3f9961ad7737eb7ae98d2ae10205775bc82638ae526274bed8"} build_url:https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/Jl_cIzTkRkOUlEZunaxnTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fef06ae7fa2cd7f28b08e2abc0580c59308d41f0a8d7a67c8029724ff8d25925a45af60674df56ff3655900ba6cad0e3639df32dcdc0531df8118e8e4ac6a2f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/274d89c03fb6376ccf7593ad1350cacc03caea7b18e0aecfcb58e2ce1e2b96e370352a7a3e3df2658473637e660ef505dfd4753289ee67ca95d0e49a3d8e8956", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e0f0128d530ba6df3d5393f487b9eefa73ea74731267c87f2da45e31158efea417bb9dccab5e3f9961ad7737eb7ae98d2ae10205775bc82638ae526274bed8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 20:03:41.076176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 20:03:41.076950) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466130831.772369-986680880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 20:03:41.161481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 20:03:41.162238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 20:03:41.162914) ========= ========= Total master_lag: 0.21 =========