builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1464153528.79 results: success (0) buildid: 20160524193102 builduid: fd7b3a4e974347269d7a5ee2113ce351 revision: ba0982c4e30cfbc79ef1f4e25c4a1afb0766cfec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:48.786337) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:48.786831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:48.787109) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:48.801750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:48.802040) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 22:18:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-05-24 22:18:49 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090291 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:48.906511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:48.906914) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018553 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:48.956939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 22:18:48.957309) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ba0982c4e30cfbc79ef1f4e25c4a1afb0766cfec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ba0982c4e30cfbc79ef1f4e25c4a1afb0766cfec --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=652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 22:18:49,357 truncating revision to first 12 chars 2016-05-24 22:18:49,357 Setting DEBUG logging. 2016-05-24 22:18:49,357 attempt 1/10 2016-05-24 22:18:49,357 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ba0982c4e30c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 22:18:50,132 unpacking tar archive at: mozilla-inbound-ba0982c4e30c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.053662 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 22:18:50.024362) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:50.024707) ========= script_repo_revision: ba0982c4e30cfbc79ef1f4e25c4a1afb0766cfec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:50.025110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:50.025376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 22:18:50.035961) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-24 22:18:50.036326) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:18:50 INFO - MultiFileLogger online at 20160524 22:18:50 in /builds/slave/test 22:18:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:18:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:18:50 INFO - {'append_to_log': False, 22:18:50 INFO - 'base_work_dir': '/builds/slave/test', 22:18:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:18:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:18:50 INFO - 'branch': 'Mozilla-Inbound', 22:18:50 INFO - 'buildbot_json_path': 'buildprops.json', 22:18:50 INFO - 'config_files': ('talos/linux_config.py',), 22:18:50 INFO - 'default_actions': ('clobber', 22:18:50 INFO - 'read-buildbot-config', 22:18:50 INFO - 'download-and-extract', 22:18:50 INFO - 'populate-webroot', 22:18:50 INFO - 'create-virtualenv', 22:18:50 INFO - 'install', 22:18:50 INFO - 'run-tests'), 22:18:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:18:50 INFO - 'download_minidump_stackwalk': True, 22:18:50 INFO - 'download_symbols': 'ondemand', 22:18:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:18:50 INFO - 'tooltool.py': '/tools/tooltool.py', 22:18:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:18:50 INFO - '/tools/misc-python/virtualenv.py')}, 22:18:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:18:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:18:50 INFO - 'installer_path': 'installer.exe', 22:18:50 INFO - 'log_level': 'info', 22:18:50 INFO - 'log_name': 'talos', 22:18:50 INFO - 'log_to_console': True, 22:18:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:18:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:18:50 INFO - 'opt_config_files': (), 22:18:50 INFO - 'pip_index': False, 22:18:50 INFO - 'sps_profile': False, 22:18:50 INFO - 'sps_profile_interval': 0, 22:18:50 INFO - 'suite': 'dromaeojs-e10s', 22:18:50 INFO - 'system_bits': '32', 22:18:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:18:50 INFO - 'title': 'talos-linux64-ix-046', 22:18:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:18:50 INFO - 'use_talos_json': True, 22:18:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:18:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:18:50 INFO - 'work_dir': 'build'} 22:18:50 INFO - ##### 22:18:50 INFO - ##### Running clobber step. 22:18:50 INFO - ##### 22:18:50 INFO - Running pre-action listener: _resource_record_pre_action 22:18:50 INFO - Running main action method: clobber 22:18:50 INFO - rmtree: /builds/slave/test/build 22:18:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:18:51 INFO - Running post-action listener: _resource_record_post_action 22:18:51 INFO - ##### 22:18:51 INFO - ##### Finished clobber step (success) 22:18:51 INFO - ##### 22:18:51 INFO - ##### 22:18:51 INFO - ##### Running read-buildbot-config step. 22:18:51 INFO - ##### 22:18:51 INFO - Running pre-action listener: _resource_record_pre_action 22:18:51 INFO - Running main action method: read_buildbot_config 22:18:51 INFO - Using buildbot properties: 22:18:51 INFO - { 22:18:51 INFO - "project": "", 22:18:51 INFO - "product": "firefox", 22:18:51 INFO - "script_repo_revision": "production", 22:18:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:18:51 INFO - "repository": "", 22:18:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:18:51 INFO - "buildid": "20160524193102", 22:18:51 INFO - "pgo_build": "True", 22:18:51 INFO - "basedir": "/builds/slave/test", 22:18:51 INFO - "buildnumber": 1070, 22:18:51 INFO - "slavename": "talos-linux64-ix-046", 22:18:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:18:51 INFO - "platform": "ubuntu64_hw", 22:18:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:18:51 INFO - "branch": "mozilla-inbound", 22:18:51 INFO - "repo_path": "integration/mozilla-inbound", 22:18:51 INFO - "revision": "ba0982c4e30cfbc79ef1f4e25c4a1afb0766cfec", 22:18:51 INFO - "stage_platform": "linux64-pgo", 22:18:51 INFO - "builduid": "fd7b3a4e974347269d7a5ee2113ce351", 22:18:51 INFO - "slavebuilddir": "test" 22:18:51 INFO - } 22:18:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:18:51 INFO - Running post-action listener: _resource_record_post_action 22:18:51 INFO - ##### 22:18:51 INFO - ##### Finished read-buildbot-config step (success) 22:18:51 INFO - ##### 22:18:51 INFO - ##### 22:18:51 INFO - ##### Running download-and-extract step. 22:18:51 INFO - ##### 22:18:51 INFO - Running pre-action listener: _resource_record_pre_action 22:18:51 INFO - Running main action method: download_and_extract 22:18:51 INFO - mkdir: /builds/slave/test/build/tests 22:18:51 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')]} 22:18:51 INFO - https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:18:51 INFO - Downloaded 1361 bytes. 22:18:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:18:51 INFO - Using the following test package requirements: 22:18:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:18:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:18:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:18:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:51 INFO - u'jsshell-linux-x86_64.zip'], 22:18:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:18:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:18:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:18:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:18:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:18:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:18:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:18:51 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')]} 22:18:51 INFO - https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:18:52 INFO - Downloaded 24420905 bytes. 22:18:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:18:54 INFO - Return code: 0 22:18:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:18:54 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')]} 22:18:54 INFO - https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:18:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:18:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:18:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:18:55 INFO - Downloaded 24420905 bytes. 22:18:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:18:56 INFO - Return code: 0 22:18:56 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')]} 22:18:56 INFO - https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:18:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:18:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:18:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:18:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:18:57 INFO - Downloaded 10834034 bytes. 22:18:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:18:57 INFO - Return code: 0 22:18:57 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')]} 22:18:57 INFO - https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:18:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:18:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:18:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:18:59 INFO - Downloaded 58661332 bytes. 22:18:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:18:59 INFO - mkdir: /builds/slave/test/properties 22:18:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:18:59 INFO - Writing to file /builds/slave/test/properties/build_url 22:18:59 INFO - Contents: 22:18:59 INFO - build_url:https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:18:59 INFO - Running post-action listener: _resource_record_post_action 22:18:59 INFO - Running post-action listener: set_extra_try_arguments 22:18:59 INFO - ##### 22:18:59 INFO - ##### Finished download-and-extract step (success) 22:18:59 INFO - ##### 22:18:59 INFO - ##### 22:18:59 INFO - ##### Running populate-webroot step. 22:18:59 INFO - ##### 22:18:59 INFO - Running pre-action listener: _resource_record_pre_action 22:18:59 INFO - Running main action method: populate_webroot 22:18:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:18:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:18:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:18:59 INFO - '--tppagecycles', 22:18:59 INFO - '7'], 22:18:59 INFO - 'tests': ['tsvgm']}}, 22:18:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:18:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:18:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:18:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:18:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:59 INFO - 'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:18:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:18:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:59 INFO - 'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['damp', 'tps']}, 22:18:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:59 INFO - 'tests': ['damp', 'tps']}, 22:18:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['dromaeo_dom']}, 22:18:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:18:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['a11yr', 22:18:59 INFO - 'ts_paint', 22:18:59 INFO - 'tpaint', 22:18:59 INFO - 'sessionrestore', 22:18:59 INFO - 'sessionrestore_no_auto_restore', 22:18:59 INFO - 'tabpaint']}, 22:18:59 INFO - 'other-e10s': {'tests': ['a11yr', 22:18:59 INFO - 'ts_paint', 22:18:59 INFO - 'tpaint', 22:18:59 INFO - 'sessionrestore', 22:18:59 INFO - 'sessionrestore_no_auto_restore', 22:18:59 INFO - 'tabpaint']}, 22:18:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:18:59 INFO - 'ts_paint', 22:18:59 INFO - 'tpaint', 22:18:59 INFO - 'sessionrestore', 22:18:59 INFO - 'sessionrestore_no_auto_restore', 22:18:59 INFO - 'tabpaint']}, 22:18:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:18:59 INFO - 'ts_paint', 22:18:59 INFO - 'tpaint', 22:18:59 INFO - 'sessionrestore', 22:18:59 INFO - 'sessionrestore_no_auto_restore', 22:18:59 INFO - 'tabpaint']}, 22:18:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['a11yr', 22:18:59 INFO - 'ts_paint', 22:18:59 INFO - 'tpaint', 22:18:59 INFO - 'sessionrestore', 22:18:59 INFO - 'sessionrestore_no_auto_restore', 22:18:59 INFO - 'tabpaint']}, 22:18:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['a11yr', 22:18:59 INFO - 'ts_paint', 22:18:59 INFO - 'tpaint', 22:18:59 INFO - 'sessionrestore', 22:18:59 INFO - 'sessionrestore_no_auto_restore', 22:18:59 INFO - 'tabpaint']}, 22:18:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['tsvgx', 22:18:59 INFO - 'tsvgr_opacity', 22:18:59 INFO - 'tart', 22:18:59 INFO - 'tscrollx', 22:18:59 INFO - 'cart']}, 22:18:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:18:59 INFO - 'tsvgr_opacity', 22:18:59 INFO - 'tart', 22:18:59 INFO - 'tscrollx', 22:18:59 INFO - 'cart']}, 22:18:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:59 INFO - 'talos_options': ['--disable-e10s'], 22:18:59 INFO - 'tests': ['tp5o']}, 22:18:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:59 INFO - 'tests': ['tp5o']}, 22:18:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:59 INFO - 'talos_options': ['--disable-e10s', 22:18:59 INFO - '--xperf_path', 22:18:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:18:59 INFO - 'tests': ['tp5n']}, 22:18:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:59 INFO - 'talos_options': ['--xperf_path', 22:18:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:18:59 INFO - 'tests': ['tp5n']}}, 22:18:59 INFO - 'talos.zip': {'path': '', 22:18:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:18:59 INFO - Running post-action listener: _resource_record_post_action 22:18:59 INFO - ##### 22:18:59 INFO - ##### Finished populate-webroot step (success) 22:18:59 INFO - ##### 22:18:59 INFO - ##### 22:18:59 INFO - ##### Running create-virtualenv step. 22:18:59 INFO - ##### 22:18:59 INFO - Running pre-action listener: _resource_record_pre_action 22:18:59 INFO - Running main action method: create_virtualenv 22:18:59 INFO - Creating virtualenv /builds/slave/test/build/venv 22:18:59 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 22:18:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:19:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:19:00 INFO - Using real prefix '/usr' 22:19:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:19:00 INFO - Installing distribute.............................................................................................................................................................................................done. 22:19:02 INFO - Installing pip.................done. 22:19:02 INFO - Return code: 0 22:19:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:02 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 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:02 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 22:19:02 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 22:19:02 INFO - Using env: {'DISPLAY': ':0', 22:19:02 INFO - 'HOME': '/home/cltbld', 22:19:02 INFO - 'LANG': 'en_US.UTF-8', 22:19:02 INFO - 'LANGUAGE': 'en_US:en', 22:19:02 INFO - 'LOGNAME': 'cltbld', 22:19:02 INFO - 'MAIL': '/var/mail/cltbld', 22:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:02 INFO - 'MOZ_NO_REMOTE': '1', 22:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:02 INFO - 'NO_EM_RESTART': '1', 22:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:02 INFO - 'PWD': '/builds/slave/test', 22:19:02 INFO - 'SHELL': '/bin/bash', 22:19:02 INFO - 'SHLVL': '1', 22:19:02 INFO - 'TERM': 'linux', 22:19:02 INFO - 'TMOUT': '86400', 22:19:02 INFO - 'USER': 'cltbld', 22:19:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:02 INFO - '_': '/tools/buildbot/bin/python'} 22:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:02 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 22:19:02 INFO - Cleaning up... 22:19:02 INFO - Return code: 0 22:19:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:02 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 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:02 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 22:19:02 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 22:19:02 INFO - Using env: {'DISPLAY': ':0', 22:19:02 INFO - 'HOME': '/home/cltbld', 22:19:02 INFO - 'LANG': 'en_US.UTF-8', 22:19:02 INFO - 'LANGUAGE': 'en_US:en', 22:19:02 INFO - 'LOGNAME': 'cltbld', 22:19:02 INFO - 'MAIL': '/var/mail/cltbld', 22:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:02 INFO - 'MOZ_NO_REMOTE': '1', 22:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:02 INFO - 'NO_EM_RESTART': '1', 22:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:02 INFO - 'PWD': '/builds/slave/test', 22:19:02 INFO - 'SHELL': '/bin/bash', 22:19:02 INFO - 'SHLVL': '1', 22:19:02 INFO - 'TERM': 'linux', 22:19:02 INFO - 'TMOUT': '86400', 22:19:02 INFO - 'USER': 'cltbld', 22:19:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:02 INFO - '_': '/tools/buildbot/bin/python'} 22:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:02 INFO - Downloading/unpacking psutil>=3.1.1 22:19:02 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 22:19:02 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 22:19:02 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 22:19:02 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 22:19:02 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 22:19:02 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 22:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:19:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:04 INFO - Installing collected packages: psutil 22:19:04 INFO - Running setup.py install for psutil 22:19:04 INFO - building 'psutil._psutil_linux' extension 22:19:04 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 22:19:05 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 22:19:05 INFO - building 'psutil._psutil_posix' extension 22:19:05 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 22:19:05 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 22:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:05 INFO - Successfully installed psutil 22:19:05 INFO - Cleaning up... 22:19:05 INFO - Return code: 0 22:19:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:05 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 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:05 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 22:19:05 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 22:19:05 INFO - Using env: {'DISPLAY': ':0', 22:19:05 INFO - 'HOME': '/home/cltbld', 22:19:05 INFO - 'LANG': 'en_US.UTF-8', 22:19:05 INFO - 'LANGUAGE': 'en_US:en', 22:19:05 INFO - 'LOGNAME': 'cltbld', 22:19:05 INFO - 'MAIL': '/var/mail/cltbld', 22:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:05 INFO - 'MOZ_NO_REMOTE': '1', 22:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:05 INFO - 'NO_EM_RESTART': '1', 22:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:05 INFO - 'PWD': '/builds/slave/test', 22:19:05 INFO - 'SHELL': '/bin/bash', 22:19:05 INFO - 'SHLVL': '1', 22:19:05 INFO - 'TERM': 'linux', 22:19:05 INFO - 'TMOUT': '86400', 22:19:05 INFO - 'USER': 'cltbld', 22:19:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:05 INFO - '_': '/tools/buildbot/bin/python'} 22:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:19:05 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 22:19:05 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 22:19:05 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 22:19:05 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 22:19:05 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 22:19:05 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 22:19:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:19:07 INFO - Installing collected packages: mozsystemmonitor 22:19:07 INFO - Running setup.py install for mozsystemmonitor 22:19:07 INFO - Successfully installed mozsystemmonitor 22:19:07 INFO - Cleaning up... 22:19:07 INFO - Return code: 0 22:19:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:07 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 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:07 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 22:19:07 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 22:19:07 INFO - Using env: {'DISPLAY': ':0', 22:19:07 INFO - 'HOME': '/home/cltbld', 22:19:07 INFO - 'LANG': 'en_US.UTF-8', 22:19:07 INFO - 'LANGUAGE': 'en_US:en', 22:19:07 INFO - 'LOGNAME': 'cltbld', 22:19:07 INFO - 'MAIL': '/var/mail/cltbld', 22:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:07 INFO - 'MOZ_NO_REMOTE': '1', 22:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:07 INFO - 'NO_EM_RESTART': '1', 22:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:07 INFO - 'PWD': '/builds/slave/test', 22:19:07 INFO - 'SHELL': '/bin/bash', 22:19:07 INFO - 'SHLVL': '1', 22:19:07 INFO - 'TERM': 'linux', 22:19:07 INFO - 'TMOUT': '86400', 22:19:07 INFO - 'USER': 'cltbld', 22:19:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:07 INFO - '_': '/tools/buildbot/bin/python'} 22:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:07 INFO - Downloading/unpacking blobuploader==1.2.4 22:19:07 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 22:19:07 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 22:19:07 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 22:19:07 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 22:19:07 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 22:19:07 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 22:19:09 INFO - Downloading blobuploader-1.2.4.tar.gz 22:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:19:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:19:09 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 22:19:09 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 22:19:09 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 22:19:09 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 22:19:09 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 22:19:09 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 22:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:19:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:19:10 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 22:19:10 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 22:19:10 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 22:19:10 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 22:19:10 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 22:19:10 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 22:19:10 INFO - Downloading docopt-0.6.1.tar.gz 22:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:19:10 INFO - Installing collected packages: blobuploader, requests, docopt 22:19:10 INFO - Running setup.py install for blobuploader 22:19:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:19:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:19:10 INFO - Running setup.py install for requests 22:19:11 INFO - Running setup.py install for docopt 22:19:11 INFO - Successfully installed blobuploader requests docopt 22:19:11 INFO - Cleaning up... 22:19:11 INFO - Return code: 0 22:19:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:11 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 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:11 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 22:19:11 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 22:19:11 INFO - Using env: {'DISPLAY': ':0', 22:19:11 INFO - 'HOME': '/home/cltbld', 22:19:11 INFO - 'LANG': 'en_US.UTF-8', 22:19:11 INFO - 'LANGUAGE': 'en_US:en', 22:19:11 INFO - 'LOGNAME': 'cltbld', 22:19:11 INFO - 'MAIL': '/var/mail/cltbld', 22:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:11 INFO - 'MOZ_NO_REMOTE': '1', 22:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:11 INFO - 'NO_EM_RESTART': '1', 22:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:11 INFO - 'PWD': '/builds/slave/test', 22:19:11 INFO - 'SHELL': '/bin/bash', 22:19:11 INFO - 'SHLVL': '1', 22:19:11 INFO - 'TERM': 'linux', 22:19:11 INFO - 'TMOUT': '86400', 22:19:11 INFO - 'USER': 'cltbld', 22:19:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:11 INFO - '_': '/tools/buildbot/bin/python'} 22:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:11 INFO - Running setup.py (path:/tmp/pip-DCs4k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:11 INFO - Running setup.py (path:/tmp/pip-yABWGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:11 INFO - Running setup.py (path:/tmp/pip-BQsVnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:11 INFO - Running setup.py (path:/tmp/pip-f2AXxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:11 INFO - Running setup.py (path:/tmp/pip-SyQZWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:11 INFO - Running setup.py (path:/tmp/pip-gzEfUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:11 INFO - Running setup.py (path:/tmp/pip-fwMa0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:11 INFO - Running setup.py (path:/tmp/pip-w26eIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:11 INFO - Running setup.py (path:/tmp/pip-J3mvOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:12 INFO - Running setup.py (path:/tmp/pip-i3pytb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:12 INFO - Running setup.py (path:/tmp/pip-pzXoo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:12 INFO - Running setup.py (path:/tmp/pip-O_YalS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:12 INFO - Running setup.py (path:/tmp/pip-m6FOVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:12 INFO - Running setup.py (path:/tmp/pip-5OjkNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:12 INFO - Running setup.py (path:/tmp/pip-qVKAlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:12 INFO - Running setup.py (path:/tmp/pip-MW_L90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:12 INFO - Running setup.py (path:/tmp/pip-Xq2Q90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:19:12 INFO - Running setup.py install for manifestparser 22:19:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:19:12 INFO - Running setup.py install for mozcrash 22:19:12 INFO - Running setup.py install for mozdebug 22:19:12 INFO - Running setup.py install for mozdevice 22:19:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Running setup.py install for mozfile 22:19:13 INFO - Running setup.py install for mozhttpd 22:19:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Running setup.py install for mozinfo 22:19:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Running setup.py install for mozInstall 22:19:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Running setup.py install for mozleak 22:19:13 INFO - Running setup.py install for mozlog 22:19:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Running setup.py install for moznetwork 22:19:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Running setup.py install for mozprocess 22:19:13 INFO - Running setup.py install for mozprofile 22:19:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:19:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:19:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:19:14 INFO - Running setup.py install for mozrunner 22:19:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:19:14 INFO - Running setup.py install for mozscreenshot 22:19:14 INFO - Running setup.py install for moztest 22:19:14 INFO - Running setup.py install for mozversion 22:19:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:19:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:19:14 INFO - Cleaning up... 22:19:14 INFO - Return code: 0 22:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:14 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')]} 22:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:14 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')]} 22:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:14 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 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:14 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 22:19:14 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 22:19:14 INFO - Using env: {'DISPLAY': ':0', 22:19:14 INFO - 'HOME': '/home/cltbld', 22:19:14 INFO - 'LANG': 'en_US.UTF-8', 22:19:14 INFO - 'LANGUAGE': 'en_US:en', 22:19:14 INFO - 'LOGNAME': 'cltbld', 22:19:14 INFO - 'MAIL': '/var/mail/cltbld', 22:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:14 INFO - 'MOZ_NO_REMOTE': '1', 22:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:14 INFO - 'NO_EM_RESTART': '1', 22:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:14 INFO - 'PWD': '/builds/slave/test', 22:19:14 INFO - 'SHELL': '/bin/bash', 22:19:14 INFO - 'SHLVL': '1', 22:19:14 INFO - 'TERM': 'linux', 22:19:14 INFO - 'TMOUT': '86400', 22:19:14 INFO - 'USER': 'cltbld', 22:19:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:14 INFO - '_': '/tools/buildbot/bin/python'} 22:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:14 INFO - Running setup.py (path:/tmp/pip-m16pr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:14 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)) 22:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:14 INFO - Running setup.py (path:/tmp/pip-ABVOmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:14 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)) 22:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:14 INFO - Running setup.py (path:/tmp/pip-YMfx4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:14 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)) 22:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:14 INFO - Running setup.py (path:/tmp/pip-jcJ8pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:14 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)) 22:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:14 INFO - Running setup.py (path:/tmp/pip-Ca9nre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:15 INFO - Running setup.py (path:/tmp/pip-d5iSN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:15 INFO - Running setup.py (path:/tmp/pip-RQU3Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:15 INFO - Running setup.py (path:/tmp/pip-thM2T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:15 INFO - Running setup.py (path:/tmp/pip-iofr27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:15 INFO - Running setup.py (path:/tmp/pip-Svr3L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:15 INFO - Running setup.py (path:/tmp/pip-5Hn9Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:15 INFO - Running setup.py (path:/tmp/pip-jwooSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:15 INFO - Running setup.py (path:/tmp/pip-yIry1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:15 INFO - Running setup.py (path:/tmp/pip-Ua4nPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:15 INFO - Running setup.py (path:/tmp/pip-7w4GMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:15 INFO - Running setup.py (path:/tmp/pip-PJ6IWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:15 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)) 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:15 INFO - Running setup.py (path:/tmp/pip-wjNFNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:15 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)) 22:19:15 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)) 22:19:15 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)) 22:19:15 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)) 22:19:15 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)) 22:19:15 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)) 22:19:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19:15 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 22:19:15 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 22:19:15 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 22:19:15 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 22:19:15 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 22:19:15 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 22:19:17 INFO - Downloading blessings-1.6.tar.gz 22:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:19:17 INFO - Installing collected packages: blessings 22:19:17 INFO - Running setup.py install for blessings 22:19:17 INFO - Successfully installed blessings 22:19:17 INFO - Cleaning up... 22:19:18 INFO - Return code: 0 22:19:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:18 INFO - Reading from file tmpfile_stdout 22:19:18 INFO - Current package versions: 22:19:18 INFO - argparse == 1.2.1 22:19:18 INFO - blessings == 1.6 22:19:18 INFO - blobuploader == 1.2.4 22:19:18 INFO - docopt == 0.6.1 22:19:18 INFO - manifestparser == 1.1 22:19:18 INFO - mozInstall == 1.12 22:19:18 INFO - mozcrash == 0.17 22:19:18 INFO - mozdebug == 0.1 22:19:18 INFO - mozdevice == 0.48 22:19:18 INFO - mozfile == 1.2 22:19:18 INFO - mozhttpd == 0.7 22:19:18 INFO - mozinfo == 0.9 22:19:18 INFO - mozleak == 0.1 22:19:18 INFO - mozlog == 3.2 22:19:18 INFO - moznetwork == 0.27 22:19:18 INFO - mozprocess == 0.22 22:19:18 INFO - mozprofile == 0.28 22:19:18 INFO - mozrunner == 6.11 22:19:18 INFO - mozscreenshot == 0.1 22:19:18 INFO - mozsystemmonitor == 0.3 22:19:18 INFO - moztest == 0.7 22:19:18 INFO - mozversion == 1.4 22:19:18 INFO - psutil == 3.1.1 22:19:18 INFO - requests == 1.2.3 22:19:18 INFO - wsgiref == 0.1.2 22:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:18 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 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:18 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 22:19:18 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 22:19:18 INFO - Using env: {'DISPLAY': ':0', 22:19:18 INFO - 'HOME': '/home/cltbld', 22:19:18 INFO - 'LANG': 'en_US.UTF-8', 22:19:18 INFO - 'LANGUAGE': 'en_US:en', 22:19:18 INFO - 'LOGNAME': 'cltbld', 22:19:18 INFO - 'MAIL': '/var/mail/cltbld', 22:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:18 INFO - 'MOZ_NO_REMOTE': '1', 22:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:18 INFO - 'NO_EM_RESTART': '1', 22:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:18 INFO - 'PWD': '/builds/slave/test', 22:19:18 INFO - 'SHELL': '/bin/bash', 22:19:18 INFO - 'SHLVL': '1', 22:19:18 INFO - 'TERM': 'linux', 22:19:18 INFO - 'TMOUT': '86400', 22:19:18 INFO - 'USER': 'cltbld', 22:19:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:18 INFO - '_': '/tools/buildbot/bin/python'} 22:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 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)) 22:19:18 INFO - Cleaning up... 22:19:18 INFO - Return code: 0 22:19:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:18 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 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:18 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 22:19:18 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 22:19:18 INFO - Using env: {'DISPLAY': ':0', 22:19:18 INFO - 'HOME': '/home/cltbld', 22:19:18 INFO - 'LANG': 'en_US.UTF-8', 22:19:18 INFO - 'LANGUAGE': 'en_US:en', 22:19:18 INFO - 'LOGNAME': 'cltbld', 22:19:18 INFO - 'MAIL': '/var/mail/cltbld', 22:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:18 INFO - 'MOZ_NO_REMOTE': '1', 22:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:18 INFO - 'NO_EM_RESTART': '1', 22:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:18 INFO - 'PWD': '/builds/slave/test', 22:19:18 INFO - 'SHELL': '/bin/bash', 22:19:18 INFO - 'SHLVL': '1', 22:19:18 INFO - 'TERM': 'linux', 22:19:18 INFO - 'TMOUT': '86400', 22:19:18 INFO - 'USER': 'cltbld', 22:19:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:18 INFO - '_': '/tools/buildbot/bin/python'} 22:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:18 INFO - Downloading/unpacking jsonschema 22:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:19:20 INFO - Downloading/unpacking functools32 (from jsonschema) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:20 INFO - Downloading functools32-3.2.3-2.tar.gz 22:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:19:20 INFO - warning: no files found matching '*.txt' 22:19:20 INFO - no previously-included directories found matching 'build' 22:19:20 INFO - no previously-included directories found matching 'dist' 22:19:20 INFO - no previously-included directories found matching '.git*' 22:19:20 INFO - Installing collected packages: jsonschema, functools32 22:19:20 INFO - Running setup.py install for functools32 22:19:20 INFO - warning: no files found matching '*.txt' 22:19:20 INFO - no previously-included directories found matching 'build' 22:19:20 INFO - no previously-included directories found matching 'dist' 22:19:20 INFO - no previously-included directories found matching '.git*' 22:19:20 INFO - Successfully installed jsonschema functools32 22:19:20 INFO - Cleaning up... 22:19:21 INFO - Return code: 0 22:19:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39372f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', '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 22:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:19:21 INFO - Using env: {'DISPLAY': ':0', 22:19:21 INFO - 'HOME': '/home/cltbld', 22:19:21 INFO - 'LANG': 'en_US.UTF-8', 22:19:21 INFO - 'LANGUAGE': 'en_US:en', 22:19:21 INFO - 'LOGNAME': 'cltbld', 22:19:21 INFO - 'MAIL': '/var/mail/cltbld', 22:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:21 INFO - 'MOZ_NO_REMOTE': '1', 22:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:21 INFO - 'NO_EM_RESTART': '1', 22:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:21 INFO - 'PWD': '/builds/slave/test', 22:19:21 INFO - 'SHELL': '/bin/bash', 22:19:21 INFO - 'SHLVL': '1', 22:19:21 INFO - 'TERM': 'linux', 22:19:21 INFO - 'TMOUT': '86400', 22:19:21 INFO - 'USER': 'cltbld', 22:19:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:21 INFO - '_': '/tools/buildbot/bin/python'} 22:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:21 INFO - Downloading/unpacking flake8 22:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:19:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:19:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 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 22:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:19:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:19:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:19:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:19:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:19:23 INFO - no previously-included directories found matching 'docs/_build' 22:19:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:19:23 INFO - Running setup.py install for pep8 22:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:19:24 INFO - no previously-included directories found matching 'docs/_build' 22:19:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:19:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:19:24 INFO - Cleaning up... 22:19:24 INFO - Return code: 0 22:19:24 INFO - Running post-action listener: _resource_record_post_action 22:19:24 INFO - Running post-action listener: _start_resource_monitoring 22:19:24 INFO - Starting resource monitoring. 22:19:24 INFO - ##### 22:19:24 INFO - ##### Finished create-virtualenv step (success) 22:19:24 INFO - ##### 22:19:24 INFO - ##### 22:19:24 INFO - ##### Running install step. 22:19:24 INFO - ##### 22:19:24 INFO - Running pre-action listener: _resource_record_pre_action 22:19:24 INFO - Running main action method: install 22:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:24 INFO - Reading from file tmpfile_stdout 22:19:24 INFO - Detecting whether we're running mozinstall >=1.0... 22:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:19:24 INFO - Reading from file tmpfile_stdout 22:19:24 INFO - Output received: 22:19:24 INFO - Usage: mozinstall [options] installer 22:19:24 INFO - Options: 22:19:24 INFO - -h, --help show this help message and exit 22:19:24 INFO - -d DEST, --destination=DEST 22:19:24 INFO - Directory to install application into. [default: 22:19:24 INFO - "/builds/slave/test"] 22:19:24 INFO - --app=APP Application being installed. [default: firefox] 22:19:24 INFO - mkdir: /builds/slave/test/build/application 22:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:19:41 INFO - Reading from file tmpfile_stdout 22:19:41 INFO - Output received: 22:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 22:19:41 INFO - Running post-action listener: _resource_record_post_action 22:19:41 INFO - ##### 22:19:41 INFO - ##### Finished install step (success) 22:19:41 INFO - ##### 22:19:41 INFO - ##### 22:19:41 INFO - ##### Running run-tests step. 22:19:41 INFO - ##### 22:19:41 INFO - Running pre-action listener: _resource_record_pre_action 22:19:41 INFO - Running main action method: run_tests 22:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:19:41 INFO - Python 2.7.3 22:19:41 INFO - Return code: 0 22:19:41 INFO - grabbing minidump binary from tooltool 22:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:41 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 0x135c9c0>, '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 0x135d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:19:41 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 22:19:41 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 22:19:41 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 22:19:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:19:41 INFO - Return code: 0 22:19:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:19:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:19:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:19:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:19:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:19:42 INFO - Return code: 0 22:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 22:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 22:19:42 INFO - Using env: {'DISPLAY': ':0', 22:19:42 INFO - 'HOME': '/home/cltbld', 22:19:42 INFO - 'LANG': 'en_US.UTF-8', 22:19:42 INFO - 'LANGUAGE': 'en_US:en', 22:19:42 INFO - 'LOGNAME': 'cltbld', 22:19:42 INFO - 'MAIL': '/var/mail/cltbld', 22:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:42 INFO - 'MOZ_NO_REMOTE': '1', 22:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:42 INFO - 'NO_EM_RESTART': '1', 22:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:42 INFO - 'PWD': '/builds/slave/test', 22:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:19:42 INFO - 'SHELL': '/bin/bash', 22:19:42 INFO - 'SHLVL': '1', 22:19:42 INFO - 'TERM': 'linux', 22:19:42 INFO - 'TMOUT': '86400', 22:19:42 INFO - 'USER': 'cltbld', 22:19:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337', 22:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:42 INFO - '_': '/tools/buildbot/bin/python'} 22:19:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 22:19:42 INFO - mozversion application_buildid: 20160524193102 22:19:42 INFO - mozversion application_changeset: ba0982c4e30cfbc79ef1f4e25c4a1afb0766cfec 22:19:42 INFO - mozversion application_display_name: Nightly 22:19:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:19:42 INFO - mozversion application_name: Firefox 22:19:42 INFO - mozversion application_remotingname: firefox 22:19:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:19:42 INFO - mozversion application_vendor: Mozilla 22:19:42 INFO - mozversion application_version: 49.0a1 22:19:42 INFO - mozversion platform_buildid: 20160524193102 22:19:42 INFO - mozversion platform_changeset: ba0982c4e30cfbc79ef1f4e25c4a1afb0766cfec 22:19:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:19:42 INFO - mozversion platform_version: 49.0a1 22:19:42 INFO - using testdate: 1464153582 22:19:42 INFO - actual date: 1464153582 22:19:42 INFO - starting webserver on 'localhost:50100' 22:19:42 INFO - SUITE-START | Running 2 tests 22:19:42 INFO - TEST-START | dromaeo_css 22:19:42 INFO - operating with platform_type : linux_ 22:19:42 INFO - Initialising browser for dromaeo_css test... 22:19:42 INFO - TEST-INFO | started process 20798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWPsIp8/profile http://localhost:50100/getInfo.html) 22:19:45 INFO - PROCESS | 20798 | 22:19:45 INFO - PROCESS | 20798 | (process:20869): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:46 INFO - PROCESS | 20798 | __metrics Screen width/height:1600/1200 22:19:46 INFO - PROCESS | 20798 | colorDepth:24 22:19:46 INFO - PROCESS | 20798 | Browser inner width/height: 1024/697 22:19:46 INFO - PROCESS | 20798 | __metrics 22:19:47 ERROR - PROCESS | 20798 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:19:48 INFO - TEST-INFO | 20798: exit 0 22:19:48 INFO - Browser initialized. 22:19:48 INFO - Running cycle 1/1 for dromaeo_css test... 22:19:48 INFO - TEST-INFO | started process 20920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWPsIp8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:50 INFO - PROCESS | 20920 | 22:19:50 INFO - PROCESS | 20920 | (process:20982): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:20:00 INFO - PROCESS | 20920 | RSS: Main: 165994496 22:20:00 INFO - PROCESS | 20920 | 22:20:49 INFO - PROCESS | 20920 | 1464153649689 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] 22:22:56 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:50100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50100/tests/dromaeo/cssquery-ext.html) 22:22:57 INFO - PROCESS | 20920 | RSS: Main: 170655744 22:22:57 INFO - PROCESS | 20920 | 22:25:59 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:50100/tests/dromaeo/cssquery-ext.html (next: http://localhost:50100/tests/dromaeo/cssquery-jquery.html) 22:26:00 INFO - PROCESS | 20920 | RSS: Main: 168726528 22:26:00 INFO - PROCESS | 20920 | 22:29:02 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:50100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50100/tests/dromaeo/cssquery-mootools.html) 22:29:02 INFO - PROCESS | 20920 | RSS: Main: 170434560 22:29:02 INFO - PROCESS | 20920 | 22:32:04 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:50100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50100/tests/dromaeo/cssquery-prototype.html) 22:32:05 INFO - PROCESS | 20920 | RSS: Main: 167800832 22:32:05 INFO - PROCESS | 20920 | 22:35:07 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:50100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50100/tests/dromaeo/cssquery-yui.html) 22:35:08 INFO - PROCESS | 20920 | RSS: Main: 169390080 22:35:08 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:50100/tests/dromaeo/cssquery-yui.html (next: http://localhost:50100/tests/dromaeo/cssquery-dojo.html) 22:38:11 INFO - PROCESS | 20920 | RSS: Main: 171003904 22:38:11 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | __start_tp_report 22:38:11 INFO - PROCESS | 20920 | _x_x_mozilla_page_load 22:38:11 INFO - PROCESS | 20920 | _x_x_mozilla_page_load_details 22:38:11 INFO - PROCESS | 20920 | |i|pagename|runs| 22:38:11 INFO - PROCESS | 20920 | |0;dojo.html;3086.598742163519;3102.084884958937;3115.657277699454;3130.968690313097;3143.732782713469;5382.381026181985;5395.055865223585;5413.702246376448;5462.863428414282;5547.944520554804;5390;5423.511883930445;5426.240326354314;5441.483059109388;5537.307836520435;4890.902181956368;4915.5821755150855;5017.2405177152605;5034.144195486758;5079.720615366154;667.1718651765458;4882.145624515713;4949.455559888409;4974.577160941306;5000.674956127858;4943.629227807911;4977.0792403405485;5001.999600079998;5007.774650140753;5013.473585273548;5010.924836127461;5014.598832093424;5021.271915572258;5025.14572522672;5038.924416133761;4925.876853078666;4935.259711043336;4957.925631115536;4974.37820272466;4979.0788704089855;5345.3585569731495;5371.194320851864;5409.83770486886;5415;5436.782528698847;5693.259876216065;5754.194412782172;5756.136579513107;5762.855928601776;5781.653100813965;5931.436513531251;5943.524518038546;5956.404359564052;5960.880782384328;6013.128096426038;5538.723063846832;5549.361823390322;5553.666779993213;5558.722063896789;5564.33228012637;5868.23712917318;5960.731767070492;6019.879602407927;6028.09578563219;6030.487408570233;5772.538196944234;5794.768209271582;5798.768049278066;5801.3038435388025;5854.795082172103;5789.1605717171615;5816.040353341651;5825.300963884361;5862.267216597926;5873.647581145145;5702.6293290935955;5811.88376232473;5842.415758424124;5864.06175011996;5883.970580147072;5820.35976042635;5868.119782032644;5874.236349274567;5877.52979761618;5884.735186916599;4408.53710360414;4461.776911154429;4484.080763443486;4484.260097083945;4494.842680506166;3857.9228415431535;3897.279003384383;3897.590752970897;3941.881743547698;3952.209558088394;5519.31008623922;5535.114381698909;5543;5560.193771903051;5584.078627026576;5826.94173058264;5843.5909486336395;5877.500412464903;5891.293044834647;5892.646441213541;5541.196526503634;5617.915731264035;5631.4087020863035;5647.774089036475;5687.175359572839;5045.621578381636;5048.3184770056305;5050.4949505049935;5069.036882992294;5093.898122037613;5864.618799778001;6014.218151640259;6045.637261764308;6072.848178795565;6084.756609735649;5876.823695289148;5908.497777688859;5914.940850591611;5923.229980102559;5933.792317268875;6067.757289708362;6084.90872636902;6092.116643086816;6118.663473509;6131.202943617302;5665.915011274752;5798.362180160263;5825.097109947965;5831.970840145772;5861.794837180678;5918.171455996078;5920.555958303058;5922.615030023035;5924.052151655715;5979.043353063489;5653.773849046157;5706.914396284142;5721.713914304351;5725.971370143123;5745.368009519033;5543.750531226186;5653.349864765604;5687.658740475585;5731.484166424875;5747.396523364986;5629.240052592848;5660.54715622741;5665.943340566541;5677.034904066236;5712;5794.362620111869;5814.73833677494;5835.94164058354;5848.707564621837;5860;5498.120300751861;5555.416681248411;5562.860928476821;5660;5677.914831277617 22:38:11 INFO - PROCESS | 20920 | |1;ext.html;583.5040215816554;607.4017093163234;623.6632218601952;641.563736659072;654.4502617801046;38679.61320386795;43989;43995.3400698989;44040;44107.77946110273;44137;44504.77747611266;44571.777141114246;44663.3300500492;44686.77656611712;8669.479831210132;8919.152680495343;8935.285177185842;8936.776580585472;8968.103189681045;8654.524001179963;8754.168354006359;8765.737027889174;8768;8773.912260877405;8732.650693972233;8773.210411063003;8821.823563528726;8823.382363234576;8845.425047371933;8728.476291422503;8738;8754.430961987482;8792.736217913473;8803.867941980876;8744.344174186897;8845.646174153026;8850.247728943048;8851.07063758309;8859.379843410963;42191.57808421938;42857.57142428598;42907.35638965387;42924.356134658;43159.35260971088;3523.066387407339;3568.946465803015;3584.623614520464;3827.2154208387215;3836.3286424875814;32702.182445439055;33810.661893380995;33885.322293554236;33898.66101339005;33912;4100.200460910124;4252.744835309892;4411.647068234533;4520.139234211835;4540.8637740867825;267049;354734;360085;361235;363939.9999999974;62491.37508624946;62543;62905.37094628995;62908;63155;64959.350406496276;66018;66205;66253.66873165603;66287;16167.514974550782;16394.754078688828;16416.261268242957;16422.83577164213;16451.91774041122;11713.765724685458;11740.88259117415;11753.529858805723;11757.235779674294;11827.704307392383;18384.121991993572;19667.311644092388;19726;19785;19874.403767886986;3227.4351988401936;3313.7797675557435;7232.153113871508;7305.232950540117;7326.4505162113055;1041.3923654412738;1061.8725752909545;1154.0709728668335;1171.4025846818013;1230.5816022552197;33480.66519334824;33642.66357336444;33759.493607595905;33815.32926951144;33902.32195356079;1111.8165502692127;1148.8104462763717;1156.6298784388914;1174.512577280436;1181.8699943006263;17519.47441576755;17961.640767184585;17967.281308747766;18011.459656210336;18013.369532066314;524202;524996;526355;528060;534419;61539.6923015391;61958.38041619526;62097.37902621007;62550.37449625537;62836.37163628397;1337.104140226051;1370.5819724983976;1381.081580748811;1386.4038463460809;1397.0779285671408;31915.521267181477;32753.672463275063;33378;33435.33129337448;34041.48937765985;48285;48359;48587.5141248583;48729.5127048725;48935.26597101118;458469;460090;463308;464025;464813;28700.569491457227;28974.27564310909;29650.555241671824;29817.403651926405;29837.403251934407;50114;50825.74587127041;50879;51600;52175.47824521706;37561;41788;44651.553484466036;45482.31776523289;46540.06919861652;41663.37504937368;41699.37450938178;42286.788566056974;42319.36520952127;42387;41718.79140604277;41866.162676746906;42659.14681706411;43348.56651433571;43407.56592434035;34938.82530587331;37128.628713713595;37417.43873841949;37915;38015;28881.566776497948;29323;29343.413131737674;29352;29487.410251794416 22:38:11 INFO - PROCESS | 20920 | |2;jquery.html;379.34752226170974;383.9980800096001;384.25262863730046;393.3117045170951;402.4627122791074;17137.82862171378;19077.809221907777;19458.610827783436;19523.12145953432;19668.21327146916;18186.818131818713;18439.262429502804;18737.15682794274;18758.718619220723;19036.904815475937;4833.226683730612;4930.28510865926;4978.079055374749;4981.576565991877;5006.374203224597;5058.974705126469;5148.073346797575;5152.149895267276;5173.3533308336455;5199.14214154664;4975.875603109915;5132.820351287705;5138.7944482220855;5151.459096794839;5151.587872970172;5094.566961808251;5142.100132476801;5160.716160611146;5185.585153187755;5187.922181167285;4844.394450693663;4956.2565615157655;4999.075171093359;5026.447090820006;5038.042771873333;13643.181409115485;13951.302434878316;14134.15195088298;14146.36341364641;14194.787078193835;2158.104386679526;2243.6298010828195;2322.100730442392;2349.8120150387927;2456.9877150614134;9372.343935924488;10108.039736225046;10109.545070471846;10503.737406564896;13231.933840330834;1974.8222659960672;2011.1955217912805;2064.876107433544;2080.708700781892;2094.5706130243266;58185.418145818425;70735.64632176858;75417.62291188564;83898.70759692986;86423;10275.948620256851;10409.68770936873;10446.85084640689;10585.24783556281;11076.889231107747;14139.586041395984;14248.145111293356;14268.714625707635;14500.347484363228;14508.854911450962;7579.279968402993;7684.269994350528;7690.577018264049;7728.381729461629;7836.373090152774;7103.964480177566;7190.101237345332;7214.170370407365;7337.926620733724;7498.925010749932;4220.6412454941055;4255.127698821734;4271.572842715704;4361.803718832597;4760.547747963938;1802.3331367393887;1827.9908600456913;1852.7961924188328;1856.758621379212;1919.42417274817;914.6890057380523;918.8897332320164;959.7655899618192;962.7256231973994;1021.9437930913871;19221.423357299303;19729.802701973083;19885.900570497055;19949.202031918852;20371.592568148553;982.4056445850158;983.1102851919024;1011.6610935336597;1015.3095894791466;1031.128696251666;10241.692749217535;11027.918276315258;11092.722681933015;11161.386123763272;11195.160362972809;462610;474351;516068;518420;524497;96690.51654741821;96771;98910.50544747374;99798.5010074945;100610.4969475148;1014.3609525998721;1027.8098551767946;1031.3554028732042;1037.8339465685453;1038.2732087538602;17523.737143943104;17634.735478968083;17846.732299015264;17902.194401251716;17931.193096310435;39015.219695606494;41236.79381603073;42129.36805947852;42784.786076069424;45005.54994450144;59682;61143.69428152831;61274;61862;62225.37774622196;6029.909551356821;7361.9631901842295;7725.22747725223;8075.9192408077515;8770.429922055046;12931.224126552437;13183.274919879499;13566.321683915567;13672.93163534176;13845.930770346084;11044.33733975964;11600.94199528997;11750.236234645063;11828;11873.406329683654;10929.781404372026;11214.66356009321;11350.886491134983;11693.006094482063;12120.454579543766;11134.33194008362;11595.304281743123;11702.414879256174;12084.45619947087;12368.505259789868;7808.219178082147;7899;7921.485103468256;7972.521648701097;8088.3529317653265;9635.951820240854;11079.72300692489;11177.161712871404;11230.775384492428;11390.487428065591 22:38:11 INFO - PROCESS | 20920 | |3;mootools.html;1506.2920427399126;1532.5095969289828;1693.9068351240685;1802.6304607555453;1828.652556014357;7893.250141236574;8406.915930840705;8538.871916921244;9125.726228213147;9130.543472826357;8422.0735719071;8584.742457726263;8730;8806.515641639708;8850.247728943032;2357.422431504284;2413.75862413759;2415.0581273303424;2417.867017314047;2420.116657420038;2343.285297984114;2366.065404165354;2390.079819269585;2419.2379400488876;2426.9635955460594;2401.3756423329887;2428.2836563213896;2438.622013587888;2442.206282958037;2442.9511409771794;2325.4883925536355;2328.883555822202;2342.5432040751975;2351.6472529120597;2385.785279324869;2287.462446325112;2298.276043046435;2307.2962746362355;2309.3880121767743;2312.7455979842202;8788.901387326585;8791.78020549485;8816.294696424335;8843.027267000625;8866.689665861664;5334.22653715213;5404.378496472917;5431.755570999315;5439.972800136014;5446.992306423324;3428.8285585720614;3505.0886769439876;3568.750187486877;3575.713942884563;3577.874774382884;1055.7255113670424;1062.4740753327153;1069.0859315285397;1080.1089101491302;1086.9510872010778;12191.87808121925;12394;12439.937800310941;12488.25070495773;12492.312922789242;4747.572718455355;4770.904581908342;4840.636952228597;4883.02339532095;4890.608751299887;10545.894541054491;10579.047885690325;10581.682549523526;10583.25917185805;10627.787444251071;5302.469753024744;5390;5398.217258497496;5398.406175320712;5399.271098401744;4461.955380446219;4921.901561968741;4928.359313289249;5065.746712664352;5065.949340506621;4111.6299533042165;4114.704502111774;4164.354525048622;4193.580641935782;4196.643285320721;1300.681333073403;1323.715401188749;1324.026840272399;1325.3903204525834;1327.3495986966318;934.4860326820358;937.9155875971195;959.6881013670585;963.1957315641378;988.081084591337;5661.320641523043;5774.422557744192;5866.6186697864505;5918.674472903946;6024.668643224665;442.7476338487096;447.16157205240177;451.2847137287371;1035.089121573011;1056.9207309451667;3981.960180398217;3993.4209539616595;4004.59954004603;4008.0581063450068;4051.1897620476025;10864.891351086546;11198.720031999264;11252.043576296106;11271.154663400277;11379.203455758183;10965.122790176767;11029;11192;11280.830787538194;11285.943570282096;8335;8566.18621230982;8576.271016963503;8576.914230857736;8581.184787445183;5644.943550564606;5787.421257874179;5794.18881356602;5871.500922421471;5894.115882617642;10229.693109206439;10267.178625709776;10390.116840068376;10422.73943151397;10475.842862356918;10259.179265658879;10413.375197488174;10564.313319634506;10589.576416943237;10609.522571484147;6831.795046148623;7264.23725508814;7500.437467189873;7529.8117547061765;7695.153533111466;8794.780130496789;8805.075467076122;8858.64565417376;8866.73399798007;8868.467891926504;7643.426742994409;7801.492902961516;7802.882956755767;7966.800829979297;8122.918770812216;7372.447066469929;7770.14528401864;7840.137584865546;7938.24586664266;8001.439899207;6781.796546103625;6925.168979722465;6932.826679333057;6990.790276291719;6998.6150761708595;5066.341375621146;5114.744262786771;5199.168133098686;5229.450907654642;5268.841934741964;5224.3624767789315;5233.031889100528;5246.737663116905;5276.657017293864;5348.973255133699 22:38:11 INFO - PROCESS | 20920 | |4;prototype.html;313.99372012559735;324.6461357120739;325.0621955657927;327.3306089047897;328.9440795064839;5432.348118225808;5493.2034854946005;5575.69333686647;5708.1437784332375;5747.275817254827;5531.2809334786525;5552.5280351170095;5572;5633.80281690141;5675.531143952384;4361.171377438284;4396.560343965594;4406.47122345319;4406.625436837857;4422.248217802981;4091.284025295576;4299.3550967354995;4346.76092814895;4406.493253275867;4432.778361081949;4273.551277115889;4301.601979356706;4327.956720432787;4328.329108988112;4343.109662519176;4282.650964946063;4360.345948107777;4361.738295702252;4381.3208952612395;4391.934120988188;3709.239605880815;3732.869349572779;3814.694824414068;3824.349860523718;3839.6736277416453;5312.017276803804;5329.227262046981;5347.224652425415;5412.5940554458575;5437.755301011464;4876.342043705122;4919.631027672903;4922.424824056304;4935.667369810167;4938.2839488274;5518.613697041209;5788.739506722208;5849.444302791228;5849.707514624251;5891.057430811093;4114.7119701620895;4123.525794533637;4124.8143833527265;4135.462389889295;4137.172565486914;6025.186599809013;6034.396560343975;6051.818445446644;6065.696715164268;6084.209052823105;4124.958750412457;4187.685923555746;4208.642265407413;4241.384999175102;4244.214820258262;4223.852165174204;4240.554741752133;4243.809028593659;4270.594293542109;4281.2293787118615;4910.729909854992;4913.754312284372;4926.167453714129;4930.707221142186;4962.528559786814;5585.218069470277;5851.151583020438;5876.001079816441;5878.677297608089;5891.322497912709;1460.5618314505605;1463.100193381063;1469.419579266184;1474.7492926202572;1483.0656686287784;906.3791302957495;917.9862302065475;926.4719110107175;937.9343445958854;940.5062342270363;5082.822101226513;5089;5092.363454568179;5117.411497677815;5118.718470484085;5361.785528578813;5404.621676482687;5410.377806552218;5437.211604317431;5445.945540544623;5110.616703747234;5135.820246291362;5153.330067091254;5252.212168174728;5687.345955215121;3219.8390080495883;3244.5782048334036;3252.5446437498767;3254.08885512057;3266.7876588021704;6132.6933653317155;6212.254529456403;6230.345813689588;6239.814435257377;6247.781327653601;6046.365131661112;6076.392360763888;6145.66198859067;6155.630662160284;6169.352218017133;6176.69116544171;6192.566520343623;6197.349278325801;6206.968965155145;6217.378262173836;5750.7987220447085;5946.821595352147;6007.48936340416;6024.90962635552;6045.425684559959;5947.821565353046;5957.314908785372;5981.222441082631;6020.367861374492;6024.367441418588;5984.760609575568;6187.597806142587;6220.688965551795;6231.22109736283;6302.306746257999;4166.729162604421;4171.770552619635;4222.155568886174;4229.767362795076;4233.407322974725;5932.7033648318275;5943.4948029416255;6050.9394906050375;6053.969730151321;6109.480694141048;5542.75057622416;5856.765729370777;5886.146508756121;5905.232319798399;5931.495822855106;5841.678707671119;5856.092305692625;5866.208061911588;5910.349861515316;5923.49650279731;5689.943100568941;5720.456556627114;5769.1634712967225;5779.768809247751;5817.76728930838;5938.762449501972;5954.225950626391;5981.611195272293;5997.730102145501;6000.489958353589;5707.971460142673;5798.971005144947;5810.854728631649;5861;5863.73613187399 22:38:11 INFO - PROCESS | 20920 | |5;yui.html;826.5867066466767;841.949483031018;850.506706110456;855.8331125430543;897.9820403591924;12360.134790564663;13018.34908254587;13040.413181406835;13069.60791176265;13070.803937940915;11033.613823516178;13779.65550861229;13793.172409655403;13802.654933626663;13843.861561384383;801.5030680977802;830.4560512864084;833.2792134803412;834.6703052294371;835.6239692138531;815.1522416686639;818.6807145213371;822.7408366364576;822.7696245051395;824.2499325613693;856.644492535597;860.8364410761935;861.0958493581745;861.3066481482405;864.4381152251055;850.4812064640595;852.0329426101357;852.2713080316364;853.4282031039219;855.230292736539;622.365187508743;623.2147494157394;623.6569886562372;624.2166081567649;624.3101372982834;13258.071934964557;13263.734725305536;13266.535671251557;13266.66833329165;13267.203967761965;14422.134671919614;14623.488177913721;14734.778978315333;14735.70528589433;14809;11663.650090497298;11700.824487632608;11728.061755059574;11770;12134.696632584168;3804.391297392404;3928.351821949375;3949.782761948092;4058.3303754880703;4059.939100913489;57310.426895730925;58534.41465585375;58539.414605853824;58647;58978.70510647419;11150.275232109887;11304.604338848101;11418.371989540488;11774.529018839321;11821.586244481574;20923.16307347689;21110.788892111188;21169.78830211709;21214.36356909295;21218.78781212199;8337.24964753163;8352.415330926777;8933.374663773604;8969.237614802814;9028;4736.147493451212;4746.8101275948575;4803.471618122004;4935.87660308488;4939.234418665113;3245.2535916739284;3280.852361643732;3287.7534184936226;3287.8656863382093;3312.5362449257123;607.1469585232755;609.856683679335;611.9877602447926;620.6214209332304;623.4046485606235;622.6886556721639;626.6083697688945;708.574855086954;767.4052609227894;791.2720297326473;8686.826263474695;9062.546872656472;9158.267338612895;9205.585748641328;9245.676401325922;640.3372509452694;664.6344510519292;755.2334380603692;825.7357645553485;842.2966822702989;4589.678722489393;4811.254255590389;4862.586680132228;4907.141250281186;4947.802087916515;70733;71845;72400.63799680967;72915.63542182361;74153.62923185457;64503;65349.34650653528;65441;66785;67465;55947.16079258733;56665.150022749694;57218;58111.41888581144;58957.41042589605;9287.48918809472;9288.674896378594;9423.952880235554;9508.429494230368;9537.332386732862;37613;37917.81041094777;38925.2214955705;38933.415998759476;39439;46574.53425465702;51975;52138;52506;52734.73632631966;11359.886401135884;11509.482073306888;11559.017483513659;12104.09219308573;12127.332996685267;12878;12884.613461596167;13095.41070651804;13619.250941197934;13906.304684765519;11876.406179690808;12350.876491234972;12757.55348562796;12881.8067728986;12920.966322693974;12294.077944154045;12320.199187052813;12412.81380779271;13121.803172952605;13184.340782960622;12073.698157546132;12415.503379864704;12698.365081745691;12814.487420503076;13075.215487070805;9902.653407130716;10150.644727434505;10217.386956782617;10526;10571.312864663772;10283.84574231402;10696.732581685521;10702.411367374869;10773;10783.24517283814 22:38:11 INFO - PROCESS | 20920 | __end_tp_report 22:38:11 INFO - PROCESS | 20920 | __start_cc_report 22:38:11 INFO - PROCESS | 20920 | _x_x_mozilla_cycle_collect,354 22:38:11 INFO - PROCESS | 20920 | __end_cc_report 22:38:11 INFO - PROCESS | 20920 | __startTimestamp1464154691677__endTimestamp 22:38:11 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | ------- Summary: start ------- 22:38:11 INFO - PROCESS | 20920 | Number of tests: 6 22:38:11 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | [#0] dojo.html Cycles:165 Average:5415.76 Median:5665.92 stddev:733.97 (13.0%) stddev-sans-first:713.11 22:38:11 INFO - PROCESS | 20920 | Values: 3086.6 3102.1 3115.7 3131.0 3143.7 5382.4 5395.1 5413.7 5462.9 5547.9 5390.0 5423.5 5426.2 5441.5 5537.3 4890.9 4915.6 5017.2 5034.1 5079.7 667.2 4882.1 4949.5 4974.6 5000.7 4943.6 4977.1 5002.0 5007.8 5013.5 5010.9 5014.6 5021.3 5025.1 5038.9 4925.9 4935.3 4957.9 4974.4 4979.1 5345.4 5371.2 5409.8 5415.0 5436.8 5693.3 5754.2 5756.1 5762.9 5781.7 5931.4 5943.5 5956.4 5960.9 6013.1 5538.7 5549.4 5553.7 5558.7 5564.3 5868.2 5960.7 6019.9 6028.1 6030.5 5772.5 5794.8 5798.8 5801.3 5854.8 5789.2 5816.0 5825.3 5862.3 5873.6 5702.6 5811.9 5842.4 5864.1 5884.0 5820.4 5868.1 5874.2 5877.5 5884.7 4408.5 4461.8 4484.1 4484.3 4494.8 3857.9 3897.3 3897.6 3941.9 3952.2 5519.3 5535.1 5543.0 5560.2 5584.1 5826.9 5843.6 5877.5 5891.3 5892.6 5541.2 5617.9 5631.4 5647.8 5687.2 5045.6 5048.3 5050.5 5069.0 5093.9 5864.6 6014.2 6045.6 6072.8 6084.8 5876.8 5908.5 5914.9 5923.2 5933.8 6067.8 6084.9 6092.1 6118.7 6131.2 5665.9 5798.4 5825.1 5832.0 5861.8 5918.2 5920.6 5922.6 5924.1 5979.0 5653.8 5706.9 5721.7 5726.0 5745.4 5543.8 5653.3 5687.7 5731.5 5747.4 5629.2 5660.5 5665.9 5677.0 5712.0 5794.4 5814.7 5835.9 5848.7 5860.0 5498.1 5555.4 5562.9 5660.0 5677.9 22:38:11 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | [#1] ext.html Cycles:180 Average:61214.12 Median:42758.36 stddev:119508.82 (279.5%) stddev-sans-first:119757.37 22:38:11 INFO - PROCESS | 20920 | Values: 583.5 607.4 623.7 641.6 654.5 38679.6 43989.0 43995.3 44040.0 44107.8 44137.0 44504.8 44571.8 44663.3 44686.8 8669.5 8919.2 8935.3 8936.8 8968.1 8654.5 8754.2 8765.7 8768.0 8773.9 8732.7 8773.2 8821.8 8823.4 8845.4 8728.5 8738.0 8754.4 8792.7 8803.9 8744.3 8845.6 8850.2 8851.1 8859.4 42191.6 42857.6 42907.4 42924.4 43159.4 3523.1 3568.9 3584.6 3827.2 3836.3 32702.2 33810.7 33885.3 33898.7 33912.0 4100.2 4252.7 4411.6 4520.1 4540.9 267049.0 354734.0 360085.0 361235.0 363940.0 62491.4 62543.0 62905.4 62908.0 63155.0 64959.4 66018.0 66205.0 66253.7 66287.0 16167.5 16394.8 16416.3 16422.8 16451.9 11713.8 11740.9 11753.5 11757.2 11827.7 18384.1 19667.3 19726.0 19785.0 19874.4 3227.4 3313.8 7232.2 7305.2 7326.5 1041.4 1061.9 1154.1 1171.4 1230.6 33480.7 33642.7 33759.5 33815.3 33902.3 1111.8 1148.8 1156.6 1174.5 1181.9 17519.5 17961.6 17967.3 18011.5 18013.4 524202.0 524996.0 526355.0 528060.0 534419.0 61539.7 61958.4 62097.4 62550.4 62836.4 1337.1 1370.6 1381.1 1386.4 1397.1 31915.5 32753.7 33378.0 33435.3 34041.5 48285.0 48359.0 48587.5 48729.5 48935.3 458469.0 460090.0 463308.0 464025.0 464813.0 28700.6 28974.3 29650.6 29817.4 29837.4 50114.0 50825.7 50879.0 51600.0 52175.5 37561.0 41788.0 44651.6 45482.3 46540.1 41663.4 41699.4 42286.8 42319.4 42387.0 41718.8 41866.2 42659.1 43348.6 43407.6 34938.8 37128.6 37417.4 37915.0 38015.0 28881.6 29323.0 29343.4 29352.0 29487.4 22:38:11 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | [#2] jquery.html Cycles:180 Average:28907.17 Median:2335.96 stddev:82553.64 (3534.0%) stddev-sans-first:82757.43 22:38:11 INFO - PROCESS | 20920 | Values: 379.3 384.0 384.3 393.3 402.5 17137.8 19077.8 19458.6 19523.1 19668.2 18186.8 18439.3 18737.2 18758.7 19036.9 4833.2 4930.3 4978.1 4981.6 5006.4 5059.0 5148.1 5152.1 5173.4 5199.1 4975.9 5132.8 5138.8 5151.5 5151.6 5094.6 5142.1 5160.7 5185.6 5187.9 4844.4 4956.3 4999.1 5026.4 5038.0 13643.2 13951.3 14134.2 14146.4 14194.8 2158.1 2243.6 2322.1 2349.8 2457.0 9372.3 10108.0 10109.5 10503.7 13231.9 1974.8 2011.2 2064.9 2080.7 2094.6 58185.4 70735.6 75417.6 83898.7 86423.0 10275.9 10409.7 10446.9 10585.2 11076.9 14139.6 14248.1 14268.7 14500.3 14508.9 7579.3 7684.3 7690.6 7728.4 7836.4 7104.0 7190.1 7214.2 7337.9 7498.9 4220.6 4255.1 4271.6 4361.8 4760.5 1802.3 1828.0 1852.8 1856.8 1919.4 914.7 918.9 959.8 962.7 1021.9 19221.4 19729.8 19885.9 19949.2 20371.6 982.4 983.1 1011.7 1015.3 1031.1 10241.7 11027.9 11092.7 11161.4 11195.2 462610.0 474351.0 516068.0 518420.0 524497.0 96690.5 96771.0 98910.5 99798.5 100610.5 1014.4 1027.8 1031.4 1037.8 1038.3 17523.7 17634.7 17846.7 17902.2 17931.2 39015.2 41236.8 42129.4 42784.8 45005.5 59682.0 61143.7 61274.0 61862.0 62225.4 6029.9 7362.0 7725.2 8075.9 8770.4 12931.2 13183.3 13566.3 13672.9 13845.9 11044.3 11600.9 11750.2 11828.0 11873.4 10929.8 11214.7 11350.9 11693.0 12120.5 11134.3 11595.3 11702.4 12084.5 12368.5 7808.2 7899.0 7921.5 7972.5 8088.4 9636.0 11079.7 11177.2 11230.8 11390.5 22:38:11 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | [#3] mootools.html Cycles:180 Average:5874.19 Median:2599.43 stddev:3355.02 (129.1%) stddev-sans-first:3348.37 22:38:11 INFO - PROCESS | 20920 | Values: 1506.3 1532.5 1693.9 1802.6 1828.7 7893.3 8406.9 8538.9 9125.7 9130.5 8422.1 8584.7 8730.0 8806.5 8850.2 2357.4 2413.8 2415.1 2417.9 2420.1 2343.3 2366.1 2390.1 2419.2 2427.0 2401.4 2428.3 2438.6 2442.2 2443.0 2325.5 2328.9 2342.5 2351.6 2385.8 2287.5 2298.3 2307.3 2309.4 2312.7 8788.9 8791.8 8816.3 8843.0 8866.7 5334.2 5404.4 5431.8 5440.0 5447.0 3428.8 3505.1 3568.8 3575.7 3577.9 1055.7 1062.5 1069.1 1080.1 1087.0 12191.9 12394.0 12439.9 12488.3 12492.3 4747.6 4770.9 4840.6 4883.0 4890.6 10545.9 10579.0 10581.7 10583.3 10627.8 5302.5 5390.0 5398.2 5398.4 5399.3 4462.0 4921.9 4928.4 5065.7 5065.9 4111.6 4114.7 4164.4 4193.6 4196.6 1300.7 1323.7 1324.0 1325.4 1327.3 934.5 937.9 959.7 963.2 988.1 5661.3 5774.4 5866.6 5918.7 6024.7 442.7 447.2 451.3 1035.1 1056.9 3982.0 3993.4 4004.6 4008.1 4051.2 10864.9 11198.7 11252.0 11271.2 11379.2 10965.1 11029.0 11192.0 11280.8 11285.9 8335.0 8566.2 8576.3 8576.9 8581.2 5644.9 5787.4 5794.2 5871.5 5894.1 10229.7 10267.2 10390.1 10422.7 10475.8 10259.2 10413.4 10564.3 10589.6 10609.5 6831.8 7264.2 7500.4 7529.8 7695.2 8794.8 8805.1 8858.6 8866.7 8868.5 7643.4 7801.5 7802.9 7966.8 8122.9 7372.4 7770.1 7840.1 7938.2 8001.4 6781.8 6925.2 6932.8 6990.8 6998.6 5066.3 5114.7 5199.2 5229.5 5268.8 5224.4 5233.0 5246.7 5276.7 5349.0 22:38:11 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | [#4] prototype.html Cycles:180 Average:4879.60 Median:5505.91 stddev:1447.73 (26.3%) stddev-sans-first:1410.65 22:38:11 INFO - PROCESS | 20920 | Values: 314.0 324.6 325.1 327.3 328.9 5432.3 5493.2 5575.7 5708.1 5747.3 5531.3 5552.5 5572.0 5633.8 5675.5 4361.2 4396.6 4406.5 4406.6 4422.2 4091.3 4299.4 4346.8 4406.5 4432.8 4273.6 4301.6 4328.0 4328.3 4343.1 4282.7 4360.3 4361.7 4381.3 4391.9 3709.2 3732.9 3814.7 3824.3 3839.7 5312.0 5329.2 5347.2 5412.6 5437.8 4876.3 4919.6 4922.4 4935.7 4938.3 5518.6 5788.7 5849.4 5849.7 5891.1 4114.7 4123.5 4124.8 4135.5 4137.2 6025.2 6034.4 6051.8 6065.7 6084.2 4125.0 4187.7 4208.6 4241.4 4244.2 4223.9 4240.6 4243.8 4270.6 4281.2 4910.7 4913.8 4926.2 4930.7 4962.5 5585.2 5851.2 5876.0 5878.7 5891.3 1460.6 1463.1 1469.4 1474.7 1483.1 906.4 918.0 926.5 937.9 940.5 5082.8 5089.0 5092.4 5117.4 5118.7 5361.8 5404.6 5410.4 5437.2 5445.9 5110.6 5135.8 5153.3 5252.2 5687.3 3219.8 3244.6 3252.5 3254.1 3266.8 6132.7 6212.3 6230.3 6239.8 6247.8 6046.4 6076.4 6145.7 6155.6 6169.4 6176.7 6192.6 6197.3 6207.0 6217.4 5750.8 5946.8 6007.5 6024.9 6045.4 5947.8 5957.3 5981.2 6020.4 6024.4 5984.8 6187.6 6220.7 6231.2 6302.3 4166.7 4171.8 4222.2 4229.8 4233.4 5932.7 5943.5 6050.9 6054.0 6109.5 5542.8 5856.8 5886.1 5905.2 5931.5 5841.7 5856.1 5866.2 5910.3 5923.5 5689.9 5720.5 5769.2 5779.8 5817.8 5938.8 5954.2 5981.6 5997.7 6000.5 5708.0 5799.0 5810.9 5861.0 5863.7 22:38:11 INFO - PROCESS | 20920 | 22:38:11 INFO - PROCESS | 20920 | [#5] yui.html Cycles:180 Average:16031.69 Median:4884.86 stddev:19735.51 (404.0%) stddev-sans-first:19757.84 22:38:11 INFO - PROCESS | 20920 | Values: 826.6 841.9 850.5 855.8 898.0 12360.1 13018.3 13040.4 13069.6 13070.8 11033.6 13779.7 13793.2 13802.7 13843.9 801.5 830.5 833.3 834.7 835.6 815.2 818.7 822.7 822.8 824.2 856.6 860.8 861.1 861.3 864.4 850.5 852.0 852.3 853.4 855.2 622.4 623.2 623.7 624.2 624.3 13258.1 13263.7 13266.5 13266.7 13267.2 14422.1 14623.5 14734.8 14735.7 14809.0 11663.7 11700.8 11728.1 11770.0 12134.7 3804.4 3928.4 3949.8 4058.3 4059.9 57310.4 58534.4 58539.4 58647.0 58978.7 11150.3 11304.6 11418.4 11774.5 11821.6 20923.2 21110.8 21169.8 21214.4 21218.8 8337.2 8352.4 8933.4 8969.2 9028.0 4736.1 4746.8 4803.5 4935.9 4939.2 3245.3 3280.9 3287.8 3287.9 3312.5 607.1 609.9 612.0 620.6 623.4 622.7 626.6 708.6 767.4 791.3 8686.8 9062.5 9158.3 9205.6 9245.7 640.3 664.6 755.2 825.7 842.3 4589.7 4811.3 4862.6 4907.1 4947.8 70733.0 71845.0 72400.6 72915.6 74153.6 64503.0 65349.3 65441.0 66785.0 67465.0 55947.2 56665.2 57218.0 58111.4 58957.4 9287.5 9288.7 9424.0 9508.4 9537.3 37613.0 37917.8 38925.2 38933.4 39439.0 46574.5 51975.0 52138.0 52506.0 52734.7 11359.9 11509.5 11559.0 12104.1 12127.3 12878.0 12884.6 13095.4 13619.3 13906.3 11876.4 12350.9 12757.6 12881.8 12921.0 12294.1 12320.2 12412.8 13121.8 13184.3 12073.7 12415.5 12698.4 12814.5 13075.2 9902.7 10150.6 10217.4 10526.0 10571.3 10283.8 10696.7 10702.4 10773.0 10783.2 22:38:11 INFO - PROCESS | 20920 | -------- Summary: end -------- 22:38:11 INFO - PROCESS | 20920 | 22:38:12 INFO - TEST-INFO | 20920: exit 0 22:38:12 INFO - TEST-OK | dromaeo_css | took 1110066ms 22:38:12 INFO - TEST-START | kraken 22:38:12 INFO - operating with platform_type : linux_ 22:38:12 INFO - Initialising browser for kraken test... 22:38:12 INFO - TEST-INFO | started process 21153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL7IvUd/profile http://localhost:50100/getInfo.html) 22:38:16 INFO - PROCESS | 21153 | 22:38:16 INFO - PROCESS | 21153 | (process:21224): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:38:16 INFO - PROCESS | 21153 | __metrics Screen width/height:1600/1200 22:38:16 INFO - PROCESS | 21153 | colorDepth:24 22:38:16 INFO - PROCESS | 21153 | Browser inner width/height: 1024/697 22:38:16 INFO - PROCESS | 21153 | __metrics 22:38:17 ERROR - PROCESS | 21153 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:38:18 INFO - TEST-INFO | 21153: exit 0 22:38:18 INFO - Browser initialized. 22:38:18 INFO - Running cycle 1/1 for kraken test... 22:38:18 INFO - TEST-INFO | started process 21275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL7IvUd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:20 INFO - PROCESS | 21275 | 22:38:20 INFO - PROCESS | 21275 | (process:21338): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:38:30 INFO - PROCESS | 21275 | RSS: Main: 165400576 22:38:30 INFO - PROCESS | 21275 | 22:38:32 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50100/tests/kraken/driver.html?testName=audio-beat-detection) 22:38:33 INFO - PROCESS | 21275 | RSS: Main: 170692608 22:38:33 INFO - PROCESS | 21275 | 22:38:36 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50100/tests/kraken/driver.html?testName=audio-dft) 22:38:36 INFO - PROCESS | 21275 | RSS: Main: 171466752 22:38:36 INFO - PROCESS | 21275 | 22:38:39 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50100/tests/kraken/driver.html?testName=audio-fft) 22:38:40 INFO - PROCESS | 21275 | RSS: Main: 165498880 22:38:40 INFO - PROCESS | 21275 | 22:38:42 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50100/tests/kraken/driver.html?testName=audio-oscillator) 22:38:43 INFO - PROCESS | 21275 | RSS: Main: 165621760 22:38:43 INFO - PROCESS | 21275 | 22:38:45 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:38:45 INFO - PROCESS | 21275 | RSS: Main: 165994496 22:38:45 INFO - PROCESS | 21275 | 22:38:48 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50100/tests/kraken/driver.html?testName=imaging-darkroom) 22:38:49 INFO - PROCESS | 21275 | RSS: Main: 166506496 22:38:49 INFO - PROCESS | 21275 | 22:38:52 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50100/tests/kraken/driver.html?testName=imaging-desaturate) 22:38:53 INFO - PROCESS | 21275 | RSS: Main: 166490112 22:38:53 INFO - PROCESS | 21275 | 22:38:56 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50100/tests/kraken/driver.html?testName=json-parse-financial) 22:38:56 INFO - PROCESS | 21275 | RSS: Main: 166846464 22:38:56 INFO - PROCESS | 21275 | 22:38:58 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:38:59 INFO - PROCESS | 21275 | RSS: Main: 167133184 22:38:59 INFO - PROCESS | 21275 | 22:39:00 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50100/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:39:01 INFO - PROCESS | 21275 | RSS: Main: 167469056 22:39:01 INFO - PROCESS | 21275 | 22:39:03 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:39:04 INFO - PROCESS | 21275 | RSS: Main: 167329792 22:39:04 INFO - PROCESS | 21275 | 22:39:06 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:39:07 INFO - PROCESS | 21275 | RSS: Main: 166961152 22:39:07 INFO - PROCESS | 21275 | 22:39:10 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:39:10 INFO - PROCESS | 21275 | RSS: Main: 166961152 22:39:10 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:50100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50100/tests/kraken/driver.html?testName=ai-astar) 22:39:12 INFO - PROCESS | 21275 | RSS: Main: 168202240 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | __start_tp_report 22:39:12 INFO - PROCESS | 21275 | _x_x_mozilla_page_load 22:39:12 INFO - PROCESS | 21275 | _x_x_mozilla_page_load_details 22:39:12 INFO - PROCESS | 21275 | |i|pagename|runs| 22:39:12 INFO - PROCESS | 21275 | |0;ai-astar;116;106;113;113;112;113;112;113;111;111 22:39:12 INFO - PROCESS | 21275 | |1;audio-beat-detection;158;123;156;180;127;156;164;127;182;124 22:39:12 INFO - PROCESS | 21275 | |2;audio-dft;161;162;162;163;162;163;169;161;163;163 22:39:12 INFO - PROCESS | 21275 | |3;audio-fft;75;76;74;161;76;74;73;74;169;80 22:39:12 INFO - PROCESS | 21275 | |4;audio-oscillator;84;85;145;85;84;82;136;84;83;152 22:39:12 INFO - PROCESS | 21275 | |5;imaging-gaussian-blur;118;117;118;117;117;117;118;116;117;117 22:39:12 INFO - PROCESS | 21275 | |6;imaging-darkroom;146;146;147;147;146;147;146;146;147;147 22:39:12 INFO - PROCESS | 21275 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;95;95 22:39:12 INFO - PROCESS | 21275 | |8;json-parse-financial;55;55;55;54;55;57;56;79;54;57 22:39:12 INFO - PROCESS | 21275 | |9;json-stringify-tinderbox;62;65;61;62;62;62;61;62;61;62 22:39:12 INFO - PROCESS | 21275 | |10;stanford-crypto-aes;80;81;83;80;85;81;81;80;81;80 22:39:12 INFO - PROCESS | 21275 | |11;stanford-crypto-ccm;120;123;121;121;134;128;121;120;223;121 22:39:12 INFO - PROCESS | 21275 | |12;stanford-crypto-pbkdf2;163;164;163;161;160;158;159;161;164;158 22:39:12 INFO - PROCESS | 21275 | |13;stanford-crypto-sha256-iterative;62;63;63;64;63;63;64;62;62;61 22:39:12 INFO - PROCESS | 21275 | __end_tp_report 22:39:12 INFO - PROCESS | 21275 | __start_cc_report 22:39:12 INFO - PROCESS | 21275 | _x_x_mozilla_cycle_collect,869 22:39:12 INFO - PROCESS | 21275 | __end_cc_report 22:39:12 INFO - PROCESS | 21275 | __startTimestamp1464154752770__endTimestamp 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | ------- Summary: start ------- 22:39:12 INFO - PROCESS | 21275 | Number of tests: 14 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.54 (2.2%) stddev-sans-first:2.24 22:39:12 INFO - PROCESS | 21275 | Values: 116.0 106.0 113.0 113.0 112.0 113.0 112.0 113.0 111.0 111.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:157.00 stddev:22.90 (14.6%) stddev-sans-first:24.09 22:39:12 INFO - PROCESS | 21275 | Values: 158.0 123.0 156.0 180.0 127.0 156.0 164.0 127.0 182.0 124.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.28 (1.4%) stddev-sans-first:2.32 22:39:12 INFO - PROCESS | 21275 | Values: 161.0 162.0 162.0 163.0 162.0 163.0 169.0 161.0 163.0 163.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#3] audio-fft Cycles:10 Average:93.20 Median:74.50 stddev:37.94 (50.9%) stddev-sans-first:39.66 22:39:12 INFO - PROCESS | 21275 | Values: 75.0 76.0 74.0 161.0 76.0 74.0 73.0 74.0 169.0 80.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.00 stddev:29.47 (35.1%) stddev-sans-first:30.53 22:39:12 INFO - PROCESS | 21275 | Values: 84.0 85.0 145.0 85.0 84.0 82.0 136.0 84.0 83.0 152.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 22:39:12 INFO - PROCESS | 21275 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:39:12 INFO - PROCESS | 21275 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:39:12 INFO - PROCESS | 21275 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:55.50 stddev:7.56 (13.6%) stddev-sans-first:7.95 22:39:12 INFO - PROCESS | 21275 | Values: 55.0 55.0 55.0 54.0 55.0 57.0 56.0 79.0 54.0 57.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.15 (1.9%) stddev-sans-first:1.22 22:39:12 INFO - PROCESS | 21275 | Values: 62.0 65.0 61.0 62.0 62.0 62.0 61.0 62.0 61.0 62.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:1.62 (2.0%) stddev-sans-first:1.66 22:39:12 INFO - PROCESS | 21275 | Values: 80.0 81.0 83.0 80.0 85.0 81.0 81.0 80.0 81.0 80.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:122.00 stddev:31.87 (26.1%) stddev-sans-first:33.44 22:39:12 INFO - PROCESS | 21275 | Values: 120.0 123.0 121.0 121.0 134.0 128.0 121.0 120.0 223.0 121.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:162.00 stddev:2.33 (1.4%) stddev-sans-first:2.37 22:39:12 INFO - PROCESS | 21275 | Values: 163.0 164.0 163.0 161.0 160.0 158.0 159.0 161.0 164.0 158.0 22:39:12 INFO - PROCESS | 21275 | 22:39:12 INFO - PROCESS | 21275 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 22:39:12 INFO - PROCESS | 21275 | Values: 62.0 63.0 63.0 64.0 63.0 63.0 64.0 62.0 62.0 61.0 22:39:12 INFO - PROCESS | 21275 | -------- Summary: end -------- 22:39:12 INFO - PROCESS | 21275 | 22:39:13 INFO - TEST-INFO | 21275: exit 0 22:39:13 INFO - TEST-OK | kraken | took 61287ms 22:39:13 INFO - SUITE-END | took 1171s 22:39:13 INFO - Completed test suite (00:19:31) 22:39:13 INFO - javascript benchmark 22:39:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7190.5705256536785, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.598742163519, 3102.084884958937, 3115.657277699454, 3130.968690313097, 3143.732782713469, 5382.381026181985, 5395.055865223585, 5413.702246376448, 5462.863428414282, 5547.944520554804, 5390.0, 5423.511883930445, 5426.240326354314, 5441.483059109388, 5537.307836520435, 4890.902181956368, 4915.5821755150855, 5017.2405177152605, 5034.144195486758, 5079.720615366154, 667.1718651765458, 4882.145624515713, 4949.455559888409, 4974.577160941306, 5000.674956127858, 4943.629227807911, 4977.0792403405485, 5001.999600079998, 5007.774650140753, 5013.473585273548, 5010.924836127461, 5014.598832093424, 5021.271915572258, 5025.14572522672, 5038.924416133761, 4925.876853078666, 4935.259711043336, 4957.925631115536, 4974.37820272466, 4979.0788704089855, 5345.3585569731495, 5371.194320851864, 5409.83770486886, 5415.0, 5436.782528698847, 5693.259876216065, 5754.194412782172, 5756.136579513107, 5762.855928601776, 5781.653100813965, 5931.436513531251, 5943.524518038546, 5956.404359564052, 5960.880782384328, 6013.128096426038, 5538.723063846832, 5549.361823390322, 5553.666779993213, 5558.722063896789, 5564.33228012637, 5868.23712917318, 5960.731767070492, 6019.879602407927, 6028.09578563219, 6030.487408570233, 5772.538196944234, 5794.768209271582, 5798.768049278066, 5801.3038435388025, 5854.795082172103, 5789.1605717171615, 5816.040353341651, 5825.300963884361, 5862.267216597926, 5873.647581145145, 5702.6293290935955, 5811.88376232473, 5842.415758424124, 5864.06175011996, 5883.970580147072, 5820.35976042635, 5868.119782032644, 5874.236349274567, 5877.52979761618, 5884.735186916599, 4408.53710360414, 4461.776911154429, 4484.080763443486, 4484.260097083945, 4494.842680506166, 3857.9228415431535, 3897.279003384383, 3897.590752970897, 3941.881743547698, 3952.209558088394, 5519.31008623922, 5535.114381698909, 5543.0, 5560.193771903051, 5584.078627026576, 5826.94173058264, 5843.5909486336395, 5877.500412464903, 5891.293044834647, 5892.646441213541, 5541.196526503634, 5617.915731264035, 5631.4087020863035, 5647.774089036475, 5687.175359572839, 5045.621578381636, 5048.3184770056305, 5050.4949505049935, 5069.036882992294, 5093.898122037613, 5864.618799778001, 6014.218151640259, 6045.637261764308, 6072.848178795565, 6084.756609735649, 5876.823695289148, 5908.497777688859, 5914.940850591611, 5923.229980102559, 5933.792317268875, 6067.757289708362, 6084.90872636902, 6092.116643086816, 6118.663473509, 6131.202943617302, 5665.915011274752, 5798.362180160263, 5825.097109947965, 5831.970840145772, 5861.794837180678, 5918.171455996078, 5920.555958303058, 5922.615030023035, 5924.052151655715, 5979.043353063489, 5653.773849046157, 5706.914396284142, 5721.713914304351, 5725.971370143123, 5745.368009519033, 5543.750531226186, 5653.349864765604, 5687.658740475585, 5731.484166424875, 5747.396523364986, 5629.240052592848, 5660.54715622741, 5665.943340566541, 5677.034904066236, 5712.0, 5794.362620111869, 5814.73833677494, 5835.94164058354, 5848.707564621837, 5860.0, 5498.120300751861, 5555.416681248411, 5562.860928476821, 5660.0, 5677.914831277617], "value": 5366.333402464475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.5040215816554, 607.4017093163234, 623.6632218601952, 641.563736659072, 654.4502617801046, 38679.61320386795, 43989.0, 43995.3400698989, 44040.0, 44107.77946110273, 44137.0, 44504.77747611266, 44571.777141114246, 44663.3300500492, 44686.77656611712, 8669.479831210132, 8919.152680495343, 8935.285177185842, 8936.776580585472, 8968.103189681045, 8654.524001179963, 8754.168354006359, 8765.737027889174, 8768.0, 8773.912260877405, 8732.650693972233, 8773.210411063003, 8821.823563528726, 8823.382363234576, 8845.425047371933, 8728.476291422503, 8738.0, 8754.430961987482, 8792.736217913473, 8803.867941980876, 8744.344174186897, 8845.646174153026, 8850.247728943048, 8851.07063758309, 8859.379843410963, 42191.57808421938, 42857.57142428598, 42907.35638965387, 42924.356134658, 43159.35260971088, 3523.066387407339, 3568.946465803015, 3584.623614520464, 3827.2154208387215, 3836.3286424875814, 32702.182445439055, 33810.661893380995, 33885.322293554236, 33898.66101339005, 33912.0, 4100.200460910124, 4252.744835309892, 4411.647068234533, 4520.139234211835, 4540.8637740867825, 267049.0, 354734.0, 360085.0, 361235.0, 363939.9999999974, 62491.37508624946, 62543.0, 62905.37094628995, 62908.0, 63155.0, 64959.350406496276, 66018.0, 66205.0, 66253.66873165603, 66287.0, 16167.514974550782, 16394.754078688828, 16416.261268242957, 16422.83577164213, 16451.91774041122, 11713.765724685458, 11740.88259117415, 11753.529858805723, 11757.235779674294, 11827.704307392383, 18384.121991993572, 19667.311644092388, 19726.0, 19785.0, 19874.403767886986, 3227.4351988401936, 3313.7797675557435, 7232.153113871508, 7305.232950540117, 7326.4505162113055, 1041.3923654412738, 1061.8725752909545, 1154.0709728668335, 1171.4025846818013, 1230.5816022552197, 33480.66519334824, 33642.66357336444, 33759.493607595905, 33815.32926951144, 33902.32195356079, 1111.8165502692127, 1148.8104462763717, 1156.6298784388914, 1174.512577280436, 1181.8699943006263, 17519.47441576755, 17961.640767184585, 17967.281308747766, 18011.459656210336, 18013.369532066314, 524202.0, 524996.0, 526355.0, 528060.0, 534419.0, 61539.6923015391, 61958.38041619526, 62097.37902621007, 62550.37449625537, 62836.37163628397, 1337.104140226051, 1370.5819724983976, 1381.081580748811, 1386.4038463460809, 1397.0779285671408, 31915.521267181477, 32753.672463275063, 33378.0, 33435.33129337448, 34041.48937765985, 48285.0, 48359.0, 48587.5141248583, 48729.5127048725, 48935.26597101118, 458469.0, 460090.0, 463308.0, 464025.0, 464813.0, 28700.569491457227, 28974.27564310909, 29650.555241671824, 29817.403651926405, 29837.403251934407, 50114.0, 50825.74587127041, 50879.0, 51600.0, 52175.47824521706, 37561.0, 41788.0, 44651.553484466036, 45482.31776523289, 46540.06919861652, 41663.37504937368, 41699.37450938178, 42286.788566056974, 42319.36520952127, 42387.0, 41718.79140604277, 41866.162676746906, 42659.14681706411, 43348.56651433571, 43407.56592434035, 34938.82530587331, 37128.628713713595, 37417.43873841949, 37915.0, 38015.0, 28881.566776497948, 29323.0, 29343.413131737674, 29352.0, 29487.410251794416], "value": 20425.618248850722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.34752226170974, 383.9980800096001, 384.25262863730046, 393.3117045170951, 402.4627122791074, 17137.82862171378, 19077.809221907777, 19458.610827783436, 19523.12145953432, 19668.21327146916, 18186.818131818713, 18439.262429502804, 18737.15682794274, 18758.718619220723, 19036.904815475937, 4833.226683730612, 4930.28510865926, 4978.079055374749, 4981.576565991877, 5006.374203224597, 5058.974705126469, 5148.073346797575, 5152.149895267276, 5173.3533308336455, 5199.14214154664, 4975.875603109915, 5132.820351287705, 5138.7944482220855, 5151.459096794839, 5151.587872970172, 5094.566961808251, 5142.100132476801, 5160.716160611146, 5185.585153187755, 5187.922181167285, 4844.394450693663, 4956.2565615157655, 4999.075171093359, 5026.447090820006, 5038.042771873333, 13643.181409115485, 13951.302434878316, 14134.15195088298, 14146.36341364641, 14194.787078193835, 2158.104386679526, 2243.6298010828195, 2322.100730442392, 2349.8120150387927, 2456.9877150614134, 9372.343935924488, 10108.039736225046, 10109.545070471846, 10503.737406564896, 13231.933840330834, 1974.8222659960672, 2011.1955217912805, 2064.876107433544, 2080.708700781892, 2094.5706130243266, 58185.418145818425, 70735.64632176858, 75417.62291188564, 83898.70759692986, 86423.0, 10275.948620256851, 10409.68770936873, 10446.85084640689, 10585.24783556281, 11076.889231107747, 14139.586041395984, 14248.145111293356, 14268.714625707635, 14500.347484363228, 14508.854911450962, 7579.279968402993, 7684.269994350528, 7690.577018264049, 7728.381729461629, 7836.373090152774, 7103.964480177566, 7190.101237345332, 7214.170370407365, 7337.926620733724, 7498.925010749932, 4220.6412454941055, 4255.127698821734, 4271.572842715704, 4361.803718832597, 4760.547747963938, 1802.3331367393887, 1827.9908600456913, 1852.7961924188328, 1856.758621379212, 1919.42417274817, 914.6890057380523, 918.8897332320164, 959.7655899618192, 962.7256231973994, 1021.9437930913871, 19221.423357299303, 19729.802701973083, 19885.900570497055, 19949.202031918852, 20371.592568148553, 982.4056445850158, 983.1102851919024, 1011.6610935336597, 1015.3095894791466, 1031.128696251666, 10241.692749217535, 11027.918276315258, 11092.722681933015, 11161.386123763272, 11195.160362972809, 462610.0, 474351.0, 516068.0, 518420.0, 524497.0, 96690.51654741821, 96771.0, 98910.50544747374, 99798.5010074945, 100610.4969475148, 1014.3609525998721, 1027.8098551767946, 1031.3554028732042, 1037.8339465685453, 1038.2732087538602, 17523.737143943104, 17634.735478968083, 17846.732299015264, 17902.194401251716, 17931.193096310435, 39015.219695606494, 41236.79381603073, 42129.36805947852, 42784.786076069424, 45005.54994450144, 59682.0, 61143.69428152831, 61274.0, 61862.0, 62225.37774622196, 6029.909551356821, 7361.9631901842295, 7725.22747725223, 8075.9192408077515, 8770.429922055046, 12931.224126552437, 13183.274919879499, 13566.321683915567, 13672.93163534176, 13845.930770346084, 11044.33733975964, 11600.94199528997, 11750.236234645063, 11828.0, 11873.406329683654, 10929.781404372026, 11214.66356009321, 11350.886491134983, 11693.006094482063, 12120.454579543766, 11134.33194008362, 11595.304281743123, 11702.414879256174, 12084.45619947087, 12368.505259789868, 7808.219178082147, 7899.0, 7921.485103468256, 7972.521648701097, 8088.3529317653265, 9635.951820240854, 11079.72300692489, 11177.161712871404, 11230.775384492428, 11390.487428065591], "value": 8826.425474150034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.2920427399126, 1532.5095969289828, 1693.9068351240685, 1802.6304607555453, 1828.652556014357, 7893.250141236574, 8406.915930840705, 8538.871916921244, 9125.726228213147, 9130.543472826357, 8422.0735719071, 8584.742457726263, 8730.0, 8806.515641639708, 8850.247728943032, 2357.422431504284, 2413.75862413759, 2415.0581273303424, 2417.867017314047, 2420.116657420038, 2343.285297984114, 2366.065404165354, 2390.079819269585, 2419.2379400488876, 2426.9635955460594, 2401.3756423329887, 2428.2836563213896, 2438.622013587888, 2442.206282958037, 2442.9511409771794, 2325.4883925536355, 2328.883555822202, 2342.5432040751975, 2351.6472529120597, 2385.785279324869, 2287.462446325112, 2298.276043046435, 2307.2962746362355, 2309.3880121767743, 2312.7455979842202, 8788.901387326585, 8791.78020549485, 8816.294696424335, 8843.027267000625, 8866.689665861664, 5334.22653715213, 5404.378496472917, 5431.755570999315, 5439.972800136014, 5446.992306423324, 3428.8285585720614, 3505.0886769439876, 3568.750187486877, 3575.713942884563, 3577.874774382884, 1055.7255113670424, 1062.4740753327153, 1069.0859315285397, 1080.1089101491302, 1086.9510872010778, 12191.87808121925, 12394.0, 12439.937800310941, 12488.25070495773, 12492.312922789242, 4747.572718455355, 4770.904581908342, 4840.636952228597, 4883.02339532095, 4890.608751299887, 10545.894541054491, 10579.047885690325, 10581.682549523526, 10583.25917185805, 10627.787444251071, 5302.469753024744, 5390.0, 5398.217258497496, 5398.406175320712, 5399.271098401744, 4461.955380446219, 4921.901561968741, 4928.359313289249, 5065.746712664352, 5065.949340506621, 4111.6299533042165, 4114.704502111774, 4164.354525048622, 4193.580641935782, 4196.643285320721, 1300.681333073403, 1323.715401188749, 1324.026840272399, 1325.3903204525834, 1327.3495986966318, 934.4860326820358, 937.9155875971195, 959.6881013670585, 963.1957315641378, 988.081084591337, 5661.320641523043, 5774.422557744192, 5866.6186697864505, 5918.674472903946, 6024.668643224665, 442.7476338487096, 447.16157205240177, 451.2847137287371, 1035.089121573011, 1056.9207309451667, 3981.960180398217, 3993.4209539616595, 4004.59954004603, 4008.0581063450068, 4051.1897620476025, 10864.891351086546, 11198.720031999264, 11252.043576296106, 11271.154663400277, 11379.203455758183, 10965.122790176767, 11029.0, 11192.0, 11280.830787538194, 11285.943570282096, 8335.0, 8566.18621230982, 8576.271016963503, 8576.914230857736, 8581.184787445183, 5644.943550564606, 5787.421257874179, 5794.18881356602, 5871.500922421471, 5894.115882617642, 10229.693109206439, 10267.178625709776, 10390.116840068376, 10422.73943151397, 10475.842862356918, 10259.179265658879, 10413.375197488174, 10564.313319634506, 10589.576416943237, 10609.522571484147, 6831.795046148623, 7264.23725508814, 7500.437467189873, 7529.8117547061765, 7695.153533111466, 8794.780130496789, 8805.075467076122, 8858.64565417376, 8866.73399798007, 8868.467891926504, 7643.426742994409, 7801.492902961516, 7802.882956755767, 7966.800829979297, 8122.918770812216, 7372.447066469929, 7770.14528401864, 7840.137584865546, 7938.24586664266, 8001.439899207, 6781.796546103625, 6925.168979722465, 6932.826679333057, 6990.790276291719, 6998.6150761708595, 5066.341375621146, 5114.744262786771, 5199.168133098686, 5229.450907654642, 5268.841934741964, 5224.3624767789315, 5233.031889100528, 5246.737663116905, 5276.657017293864, 5348.973255133699], "value": 4666.657244507988, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.99372012559735, 324.6461357120739, 325.0621955657927, 327.3306089047897, 328.9440795064839, 5432.348118225808, 5493.2034854946005, 5575.69333686647, 5708.1437784332375, 5747.275817254827, 5531.2809334786525, 5552.5280351170095, 5572.0, 5633.80281690141, 5675.531143952384, 4361.171377438284, 4396.560343965594, 4406.47122345319, 4406.625436837857, 4422.248217802981, 4091.284025295576, 4299.3550967354995, 4346.76092814895, 4406.493253275867, 4432.778361081949, 4273.551277115889, 4301.601979356706, 4327.956720432787, 4328.329108988112, 4343.109662519176, 4282.650964946063, 4360.345948107777, 4361.738295702252, 4381.3208952612395, 4391.934120988188, 3709.239605880815, 3732.869349572779, 3814.694824414068, 3824.349860523718, 3839.6736277416453, 5312.017276803804, 5329.227262046981, 5347.224652425415, 5412.5940554458575, 5437.755301011464, 4876.342043705122, 4919.631027672903, 4922.424824056304, 4935.667369810167, 4938.2839488274, 5518.613697041209, 5788.739506722208, 5849.444302791228, 5849.707514624251, 5891.057430811093, 4114.7119701620895, 4123.525794533637, 4124.8143833527265, 4135.462389889295, 4137.172565486914, 6025.186599809013, 6034.396560343975, 6051.818445446644, 6065.696715164268, 6084.209052823105, 4124.958750412457, 4187.685923555746, 4208.642265407413, 4241.384999175102, 4244.214820258262, 4223.852165174204, 4240.554741752133, 4243.809028593659, 4270.594293542109, 4281.2293787118615, 4910.729909854992, 4913.754312284372, 4926.167453714129, 4930.707221142186, 4962.528559786814, 5585.218069470277, 5851.151583020438, 5876.001079816441, 5878.677297608089, 5891.322497912709, 1460.5618314505605, 1463.100193381063, 1469.419579266184, 1474.7492926202572, 1483.0656686287784, 906.3791302957495, 917.9862302065475, 926.4719110107175, 937.9343445958854, 940.5062342270363, 5082.822101226513, 5089.0, 5092.363454568179, 5117.411497677815, 5118.718470484085, 5361.785528578813, 5404.621676482687, 5410.377806552218, 5437.211604317431, 5445.945540544623, 5110.616703747234, 5135.820246291362, 5153.330067091254, 5252.212168174728, 5687.345955215121, 3219.8390080495883, 3244.5782048334036, 3252.5446437498767, 3254.08885512057, 3266.7876588021704, 6132.6933653317155, 6212.254529456403, 6230.345813689588, 6239.814435257377, 6247.781327653601, 6046.365131661112, 6076.392360763888, 6145.66198859067, 6155.630662160284, 6169.352218017133, 6176.69116544171, 6192.566520343623, 6197.349278325801, 6206.968965155145, 6217.378262173836, 5750.7987220447085, 5946.821595352147, 6007.48936340416, 6024.90962635552, 6045.425684559959, 5947.821565353046, 5957.314908785372, 5981.222441082631, 6020.367861374492, 6024.367441418588, 5984.760609575568, 6187.597806142587, 6220.688965551795, 6231.22109736283, 6302.306746257999, 4166.729162604421, 4171.770552619635, 4222.155568886174, 4229.767362795076, 4233.407322974725, 5932.7033648318275, 5943.4948029416255, 6050.9394906050375, 6053.969730151321, 6109.480694141048, 5542.75057622416, 5856.765729370777, 5886.146508756121, 5905.232319798399, 5931.495822855106, 5841.678707671119, 5856.092305692625, 5866.208061911588, 5910.349861515316, 5923.49650279731, 5689.943100568941, 5720.456556627114, 5769.1634712967225, 5779.768809247751, 5817.76728930838, 5938.762449501972, 5954.225950626391, 5981.611195272293, 5997.730102145501, 6000.489958353589, 5707.971460142673, 5798.971005144947, 5810.854728631649, 5861.0, 5863.73613187399], "value": 4407.167834590802, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.5867066466767, 841.949483031018, 850.506706110456, 855.8331125430543, 897.9820403591924, 12360.134790564663, 13018.34908254587, 13040.413181406835, 13069.60791176265, 13070.803937940915, 11033.613823516178, 13779.65550861229, 13793.172409655403, 13802.654933626663, 13843.861561384383, 801.5030680977802, 830.4560512864084, 833.2792134803412, 834.6703052294371, 835.6239692138531, 815.1522416686639, 818.6807145213371, 822.7408366364576, 822.7696245051395, 824.2499325613693, 856.644492535597, 860.8364410761935, 861.0958493581745, 861.3066481482405, 864.4381152251055, 850.4812064640595, 852.0329426101357, 852.2713080316364, 853.4282031039219, 855.230292736539, 622.365187508743, 623.2147494157394, 623.6569886562372, 624.2166081567649, 624.3101372982834, 13258.071934964557, 13263.734725305536, 13266.535671251557, 13266.66833329165, 13267.203967761965, 14422.134671919614, 14623.488177913721, 14734.778978315333, 14735.70528589433, 14809.0, 11663.650090497298, 11700.824487632608, 11728.061755059574, 11770.0, 12134.696632584168, 3804.391297392404, 3928.351821949375, 3949.782761948092, 4058.3303754880703, 4059.939100913489, 57310.426895730925, 58534.41465585375, 58539.414605853824, 58647.0, 58978.70510647419, 11150.275232109887, 11304.604338848101, 11418.371989540488, 11774.529018839321, 11821.586244481574, 20923.16307347689, 21110.788892111188, 21169.78830211709, 21214.36356909295, 21218.78781212199, 8337.24964753163, 8352.415330926777, 8933.374663773604, 8969.237614802814, 9028.0, 4736.147493451212, 4746.8101275948575, 4803.471618122004, 4935.87660308488, 4939.234418665113, 3245.2535916739284, 3280.852361643732, 3287.7534184936226, 3287.8656863382093, 3312.5362449257123, 607.1469585232755, 609.856683679335, 611.9877602447926, 620.6214209332304, 623.4046485606235, 622.6886556721639, 626.6083697688945, 708.574855086954, 767.4052609227894, 791.2720297326473, 8686.826263474695, 9062.546872656472, 9158.267338612895, 9205.585748641328, 9245.676401325922, 640.3372509452694, 664.6344510519292, 755.2334380603692, 825.7357645553485, 842.2966822702989, 4589.678722489393, 4811.254255590389, 4862.586680132228, 4907.141250281186, 4947.802087916515, 70733.0, 71845.0, 72400.63799680967, 72915.63542182361, 74153.62923185457, 64503.0, 65349.34650653528, 65441.0, 66785.0, 67465.0, 55947.16079258733, 56665.150022749694, 57218.0, 58111.41888581144, 58957.41042589605, 9287.48918809472, 9288.674896378594, 9423.952880235554, 9508.429494230368, 9537.332386732862, 37613.0, 37917.81041094777, 38925.2214955705, 38933.415998759476, 39439.0, 46574.53425465702, 51975.0, 52138.0, 52506.0, 52734.73632631966, 11359.886401135884, 11509.482073306888, 11559.017483513659, 12104.09219308573, 12127.332996685267, 12878.0, 12884.613461596167, 13095.41070651804, 13619.250941197934, 13906.304684765519, 11876.406179690808, 12350.876491234972, 12757.55348562796, 12881.8067728986, 12920.966322693974, 12294.077944154045, 12320.199187052813, 12412.81380779271, 13121.803172952605, 13184.340782960622, 12073.698157546132, 12415.503379864704, 12698.365081745691, 12814.487420503076, 13075.215487070805, 9902.653407130716, 10150.644727434505, 10217.386956782617, 10526.0, 10571.312864663772, 10283.84574231402, 10696.732581685521, 10702.411367374869, 10773.0, 10783.24517283814], "value": 6945.983682493752, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 106.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 111.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 156.0, 180.0, 127.0, 156.0, 164.0, 127.0, 182.0, 124.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 162.0, 163.0, 169.0, 161.0, 163.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 161.0, 76.0, 74.0, 73.0, 74.0, 169.0, 80.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 145.0, 85.0, 84.0, 82.0, 136.0, 84.0, 83.0, 152.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 57.0, 56.0, 79.0, 54.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 83.0, 80.0, 85.0, 81.0, 81.0, 80.0, 81.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 121.0, 121.0, 134.0, 128.0, 121.0, 120.0, 223.0, 121.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 161.0, 160.0, 158.0, 159.0, 161.0, 164.0, 158.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 62.0, 62.0, 61.0], "value": 62.7, "unit": "score"}]}]} 22:39:14 INFO - Return code: 0 22:39:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:39:14 ERROR - # TBPL SUCCESS # 22:39:14 INFO - Running post-action listener: _resource_record_post_action 22:39:14 INFO - ##### 22:39:14 INFO - ##### Finished run-tests step (success) 22:39:14 INFO - ##### 22:39:14 INFO - Running post-run listener: _resource_record_post_run 22:39:14 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549142528; Read time: 8; Write time: 554976 22:39:14 INFO - TinderboxPrint: CPU usage
13.5% 22:39:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:39:14 INFO - TinderboxPrint: I/O write bytes / time
549,142,528 / 554,976 22:39:14 INFO - TinderboxPrint: CPU idle
8,208.0 (86.5%) 22:39:14 INFO - TinderboxPrint: CPU user
1,223.7 (12.9%) 22:39:14 INFO - TinderboxPrint: Swap in / out
0 / 0 22:39:14 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256274432; Read time: 0; Write time: 321028 22:39:14 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290623488; Read time: 8; Write time: 233832 22:39:14 INFO - Running post-run listener: _upload_blobber_files 22:39:14 INFO - Blob upload gear active. 22:39:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:39:14 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 22:39:14 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:39:14 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:39:15 INFO - (blobuploader) - INFO - Open directory for files ... 22:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:39:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:15 INFO - (blobuploader) - INFO - Done attempting. 22:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:39:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:16 INFO - (blobuploader) - INFO - Done attempting. 22:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:20 INFO - (blobuploader) - INFO - Done attempting. 22:39:20 INFO - (blobuploader) - INFO - Iteration through files over. 22:39:20 INFO - Return code: 0 22:39:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:39:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:39:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40ea514261424fe7a17da1296414a4c3371c6ab6ba2636bb1f7a0428839b29d0a13858902ef91aa491753e00433e2b4b5823134e4a170db2f48b6afa41325dc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7b0500121c040275176b727e59bc85e657dd7a5f7954acad3bfbefbc6653aecb431722d063337d6588e4f70228c6a649b8f9f67e3d7eb6a1811b506f8a34f55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73fbce513731483d922da99a1f016ef6339cad0c285e8b4f4b20b58fe9168385a7b08366bc34ec396cda0075d36c212664ef03a45c2c540af1e6c117ccb817cb"} 22:39:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:39:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:39:20 INFO - Contents: 22:39:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40ea514261424fe7a17da1296414a4c3371c6ab6ba2636bb1f7a0428839b29d0a13858902ef91aa491753e00433e2b4b5823134e4a170db2f48b6afa41325dc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7b0500121c040275176b727e59bc85e657dd7a5f7954acad3bfbefbc6653aecb431722d063337d6588e4f70228c6a649b8f9f67e3d7eb6a1811b506f8a34f55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73fbce513731483d922da99a1f016ef6339cad0c285e8b4f4b20b58fe9168385a7b08366bc34ec396cda0075d36c212664ef03a45c2c540af1e6c117ccb817cb"} 22:39:20 INFO - Running post-run listener: copy_logs_to_upload_dir 22:39:20 INFO - Copying logs to upload dir... 22:39:20 INFO - mkdir: /builds/slave/test/build/upload/logs 22:39:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.434245 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-24 22:39:20.490395) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 22:39:20.494185) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337 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/Mozilla-Inbound/sha512/40ea514261424fe7a17da1296414a4c3371c6ab6ba2636bb1f7a0428839b29d0a13858902ef91aa491753e00433e2b4b5823134e4a170db2f48b6afa41325dc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7b0500121c040275176b727e59bc85e657dd7a5f7954acad3bfbefbc6653aecb431722d063337d6588e4f70228c6a649b8f9f67e3d7eb6a1811b506f8a34f55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73fbce513731483d922da99a1f016ef6339cad0c285e8b4f4b20b58fe9168385a7b08366bc34ec396cda0075d36c212664ef03a45c2c540af1e6c117ccb817cb"} build_url:https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/O6G9AU2nTISBsYjRGsDyGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40ea514261424fe7a17da1296414a4c3371c6ab6ba2636bb1f7a0428839b29d0a13858902ef91aa491753e00433e2b4b5823134e4a170db2f48b6afa41325dc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7b0500121c040275176b727e59bc85e657dd7a5f7954acad3bfbefbc6653aecb431722d063337d6588e4f70228c6a649b8f9f67e3d7eb6a1811b506f8a34f55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73fbce513731483d922da99a1f016ef6339cad0c285e8b4f4b20b58fe9168385a7b08366bc34ec396cda0075d36c212664ef03a45c2c540af1e6c117ccb817cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 22:39:20.519822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 22:39:20.520169) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464152256.17447-1505835337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 22:39:20.607345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 22:39:20.607659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 22:39:20.607975) ========= ========= Total master_lag: 0.18 =========