builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1469893196.74 results: success (0) buildid: 20160730072226 builduid: d4734284d46846a0a3779bed7576fe6f revision: e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:56.743251) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:56.743656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:56.744025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:56.809725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:56.809988) ========= 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=33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 08:39:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2016-07-30 08:39:58 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075277 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:56.921324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:56.921644) ========= 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=33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017024 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:56.992681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 08:39:56.993006) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 --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 e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 --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=33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 08:39:59,114 truncating revision to first 12 chars 2016-07-30 08:39:59,114 Setting DEBUG logging. 2016-07-30 08:39:59,114 attempt 1/10 2016-07-30 08:39:59,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e5859dfe0bcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 08:39:59,812 unpacking tar archive at: mozilla-central-e5859dfe0bcb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.032941 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 08:39:58.042676) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:58.042990) ========= script_repo_revision: e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:58.043398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:58.043683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 08:39:58.053884) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-30 08:39:58.054159) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:00 INFO - MultiFileLogger online at 20160730 08:40:00 in /builds/slave/test 08:40:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:40:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:00 INFO - {'append_to_log': False, 08:40:00 INFO - 'base_work_dir': '/builds/slave/test', 08:40:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:40:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:00 INFO - 'branch': 'Firefox-Non-PGO', 08:40:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:00 INFO - 'config_files': ('talos/linux_config.py',), 08:40:00 INFO - 'default_actions': ('clobber', 08:40:00 INFO - 'read-buildbot-config', 08:40:00 INFO - 'download-and-extract', 08:40:00 INFO - 'populate-webroot', 08:40:00 INFO - 'create-virtualenv', 08:40:00 INFO - 'install', 08:40:00 INFO - 'run-tests'), 08:40:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:00 INFO - 'download_minidump_stackwalk': True, 08:40:00 INFO - 'download_symbols': 'ondemand', 08:40:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:00 INFO - 'installer_path': 'installer.exe', 08:40:00 INFO - 'log_level': 'info', 08:40:00 INFO - 'log_name': 'talos', 08:40:00 INFO - 'log_to_console': True, 08:40:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:00 INFO - 'opt_config_files': (), 08:40:00 INFO - 'pip_index': False, 08:40:00 INFO - 'sps_profile': False, 08:40:00 INFO - 'sps_profile_interval': 0, 08:40:00 INFO - 'suite': 'dromaeojs-e10s', 08:40:00 INFO - 'system_bits': '32', 08:40:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:00 INFO - 'title': 'talos-linux64-ix-063', 08:40:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:00 INFO - 'use_talos_json': True, 08:40:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:00 INFO - 'work_dir': 'build'} 08:40:00 INFO - [mozharness: 2016-07-30 15:40:00.267943Z] Running clobber step. 08:40:00 INFO - Running pre-action listener: _resource_record_pre_action 08:40:00 INFO - Running main action method: clobber 08:40:00 INFO - rmtree: /builds/slave/test/build 08:40:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:00 INFO - Running post-action listener: _resource_record_post_action 08:40:00 INFO - [mozharness: 2016-07-30 15:40:00.739147Z] Finished clobber step (success) 08:40:00 INFO - [mozharness: 2016-07-30 15:40:00.739248Z] Running read-buildbot-config step. 08:40:00 INFO - Running pre-action listener: _resource_record_pre_action 08:40:00 INFO - Running main action method: read_buildbot_config 08:40:00 INFO - Using buildbot properties: 08:40:00 INFO - { 08:40:00 INFO - "project": "", 08:40:00 INFO - "product": "firefox", 08:40:00 INFO - "script_repo_revision": "production", 08:40:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:40:00 INFO - "repository": "", 08:40:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:40:00 INFO - "buildid": "20160730072226", 08:40:00 INFO - "pgo_build": "False", 08:40:00 INFO - "basedir": "/builds/slave/test", 08:40:00 INFO - "buildnumber": 144, 08:40:00 INFO - "slavename": "talos-linux64-ix-063", 08:40:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:40:00 INFO - "platform": "ubuntu64_hw", 08:40:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:40:00 INFO - "branch": "mozilla-central", 08:40:00 INFO - "repo_path": "mozilla-central", 08:40:00 INFO - "revision": "e5859dfe0bcbd40f4e33f4a633f73ea3473a7849", 08:40:00 INFO - "stage_platform": "linux64", 08:40:00 INFO - "builduid": "d4734284d46846a0a3779bed7576fe6f", 08:40:00 INFO - "slavebuilddir": "test" 08:40:00 INFO - } 08:40:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:40:00 INFO - Running post-action listener: _resource_record_post_action 08:40:00 INFO - [mozharness: 2016-07-30 15:40:00.741695Z] Finished read-buildbot-config step (success) 08:40:00 INFO - [mozharness: 2016-07-30 15:40:00.741784Z] Running download-and-extract step. 08:40:00 INFO - Running pre-action listener: _resource_record_pre_action 08:40:00 INFO - Running main action method: download_and_extract 08:40:00 INFO - mkdir: /builds/slave/test/build/tests 08:40: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')]} 08:40:00 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:40:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:03 INFO - Downloaded 1361 bytes. 08:40:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:03 INFO - Using the following test package requirements: 08:40:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:40:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'jsshell-linux-x86_64.zip'], 08:40:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:40:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:40:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:03 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')]} 08:40:03 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:04 INFO - Downloaded 20231949 bytes. 08:40:04 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'] 08:40:04 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 08:40:05 INFO - Return code: 0 08:40:05 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 08:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:05 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:09 INFO - Downloaded 20231949 bytes. 08:40:09 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'] 08:40:09 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 08:40:10 INFO - Return code: 0 08:40:10 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')]} 08:40:10 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:11 INFO - Downloaded 14413723 bytes. 08:40:11 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'] 08:40:11 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 08:40:11 INFO - Return code: 0 08:40: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')]} 08:40:11 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/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 08:40:13 INFO - Downloaded 55603721 bytes. 08:40:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:13 INFO - mkdir: /builds/slave/test/properties 08:40:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:13 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:13 INFO - Contents: 08:40:13 INFO - build_url:https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:13 INFO - Running post-action listener: _resource_record_post_action 08:40:13 INFO - Running post-action listener: set_extra_try_arguments 08:40:13 INFO - [mozharness: 2016-07-30 15:40:13.882575Z] Finished download-and-extract step (success) 08:40:13 INFO - [mozharness: 2016-07-30 15:40:13.882812Z] Running populate-webroot step. 08:40:13 INFO - Running pre-action listener: _resource_record_pre_action 08:40:13 INFO - Running main action method: populate_webroot 08:40:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:13 INFO - '--tppagecycles', 08:40:13 INFO - '7'], 08:40:13 INFO - 'tests': ['tsvgm']}}, 08:40:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:13 INFO - 'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:13 INFO - 'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['damp', 'tps']}, 08:40:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:13 INFO - 'tests': ['damp', 'tps']}, 08:40:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['dromaeo_dom']}, 08:40:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['basic_compositor_video']}, 08:40:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['a11yr', 08:40:13 INFO - 'ts_paint', 08:40:13 INFO - 'tpaint', 08:40:13 INFO - 'sessionrestore', 08:40:13 INFO - 'sessionrestore_no_auto_restore', 08:40:13 INFO - 'tabpaint']}, 08:40:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:13 INFO - 'ts_paint', 08:40:13 INFO - 'tpaint', 08:40:13 INFO - 'sessionrestore', 08:40:13 INFO - 'sessionrestore_no_auto_restore', 08:40:13 INFO - 'tabpaint']}, 08:40:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:13 INFO - 'ts_paint', 08:40:13 INFO - 'tpaint', 08:40:13 INFO - 'sessionrestore', 08:40:13 INFO - 'sessionrestore_no_auto_restore', 08:40:13 INFO - 'tabpaint']}, 08:40:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:13 INFO - 'ts_paint', 08:40:13 INFO - 'tpaint', 08:40:13 INFO - 'sessionrestore', 08:40:13 INFO - 'sessionrestore_no_auto_restore', 08:40:13 INFO - 'tabpaint']}, 08:40:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['a11yr', 08:40:13 INFO - 'ts_paint', 08:40:13 INFO - 'tpaint', 08:40:13 INFO - 'sessionrestore', 08:40:13 INFO - 'sessionrestore_no_auto_restore', 08:40:13 INFO - 'tabpaint']}, 08:40:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['a11yr', 08:40:13 INFO - 'ts_paint', 08:40:13 INFO - 'tpaint', 08:40:13 INFO - 'sessionrestore', 08:40:13 INFO - 'sessionrestore_no_auto_restore', 08:40:13 INFO - 'tabpaint']}, 08:40:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['tsvgx', 08:40:13 INFO - 'tsvgr_opacity', 08:40:13 INFO - 'tart', 08:40:13 INFO - 'tscrollx', 08:40:13 INFO - 'cart']}, 08:40:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:13 INFO - 'tsvgr_opacity', 08:40:13 INFO - 'tart', 08:40:13 INFO - 'tscrollx', 08:40:13 INFO - 'cart']}, 08:40:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:13 INFO - 'talos_options': ['--disable-e10s'], 08:40:13 INFO - 'tests': ['tp5o']}, 08:40:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:13 INFO - 'tests': ['tp5o']}, 08:40:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:13 INFO - 'talos_options': ['--disable-e10s', 08:40:13 INFO - '--xperf_path', 08:40:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:13 INFO - 'tests': ['tp5n']}, 08:40:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:13 INFO - 'talos_options': ['--xperf_path', 08:40:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:13 INFO - 'tests': ['tp5n']}}, 08:40:13 INFO - 'talos.zip': {'path': '', 08:40:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:13 INFO - Running post-action listener: _resource_record_post_action 08:40:13 INFO - [mozharness: 2016-07-30 15:40:13.899172Z] Finished populate-webroot step (success) 08:40:13 INFO - [mozharness: 2016-07-30 15:40:13.899261Z] Running create-virtualenv step. 08:40:13 INFO - Running pre-action listener: _resource_record_pre_action 08:40:13 INFO - Running main action method: create_virtualenv 08:40:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:13 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 08:40:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:13 INFO - Using real prefix '/usr' 08:40:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:15 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:17 INFO - Installing pip.................done. 08:40:17 INFO - Return code: 0 08:40:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:17 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')]} 08:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:17 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')]} 08:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:17 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:17 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 08:40:17 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 08:40:17 INFO - Using env: {'DISPLAY': ':0', 08:40:17 INFO - 'HOME': '/home/cltbld', 08:40:17 INFO - 'LANG': 'en_US.UTF-8', 08:40:17 INFO - 'LANGUAGE': 'en_US:en', 08:40:17 INFO - 'LOGNAME': 'cltbld', 08:40:17 INFO - 'MAIL': '/var/mail/cltbld', 08:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:17 INFO - 'MOZ_NO_REMOTE': '1', 08:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:17 INFO - 'NO_EM_RESTART': '1', 08:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:17 INFO - 'PWD': '/builds/slave/test', 08:40:17 INFO - 'SHELL': '/bin/bash', 08:40:17 INFO - 'SHLVL': '1', 08:40:17 INFO - 'TERM': 'linux', 08:40:17 INFO - 'TMOUT': '86400', 08:40:17 INFO - 'USER': 'cltbld', 08:40:17 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:17 INFO - '_': '/tools/buildbot/bin/python'} 08:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:17 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 08:40:17 INFO - Cleaning up... 08:40:17 INFO - Return code: 0 08:40:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:17 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')]} 08:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:17 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')]} 08:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:17 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:17 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 08:40:17 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 08:40:17 INFO - Using env: {'DISPLAY': ':0', 08:40:17 INFO - 'HOME': '/home/cltbld', 08:40:17 INFO - 'LANG': 'en_US.UTF-8', 08:40:17 INFO - 'LANGUAGE': 'en_US:en', 08:40:17 INFO - 'LOGNAME': 'cltbld', 08:40:17 INFO - 'MAIL': '/var/mail/cltbld', 08:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:17 INFO - 'MOZ_NO_REMOTE': '1', 08:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:17 INFO - 'NO_EM_RESTART': '1', 08:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:17 INFO - 'PWD': '/builds/slave/test', 08:40:17 INFO - 'SHELL': '/bin/bash', 08:40:17 INFO - 'SHLVL': '1', 08:40:17 INFO - 'TERM': 'linux', 08:40:17 INFO - 'TMOUT': '86400', 08:40:17 INFO - 'USER': 'cltbld', 08:40:17 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:17 INFO - '_': '/tools/buildbot/bin/python'} 08:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:17 INFO - Downloading/unpacking psutil>=3.1.1 08:40:17 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 08:40:17 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 08:40:17 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 08:40:17 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 08:40:17 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 08:40:17 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 08:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:19 INFO - Installing collected packages: psutil 08:40:19 INFO - Running setup.py install for psutil 08:40:19 INFO - building 'psutil._psutil_linux' extension 08:40:19 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 08:40:19 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 08:40:19 INFO - building 'psutil._psutil_posix' extension 08:40:19 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 08:40:20 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 08:40:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:20 INFO - Successfully installed psutil 08:40:20 INFO - Cleaning up... 08:40:20 INFO - Return code: 0 08:40:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:20 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:20 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 08:40:20 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 08:40:20 INFO - Using env: {'DISPLAY': ':0', 08:40:20 INFO - 'HOME': '/home/cltbld', 08:40:20 INFO - 'LANG': 'en_US.UTF-8', 08:40:20 INFO - 'LANGUAGE': 'en_US:en', 08:40:20 INFO - 'LOGNAME': 'cltbld', 08:40:20 INFO - 'MAIL': '/var/mail/cltbld', 08:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:20 INFO - 'MOZ_NO_REMOTE': '1', 08:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:20 INFO - 'NO_EM_RESTART': '1', 08:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:20 INFO - 'PWD': '/builds/slave/test', 08:40:20 INFO - 'SHELL': '/bin/bash', 08:40:20 INFO - 'SHLVL': '1', 08:40:20 INFO - 'TERM': 'linux', 08:40:20 INFO - 'TMOUT': '86400', 08:40:20 INFO - 'USER': 'cltbld', 08:40:20 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:20 INFO - '_': '/tools/buildbot/bin/python'} 08:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:22 INFO - Installing collected packages: mozsystemmonitor 08:40:22 INFO - Running setup.py install for mozsystemmonitor 08:40:22 INFO - Successfully installed mozsystemmonitor 08:40:22 INFO - Cleaning up... 08:40:22 INFO - Return code: 0 08:40:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:22 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:22 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 08:40:22 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 08:40:22 INFO - Using env: {'DISPLAY': ':0', 08:40:22 INFO - 'HOME': '/home/cltbld', 08:40:22 INFO - 'LANG': 'en_US.UTF-8', 08:40:22 INFO - 'LANGUAGE': 'en_US:en', 08:40:22 INFO - 'LOGNAME': 'cltbld', 08:40:22 INFO - 'MAIL': '/var/mail/cltbld', 08:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:22 INFO - 'MOZ_NO_REMOTE': '1', 08:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:22 INFO - 'NO_EM_RESTART': '1', 08:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:22 INFO - 'PWD': '/builds/slave/test', 08:40:22 INFO - 'SHELL': '/bin/bash', 08:40:22 INFO - 'SHLVL': '1', 08:40:22 INFO - 'TERM': 'linux', 08:40:22 INFO - 'TMOUT': '86400', 08:40:22 INFO - 'USER': 'cltbld', 08:40:22 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:22 INFO - '_': '/tools/buildbot/bin/python'} 08:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:22 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:22 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 08:40:22 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 08:40:22 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 08:40:22 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 08:40:22 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 08:40:22 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 08:40:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:24 INFO - warning: no files found matching '*.txt' 08:40:24 INFO - no previously-included directories found matching 'build' 08:40:24 INFO - no previously-included directories found matching 'dist' 08:40:24 INFO - no previously-included directories found matching '.git*' 08:40:24 INFO - Installing collected packages: jsonschema, functools32 08:40:24 INFO - Running setup.py install for functools32 08:40:24 INFO - warning: no files found matching '*.txt' 08:40:24 INFO - no previously-included directories found matching 'build' 08:40:24 INFO - no previously-included directories found matching 'dist' 08:40:24 INFO - no previously-included directories found matching '.git*' 08:40:25 INFO - Successfully installed jsonschema functools32 08:40:25 INFO - Cleaning up... 08:40:25 INFO - Return code: 0 08:40:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:25 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:25 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:40:25 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 functools32==3.2.3-2 08:40:25 INFO - Using env: {'DISPLAY': ':0', 08:40:25 INFO - 'HOME': '/home/cltbld', 08:40:25 INFO - 'LANG': 'en_US.UTF-8', 08:40:25 INFO - 'LANGUAGE': 'en_US:en', 08:40:25 INFO - 'LOGNAME': 'cltbld', 08:40:25 INFO - 'MAIL': '/var/mail/cltbld', 08:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:25 INFO - 'MOZ_NO_REMOTE': '1', 08:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:25 INFO - 'NO_EM_RESTART': '1', 08:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:25 INFO - 'PWD': '/builds/slave/test', 08:40:25 INFO - 'SHELL': '/bin/bash', 08:40:25 INFO - 'SHLVL': '1', 08:40:25 INFO - 'TERM': 'linux', 08:40:25 INFO - 'TMOUT': '86400', 08:40:25 INFO - 'USER': 'cltbld', 08:40:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:25 INFO - '_': '/tools/buildbot/bin/python'} 08:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:25 INFO - Cleaning up... 08:40:25 INFO - Return code: 0 08:40:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:25 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:25 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 08:40:25 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 08:40:25 INFO - Using env: {'DISPLAY': ':0', 08:40:25 INFO - 'HOME': '/home/cltbld', 08:40:25 INFO - 'LANG': 'en_US.UTF-8', 08:40:25 INFO - 'LANGUAGE': 'en_US:en', 08:40:25 INFO - 'LOGNAME': 'cltbld', 08:40:25 INFO - 'MAIL': '/var/mail/cltbld', 08:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:25 INFO - 'MOZ_NO_REMOTE': '1', 08:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:25 INFO - 'NO_EM_RESTART': '1', 08:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:25 INFO - 'PWD': '/builds/slave/test', 08:40:25 INFO - 'SHELL': '/bin/bash', 08:40:25 INFO - 'SHLVL': '1', 08:40:25 INFO - 'TERM': 'linux', 08:40:25 INFO - 'TMOUT': '86400', 08:40:25 INFO - 'USER': 'cltbld', 08:40:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:25 INFO - '_': '/tools/buildbot/bin/python'} 08:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:25 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 08:40:25 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 08:40:25 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 08:40:25 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 08:40:25 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 08:40:25 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 08:40:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:28 INFO - Downloading docopt-0.6.1.tar.gz 08:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:28 INFO - Running setup.py install for blobuploader 08:40:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:28 INFO - Running setup.py install for requests 08:40:28 INFO - Running setup.py install for docopt 08:40:28 INFO - Successfully installed blobuploader requests docopt 08:40:28 INFO - Cleaning up... 08:40:28 INFO - Return code: 0 08:40:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:28 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:28 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 08:40:28 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 08:40:28 INFO - Using env: {'DISPLAY': ':0', 08:40:28 INFO - 'HOME': '/home/cltbld', 08:40:28 INFO - 'LANG': 'en_US.UTF-8', 08:40:28 INFO - 'LANGUAGE': 'en_US:en', 08:40:28 INFO - 'LOGNAME': 'cltbld', 08:40:28 INFO - 'MAIL': '/var/mail/cltbld', 08:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:28 INFO - 'MOZ_NO_REMOTE': '1', 08:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:28 INFO - 'NO_EM_RESTART': '1', 08:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:28 INFO - 'PWD': '/builds/slave/test', 08:40:28 INFO - 'SHELL': '/bin/bash', 08:40:28 INFO - 'SHLVL': '1', 08:40:28 INFO - 'TERM': 'linux', 08:40:28 INFO - 'TMOUT': '86400', 08:40:28 INFO - 'USER': 'cltbld', 08:40:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:28 INFO - '_': '/tools/buildbot/bin/python'} 08:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:28 INFO - Running setup.py (path:/tmp/pip-fi4Juf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:29 INFO - Running setup.py (path:/tmp/pip-dtia_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:29 INFO - Running setup.py (path:/tmp/pip-r6ptds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:29 INFO - Running setup.py (path:/tmp/pip-uK04d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:29 INFO - Running setup.py (path:/tmp/pip-mU9WKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:29 INFO - Running setup.py (path:/tmp/pip-rgYtIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:29 INFO - Running setup.py (path:/tmp/pip-4U03iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:29 INFO - Running setup.py (path:/tmp/pip-XDeBxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:29 INFO - Running setup.py (path:/tmp/pip-3aEEZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:29 INFO - Running setup.py (path:/tmp/pip-E7CIUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:29 INFO - Running setup.py (path:/tmp/pip-7O_Y_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:29 INFO - Running setup.py (path:/tmp/pip-Hnv1oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:29 INFO - Running setup.py (path:/tmp/pip-l3fRAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:29 INFO - Running setup.py (path:/tmp/pip-XC6ptA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:29 INFO - Running setup.py (path:/tmp/pip-2n4ZDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:30 INFO - Running setup.py (path:/tmp/pip-gs9hph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:30 INFO - Running setup.py (path:/tmp/pip-Uw_78v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:30 INFO - Running setup.py install for manifestparser 08:40:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Running setup.py install for mozcrash 08:40:30 INFO - Running setup.py install for mozdebug 08:40:30 INFO - Running setup.py install for mozdevice 08:40:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Running setup.py install for mozfile 08:40:30 INFO - Running setup.py install for mozhttpd 08:40:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Running setup.py install for mozinfo 08:40:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Running setup.py install for mozInstall 08:40:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:30 INFO - Running setup.py install for mozleak 08:40:31 INFO - Running setup.py install for mozlog 08:40:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:31 INFO - Running setup.py install for moznetwork 08:40:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:31 INFO - Running setup.py install for mozprocess 08:40:31 INFO - Running setup.py install for mozprofile 08:40:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:31 INFO - Running setup.py install for mozrunner 08:40:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:31 INFO - Running setup.py install for mozscreenshot 08:40:31 INFO - Running setup.py install for moztest 08:40:31 INFO - Running setup.py install for mozversion 08:40:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:31 INFO - Cleaning up... 08:40:31 INFO - Return code: 0 08:40:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:31 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 08:40:31 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 08:40:31 INFO - Using env: {'DISPLAY': ':0', 08:40:31 INFO - 'HOME': '/home/cltbld', 08:40:31 INFO - 'LANG': 'en_US.UTF-8', 08:40:31 INFO - 'LANGUAGE': 'en_US:en', 08:40:31 INFO - 'LOGNAME': 'cltbld', 08:40:31 INFO - 'MAIL': '/var/mail/cltbld', 08:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:31 INFO - 'MOZ_NO_REMOTE': '1', 08:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:31 INFO - 'NO_EM_RESTART': '1', 08:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:31 INFO - 'PWD': '/builds/slave/test', 08:40:31 INFO - 'SHELL': '/bin/bash', 08:40:31 INFO - 'SHLVL': '1', 08:40:31 INFO - 'TERM': 'linux', 08:40:31 INFO - 'TMOUT': '86400', 08:40:31 INFO - 'USER': 'cltbld', 08:40:31 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:31 INFO - '_': '/tools/buildbot/bin/python'} 08:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:32 INFO - Running setup.py (path:/tmp/pip-9N2oOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:32 INFO - Running setup.py (path:/tmp/pip-c6amJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:32 INFO - Running setup.py (path:/tmp/pip-PPliEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:32 INFO - Running setup.py (path:/tmp/pip-6v54fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:32 INFO - Running setup.py (path:/tmp/pip-aXu6wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:32 INFO - Running setup.py (path:/tmp/pip-n7uSXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:32 INFO - Running setup.py (path:/tmp/pip-MNTfx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:32 INFO - Running setup.py (path:/tmp/pip-yaPxLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:32 INFO - Running setup.py (path:/tmp/pip-0Tm53m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:32 INFO - Running setup.py (path:/tmp/pip-Ih87Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:32 INFO - Running setup.py (path:/tmp/pip-Kq3gKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:32 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)) 08:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:33 INFO - Running setup.py (path:/tmp/pip-LIJz2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 08:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:33 INFO - Running setup.py (path:/tmp/pip-d2x4Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:33 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)) 08:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:33 INFO - Running setup.py (path:/tmp/pip-86gJlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 08:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:33 INFO - Running setup.py (path:/tmp/pip-Fv18re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:33 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)) 08:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:33 INFO - Running setup.py (path:/tmp/pip-YOfA_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:33 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)) 08:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:33 INFO - Running setup.py (path:/tmp/pip-8vCaE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:33 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)) 08:40:33 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)) 08:40:33 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)) 08:40:33 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)) 08:40:33 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)) 08:40:33 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)) 08:40:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:35 INFO - Downloading blessings-1.6.tar.gz 08:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:35 INFO - Installing collected packages: blessings 08:40:35 INFO - Running setup.py install for blessings 08:40:35 INFO - Successfully installed blessings 08:40:35 INFO - Cleaning up... 08:40:35 INFO - Return code: 0 08:40:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:35 INFO - Reading from file tmpfile_stdout 08:40:35 INFO - Current package versions: 08:40:35 INFO - argparse == 1.2.1 08:40:35 INFO - blessings == 1.6 08:40:35 INFO - blobuploader == 1.2.4 08:40:35 INFO - docopt == 0.6.1 08:40:35 INFO - functools32 == 3.2.3-2 08:40:35 INFO - jsonschema == 2.5.1 08:40:35 INFO - manifestparser == 1.1 08:40:35 INFO - mozInstall == 1.12 08:40:35 INFO - mozcrash == 0.17 08:40:35 INFO - mozdebug == 0.1 08:40:35 INFO - mozdevice == 0.48 08:40:35 INFO - mozfile == 1.2 08:40:35 INFO - mozhttpd == 0.7 08:40:35 INFO - mozinfo == 0.9 08:40:35 INFO - mozleak == 0.1 08:40:35 INFO - mozlog == 3.3 08:40:35 INFO - moznetwork == 0.27 08:40:35 INFO - mozprocess == 0.23 08:40:35 INFO - mozprofile == 0.28 08:40:35 INFO - mozrunner == 6.12 08:40:35 INFO - mozscreenshot == 0.1 08:40:35 INFO - mozsystemmonitor == 0.3 08:40:35 INFO - moztest == 0.7 08:40:35 INFO - mozversion == 1.4 08:40:35 INFO - psutil == 3.1.1 08:40:35 INFO - requests == 1.2.3 08:40:35 INFO - wsgiref == 0.1.2 08:40:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:35 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:35 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 08:40:35 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 08:40:35 INFO - Using env: {'DISPLAY': ':0', 08:40:35 INFO - 'HOME': '/home/cltbld', 08:40:35 INFO - 'LANG': 'en_US.UTF-8', 08:40:35 INFO - 'LANGUAGE': 'en_US:en', 08:40:35 INFO - 'LOGNAME': 'cltbld', 08:40:35 INFO - 'MAIL': '/var/mail/cltbld', 08:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:35 INFO - 'MOZ_NO_REMOTE': '1', 08:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:35 INFO - 'NO_EM_RESTART': '1', 08:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:35 INFO - 'PWD': '/builds/slave/test', 08:40:35 INFO - 'SHELL': '/bin/bash', 08:40:35 INFO - 'SHLVL': '1', 08:40:35 INFO - 'TERM': 'linux', 08:40:35 INFO - 'TMOUT': '86400', 08:40:35 INFO - 'USER': 'cltbld', 08:40:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:35 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 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)) 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 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 0x16d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, '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': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', '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 08:40:36 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 08:40:36 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 08:40:36 INFO - Using env: {'DISPLAY': ':0', 08:40:36 INFO - 'HOME': '/home/cltbld', 08:40:36 INFO - 'LANG': 'en_US.UTF-8', 08:40:36 INFO - 'LANGUAGE': 'en_US:en', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MAIL': '/var/mail/cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SHLVL': '1', 08:40:36 INFO - 'TERM': 'linux', 08:40:36 INFO - 'TMOUT': '86400', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Running post-action listener: _resource_record_post_action 08:40:36 INFO - Running post-action listener: _start_resource_monitoring 08:40:36 INFO - Starting resource monitoring. 08:40:36 INFO - [mozharness: 2016-07-30 15:40:36.284759Z] Finished create-virtualenv step (success) 08:40:36 INFO - [mozharness: 2016-07-30 15:40:36.285196Z] Running install step. 08:40:36 INFO - Running pre-action listener: _resource_record_pre_action 08:40:36 INFO - Running main action method: install 08:40:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:36 INFO - Reading from file tmpfile_stdout 08:40:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:36 INFO - Reading from file tmpfile_stdout 08:40:36 INFO - Output received: 08:40:36 INFO - Usage: mozinstall [options] installer 08:40:36 INFO - Options: 08:40:36 INFO - -h, --help show this help message and exit 08:40:36 INFO - -d DEST, --destination=DEST 08:40:36 INFO - Directory to install application into. [default: 08:40:36 INFO - "/builds/slave/test"] 08:40:36 INFO - --app=APP Application being installed. [default: firefox] 08:40:36 INFO - mkdir: /builds/slave/test/build/application 08:40:36 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'] 08:40:36 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 08:40:55 INFO - Reading from file tmpfile_stdout 08:40:55 INFO - Output received: 08:40:55 INFO - /builds/slave/test/build/application/firefox/firefox 08:40:55 INFO - Running post-action listener: _resource_record_post_action 08:40:55 INFO - [mozharness: 2016-07-30 15:40:55.923408Z] Finished install step (success) 08:40:55 INFO - [mozharness: 2016-07-30 15:40:55.923660Z] Running run-tests step. 08:40:55 INFO - Running pre-action listener: _resource_record_pre_action 08:40:55 INFO - Running main action method: run_tests 08:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:40:55 INFO - Python 2.7.3 08:40:55 INFO - Return code: 0 08:40:55 INFO - grabbing minidump binary from tooltool 08:40:55 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')]} 08:40:55 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 0x198e570>, '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 0x198f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:40:55 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 08:40:55 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 08:40:55 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 08:40:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:40:55 INFO - Return code: 0 08:40:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:40:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:40:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:40:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:40:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 08:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 08:40:55 INFO - Using env: {'DISPLAY': ':0', 08:40:55 INFO - 'HOME': '/home/cltbld', 08:40:55 INFO - 'LANG': 'en_US.UTF-8', 08:40:55 INFO - 'LANGUAGE': 'en_US:en', 08:40:55 INFO - 'LOGNAME': 'cltbld', 08:40:55 INFO - 'MAIL': '/var/mail/cltbld', 08:40:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:40:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:55 INFO - 'MOZ_NO_REMOTE': '1', 08:40:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:55 INFO - 'NO_EM_RESTART': '1', 08:40:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:55 INFO - 'PWD': '/builds/slave/test', 08:40:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:40:55 INFO - 'SHELL': '/bin/bash', 08:40:55 INFO - 'SHLVL': '1', 08:40:55 INFO - 'TERM': 'linux', 08:40:55 INFO - 'TMOUT': '86400', 08:40:55 INFO - 'USER': 'cltbld', 08:40:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935', 08:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:55 INFO - '_': '/tools/buildbot/bin/python'} 08:40:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 08:40:56 INFO - mozversion application_buildid: 20160730072226 08:40:56 INFO - mozversion application_changeset: e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 08:40:56 INFO - mozversion application_display_name: Nightly 08:40:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:40:56 INFO - mozversion application_name: Firefox 08:40:56 INFO - mozversion application_remotingname: firefox 08:40:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:40:56 INFO - mozversion application_vendor: Mozilla 08:40:56 INFO - mozversion application_version: 50.0a1 08:40:56 INFO - mozversion platform_buildid: 20160730072226 08:40:56 INFO - mozversion platform_changeset: e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 08:40:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:40:56 INFO - mozversion platform_version: 50.0a1 08:40:56 INFO - using testdate: 1469893256 08:40:56 INFO - actual date: 1469893256 08:40:56 INFO - starting webserver on 'localhost:47699' 08:40:56 INFO - SUITE-START | Running 2 tests 08:40:56 INFO - TEST-START | dromaeo_css 08:40:56 INFO - operating with platform_type : linux_ 08:40:56 INFO - Initialising browser for dromaeo_css test... 08:40:56 INFO - TEST-INFO | started process 12377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGe8m8A/profile http://localhost:47699/getInfo.html) 08:41:08 INFO - PROCESS | 12377 | __metrics Screen width/height:1600/1200 08:41:08 INFO - PROCESS | 12377 | colorDepth:24 08:41:08 INFO - PROCESS | 12377 | Browser inner width/height: 1024/697 08:41:08 INFO - PROCESS | 12377 | __metrics 08:41:10 ERROR - PROCESS | 12377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:41:11 INFO - TEST-INFO | 12377: exit 0 08:41:11 INFO - Browser initialized. 08:41:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:11 INFO - TEST-INFO | started process 12498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGe8m8A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:23 INFO - PROCESS | 12498 | RSS: Main: 163901440 08:41:23 INFO - PROCESS | 12498 | 08:42:12 INFO - PROCESS | 12498 | 1469893332817 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] 08:44:25 INFO - PROCESS | 12498 | Cycle 1(1): loaded http://localhost:47699/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47699/tests/dromaeo/cssquery-ext.html) 08:44:26 INFO - PROCESS | 12498 | RSS: Main: 166367232 08:44:26 INFO - PROCESS | 12498 | 08:47:28 INFO - PROCESS | 12498 | Cycle 1(1): loaded http://localhost:47699/tests/dromaeo/cssquery-ext.html (next: http://localhost:47699/tests/dromaeo/cssquery-jquery.html) 08:47:29 INFO - PROCESS | 12498 | RSS: Main: 166252544 08:47:29 INFO - PROCESS | 12498 | 08:50:31 INFO - PROCESS | 12498 | Cycle 1(1): loaded http://localhost:47699/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47699/tests/dromaeo/cssquery-mootools.html) 08:50:32 INFO - PROCESS | 12498 | RSS: Main: 169611264 08:50:32 INFO - PROCESS | 12498 | 08:53:34 INFO - PROCESS | 12498 | Cycle 1(1): loaded http://localhost:47699/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47699/tests/dromaeo/cssquery-prototype.html) 08:53:34 INFO - PROCESS | 12498 | RSS: Main: 164716544 08:53:34 INFO - PROCESS | 12498 | 08:56:37 INFO - PROCESS | 12498 | Cycle 1(1): loaded http://localhost:47699/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47699/tests/dromaeo/cssquery-yui.html) 08:56:38 INFO - PROCESS | 12498 | RSS: Main: 166330368 08:56:38 INFO - PROCESS | 12498 | 08:59:40 INFO - PROCESS | 12498 | Cycle 1(1): loaded http://localhost:47699/tests/dromaeo/cssquery-yui.html (next: http://localhost:47699/tests/dromaeo/cssquery-dojo.html) 08:59:41 INFO - PROCESS | 12498 | RSS: Main: 169697280 08:59:41 INFO - PROCESS | 12498 | 08:59:41 INFO - PROCESS | 12498 | __start_tp_report 08:59:41 INFO - PROCESS | 12498 | _x_x_mozilla_page_load 08:59:41 INFO - PROCESS | 12498 | _x_x_mozilla_page_load_details 08:59:41 INFO - PROCESS | 12498 | |i|pagename|runs| 08:59:41 INFO - PROCESS | 12498 | |0;dojo.html;2679.4507126039166;2685.2078636802144;2700.3654141276784;2717.9592306115405;2727.6044973478834;4719.221328480805;4857.975710121449;4916.065947469978;4938.185199442092;4948.529889660485;4765.166095933215;4804.83183088592;4862.927056094152;4865.829695960642;4865.951340486594;4419.977900110503;4479.126570318773;4534.773261336936;4549.31760235964;4569.4516658001085;4500.39244701966;4584.679072464929;4604.217283061887;4605.240135377676;4615.284630882202;4546.727196368212;4584.472785629645;4599.425071866017;4608.838690645828;4622.445306563217;4354.455693038371;4399.890002749925;4429.867103986886;4488.551144885518;4505.752183629899;4395.252807022782;4410.29435290352;4436.44544431946;4439.156560253541;4509.1658043262105;4879.951200487985;4888.266759985995;4889.902201955941;4898.632602554822;4904.0437114762635;5180.792768289301;5234.369178031173;5245.160774276097;5305.946940530623;5345.705986170759;5313.654612450178;5321.255024296602;5325.094733895247;5339.4927481889545;5366.248725178478;4915.4347250065985;4936.432310284292;4936.8765780855765;4937.950620493821;4945.2087665973995;5138.332016837787;5173.741312934339;5200.6619569727845;5205.973970130125;5411.783528658888;5016.698998060128;5028.572571331478;5030.245463180552;5034.446210916796;5067.442581316052;5114.974425127851;5117.053345131163;5124.538791508782;5125.1287281162295;5171.224316352577;5031.471695471922;5073.188289873677;5162.174052151638;5201.453847345974;5222.086134926372;5226.137687281632;5236.345456817898;5240.266362709223;5252.369715634072;5270.841874743764;4509.774511274423;4515.887102822456;4517.977410112929;4562.429696287964;4567.040921406476;3831.176297096082;3838.405047217686;3857.498525191707;3888.202918401721;3920.5883382245024;4488.820447182142;4513.277875539898;4530.546945305443;4567.908641827211;4575.3365761965;5256.159014557652;5273.736313184326;5275.920861187085;5307.363116425976;5312.681239125664;4399.076193999232;4481.3726078349055;4521.502634710179;4542.523035081335;4545.0909818036525;4780.115678599401;4785.042991401733;4798.328234047236;4830.4444988826735;4834.419869615669;4944.90110197794;4970.90058198834;4971.975140124277;4990.326305948723;5044.520770526794;5097.719625420637;5154.8969020620125;5157.355330583677;5204.7918083276245;5297.920531192112;4868.07506573764;4890.951090489192;4909.754512274443;4937.975310123426;4943.555080042814;5092.770825312796;5129;5133.358330208724;5133.614978876674;5134.666246693953;5036.798528058983;5177.715225662625;5203.297554830049;5237.397699264633;5239.423663396947;5092.618053645917;5099.898002039864;5123.38519377677;5126.974365128151;5144.871378215425;5124.130486927333;5137.229415587692;5138.049460849755;5149.073166829857;5188.558972487381;4652.441706995182;4684.273937539687;4703.717776933395;4855.490173531728;5045.84862454127;4974.527419895104;5031.446540880574;5114.872128196825;5136.075506408883;5215.217717342429;5017.473165317735;5053.2420136979745;5064.7467626619255;5073.3911930568565;5099.464556221544 08:59:41 INFO - PROCESS | 12498 | |1;ext.html;540.9729513524322;541.7589172818097;549.8432946610214;552.378574104133;587.9764809407624;34263;38821.22357552847;38822.41766373507;38843.61156388439;39029.804850975706;39404.60595394045;39874.800625996904;39903.20193596126;39910.80044599773;39927.20145597086;7677.769666910001;7822.178671239523;7826.295633392993;7828.686852525921;7836.686532538692;7647.044119485065;7768.067831860157;7784.3772498200005;7787.571683557402;7794.610269486503;7711.884321735179;7777.02787151606;7800.219978002211;7828.138904720477;7850.214978502161;7747.0703515577925;7774.805629859242;7784.182660820589;7821.765347039598;7835.059792824897;7626.694932202705;7713.807154821118;7714.382849372093;7715.344195743369;7746.10919744231;36411.63588364109;36577.45133822995;37043;37046.62953370459;37101.814490927645;3038.5442183672403;3198.296374797541;3267.869285228588;3393.2025973896116;3400.1159698478327;28459.430811383863;28915.710842891724;29021;29376.559351609743;29421.264468388246;3141.6387115481784;3217.581714377139;3226.8547915343865;3249.106495713674;3293.950590741141;170121.14939425225;171966;172012;172620;172851;30900.845495772377;31952.201194970312;32186.35627287441;54006;54657;31687.20781980423;31787.84106079501;32058.83970580132;32111.03666889997;32159.67840321567;13340.73318533624;13366.93316533411;13442.663933401547;13445.260510671811;13479.595612131652;11260.943695281636;11263.605773797877;11265.605703800491;11274.830877536844;11336;7581.3934885209055;7708.267714567107;7755.7673269802;7782;7782.571958542335;3059.3575349176476;3063.877444902179;3069.9539506907413;3098.4577698903054;3126.124685088179;871.333429926107;906.954652267384;911.1207684584275;971.3831716859845;1013.6046941692746;26929.86535067312;27177.912883484834;27511.58732619012;27536;27935.860320698266;972.6790159247431;993.8260804359353;995.2734503812258;997.508724456927;1018.4602160854758;14235.928820355832;14773.778393324108;14791.408343666133;14873.405063797327;14904;102511;323522;323668;324650;325359;45537.316940245924;46231.53768462272;46252.768736156104;46509.30236046462;46687;1193.4510125342267;1195.061823504485;1230.4032544216047;1232.8582213045436;1240.3550153920091;25610;26195.73804261933;26474.735252648;26721.86639066792;26919.461610768067;40523;40612.59387406206;40903.795481022404;40988.79505602453;41046.79476602598;276629;276888;276938;277946;278329;23959.880200598884;24350.26949191527;24575;24596.6310505339;24720.258392248263;39427.40858887062;40279.1944161121;40639;40711.79644101761;41414;33306.500402494465;34195.48706769351;34641.65358346384;34778.478322824674;34823.825880871445;31365.843170784;34217.828910855285;34497;34671;34831.30337393187;34333.656663433045;35667.64332356643;36161;36337.63662363343;39388.803055984536;30342.54486182665;32457;33382;33950.66049339475;34047.14882127967;25368.746312536638;25694.743052569236;25720.356991075372;25726.614100788876;26018.479630407666 08:59:41 INFO - PROCESS | 12498 | |2;jquery.html;360.43591778866056;366.6663336363909;369.59713911836093;385.02780479289805;386.37600275554985;15798.526044218677;16640.583985400357;16989.660206795856;17066.317347306107;17174.484765457026;15546.222688865568;15707.84292157078;15884.76172857408;16011.759823602626;16044.83955160448;4956.553910148086;5113.105206588851;5148.330717006784;5156.793728250866;5186.403563590179;3723.6834869036165;5139.974300128494;5670.6030577859565;5908.586398952075;5946.762129514815;5976.940230597704;5992.880142397149;6012.488938440216;6013.548983826208;6034.487068599153;5989.520838332945;6008;6014.0678194879865;6042.9726946419;6050.394960503959;5197.818076367347;5302.072137375943;5305.257263983007;5318.760655770499;5335.039692855285;18930.716039259285;19355.322563710204;19499.512512187168;19500.609987800166;20147.597048059102;1915.2339064374223;1929.077447666786;2059.104289634014;2092.1422216891;2299.6320588705894;13122.737545249041;13161.276129812952;13221;13363.33183340829;13422.0604557681;1776.8489678377352;1781.2518742128336;1786.6158775863253;1813.2837529175902;1814.6642871068896;67749;67823.66088169577;69596;69819.30180698179;71865.2813471869;9050.728478145666;9129.497877616663;9465.810683786285;9534.28492863038;9659.855102173473;13222.338883055809;13262.602121936357;13264.270465124318;13279.800802987962;13322.467101316033;7306.853862922711;7393.445491588152;7518.511296765692;7546.320831125116;7616.276453736886;7030.859382812315;7031.578105313698;7185.784426467214;7325.4872158948365;7397.334239918433;5818.941810581925;5847.210626565359;5885.793997210077;5925.851853703692;5949.196858424144;1680.4118558504426;1702.1319127245195;1752.4304601004724;1812.1754601656214;1837.5498002989352;833.8832563441002;881.070470653454;896.8699538567001;908.5502676175204;909.1817364372118;16673.582745466527;16756.162191890602;17161.399351022905;17433.912830435765;17619.383321583682;888.200619442494;900.6532484993194;910.1353713971753;933.0809152984305;944.6646440513518;9989.400635961865;9990.200783937413;9998.600195972569;10130.493475326204;10145.695629131138;353216;353884;358684;388107;389263;66182.33817661858;66573.33426665768;68293.31706682869;68706.65646671735;70353.94469082968;917.6971599372191;927.7495076329218;934.5841100710119;962.0379620379621;968.2109081099022;12580.937095314464;14535.328437229853;14964.476243331432;15624.765628515808;15911.124888131264;37278.8136059318;37784.811075944446;38229.80885095668;38747.806260968515;38835.41746873856;50620.24069638885;51625.7418712919;52042.47957520528;52204.216936746736;54079;6432.6462044588;7551.924480755122;7730.11103723079;7855.253750893656;8098.51408915467;9545.665901693408;11255.268407553483;11274.661760147208;11510.827337589775;11661.6501504955;9373.718788436357;9480;9594.616215351587;9777.85333219988;9786;9493.041997673265;9740.756481087747;10105.44420056904;10185.74535636615;10227.181825454094;8565.828683426173;8797.252233560219;9121.726348209564;9173.807405037302;9597.664081757104;6248.812535623939;6353.301136875032;6538.8365290868105;6831.28271531482;6921.930780692129;7211.963940180265;9530.714078577654;9784.266180036668;10004.699859004242;10053.949730251303 08:59:41 INFO - PROCESS | 12498 | |3;mootools.html;1350.1628990026186;1381.5579014715288;1427.3576890399322;1624.4476877861518;1631.2414727151886;6323.652199129057;7275.1633562140305;7307.159676637189;7728.8067798305;7732.188120247378;7475.813104672386;7710.11333696625;7726.111497177826;7736.767896963086;7742.729004484844;2125.6811478278305;2142.1752625239237;2150.2474134053036;2168.382011126829;2173.880436575988;2135.2846796323174;2147.6026935016994;2189.7810218978134;2194.615942210115;2203.8236941044756;2157.5361297321074;2164.3074216250807;2165.8592191507582;2179.585878683053;2209.9226527071555;2050.1286953045046;2072.450800537851;2081.708560801489;2083.6561967275306;2084.6560317547587;2061.8865962372065;2101.432613194444;2117.343623476712;2128.31893793986;2133.669281261407;7547.886781698279;7556.848863022708;7638.809029774245;7708.768736937901;7717.7298794542485;4470.798814053375;4614.261718125117;4616.169089563878;4619.8152073917;4645.558671926162;2852.5150724376904;2899.420115976792;2907.1278616414993;2954.3943491584387;2961.822290662567;852.7441767469734;892.584947999177;893.7497500699815;897.1163404047008;909.4679612426738;10234.590616375335;10241.385516869012;10248.79502409955;10253.589856405735;10278.897211027868;3899.161680238762;4064.3700226464352;4126.463559737215;4186.91626167475;4224.640905523065;8851.557422128997;8866.689665861664;8871.778205544784;8876.955615221883;8892.688755893512;4594.839180628662;4616.722996620214;4639.953600463952;4645.512221216791;4648.721076735406;3619.3304238715396;4062.5937406259727;4099.85650502231;4240.173166232555;4255.5744425557195;3515.472679098156;3554.1647712787476;3625.746197766131;3699.7595156314756;3714.5728241252064;1176.211938001541;1211.3035004872233;1218.4029825385674;1233.5990802989065;1234.1916044990546;735.0995031086983;833.6248688090384;834.7287131682227;879.331707901999;905.0406569036842;5139.460356662571;5245.737713114329;5281.339832520935;5345.064613692588;5392.91910621341;785.9096203936506;801.5631480842954;809.8137428391385;855.5123579559715;878.7056336127469;3578.3737845876867;3696.5009723687494;3752.2683076799763;3754.4180651998986;3774.2828862516585;9144.497052662035;9516.38143520669;9523.952380238054;9527.666531671359;9568.282378821616;9382.577783999737;9386.765330866647;9399.71800845962;9514.952425237829;9559.139677429064;7085.716571337089;7182.892256616155;7208.06295181623;7222.711091556279;7242.96378518104;5040.218766091261;5136.1268584340005;5190.065788158167;5206.375234971676;5372.731363431891;8474.830503390021;8524.147585241426;8564.871526927225;8571.442856214326;8577.399582029448;8533.146685331418;8560.571971401281;8779.429337093325;8816.955915220382;8832.558372081241;6107.725152368065;6229.345918678655;6317.147185129948;6467.223933128054;6555.967220163869;7104.751333703295;7176.174739904978;7204.279572042754;7218.711251549879;7223.422126229994;6195.96902015487;6314.589551679126;6366.9681651591445;6369.49044076482;6476.384743449365;6232.096346029891;6251.71867265965;6330.3669633036325;6365.840853978688;6384.138141350858;6127.938720612737;6183.721732521957;6200.534959877937;6204.689765511616;6214.658193799384;4046.959530404776;4101.712880098365;4170.770607616489;4198.118395137056;4296.162248361665;4413.183561041217;4425.092855964455;4482.462104547345;4564.406627138451;4663.393758811333 08:59:41 INFO - PROCESS | 12498 | |4;prototype.html;284.1093172902947;290.9781766367522;296.8664101154481;297.21238717398876;299.2085932707988;4917.778699958501;5050.974745126278;5174.240758142231;5220;5237.214417837326;4867.951320486794;5033.144365457872;5038.445770965191;5059.342285502879;5063.74681265937;3986.8405263789414;3987.8604248851298;3989.8603548875794;3998.380251061076;4025.29557327468;3909.4135879618;4009.358502639578;4010.1177740896956;4011.1376054148354;4017.9598204018025;3909.3158697228014;3919.2161567686435;3938.2277974911262;3939.527256729182;3946.585608511108;3913.66733827625;3932.115274063327;3936.15372694872;3938.586448422903;3971.2653159165357;3513.332466831294;3515.9824200878834;3516.578010638714;3522.137076416269;3534.6995505381815;4890.141746136481;4946.431160416562;4947.406311242674;4958.851234462972;5007.4992500749995;4469.351943968139;4501.774911254424;4525.298578720271;4531.116432295704;4553.931691024637;5305.798093791111;5309.787608495655;5351.7056561889085;5357.785688572491;5367.490088441592;3715.5727091384565;3767.6232376762377;3788.3749181385037;3810.942835857464;3811.4663947047434;5543.279373681396;5553.4176607877125;5553.945040335061;5558.527525160326;5567.359753628303;3915.138669492707;3915.4322623219473;3929.6659783918117;3938.7439816411843;3940.4877365942243;3845.903917383588;3957.683385329167;3980.5223373195404;3983.4423180754716;3989.2221016901426;4456.799444025027;4471.105778844244;4471.530489298641;4497.775111244425;4509.165804326144;5257.684538927677;5283.181106928432;5332;5341.93161367728;5342.332208473941;1302.446460254388;1328.8173525562258;1357.5587933921317;1358.4634069542476;1370.1984339161502;911.4986757283467;931.4923366764993;954.3176628710505;960.0687333286701;961.8124465729115;4597.264437689953;4601.447826260804;4626.444826620827;4628;4628.907421851612;5464.398916119224;5480.972595137078;5490.149026900836;5502;5512.80705175317;4412.183746006999;4535.274356103007;4571.508527852328;4643.767811609406;4688.507706690816;2550.3932522511072;2564.7814640335973;2574.961375579368;2584.844909305448;2615.8692065396654;4509.684322097487;4521.914740462265;4558.703684260512;4588.178270363769;4627.490975992638;4855.902881942412;4860.392450943632;4911.238757992445;4932.926006109911;5205.958808238367;5143.871403214875;5161.148410512298;5166.793328266903;5182.455842136596;5200.6619569727845;5554.333479982428;5560.749766260609;5561.916571251353;5563.109902415756;5589.860253493695;5285.920711189412;5379.515843574097;5404.83785486436;5459.645123067146;5459.761497786048;5179.715115668674;5183.896322073613;5190.8961820764125;5201.245819356248;5202.580799928051;3842.865499707497;3877.4215146926977;3880.1463677990796;3884;3889.824957876959;5273.973630131824;5367.946320536901;5488.4237155098135;5605.32736071674;5619.831405057855;5238.90443822474;5390.760125171154;5402.945970540244;5409.891802164014;5417.6478528895495;5324.8817748273295;5389.434109418611;5420.268263784339;5426.344964785778;5440.891182176255;5138.3833939927445;5273.789048438173;5280.099164300772;5307.389650190277;5335.67985920846;5404.783923617155;5432.837014889559;5446.373667028342;5453.509184173285;5462.371827239759;5319.654222475527;5360.70516121617;5362.785488580413;5373.247745315581;5376.7580458878665 08:59:41 INFO - PROCESS | 12498 | |5;yui.html;612.6018088242641;613.9846503837405;620.7423919073582;626.1484381241507;675.1871225758837;11811.468483918223;12121.09091818115;12205.145639805218;12778.233306001646;12784.552540661067;12818.935905320484;13060.869391306107;13070.411831467583;13092.541761038365;13103.868961310383;635.7202830754476;761.8933349331085;790.6876783670475;795.7374066558021;797.0674311056079;759.4683721395018;766.4022062791032;768.9923100768976;786.6538722961878;790.0479921694373;822.1326500541926;823.5017814222399;823.8269963307713;824.6948629007246;824.789678631948;810.3314765318606;814.3200427642926;817.239966830847;819.2913130142443;820.0692214336741;598.6049207523057;599.7840777320162;603.1405247522263;603.8188543436995;603.9003564411867;12941.417636206394;13029.348532573333;13050.86949130506;13076.280804555745;13088.280144592043;12941.935290323583;12967.870321296761;13029.478820847155;13086.411111500005;13112.14771039889;10091.69724908254;10091.949540252252;10128.89871101287;10190.694279171637;10464;3222.2588804574843;3253.9837300813583;3292.571965644475;3325.9168520787175;3402.7788193767324;60292;60938.390616094155;60946.695266523384;61520;62220;9322.906770932339;9391.107844754737;9412.388194767454;9971.601135954626;10146.391216527032;18123.45629631087;18156.727649085275;18295.63408731818;18350.541236469195;18392.26430942774;6442.967785161138;6490.610563366213;6508.869822603616;6606.8348291293105;6713.63075030878;3469.9479507807405;3516.103393634658;3550;3648.2156336387275;3664.1755604988666;2706.8917243310443;2788.512010398172;2813.7748980081547;2814.2120206342256;2819;484.01744458748794;490.79877250327195;491.08902984963095;494.8367038877234;503.87655024518494;484.5203248783679;489.3638270248662;508.02966334302045;531.7633653024367;550.0017468295111;7408.444366672521;7831.192953723825;7867.881981770278;7878.684852605947;8048.919510804934;530.2073400266626;540.2328693255587;552.3316786688072;564.3030856891735;573.2204202284889;3554.7689400188906;3578.499010138583;3603.819809009539;3607.7294202934886;3762.379207430798;91246;92317;92362.53818730863;94970;95481.5225923866;72702.63648681829;73933.63033184799;75378.24621753822;85757;87592;76111.23888761153;76818.61590692123;79220.20779792244;79800;79956;9032.45805251687;9241.815163696823;9287.907120928705;9395.24838012971;9477.957424683142;31449.52825707662;33197.004089877344;43955.78022109997;44021;45033.32450013187;58559.70720146372;63074;63496.68251658712;63584.68207659117;66499;11682.88317116852;12014.310343109397;12063.81904271419;12228.205166664138;12386.504539818667;12562.246265224116;12921.095523313277;13003.544875929298;13141.868581314448;13210.735785284432;11565.595204167814;11619.36093514831;11889.227200231957;12099.33453660057;12213.389330533615;12099.455524501242;12128.514859405877;12147;12249.87750122523;12598.622041338775;11591.420428978687;11874.525018999144;12018.579349722717;12029.278243305429;12602.432890519765;9277.211437027658;9393.906060939576;9566.708291213079;10084.69745907624;10115.949420252851;9720.319577629498;10606.151507879506;10693.251472396858;10726.946365268435;10759.569617215224 08:59:41 INFO - PROCESS | 12498 | __end_tp_report 08:59:41 INFO - PROCESS | 12498 | __start_cc_report 08:59:41 INFO - PROCESS | 12498 | _x_x_mozilla_cycle_collect,356 08:59:41 INFO - PROCESS | 12498 | __end_cc_report 08:59:41 INFO - PROCESS | 12498 | __startTimestamp1469894381204__endTimestamp 08:59:41 INFO - PROCESS | 12498 | 08:59:41 INFO - PROCESS | 12498 | ------- Summary: start ------- 08:59:41 INFO - PROCESS | 12498 | Number of tests: 6 08:59:41 INFO - PROCESS | 12498 | 08:59:41 INFO - PROCESS | 12498 | [#0] dojo.html Cycles:165 Average:4826.76 Median:4944.90 stddev:501.50 (10.1%) stddev-sans-first:473.90 08:59:41 INFO - PROCESS | 12498 | Values: 2679.5 2685.2 2700.4 2718.0 2727.6 4719.2 4858.0 4916.1 4938.2 4948.5 4765.2 4804.8 4862.9 4865.8 4866.0 4420.0 4479.1 4534.8 4549.3 4569.5 4500.4 4584.7 4604.2 4605.2 4615.3 4546.7 4584.5 4599.4 4608.8 4622.4 4354.5 4399.9 4429.9 4488.6 4505.8 4395.3 4410.3 4436.4 4439.2 4509.2 4880.0 4888.3 4889.9 4898.6 4904.0 5180.8 5234.4 5245.2 5305.9 5345.7 5313.7 5321.3 5325.1 5339.5 5366.2 4915.4 4936.4 4936.9 4938.0 4945.2 5138.3 5173.7 5200.7 5206.0 5411.8 5016.7 5028.6 5030.2 5034.4 5067.4 5115.0 5117.1 5124.5 5125.1 5171.2 5031.5 5073.2 5162.2 5201.5 5222.1 5226.1 5236.3 5240.3 5252.4 5270.8 4509.8 4515.9 4518.0 4562.4 4567.0 3831.2 3838.4 3857.5 3888.2 3920.6 4488.8 4513.3 4530.5 4567.9 4575.3 5256.2 5273.7 5275.9 5307.4 5312.7 4399.1 4481.4 4521.5 4542.5 4545.1 4780.1 4785.0 4798.3 4830.4 4834.4 4944.9 4970.9 4972.0 4990.3 5044.5 5097.7 5154.9 5157.4 5204.8 5297.9 4868.1 4891.0 4909.8 4938.0 4943.6 5092.8 5129.0 5133.4 5133.6 5134.7 5036.8 5177.7 5203.3 5237.4 5239.4 5092.6 5099.9 5123.4 5127.0 5144.9 5124.1 5137.2 5138.0 5149.1 5188.6 4652.4 4684.3 4703.7 4855.5 5045.8 4974.5 5031.4 5114.9 5136.1 5215.2 5017.5 5053.2 5064.7 5073.4 5099.5 08:59:41 INFO - PROCESS | 12498 | 08:59:41 INFO - PROCESS | 12498 | [#1] ext.html Cycles:180 Average:39271.36 Median:18723.63 stddev:66651.13 (356.0%) stddev-sans-first:66774.66 08:59:41 INFO - PROCESS | 12498 | Values: 541.0 541.8 549.8 552.4 588.0 34263.0 38821.2 38822.4 38843.6 39029.8 39404.6 39874.8 39903.2 39910.8 39927.2 7677.8 7822.2 7826.3 7828.7 7836.7 7647.0 7768.1 7784.4 7787.6 7794.6 7711.9 7777.0 7800.2 7828.1 7850.2 7747.1 7774.8 7784.2 7821.8 7835.1 7626.7 7713.8 7714.4 7715.3 7746.1 36411.6 36577.5 37043.0 37046.6 37101.8 3038.5 3198.3 3267.9 3393.2 3400.1 28459.4 28915.7 29021.0 29376.6 29421.3 3141.6 3217.6 3226.9 3249.1 3294.0 170121.1 171966.0 172012.0 172620.0 172851.0 30900.8 31952.2 32186.4 54006.0 54657.0 31687.2 31787.8 32058.8 32111.0 32159.7 13340.7 13366.9 13442.7 13445.3 13479.6 11260.9 11263.6 11265.6 11274.8 11336.0 7581.4 7708.3 7755.8 7782.0 7782.6 3059.4 3063.9 3070.0 3098.5 3126.1 871.3 907.0 911.1 971.4 1013.6 26929.9 27177.9 27511.6 27536.0 27935.9 972.7 993.8 995.3 997.5 1018.5 14235.9 14773.8 14791.4 14873.4 14904.0 102511.0 323522.0 323668.0 324650.0 325359.0 45537.3 46231.5 46252.8 46509.3 46687.0 1193.5 1195.1 1230.4 1232.9 1240.4 25610.0 26195.7 26474.7 26721.9 26919.5 40523.0 40612.6 40903.8 40988.8 41046.8 276629.0 276888.0 276938.0 277946.0 278329.0 23959.9 24350.3 24575.0 24596.6 24720.3 39427.4 40279.2 40639.0 40711.8 41414.0 33306.5 34195.5 34641.7 34778.5 34823.8 31365.8 34217.8 34497.0 34671.0 34831.3 34333.7 35667.6 36161.0 36337.6 39388.8 30342.5 32457.0 33382.0 33950.7 34047.1 25368.7 25694.7 25720.4 25726.6 26018.5 08:59:41 INFO - PROCESS | 12498 | 08:59:41 INFO - PROCESS | 12498 | [#2] jquery.html Cycles:180 Average:23506.89 Median:5326.90 stddev:60893.04 (1143.1%) stddev-sans-first:61039.06 08:59:41 INFO - PROCESS | 12498 | Values: 360.4 366.7 369.6 385.0 386.4 15798.5 16640.6 16989.7 17066.3 17174.5 15546.2 15707.8 15884.8 16011.8 16044.8 4956.6 5113.1 5148.3 5156.8 5186.4 3723.7 5140.0 5670.6 5908.6 5946.8 5976.9 5992.9 6012.5 6013.5 6034.5 5989.5 6008.0 6014.1 6043.0 6050.4 5197.8 5302.1 5305.3 5318.8 5335.0 18930.7 19355.3 19499.5 19500.6 20147.6 1915.2 1929.1 2059.1 2092.1 2299.6 13122.7 13161.3 13221.0 13363.3 13422.1 1776.8 1781.3 1786.6 1813.3 1814.7 67749.0 67823.7 69596.0 69819.3 71865.3 9050.7 9129.5 9465.8 9534.3 9659.9 13222.3 13262.6 13264.3 13279.8 13322.5 7306.9 7393.4 7518.5 7546.3 7616.3 7030.9 7031.6 7185.8 7325.5 7397.3 5818.9 5847.2 5885.8 5925.9 5949.2 1680.4 1702.1 1752.4 1812.2 1837.5 833.9 881.1 896.9 908.6 909.2 16673.6 16756.2 17161.4 17433.9 17619.4 888.2 900.7 910.1 933.1 944.7 9989.4 9990.2 9998.6 10130.5 10145.7 353216.0 353884.0 358684.0 388107.0 389263.0 66182.3 66573.3 68293.3 68706.7 70353.9 917.7 927.7 934.6 962.0 968.2 12580.9 14535.3 14964.5 15624.8 15911.1 37278.8 37784.8 38229.8 38747.8 38835.4 50620.2 51625.7 52042.5 52204.2 54079.0 6432.6 7551.9 7730.1 7855.3 8098.5 9545.7 11255.3 11274.7 11510.8 11661.7 9373.7 9480.0 9594.6 9777.9 9786.0 9493.0 9740.8 10105.4 10185.7 10227.2 8565.8 8797.3 9121.7 9173.8 9597.7 6248.8 6353.3 6538.8 6831.3 6921.9 7212.0 9530.7 9784.3 10004.7 10053.9 08:59:41 INFO - PROCESS | 12498 | 08:59:41 INFO - PROCESS | 12498 | [#3] mootools.html Cycles:180 Average:5003.29 Median:5263.54 stddev:2770.93 (52.6%) stddev-sans-first:2765.10 08:59:41 INFO - PROCESS | 12498 | Values: 1350.2 1381.6 1427.4 1624.4 1631.2 6323.7 7275.2 7307.2 7728.8 7732.2 7475.8 7710.1 7726.1 7736.8 7742.7 2125.7 2142.2 2150.2 2168.4 2173.9 2135.3 2147.6 2189.8 2194.6 2203.8 2157.5 2164.3 2165.9 2179.6 2209.9 2050.1 2072.5 2081.7 2083.7 2084.7 2061.9 2101.4 2117.3 2128.3 2133.7 7547.9 7556.8 7638.8 7708.8 7717.7 4470.8 4614.3 4616.2 4619.8 4645.6 2852.5 2899.4 2907.1 2954.4 2961.8 852.7 892.6 893.7 897.1 909.5 10234.6 10241.4 10248.8 10253.6 10278.9 3899.2 4064.4 4126.5 4186.9 4224.6 8851.6 8866.7 8871.8 8877.0 8892.7 4594.8 4616.7 4640.0 4645.5 4648.7 3619.3 4062.6 4099.9 4240.2 4255.6 3515.5 3554.2 3625.7 3699.8 3714.6 1176.2 1211.3 1218.4 1233.6 1234.2 735.1 833.6 834.7 879.3 905.0 5139.5 5245.7 5281.3 5345.1 5392.9 785.9 801.6 809.8 855.5 878.7 3578.4 3696.5 3752.3 3754.4 3774.3 9144.5 9516.4 9524.0 9527.7 9568.3 9382.6 9386.8 9399.7 9515.0 9559.1 7085.7 7182.9 7208.1 7222.7 7243.0 5040.2 5136.1 5190.1 5206.4 5372.7 8474.8 8524.1 8564.9 8571.4 8577.4 8533.1 8560.6 8779.4 8817.0 8832.6 6107.7 6229.3 6317.1 6467.2 6556.0 7104.8 7176.2 7204.3 7218.7 7223.4 6196.0 6314.6 6367.0 6369.5 6476.4 6232.1 6251.7 6330.4 6365.8 6384.1 6127.9 6183.7 6200.5 6204.7 6214.7 4047.0 4101.7 4170.8 4198.1 4296.2 4413.2 4425.1 4482.5 4564.4 4663.4 08:59:41 INFO - PROCESS | 12498 | 08:59:41 INFO - PROCESS | 12498 | [#4] prototype.html Cycles:180 Average:4393.98 Median:4925.35 stddev:1288.80 (26.2%) stddev-sans-first:1254.96 08:59:41 INFO - PROCESS | 12498 | Values: 284.1 291.0 296.9 297.2 299.2 4917.8 5051.0 5174.2 5220.0 5237.2 4868.0 5033.1 5038.4 5059.3 5063.7 3986.8 3987.9 3989.9 3998.4 4025.3 3909.4 4009.4 4010.1 4011.1 4018.0 3909.3 3919.2 3938.2 3939.5 3946.6 3913.7 3932.1 3936.2 3938.6 3971.3 3513.3 3516.0 3516.6 3522.1 3534.7 4890.1 4946.4 4947.4 4958.9 5007.5 4469.4 4501.8 4525.3 4531.1 4553.9 5305.8 5309.8 5351.7 5357.8 5367.5 3715.6 3767.6 3788.4 3810.9 3811.5 5543.3 5553.4 5553.9 5558.5 5567.4 3915.1 3915.4 3929.7 3938.7 3940.5 3845.9 3957.7 3980.5 3983.4 3989.2 4456.8 4471.1 4471.5 4497.8 4509.2 5257.7 5283.2 5332.0 5341.9 5342.3 1302.4 1328.8 1357.6 1358.5 1370.2 911.5 931.5 954.3 960.1 961.8 4597.3 4601.4 4626.4 4628.0 4628.9 5464.4 5481.0 5490.1 5502.0 5512.8 4412.2 4535.3 4571.5 4643.8 4688.5 2550.4 2564.8 2575.0 2584.8 2615.9 4509.7 4521.9 4558.7 4588.2 4627.5 4855.9 4860.4 4911.2 4932.9 5206.0 5143.9 5161.1 5166.8 5182.5 5200.7 5554.3 5560.7 5561.9 5563.1 5589.9 5285.9 5379.5 5404.8 5459.6 5459.8 5179.7 5183.9 5190.9 5201.2 5202.6 3842.9 3877.4 3880.1 3884.0 3889.8 5274.0 5367.9 5488.4 5605.3 5619.8 5238.9 5390.8 5402.9 5409.9 5417.6 5324.9 5389.4 5420.3 5426.3 5440.9 5138.4 5273.8 5280.1 5307.4 5335.7 5404.8 5432.8 5446.4 5453.5 5462.4 5319.7 5360.7 5362.8 5373.2 5376.8 08:59:41 INFO - PROCESS | 12498 | 08:59:41 INFO - PROCESS | 12498 | [#5] yui.html Cycles:180 Average:17452.50 Median:490.94 stddev:24724.34 (5036.1%) stddev-sans-first:24761.37 08:59:41 INFO - PROCESS | 12498 | Values: 612.6 614.0 620.7 626.1 675.2 11811.5 12121.1 12205.1 12778.2 12784.6 12818.9 13060.9 13070.4 13092.5 13103.9 635.7 761.9 790.7 795.7 797.1 759.5 766.4 769.0 786.7 790.0 822.1 823.5 823.8 824.7 824.8 810.3 814.3 817.2 819.3 820.1 598.6 599.8 603.1 603.8 603.9 12941.4 13029.3 13050.9 13076.3 13088.3 12941.9 12967.9 13029.5 13086.4 13112.1 10091.7 10091.9 10128.9 10190.7 10464.0 3222.3 3254.0 3292.6 3325.9 3402.8 60292.0 60938.4 60946.7 61520.0 62220.0 9322.9 9391.1 9412.4 9971.6 10146.4 18123.5 18156.7 18295.6 18350.5 18392.3 6443.0 6490.6 6508.9 6606.8 6713.6 3469.9 3516.1 3550.0 3648.2 3664.2 2706.9 2788.5 2813.8 2814.2 2819.0 484.0 490.8 491.1 494.8 503.9 484.5 489.4 508.0 531.8 550.0 7408.4 7831.2 7867.9 7878.7 8048.9 530.2 540.2 552.3 564.3 573.2 3554.8 3578.5 3603.8 3607.7 3762.4 91246.0 92317.0 92362.5 94970.0 95481.5 72702.6 73933.6 75378.2 85757.0 87592.0 76111.2 76818.6 79220.2 79800.0 79956.0 9032.5 9241.8 9287.9 9395.2 9478.0 31449.5 33197.0 43955.8 44021.0 45033.3 58559.7 63074.0 63496.7 63584.7 66499.0 11682.9 12014.3 12063.8 12228.2 12386.5 12562.2 12921.1 13003.5 13141.9 13210.7 11565.6 11619.4 11889.2 12099.3 12213.4 12099.5 12128.5 12147.0 12249.9 12598.6 11591.4 11874.5 12018.6 12029.3 12602.4 9277.2 9393.9 9566.7 10084.7 10115.9 9720.3 10606.2 10693.3 10726.9 10759.6 08:59:41 INFO - PROCESS | 12498 | -------- Summary: end -------- 08:59:41 INFO - PROCESS | 12498 | 08:59:42 INFO - TEST-INFO | 12498: exit 0 08:59:42 INFO - TEST-OK | dromaeo_css | took 1125982ms 08:59:42 INFO - TEST-START | kraken 08:59:42 INFO - operating with platform_type : linux_ 08:59:42 INFO - Initialising browser for kraken test... 08:59:42 INFO - TEST-INFO | started process 12743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO1JIos/profile http://localhost:47699/getInfo.html) 08:59:49 INFO - PROCESS | 12743 | __metrics Screen width/height:1600/1200 08:59:49 INFO - PROCESS | 12743 | colorDepth:24 08:59:49 INFO - PROCESS | 12743 | Browser inner width/height: 1024/697 08:59:49 INFO - PROCESS | 12743 | __metrics 08:59:50 ERROR - PROCESS | 12743 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:59:51 INFO - TEST-INFO | 12743: exit 0 08:59:51 INFO - Browser initialized. 08:59:51 INFO - Running cycle 1/1 for kraken test... 08:59:51 INFO - TEST-INFO | started process 12862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO1JIos/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:03 INFO - PROCESS | 12862 | RSS: Main: 163897344 09:00:03 INFO - PROCESS | 12862 | 09:00:06 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47699/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:07 INFO - PROCESS | 12862 | RSS: Main: 169201664 09:00:07 INFO - PROCESS | 12862 | 09:00:10 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47699/tests/kraken/driver.html?testName=audio-dft) 09:00:10 INFO - PROCESS | 12862 | RSS: Main: 168087552 09:00:10 INFO - PROCESS | 12862 | 09:00:13 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47699/tests/kraken/driver.html?testName=audio-fft) 09:00:14 INFO - PROCESS | 12862 | RSS: Main: 164454400 09:00:14 INFO - PROCESS | 12862 | 09:00:16 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47699/tests/kraken/driver.html?testName=audio-oscillator) 09:00:17 INFO - PROCESS | 12862 | RSS: Main: 165089280 09:00:17 INFO - PROCESS | 12862 | 09:00:19 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47699/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:20 INFO - PROCESS | 12862 | RSS: Main: 165474304 09:00:20 INFO - PROCESS | 12862 | 09:00:23 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47699/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:24 INFO - PROCESS | 12862 | RSS: Main: 166146048 09:00:24 INFO - PROCESS | 12862 | 09:00:27 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47699/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:28 INFO - PROCESS | 12862 | RSS: Main: 162537472 09:00:28 INFO - PROCESS | 12862 | 09:00:31 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47699/tests/kraken/driver.html?testName=json-parse-financial) 09:00:31 INFO - PROCESS | 12862 | RSS: Main: 164892672 09:00:31 INFO - PROCESS | 12862 | 09:00:33 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47699/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:34 INFO - PROCESS | 12862 | RSS: Main: 164941824 09:00:34 INFO - PROCESS | 12862 | 09:00:36 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47699/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:36 INFO - PROCESS | 12862 | RSS: Main: 165625856 09:00:36 INFO - PROCESS | 12862 | 09:00:38 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47699/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:39 INFO - PROCESS | 12862 | RSS: Main: 166158336 09:00:39 INFO - PROCESS | 12862 | 09:00:42 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:43 INFO - PROCESS | 12862 | RSS: Main: 166383616 09:00:43 INFO - PROCESS | 12862 | 09:00:45 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:46 INFO - PROCESS | 12862 | RSS: Main: 166658048 09:00:46 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:47699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47699/tests/kraken/driver.html?testName=ai-astar) 09:00:48 INFO - PROCESS | 12862 | RSS: Main: 167071744 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | __start_tp_report 09:00:48 INFO - PROCESS | 12862 | _x_x_mozilla_page_load 09:00:48 INFO - PROCESS | 12862 | _x_x_mozilla_page_load_details 09:00:48 INFO - PROCESS | 12862 | |i|pagename|runs| 09:00:48 INFO - PROCESS | 12862 | |0;ai-astar;106;113;108;113;114;114;114;113;114;114 09:00:48 INFO - PROCESS | 12862 | |1;audio-beat-detection;152;125;149;178;122;146;155;125;190;122 09:00:48 INFO - PROCESS | 12862 | |2;audio-dft;163;164;165;176;164;164;163;164;164;166 09:00:48 INFO - PROCESS | 12862 | |3;audio-fft;77;79;80;172;77;88;76;76;162;75 09:00:48 INFO - PROCESS | 12862 | |4;audio-oscillator;86;86;158;86;88;87;132;89;85;138 09:00:48 INFO - PROCESS | 12862 | |5;imaging-gaussian-blur;118;118;117;118;118;118;117;118;118;118 09:00:48 INFO - PROCESS | 12862 | |6;imaging-darkroom;149;149;149;151;148;148;149;149;149;149 09:00:48 INFO - PROCESS | 12862 | |7;imaging-desaturate;95;96;96;96;96;96;97;96;96;95 09:00:48 INFO - PROCESS | 12862 | |8;json-parse-financial;62;65;62;63;62;62;63;71;62;66 09:00:48 INFO - PROCESS | 12862 | |9;json-stringify-tinderbox;64;66;65;65;69;66;66;64;66;66 09:00:48 INFO - PROCESS | 12862 | |10;stanford-crypto-aes;80;85;79;80;83;85;84;79;78;79 09:00:48 INFO - PROCESS | 12862 | |11;stanford-crypto-ccm;143;137;142;146;140;134;134;131;170;132 09:00:48 INFO - PROCESS | 12862 | |12;stanford-crypto-pbkdf2;171;166;167;170;172;165;167;168;170;166 09:00:48 INFO - PROCESS | 12862 | |13;stanford-crypto-sha256-iterative;72;69;73;70;67;69;68;67;68;69 09:00:48 INFO - PROCESS | 12862 | __end_tp_report 09:00:48 INFO - PROCESS | 12862 | __start_cc_report 09:00:48 INFO - PROCESS | 12862 | _x_x_mozilla_cycle_collect,971 09:00:48 INFO - PROCESS | 12862 | __end_cc_report 09:00:48 INFO - PROCESS | 12862 | __startTimestamp1469894448602__endTimestamp 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | ------- Summary: start ------- 09:00:48 INFO - PROCESS | 12862 | Number of tests: 14 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#0] ai-astar Cycles:10 Average:112.30 Median:114.00 stddev:2.87 (2.5%) stddev-sans-first:1.94 09:00:48 INFO - PROCESS | 12862 | Values: 106.0 113.0 108.0 113.0 114.0 114.0 114.0 113.0 114.0 114.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:150.50 stddev:23.85 (15.8%) stddev-sans-first:25.21 09:00:48 INFO - PROCESS | 12862 | Values: 152.0 125.0 149.0 178.0 122.0 146.0 155.0 125.0 190.0 122.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.00 stddev:3.86 (2.4%) stddev-sans-first:4.00 09:00:48 INFO - PROCESS | 12862 | Values: 163.0 164.0 165.0 176.0 164.0 164.0 163.0 164.0 164.0 166.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#3] audio-fft Cycles:10 Average:96.20 Median:77.00 stddev:37.57 (48.8%) stddev-sans-first:39.20 09:00:48 INFO - PROCESS | 12862 | Values: 77.0 79.0 80.0 172.0 77.0 88.0 76.0 76.0 162.0 75.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:86.00 stddev:27.80 (32.3%) stddev-sans-first:28.76 09:00:48 INFO - PROCESS | 12862 | Values: 86.0 86.0 158.0 86.0 88.0 87.0 132.0 89.0 85.0 138.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:00:48 INFO - PROCESS | 12862 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:00:48 INFO - PROCESS | 12862 | Values: 149.0 149.0 149.0 151.0 148.0 148.0 149.0 149.0 149.0 149.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 09:00:48 INFO - PROCESS | 12862 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:63.00 stddev:2.90 (4.6%) stddev-sans-first:3.00 09:00:48 INFO - PROCESS | 12862 | Values: 62.0 65.0 62.0 63.0 62.0 62.0 63.0 71.0 62.0 66.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:1.42 (2.1%) stddev-sans-first:1.36 09:00:48 INFO - PROCESS | 12862 | Values: 64.0 66.0 65.0 65.0 69.0 66.0 66.0 64.0 66.0 66.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:2.74 (3.4%) stddev-sans-first:2.87 09:00:48 INFO - PROCESS | 12862 | Values: 80.0 85.0 79.0 80.0 83.0 85.0 84.0 79.0 78.0 79.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:141.00 stddev:11.39 (8.1%) stddev-sans-first:12.05 09:00:48 INFO - PROCESS | 12862 | Values: 143.0 137.0 142.0 146.0 140.0 134.0 134.0 131.0 170.0 132.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:169.00 stddev:2.39 (1.4%) stddev-sans-first:2.32 09:00:48 INFO - PROCESS | 12862 | Values: 171.0 166.0 167.0 170.0 172.0 165.0 167.0 168.0 170.0 166.0 09:00:48 INFO - PROCESS | 12862 | 09:00:48 INFO - PROCESS | 12862 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.99 (2.9%) stddev-sans-first:1.83 09:00:48 INFO - PROCESS | 12862 | Values: 72.0 69.0 73.0 70.0 67.0 69.0 68.0 67.0 68.0 69.0 09:00:48 INFO - PROCESS | 12862 | -------- Summary: end -------- 09:00:48 INFO - PROCESS | 12862 | 09:00:49 INFO - TEST-INFO | 12862: exit 0 09:00:49 INFO - TEST-OK | kraken | took 67653ms 09:00:49 INFO - SUITE-END | took 1193s 09:00:50 INFO - Completed test suite (00:19:54) 09:00:50 INFO - javascript benchmark 09:00:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6340.8922038405135, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.4507126039166, 2685.2078636802144, 2700.3654141276784, 2717.9592306115405, 2727.6044973478834, 4719.221328480805, 4857.975710121449, 4916.065947469978, 4938.185199442092, 4948.529889660485, 4765.166095933215, 4804.83183088592, 4862.927056094152, 4865.829695960642, 4865.951340486594, 4419.977900110503, 4479.126570318773, 4534.773261336936, 4549.31760235964, 4569.4516658001085, 4500.39244701966, 4584.679072464929, 4604.217283061887, 4605.240135377676, 4615.284630882202, 4546.727196368212, 4584.472785629645, 4599.425071866017, 4608.838690645828, 4622.445306563217, 4354.455693038371, 4399.890002749925, 4429.867103986886, 4488.551144885518, 4505.752183629899, 4395.252807022782, 4410.29435290352, 4436.44544431946, 4439.156560253541, 4509.1658043262105, 4879.951200487985, 4888.266759985995, 4889.902201955941, 4898.632602554822, 4904.0437114762635, 5180.792768289301, 5234.369178031173, 5245.160774276097, 5305.946940530623, 5345.705986170759, 5313.654612450178, 5321.255024296602, 5325.094733895247, 5339.4927481889545, 5366.248725178478, 4915.4347250065985, 4936.432310284292, 4936.8765780855765, 4937.950620493821, 4945.2087665973995, 5138.332016837787, 5173.741312934339, 5200.6619569727845, 5205.973970130125, 5411.783528658888, 5016.698998060128, 5028.572571331478, 5030.245463180552, 5034.446210916796, 5067.442581316052, 5114.974425127851, 5117.053345131163, 5124.538791508782, 5125.1287281162295, 5171.224316352577, 5031.471695471922, 5073.188289873677, 5162.174052151638, 5201.453847345974, 5222.086134926372, 5226.137687281632, 5236.345456817898, 5240.266362709223, 5252.369715634072, 5270.841874743764, 4509.774511274423, 4515.887102822456, 4517.977410112929, 4562.429696287964, 4567.040921406476, 3831.176297096082, 3838.405047217686, 3857.498525191707, 3888.202918401721, 3920.5883382245024, 4488.820447182142, 4513.277875539898, 4530.546945305443, 4567.908641827211, 4575.3365761965, 5256.159014557652, 5273.736313184326, 5275.920861187085, 5307.363116425976, 5312.681239125664, 4399.076193999232, 4481.3726078349055, 4521.502634710179, 4542.523035081335, 4545.0909818036525, 4780.115678599401, 4785.042991401733, 4798.328234047236, 4830.4444988826735, 4834.419869615669, 4944.90110197794, 4970.90058198834, 4971.975140124277, 4990.326305948723, 5044.520770526794, 5097.719625420637, 5154.8969020620125, 5157.355330583677, 5204.7918083276245, 5297.920531192112, 4868.07506573764, 4890.951090489192, 4909.754512274443, 4937.975310123426, 4943.555080042814, 5092.770825312796, 5129.0, 5133.358330208724, 5133.614978876674, 5134.666246693953, 5036.798528058983, 5177.715225662625, 5203.297554830049, 5237.397699264633, 5239.423663396947, 5092.618053645917, 5099.898002039864, 5123.38519377677, 5126.974365128151, 5144.871378215425, 5124.130486927333, 5137.229415587692, 5138.049460849755, 5149.073166829857, 5188.558972487381, 4652.441706995182, 4684.273937539687, 4703.717776933395, 4855.490173531728, 5045.84862454127, 4974.527419895104, 5031.446540880574, 5114.872128196825, 5136.075506408883, 5215.217717342429, 5017.473165317735, 5053.2420136979745, 5064.7467626619255, 5073.3911930568565, 5099.464556221544], "value": 4794.678894722443, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.9729513524322, 541.7589172818097, 549.8432946610214, 552.378574104133, 587.9764809407624, 34263.0, 38821.22357552847, 38822.41766373507, 38843.61156388439, 39029.804850975706, 39404.60595394045, 39874.800625996904, 39903.20193596126, 39910.80044599773, 39927.20145597086, 7677.769666910001, 7822.178671239523, 7826.295633392993, 7828.686852525921, 7836.686532538692, 7647.044119485065, 7768.067831860157, 7784.3772498200005, 7787.571683557402, 7794.610269486503, 7711.884321735179, 7777.02787151606, 7800.219978002211, 7828.138904720477, 7850.214978502161, 7747.0703515577925, 7774.805629859242, 7784.182660820589, 7821.765347039598, 7835.059792824897, 7626.694932202705, 7713.807154821118, 7714.382849372093, 7715.344195743369, 7746.10919744231, 36411.63588364109, 36577.45133822995, 37043.0, 37046.62953370459, 37101.814490927645, 3038.5442183672403, 3198.296374797541, 3267.869285228588, 3393.2025973896116, 3400.1159698478327, 28459.430811383863, 28915.710842891724, 29021.0, 29376.559351609743, 29421.264468388246, 3141.6387115481784, 3217.581714377139, 3226.8547915343865, 3249.106495713674, 3293.950590741141, 170121.14939425225, 171966.0, 172012.0, 172620.0, 172851.0, 30900.845495772377, 31952.201194970312, 32186.35627287441, 54006.0, 54657.0, 31687.20781980423, 31787.84106079501, 32058.83970580132, 32111.03666889997, 32159.67840321567, 13340.73318533624, 13366.93316533411, 13442.663933401547, 13445.260510671811, 13479.595612131652, 11260.943695281636, 11263.605773797877, 11265.605703800491, 11274.830877536844, 11336.0, 7581.3934885209055, 7708.267714567107, 7755.7673269802, 7782.0, 7782.571958542335, 3059.3575349176476, 3063.877444902179, 3069.9539506907413, 3098.4577698903054, 3126.124685088179, 871.333429926107, 906.954652267384, 911.1207684584275, 971.3831716859845, 1013.6046941692746, 26929.86535067312, 27177.912883484834, 27511.58732619012, 27536.0, 27935.860320698266, 972.6790159247431, 993.8260804359353, 995.2734503812258, 997.508724456927, 1018.4602160854758, 14235.928820355832, 14773.778393324108, 14791.408343666133, 14873.405063797327, 14904.0, 102511.0, 323522.0, 323668.0, 324650.0, 325359.0, 45537.316940245924, 46231.53768462272, 46252.768736156104, 46509.30236046462, 46687.0, 1193.4510125342267, 1195.061823504485, 1230.4032544216047, 1232.8582213045436, 1240.3550153920091, 25610.0, 26195.73804261933, 26474.735252648, 26721.86639066792, 26919.461610768067, 40523.0, 40612.59387406206, 40903.795481022404, 40988.79505602453, 41046.79476602598, 276629.0, 276888.0, 276938.0, 277946.0, 278329.0, 23959.880200598884, 24350.26949191527, 24575.0, 24596.6310505339, 24720.258392248263, 39427.40858887062, 40279.1944161121, 40639.0, 40711.79644101761, 41414.0, 33306.500402494465, 34195.48706769351, 34641.65358346384, 34778.478322824674, 34823.825880871445, 31365.843170784, 34217.828910855285, 34497.0, 34671.0, 34831.30337393187, 34333.656663433045, 35667.64332356643, 36161.0, 36337.63662363343, 39388.803055984536, 30342.54486182665, 32457.0, 33382.0, 33950.66049339475, 34047.14882127967, 25368.746312536638, 25694.743052569236, 25720.356991075372, 25726.614100788876, 26018.479630407666], "value": 15779.686472900139, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.43591778866056, 366.6663336363909, 369.59713911836093, 385.02780479289805, 386.37600275554985, 15798.526044218677, 16640.583985400357, 16989.660206795856, 17066.317347306107, 17174.484765457026, 15546.222688865568, 15707.84292157078, 15884.76172857408, 16011.759823602626, 16044.83955160448, 4956.553910148086, 5113.105206588851, 5148.330717006784, 5156.793728250866, 5186.403563590179, 3723.6834869036165, 5139.974300128494, 5670.6030577859565, 5908.586398952075, 5946.762129514815, 5976.940230597704, 5992.880142397149, 6012.488938440216, 6013.548983826208, 6034.487068599153, 5989.520838332945, 6008.0, 6014.0678194879865, 6042.9726946419, 6050.394960503959, 5197.818076367347, 5302.072137375943, 5305.257263983007, 5318.760655770499, 5335.039692855285, 18930.716039259285, 19355.322563710204, 19499.512512187168, 19500.609987800166, 20147.597048059102, 1915.2339064374223, 1929.077447666786, 2059.104289634014, 2092.1422216891, 2299.6320588705894, 13122.737545249041, 13161.276129812952, 13221.0, 13363.33183340829, 13422.0604557681, 1776.8489678377352, 1781.2518742128336, 1786.6158775863253, 1813.2837529175902, 1814.6642871068896, 67749.0, 67823.66088169577, 69596.0, 69819.30180698179, 71865.2813471869, 9050.728478145666, 9129.497877616663, 9465.810683786285, 9534.28492863038, 9659.855102173473, 13222.338883055809, 13262.602121936357, 13264.270465124318, 13279.800802987962, 13322.467101316033, 7306.853862922711, 7393.445491588152, 7518.511296765692, 7546.320831125116, 7616.276453736886, 7030.859382812315, 7031.578105313698, 7185.784426467214, 7325.4872158948365, 7397.334239918433, 5818.941810581925, 5847.210626565359, 5885.793997210077, 5925.851853703692, 5949.196858424144, 1680.4118558504426, 1702.1319127245195, 1752.4304601004724, 1812.1754601656214, 1837.5498002989352, 833.8832563441002, 881.070470653454, 896.8699538567001, 908.5502676175204, 909.1817364372118, 16673.582745466527, 16756.162191890602, 17161.399351022905, 17433.912830435765, 17619.383321583682, 888.200619442494, 900.6532484993194, 910.1353713971753, 933.0809152984305, 944.6646440513518, 9989.400635961865, 9990.200783937413, 9998.600195972569, 10130.493475326204, 10145.695629131138, 353216.0, 353884.0, 358684.0, 388107.0, 389263.0, 66182.33817661858, 66573.33426665768, 68293.31706682869, 68706.65646671735, 70353.94469082968, 917.6971599372191, 927.7495076329218, 934.5841100710119, 962.0379620379621, 968.2109081099022, 12580.937095314464, 14535.328437229853, 14964.476243331432, 15624.765628515808, 15911.124888131264, 37278.8136059318, 37784.811075944446, 38229.80885095668, 38747.806260968515, 38835.41746873856, 50620.24069638885, 51625.7418712919, 52042.47957520528, 52204.216936746736, 54079.0, 6432.6462044588, 7551.924480755122, 7730.11103723079, 7855.253750893656, 8098.51408915467, 9545.665901693408, 11255.268407553483, 11274.661760147208, 11510.827337589775, 11661.6501504955, 9373.718788436357, 9480.0, 9594.616215351587, 9777.85333219988, 9786.0, 9493.041997673265, 9740.756481087747, 10105.44420056904, 10185.74535636615, 10227.181825454094, 8565.828683426173, 8797.252233560219, 9121.726348209564, 9173.807405037302, 9597.664081757104, 6248.812535623939, 6353.301136875032, 6538.8365290868105, 6831.28271531482, 6921.930780692129, 7211.963940180265, 9530.714078577654, 9784.266180036668, 10004.699859004242, 10053.949730251303], "value": 8254.975757879787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.1628990026186, 1381.5579014715288, 1427.3576890399322, 1624.4476877861518, 1631.2414727151886, 6323.652199129057, 7275.1633562140305, 7307.159676637189, 7728.8067798305, 7732.188120247378, 7475.813104672386, 7710.11333696625, 7726.111497177826, 7736.767896963086, 7742.729004484844, 2125.6811478278305, 2142.1752625239237, 2150.2474134053036, 2168.382011126829, 2173.880436575988, 2135.2846796323174, 2147.6026935016994, 2189.7810218978134, 2194.615942210115, 2203.8236941044756, 2157.5361297321074, 2164.3074216250807, 2165.8592191507582, 2179.585878683053, 2209.9226527071555, 2050.1286953045046, 2072.450800537851, 2081.708560801489, 2083.6561967275306, 2084.6560317547587, 2061.8865962372065, 2101.432613194444, 2117.343623476712, 2128.31893793986, 2133.669281261407, 7547.886781698279, 7556.848863022708, 7638.809029774245, 7708.768736937901, 7717.7298794542485, 4470.798814053375, 4614.261718125117, 4616.169089563878, 4619.8152073917, 4645.558671926162, 2852.5150724376904, 2899.420115976792, 2907.1278616414993, 2954.3943491584387, 2961.822290662567, 852.7441767469734, 892.584947999177, 893.7497500699815, 897.1163404047008, 909.4679612426738, 10234.590616375335, 10241.385516869012, 10248.79502409955, 10253.589856405735, 10278.897211027868, 3899.161680238762, 4064.3700226464352, 4126.463559737215, 4186.91626167475, 4224.640905523065, 8851.557422128997, 8866.689665861664, 8871.778205544784, 8876.955615221883, 8892.688755893512, 4594.839180628662, 4616.722996620214, 4639.953600463952, 4645.512221216791, 4648.721076735406, 3619.3304238715396, 4062.5937406259727, 4099.85650502231, 4240.173166232555, 4255.5744425557195, 3515.472679098156, 3554.1647712787476, 3625.746197766131, 3699.7595156314756, 3714.5728241252064, 1176.211938001541, 1211.3035004872233, 1218.4029825385674, 1233.5990802989065, 1234.1916044990546, 735.0995031086983, 833.6248688090384, 834.7287131682227, 879.331707901999, 905.0406569036842, 5139.460356662571, 5245.737713114329, 5281.339832520935, 5345.064613692588, 5392.91910621341, 785.9096203936506, 801.5631480842954, 809.8137428391385, 855.5123579559715, 878.7056336127469, 3578.3737845876867, 3696.5009723687494, 3752.2683076799763, 3754.4180651998986, 3774.2828862516585, 9144.497052662035, 9516.38143520669, 9523.952380238054, 9527.666531671359, 9568.282378821616, 9382.577783999737, 9386.765330866647, 9399.71800845962, 9514.952425237829, 9559.139677429064, 7085.716571337089, 7182.892256616155, 7208.06295181623, 7222.711091556279, 7242.96378518104, 5040.218766091261, 5136.1268584340005, 5190.065788158167, 5206.375234971676, 5372.731363431891, 8474.830503390021, 8524.147585241426, 8564.871526927225, 8571.442856214326, 8577.399582029448, 8533.146685331418, 8560.571971401281, 8779.429337093325, 8816.955915220382, 8832.558372081241, 6107.725152368065, 6229.345918678655, 6317.147185129948, 6467.223933128054, 6555.967220163869, 7104.751333703295, 7176.174739904978, 7204.279572042754, 7218.711251549879, 7223.422126229994, 6195.96902015487, 6314.589551679126, 6366.9681651591445, 6369.49044076482, 6476.384743449365, 6232.096346029891, 6251.71867265965, 6330.3669633036325, 6365.840853978688, 6384.138141350858, 6127.938720612737, 6183.721732521957, 6200.534959877937, 6204.689765511616, 6214.658193799384, 4046.959530404776, 4101.712880098365, 4170.770607616489, 4198.118395137056, 4296.162248361665, 4413.183561041217, 4425.092855964455, 4482.462104547345, 4564.406627138451, 4663.393758811333], "value": 4049.7758715587493, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.1093172902947, 290.9781766367522, 296.8664101154481, 297.21238717398876, 299.2085932707988, 4917.778699958501, 5050.974745126278, 5174.240758142231, 5220.0, 5237.214417837326, 4867.951320486794, 5033.144365457872, 5038.445770965191, 5059.342285502879, 5063.74681265937, 3986.8405263789414, 3987.8604248851298, 3989.8603548875794, 3998.380251061076, 4025.29557327468, 3909.4135879618, 4009.358502639578, 4010.1177740896956, 4011.1376054148354, 4017.9598204018025, 3909.3158697228014, 3919.2161567686435, 3938.2277974911262, 3939.527256729182, 3946.585608511108, 3913.66733827625, 3932.115274063327, 3936.15372694872, 3938.586448422903, 3971.2653159165357, 3513.332466831294, 3515.9824200878834, 3516.578010638714, 3522.137076416269, 3534.6995505381815, 4890.141746136481, 4946.431160416562, 4947.406311242674, 4958.851234462972, 5007.4992500749995, 4469.351943968139, 4501.774911254424, 4525.298578720271, 4531.116432295704, 4553.931691024637, 5305.798093791111, 5309.787608495655, 5351.7056561889085, 5357.785688572491, 5367.490088441592, 3715.5727091384565, 3767.6232376762377, 3788.3749181385037, 3810.942835857464, 3811.4663947047434, 5543.279373681396, 5553.4176607877125, 5553.945040335061, 5558.527525160326, 5567.359753628303, 3915.138669492707, 3915.4322623219473, 3929.6659783918117, 3938.7439816411843, 3940.4877365942243, 3845.903917383588, 3957.683385329167, 3980.5223373195404, 3983.4423180754716, 3989.2221016901426, 4456.799444025027, 4471.105778844244, 4471.530489298641, 4497.775111244425, 4509.165804326144, 5257.684538927677, 5283.181106928432, 5332.0, 5341.93161367728, 5342.332208473941, 1302.446460254388, 1328.8173525562258, 1357.5587933921317, 1358.4634069542476, 1370.1984339161502, 911.4986757283467, 931.4923366764993, 954.3176628710505, 960.0687333286701, 961.8124465729115, 4597.264437689953, 4601.447826260804, 4626.444826620827, 4628.0, 4628.907421851612, 5464.398916119224, 5480.972595137078, 5490.149026900836, 5502.0, 5512.80705175317, 4412.183746006999, 4535.274356103007, 4571.508527852328, 4643.767811609406, 4688.507706690816, 2550.3932522511072, 2564.7814640335973, 2574.961375579368, 2584.844909305448, 2615.8692065396654, 4509.684322097487, 4521.914740462265, 4558.703684260512, 4588.178270363769, 4627.490975992638, 4855.902881942412, 4860.392450943632, 4911.238757992445, 4932.926006109911, 5205.958808238367, 5143.871403214875, 5161.148410512298, 5166.793328266903, 5182.455842136596, 5200.6619569727845, 5554.333479982428, 5560.749766260609, 5561.916571251353, 5563.109902415756, 5589.860253493695, 5285.920711189412, 5379.515843574097, 5404.83785486436, 5459.645123067146, 5459.761497786048, 5179.715115668674, 5183.896322073613, 5190.8961820764125, 5201.245819356248, 5202.580799928051, 3842.865499707497, 3877.4215146926977, 3880.1463677990796, 3884.0, 3889.824957876959, 5273.973630131824, 5367.946320536901, 5488.4237155098135, 5605.32736071674, 5619.831405057855, 5238.90443822474, 5390.760125171154, 5402.945970540244, 5409.891802164014, 5417.6478528895495, 5324.8817748273295, 5389.434109418611, 5420.268263784339, 5426.344964785778, 5440.891182176255, 5138.3833939927445, 5273.789048438173, 5280.099164300772, 5307.389650190277, 5335.67985920846, 5404.783923617155, 5432.837014889559, 5446.373667028342, 5453.509184173285, 5462.371827239759, 5319.654222475527, 5360.70516121617, 5362.785488580413, 5373.247745315581, 5376.7580458878665], "value": 3980.6613008837294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.6018088242641, 613.9846503837405, 620.7423919073582, 626.1484381241507, 675.1871225758837, 11811.468483918223, 12121.09091818115, 12205.145639805218, 12778.233306001646, 12784.552540661067, 12818.935905320484, 13060.869391306107, 13070.411831467583, 13092.541761038365, 13103.868961310383, 635.7202830754476, 761.8933349331085, 790.6876783670475, 795.7374066558021, 797.0674311056079, 759.4683721395018, 766.4022062791032, 768.9923100768976, 786.6538722961878, 790.0479921694373, 822.1326500541926, 823.5017814222399, 823.8269963307713, 824.6948629007246, 824.789678631948, 810.3314765318606, 814.3200427642926, 817.239966830847, 819.2913130142443, 820.0692214336741, 598.6049207523057, 599.7840777320162, 603.1405247522263, 603.8188543436995, 603.9003564411867, 12941.417636206394, 13029.348532573333, 13050.86949130506, 13076.280804555745, 13088.280144592043, 12941.935290323583, 12967.870321296761, 13029.478820847155, 13086.411111500005, 13112.14771039889, 10091.69724908254, 10091.949540252252, 10128.89871101287, 10190.694279171637, 10464.0, 3222.2588804574843, 3253.9837300813583, 3292.571965644475, 3325.9168520787175, 3402.7788193767324, 60292.0, 60938.390616094155, 60946.695266523384, 61520.0, 62220.0, 9322.906770932339, 9391.107844754737, 9412.388194767454, 9971.601135954626, 10146.391216527032, 18123.45629631087, 18156.727649085275, 18295.63408731818, 18350.541236469195, 18392.26430942774, 6442.967785161138, 6490.610563366213, 6508.869822603616, 6606.8348291293105, 6713.63075030878, 3469.9479507807405, 3516.103393634658, 3550.0, 3648.2156336387275, 3664.1755604988666, 2706.8917243310443, 2788.512010398172, 2813.7748980081547, 2814.2120206342256, 2819.0, 484.01744458748794, 490.79877250327195, 491.08902984963095, 494.8367038877234, 503.87655024518494, 484.5203248783679, 489.3638270248662, 508.02966334302045, 531.7633653024367, 550.0017468295111, 7408.444366672521, 7831.192953723825, 7867.881981770278, 7878.684852605947, 8048.919510804934, 530.2073400266626, 540.2328693255587, 552.3316786688072, 564.3030856891735, 573.2204202284889, 3554.7689400188906, 3578.499010138583, 3603.819809009539, 3607.7294202934886, 3762.379207430798, 91246.0, 92317.0, 92362.53818730863, 94970.0, 95481.5225923866, 72702.63648681829, 73933.63033184799, 75378.24621753822, 85757.0, 87592.0, 76111.23888761153, 76818.61590692123, 79220.20779792244, 79800.0, 79956.0, 9032.45805251687, 9241.815163696823, 9287.907120928705, 9395.24838012971, 9477.957424683142, 31449.52825707662, 33197.004089877344, 43955.78022109997, 44021.0, 45033.32450013187, 58559.70720146372, 63074.0, 63496.68251658712, 63584.68207659117, 66499.0, 11682.88317116852, 12014.310343109397, 12063.81904271419, 12228.205166664138, 12386.504539818667, 12562.246265224116, 12921.095523313277, 13003.544875929298, 13141.868581314448, 13210.735785284432, 11565.595204167814, 11619.36093514831, 11889.227200231957, 12099.33453660057, 12213.389330533615, 12099.455524501242, 12128.514859405877, 12147.0, 12249.87750122523, 12598.622041338775, 11591.420428978687, 11874.525018999144, 12018.579349722717, 12029.278243305429, 12602.432890519765, 9277.211437027658, 9393.906060939576, 9566.708291213079, 10084.69745907624, 10115.949420252851, 9720.319577629498, 10606.151507879506, 10693.251472396858, 10726.946365268435, 10759.569617215224], "value": 6455.039959153263, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 108.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 149.0, 178.0, 122.0, 146.0, 155.0, 125.0, 190.0, 122.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 176.0, 164.0, 164.0, 163.0, 164.0, 164.0, 166.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 80.0, 172.0, 77.0, 88.0, 76.0, 76.0, 162.0, 75.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 158.0, 86.0, 88.0, 87.0, 132.0, 89.0, 85.0, 138.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 151.0, 148.0, 148.0, 149.0, 149.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 63.0, 62.0, 62.0, 63.0, 71.0, 62.0, 66.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 69.0, 66.0, 66.0, 64.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 79.0, 80.0, 83.0, 85.0, 84.0, 79.0, 78.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 137.0, 142.0, 146.0, 140.0, 134.0, 134.0, 131.0, 170.0, 132.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 167.0, 170.0, 172.0, 165.0, 167.0, 168.0, 170.0, 166.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 73.0, 70.0, 67.0, 69.0, 68.0, 67.0, 68.0, 69.0], "value": 69.2, "unit": "score"}]}]} 09:00:50 INFO - Return code: 0 09:00:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:00:50 ERROR - # TBPL SUCCESS # 09:00:50 INFO - Running post-action listener: _resource_record_post_action 09:00:50 INFO - [mozharness: 2016-07-30 16:00:50.404895Z] Finished run-tests step (success) 09:00:50 INFO - Running post-run listener: _resource_record_post_run 09:00:50 INFO - Total resource usage - Wall time: 1214s; CPU: 14.0%; Read bytes: 8192; Write bytes: 536928256; Read time: 5308; Write time: 2582384 09:00:50 INFO - TinderboxPrint: CPU usage
13.7% 09:00:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 5,308 09:00:50 INFO - TinderboxPrint: I/O write bytes / time
536,928,256 / 2,582,384 09:00:50 INFO - TinderboxPrint: CPU idle
8,359.2 (86.3%) 09:00:50 INFO - TinderboxPrint: CPU user
1,220.2 (12.6%) 09:00:50 INFO - TinderboxPrint: Swap in / out
0 / 0 09:00:50 INFO - install - Wall time: 20s; CPU: 21.0%; Read bytes: 0; Write bytes: 224198656; Read time: 0; Write time: 1329064 09:00:50 INFO - run-tests - Wall time: 1194s; CPU: 14.0%; Read bytes: 8192; Write bytes: 296173568; Read time: 5308; Write time: 1099112 09:00:51 INFO - Running post-run listener: _upload_blobber_files 09:00:51 INFO - Blob upload gear active. 09:00:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:51 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 09:00:51 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:00:51 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:00:51 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:00:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:55 INFO - (blobuploader) - INFO - Done attempting. 09:00:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:00:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:56 INFO - (blobuploader) - INFO - Done attempting. 09:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:56 INFO - (blobuploader) - INFO - Done attempting. 09:00:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:56 INFO - Return code: 0 09:00:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33bb3087a1f6bd504532d9b60a83232678f145843da7c70d57fab9ed96f6548448bbad74ed24a6c267f01960b81436d7fcc23ee752f10f23eb7e32e95a8c4785", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d34b6138034c92c2e3f3673bb805066e914e7166262b67b54777983084f0a25ec6141fec00b718c9e8e080e5c3310f67c0ed7f290d259c5764644b94953d9b14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/601b823edf804c47fa6091cb41636810a49ddbd220e90b85215612a3fd9200fb7c903e338333a7defafb70e8afe2786e4002ace621496364870f28eae83fd363"} 09:00:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:56 INFO - Contents: 09:00:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33bb3087a1f6bd504532d9b60a83232678f145843da7c70d57fab9ed96f6548448bbad74ed24a6c267f01960b81436d7fcc23ee752f10f23eb7e32e95a8c4785", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d34b6138034c92c2e3f3673bb805066e914e7166262b67b54777983084f0a25ec6141fec00b718c9e8e080e5c3310f67c0ed7f290d259c5764644b94953d9b14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/601b823edf804c47fa6091cb41636810a49ddbd220e90b85215612a3fd9200fb7c903e338333a7defafb70e8afe2786e4002ace621496364870f28eae83fd363"} 09:00:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:56 INFO - Copying logs to upload dir... 09:00:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.645582 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-30 09:00:54.708525) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 09:00:54.712376) ========= 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=33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935 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-Non-PGO/sha512/33bb3087a1f6bd504532d9b60a83232678f145843da7c70d57fab9ed96f6548448bbad74ed24a6c267f01960b81436d7fcc23ee752f10f23eb7e32e95a8c4785", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d34b6138034c92c2e3f3673bb805066e914e7166262b67b54777983084f0a25ec6141fec00b718c9e8e080e5c3310f67c0ed7f290d259c5764644b94953d9b14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/601b823edf804c47fa6091cb41636810a49ddbd220e90b85215612a3fd9200fb7c903e338333a7defafb70e8afe2786e4002ace621496364870f28eae83fd363"} build_url:https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/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-Non-PGO/sha512/33bb3087a1f6bd504532d9b60a83232678f145843da7c70d57fab9ed96f6548448bbad74ed24a6c267f01960b81436d7fcc23ee752f10f23eb7e32e95a8c4785", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d34b6138034c92c2e3f3673bb805066e914e7166262b67b54777983084f0a25ec6141fec00b718c9e8e080e5c3310f67c0ed7f290d259c5764644b94953d9b14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/601b823edf804c47fa6091cb41636810a49ddbd220e90b85215612a3fd9200fb7c903e338333a7defafb70e8afe2786e4002ace621496364870f28eae83fd363"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 09:00:54.742029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 09:00:54.742354) ========= 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=33d5923976266a1c518c4bf7000001ab-1469890682.186089-1906773935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 09:00:54.825946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 09:00:54.826275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 09:00:54.826580) ========= ========= Total master_lag: 0.21 =========