builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1465386796.66 results: success (0) buildid: 20160608033929 builduid: 3a350f67fdb04b55a67c75be9e4312c7 revision: 2011b521c19712830278bf7af43dae1034a14a7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.657738) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.658099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.658369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.672957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.673213) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 04:53:17-- 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.9M=0s 2016-06-08 04:53:17 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.761946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.762218) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015955 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.813707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:16.814426) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2011b521c19712830278bf7af43dae1034a14a7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2011b521c19712830278bf7af43dae1034a14a7f --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=8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 04:53:17,204 truncating revision to first 12 chars 2016-06-08 04:53:17,204 Setting DEBUG logging. 2016-06-08 04:53:17,204 attempt 1/10 2016-06-08 04:53:17,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2011b521c197?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 04:53:17,521 unpacking tar archive at: fx-team-2011b521c197/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:17.500557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:17.501254) ========= script_repo_revision: 2011b521c19712830278bf7af43dae1034a14a7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:17.502231) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:17.502968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 04:53:17.519703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-08 04:53:17.520028) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:53:17 INFO - MultiFileLogger online at 20160608 04:53:17 in /builds/slave/test 04:53:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:53:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:17 INFO - {'append_to_log': False, 04:53:17 INFO - 'base_work_dir': '/builds/slave/test', 04:53:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:53:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:17 INFO - 'branch': 'Fx-Team-Non-PGO', 04:53:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:17 INFO - 'config_files': ('talos/linux_config.py',), 04:53:17 INFO - 'default_actions': ('clobber', 04:53:17 INFO - 'read-buildbot-config', 04:53:17 INFO - 'download-and-extract', 04:53:17 INFO - 'populate-webroot', 04:53:17 INFO - 'create-virtualenv', 04:53:17 INFO - 'install', 04:53:17 INFO - 'run-tests'), 04:53:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:17 INFO - 'download_minidump_stackwalk': True, 04:53:17 INFO - 'download_symbols': 'ondemand', 04:53:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:17 INFO - 'installer_path': 'installer.exe', 04:53:17 INFO - 'log_level': 'info', 04:53:17 INFO - 'log_name': 'talos', 04:53:17 INFO - 'log_to_console': True, 04:53:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:53:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:53:17 INFO - 'opt_config_files': (), 04:53:17 INFO - 'pip_index': False, 04:53:17 INFO - 'sps_profile': False, 04:53:17 INFO - 'sps_profile_interval': 0, 04:53:17 INFO - 'suite': 'dromaeojs-e10s', 04:53:17 INFO - 'system_bits': '32', 04:53:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:17 INFO - 'title': 'talos-linux64-ix-001', 04:53:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:17 INFO - 'use_talos_json': True, 04:53:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:17 INFO - 'work_dir': 'build'} 04:53:17 INFO - ##### 04:53:17 INFO - ##### Running clobber step. 04:53:17 INFO - ##### 04:53:17 INFO - Running pre-action listener: _resource_record_pre_action 04:53:17 INFO - Running main action method: clobber 04:53:17 INFO - rmtree: /builds/slave/test/build 04:53:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:18 INFO - Running post-action listener: _resource_record_post_action 04:53:18 INFO - ##### 04:53:18 INFO - ##### Finished clobber step (success) 04:53:18 INFO - ##### 04:53:18 INFO - ##### 04:53:18 INFO - ##### Running read-buildbot-config step. 04:53:18 INFO - ##### 04:53:18 INFO - Running pre-action listener: _resource_record_pre_action 04:53:18 INFO - Running main action method: read_buildbot_config 04:53:18 INFO - Using buildbot properties: 04:53:18 INFO - { 04:53:18 INFO - "project": "", 04:53:18 INFO - "product": "firefox", 04:53:18 INFO - "script_repo_revision": "production", 04:53:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:53:18 INFO - "repository": "", 04:53:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:53:18 INFO - "buildid": "20160608033929", 04:53:18 INFO - "pgo_build": "False", 04:53:18 INFO - "basedir": "/builds/slave/test", 04:53:18 INFO - "buildnumber": 1568, 04:53:18 INFO - "slavename": "talos-linux64-ix-001", 04:53:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:53:18 INFO - "platform": "ubuntu64_hw", 04:53:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:53:18 INFO - "branch": "fx-team", 04:53:18 INFO - "repo_path": "integration/fx-team", 04:53:18 INFO - "revision": "2011b521c19712830278bf7af43dae1034a14a7f", 04:53:18 INFO - "stage_platform": "linux64", 04:53:18 INFO - "builduid": "3a350f67fdb04b55a67c75be9e4312c7", 04:53:18 INFO - "slavebuilddir": "test" 04:53:18 INFO - } 04:53:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:53:18 INFO - Running post-action listener: _resource_record_post_action 04:53:18 INFO - ##### 04:53:18 INFO - ##### Finished read-buildbot-config step (success) 04:53:18 INFO - ##### 04:53:18 INFO - ##### 04:53:18 INFO - ##### Running download-and-extract step. 04:53:18 INFO - ##### 04:53:18 INFO - Running pre-action listener: _resource_record_pre_action 04:53:18 INFO - Running main action method: download_and_extract 04:53:18 INFO - mkdir: /builds/slave/test/build/tests 04:53: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')]} 04:53:18 INFO - https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:53:22 INFO - Downloaded 1361 bytes. 04:53:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:53:22 INFO - Using the following test package requirements: 04:53:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:53:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:53:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:22 INFO - u'jsshell-linux-x86_64.zip'], 04:53:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:53:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:53:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:53:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:53:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:53:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:22 INFO - https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:53:23 INFO - Downloaded 22878197 bytes. 04:53:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:53:24 INFO - Return code: 0 04:53:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:24 INFO - https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:53:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:53:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:53:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:53:26 INFO - Downloaded 22878197 bytes. 04:53:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:53:27 INFO - Return code: 0 04:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:27 INFO - https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:53:29 INFO - Downloaded 10833369 bytes. 04:53:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:53:29 INFO - Return code: 0 04:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:29 INFO - https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:53:31 INFO - Downloaded 55298970 bytes. 04:53:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:53:31 INFO - mkdir: /builds/slave/test/properties 04:53:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:31 INFO - Contents: 04:53:31 INFO - build_url:https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:53:32 INFO - Running post-action listener: _resource_record_post_action 04:53:32 INFO - Running post-action listener: set_extra_try_arguments 04:53:32 INFO - ##### 04:53:32 INFO - ##### Finished download-and-extract step (success) 04:53:32 INFO - ##### 04:53:32 INFO - ##### 04:53:32 INFO - ##### Running populate-webroot step. 04:53:32 INFO - ##### 04:53:32 INFO - Running pre-action listener: _resource_record_pre_action 04:53:32 INFO - Running main action method: populate_webroot 04:53:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:32 INFO - '--tppagecycles', 04:53:32 INFO - '7'], 04:53:32 INFO - 'tests': ['tsvgm']}}, 04:53:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:32 INFO - 'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:32 INFO - 'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['damp', 'tps']}, 04:53:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:32 INFO - 'tests': ['damp', 'tps']}, 04:53:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['dromaeo_dom']}, 04:53:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['a11yr', 04:53:32 INFO - 'ts_paint', 04:53:32 INFO - 'tpaint', 04:53:32 INFO - 'sessionrestore', 04:53:32 INFO - 'sessionrestore_no_auto_restore', 04:53:32 INFO - 'tabpaint']}, 04:53:32 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:32 INFO - 'ts_paint', 04:53:32 INFO - 'tpaint', 04:53:32 INFO - 'sessionrestore', 04:53:32 INFO - 'sessionrestore_no_auto_restore', 04:53:32 INFO - 'tabpaint']}, 04:53:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:32 INFO - 'ts_paint', 04:53:32 INFO - 'tpaint', 04:53:32 INFO - 'sessionrestore', 04:53:32 INFO - 'sessionrestore_no_auto_restore', 04:53:32 INFO - 'tabpaint']}, 04:53:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:32 INFO - 'ts_paint', 04:53:32 INFO - 'tpaint', 04:53:32 INFO - 'sessionrestore', 04:53:32 INFO - 'sessionrestore_no_auto_restore', 04:53:32 INFO - 'tabpaint']}, 04:53:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['a11yr', 04:53:32 INFO - 'ts_paint', 04:53:32 INFO - 'tpaint', 04:53:32 INFO - 'sessionrestore', 04:53:32 INFO - 'sessionrestore_no_auto_restore', 04:53:32 INFO - 'tabpaint']}, 04:53:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['a11yr', 04:53:32 INFO - 'ts_paint', 04:53:32 INFO - 'tpaint', 04:53:32 INFO - 'sessionrestore', 04:53:32 INFO - 'sessionrestore_no_auto_restore', 04:53:32 INFO - 'tabpaint']}, 04:53:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['tsvgx', 04:53:32 INFO - 'tsvgr_opacity', 04:53:32 INFO - 'tart', 04:53:32 INFO - 'tscrollx', 04:53:32 INFO - 'cart']}, 04:53:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:32 INFO - 'tsvgr_opacity', 04:53:32 INFO - 'tart', 04:53:32 INFO - 'tscrollx', 04:53:32 INFO - 'cart']}, 04:53:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:32 INFO - 'talos_options': ['--disable-e10s'], 04:53:32 INFO - 'tests': ['tp5o']}, 04:53:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:32 INFO - 'tests': ['tp5o']}, 04:53:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:32 INFO - 'talos_options': ['--disable-e10s', 04:53:32 INFO - '--xperf_path', 04:53:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:32 INFO - 'tests': ['tp5n']}, 04:53:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:32 INFO - 'talos_options': ['--xperf_path', 04:53:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:32 INFO - 'tests': ['tp5n']}}, 04:53:32 INFO - 'talos.zip': {'path': '', 04:53:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:32 INFO - Running post-action listener: _resource_record_post_action 04:53:32 INFO - ##### 04:53:32 INFO - ##### Finished populate-webroot step (success) 04:53:32 INFO - ##### 04:53:32 INFO - ##### 04:53:32 INFO - ##### Running create-virtualenv step. 04:53:32 INFO - ##### 04:53:32 INFO - Running pre-action listener: _resource_record_pre_action 04:53:32 INFO - Running main action method: create_virtualenv 04:53:32 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:32 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 04:53:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:32 INFO - Using real prefix '/usr' 04:53:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:34 INFO - Installing pip.................done. 04:53:34 INFO - Return code: 0 04:53:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:34 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')]} 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:34 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')]} 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:34 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:34 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 04:53:34 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 04:53:34 INFO - Using env: {'DISPLAY': ':0', 04:53:34 INFO - 'HOME': '/home/cltbld', 04:53:34 INFO - 'LANG': 'en_US.UTF-8', 04:53:34 INFO - 'LANGUAGE': 'en_US:en', 04:53:34 INFO - 'LOGNAME': 'cltbld', 04:53:34 INFO - 'MAIL': '/var/mail/cltbld', 04:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:34 INFO - 'MOZ_NO_REMOTE': '1', 04:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:34 INFO - 'NO_EM_RESTART': '1', 04:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:34 INFO - 'PWD': '/builds/slave/test', 04:53:34 INFO - 'SHELL': '/bin/bash', 04:53:34 INFO - 'SHLVL': '1', 04:53:34 INFO - 'TERM': 'linux', 04:53:34 INFO - 'TMOUT': '86400', 04:53:34 INFO - 'USER': 'cltbld', 04:53:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:34 INFO - '_': '/tools/buildbot/bin/python'} 04:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:34 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 04:53:34 INFO - Cleaning up... 04:53:34 INFO - Return code: 0 04:53:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:34 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')]} 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:34 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')]} 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:34 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:34 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 04:53:34 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 04:53:34 INFO - Using env: {'DISPLAY': ':0', 04:53:34 INFO - 'HOME': '/home/cltbld', 04:53:34 INFO - 'LANG': 'en_US.UTF-8', 04:53:34 INFO - 'LANGUAGE': 'en_US:en', 04:53:34 INFO - 'LOGNAME': 'cltbld', 04:53:34 INFO - 'MAIL': '/var/mail/cltbld', 04:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:34 INFO - 'MOZ_NO_REMOTE': '1', 04:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:34 INFO - 'NO_EM_RESTART': '1', 04:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:34 INFO - 'PWD': '/builds/slave/test', 04:53:34 INFO - 'SHELL': '/bin/bash', 04:53:34 INFO - 'SHLVL': '1', 04:53:34 INFO - 'TERM': 'linux', 04:53:34 INFO - 'TMOUT': '86400', 04:53:34 INFO - 'USER': 'cltbld', 04:53:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:34 INFO - '_': '/tools/buildbot/bin/python'} 04:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:35 INFO - Downloading/unpacking psutil>=3.1.1 04:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:37 INFO - Installing collected packages: psutil 04:53:37 INFO - Running setup.py install for psutil 04:53:37 INFO - building 'psutil._psutil_linux' extension 04:53:37 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 04:53:37 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 04:53:37 INFO - building 'psutil._psutil_posix' extension 04:53:37 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 04:53:37 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 04:53:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:37 INFO - Successfully installed psutil 04:53:37 INFO - Cleaning up... 04:53:37 INFO - Return code: 0 04:53:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53:37 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')]} 04:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:37 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')]} 04:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:37 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:37 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 04:53:37 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 04:53:37 INFO - Using env: {'DISPLAY': ':0', 04:53:37 INFO - 'HOME': '/home/cltbld', 04:53:37 INFO - 'LANG': 'en_US.UTF-8', 04:53:37 INFO - 'LANGUAGE': 'en_US:en', 04:53:37 INFO - 'LOGNAME': 'cltbld', 04:53:37 INFO - 'MAIL': '/var/mail/cltbld', 04:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:37 INFO - 'MOZ_NO_REMOTE': '1', 04:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:37 INFO - 'NO_EM_RESTART': '1', 04:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:37 INFO - 'PWD': '/builds/slave/test', 04:53:37 INFO - 'SHELL': '/bin/bash', 04:53:37 INFO - 'SHLVL': '1', 04:53:37 INFO - 'TERM': 'linux', 04:53:37 INFO - 'TMOUT': '86400', 04:53:37 INFO - 'USER': 'cltbld', 04:53:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:37 INFO - '_': '/tools/buildbot/bin/python'} 04:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:39 INFO - Installing collected packages: mozsystemmonitor 04:53:39 INFO - Running setup.py install for mozsystemmonitor 04:53:39 INFO - Successfully installed mozsystemmonitor 04:53:39 INFO - Cleaning up... 04:53:40 INFO - Return code: 0 04:53:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:53:40 INFO - Using env: {'DISPLAY': ':0', 04:53:40 INFO - 'HOME': '/home/cltbld', 04:53:40 INFO - 'LANG': 'en_US.UTF-8', 04:53:40 INFO - 'LANGUAGE': 'en_US:en', 04:53:40 INFO - 'LOGNAME': 'cltbld', 04:53:40 INFO - 'MAIL': '/var/mail/cltbld', 04:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:40 INFO - 'MOZ_NO_REMOTE': '1', 04:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:40 INFO - 'NO_EM_RESTART': '1', 04:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:40 INFO - 'PWD': '/builds/slave/test', 04:53:40 INFO - 'SHELL': '/bin/bash', 04:53:40 INFO - 'SHLVL': '1', 04:53:40 INFO - 'TERM': 'linux', 04:53:40 INFO - 'TMOUT': '86400', 04:53:40 INFO - 'USER': 'cltbld', 04:53:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:40 INFO - '_': '/tools/buildbot/bin/python'} 04:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:42 INFO - warning: no files found matching '*.txt' 04:53:42 INFO - no previously-included directories found matching 'build' 04:53:42 INFO - no previously-included directories found matching 'dist' 04:53:42 INFO - no previously-included directories found matching '.git*' 04:53:42 INFO - Installing collected packages: jsonschema, functools32 04:53:42 INFO - Running setup.py install for functools32 04:53:42 INFO - warning: no files found matching '*.txt' 04:53:42 INFO - no previously-included directories found matching 'build' 04:53:42 INFO - no previously-included directories found matching 'dist' 04:53:42 INFO - no previously-included directories found matching '.git*' 04:53:42 INFO - Successfully installed jsonschema functools32 04:53:42 INFO - Cleaning up... 04:53:42 INFO - Return code: 0 04:53:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:42 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')]} 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 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')]} 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:42 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 04:53:42 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 04:53:42 INFO - Using env: {'DISPLAY': ':0', 04:53:42 INFO - 'HOME': '/home/cltbld', 04:53:42 INFO - 'LANG': 'en_US.UTF-8', 04:53:42 INFO - 'LANGUAGE': 'en_US:en', 04:53:42 INFO - 'LOGNAME': 'cltbld', 04:53:42 INFO - 'MAIL': '/var/mail/cltbld', 04:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:42 INFO - 'MOZ_NO_REMOTE': '1', 04:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:42 INFO - 'NO_EM_RESTART': '1', 04:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:42 INFO - 'PWD': '/builds/slave/test', 04:53:42 INFO - 'SHELL': '/bin/bash', 04:53:42 INFO - 'SHLVL': '1', 04:53:42 INFO - 'TERM': 'linux', 04:53:42 INFO - 'TMOUT': '86400', 04:53:42 INFO - 'USER': 'cltbld', 04:53:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:42 INFO - '_': '/tools/buildbot/bin/python'} 04:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:44 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 04:53:44 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 04:53:44 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 04:53:44 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 04:53:44 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 04:53:44 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 04:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:45 INFO - Downloading docopt-0.6.1.tar.gz 04:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:45 INFO - Running setup.py install for blobuploader 04:53:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:45 INFO - Running setup.py install for requests 04:53:45 INFO - Running setup.py install for docopt 04:53:46 INFO - Successfully installed blobuploader requests docopt 04:53:46 INFO - Cleaning up... 04:53:46 INFO - Return code: 0 04:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:46 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')]} 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 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')]} 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:46 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 04:53:46 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 04:53:46 INFO - Using env: {'DISPLAY': ':0', 04:53:46 INFO - 'HOME': '/home/cltbld', 04:53:46 INFO - 'LANG': 'en_US.UTF-8', 04:53:46 INFO - 'LANGUAGE': 'en_US:en', 04:53:46 INFO - 'LOGNAME': 'cltbld', 04:53:46 INFO - 'MAIL': '/var/mail/cltbld', 04:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:46 INFO - 'MOZ_NO_REMOTE': '1', 04:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:46 INFO - 'NO_EM_RESTART': '1', 04:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:46 INFO - 'PWD': '/builds/slave/test', 04:53:46 INFO - 'SHELL': '/bin/bash', 04:53:46 INFO - 'SHLVL': '1', 04:53:46 INFO - 'TERM': 'linux', 04:53:46 INFO - 'TMOUT': '86400', 04:53:46 INFO - 'USER': 'cltbld', 04:53:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:46 INFO - '_': '/tools/buildbot/bin/python'} 04:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:46 INFO - Running setup.py (path:/tmp/pip-R1WP19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:46 INFO - Running setup.py (path:/tmp/pip-loXvIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:46 INFO - Running setup.py (path:/tmp/pip-GMTfLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:46 INFO - Running setup.py (path:/tmp/pip-fvoJjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:46 INFO - Running setup.py (path:/tmp/pip-06XMuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:46 INFO - Running setup.py (path:/tmp/pip-CV2iZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:46 INFO - Running setup.py (path:/tmp/pip-PEeOAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:46 INFO - Running setup.py (path:/tmp/pip-Lk8wNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:46 INFO - Running setup.py (path:/tmp/pip-wLTsMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:46 INFO - Running setup.py (path:/tmp/pip-JV6HQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:47 INFO - Running setup.py (path:/tmp/pip-fAQZQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:47 INFO - Running setup.py (path:/tmp/pip-XB80Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:47 INFO - Running setup.py (path:/tmp/pip-318N_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:47 INFO - Running setup.py (path:/tmp/pip-4Gqbm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:47 INFO - Running setup.py (path:/tmp/pip-oc88Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:47 INFO - Running setup.py (path:/tmp/pip-DSnxmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:47 INFO - Running setup.py (path:/tmp/pip-pS2Hm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:47 INFO - Running setup.py install for manifestparser 04:53:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:47 INFO - Running setup.py install for mozcrash 04:53:47 INFO - Running setup.py install for mozdebug 04:53:47 INFO - Running setup.py install for mozdevice 04:53:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:47 INFO - Running setup.py install for mozfile 04:53:48 INFO - Running setup.py install for mozhttpd 04:53:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Running setup.py install for mozinfo 04:53:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Running setup.py install for mozInstall 04:53:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Running setup.py install for mozleak 04:53:48 INFO - Running setup.py install for mozlog 04:53:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Running setup.py install for moznetwork 04:53:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Running setup.py install for mozprocess 04:53:48 INFO - Running setup.py install for mozprofile 04:53:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Running setup.py install for mozrunner 04:53:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Running setup.py install for mozscreenshot 04:53:49 INFO - Running setup.py install for moztest 04:53:49 INFO - Running setup.py install for mozversion 04:53:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:49 INFO - Cleaning up... 04:53:49 INFO - Return code: 0 04:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:49 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')]} 04:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:49 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')]} 04:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:49 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:49 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 04:53:49 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 04:53:49 INFO - Using env: {'DISPLAY': ':0', 04:53:49 INFO - 'HOME': '/home/cltbld', 04:53:49 INFO - 'LANG': 'en_US.UTF-8', 04:53:49 INFO - 'LANGUAGE': 'en_US:en', 04:53:49 INFO - 'LOGNAME': 'cltbld', 04:53:49 INFO - 'MAIL': '/var/mail/cltbld', 04:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:49 INFO - 'MOZ_NO_REMOTE': '1', 04:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:49 INFO - 'NO_EM_RESTART': '1', 04:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:49 INFO - 'PWD': '/builds/slave/test', 04:53:49 INFO - 'SHELL': '/bin/bash', 04:53:49 INFO - 'SHLVL': '1', 04:53:49 INFO - 'TERM': 'linux', 04:53:49 INFO - 'TMOUT': '86400', 04:53:49 INFO - 'USER': 'cltbld', 04:53:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:49 INFO - '_': '/tools/buildbot/bin/python'} 04:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:49 INFO - Running setup.py (path:/tmp/pip-3Xwtxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:49 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)) 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:49 INFO - Running setup.py (path:/tmp/pip-seIEyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:49 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)) 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:49 INFO - Running setup.py (path:/tmp/pip-mgohJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:49 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)) 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:49 INFO - Running setup.py (path:/tmp/pip-JnxVUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:49 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)) 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:49 INFO - Running setup.py (path:/tmp/pip-whn3Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:49 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)) 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:49 INFO - Running setup.py (path:/tmp/pip-sKqa4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:49 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)) 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:49 INFO - Running setup.py (path:/tmp/pip-sKDwZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:50 INFO - Running setup.py (path:/tmp/pip-mPolCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:50 INFO - Running setup.py (path:/tmp/pip-Hwx_XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:50 INFO - Running setup.py (path:/tmp/pip-D2NA2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:50 INFO - Running setup.py (path:/tmp/pip-qSNk2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:50 INFO - Running setup.py (path:/tmp/pip-Py8L5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:50 INFO - Running setup.py (path:/tmp/pip-mt6cGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:50 INFO - Running setup.py (path:/tmp/pip-UNOf04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:50 INFO - Running setup.py (path:/tmp/pip-rkUUuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:50 INFO - Running setup.py (path:/tmp/pip-Y4ETxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:50 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)) 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:50 INFO - Running setup.py (path:/tmp/pip-zFzEiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:50 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)) 04:53:50 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)) 04:53:50 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)) 04:53:50 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)) 04:53:50 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)) 04:53:50 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)) 04:53:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:52 INFO - Downloading blessings-1.6.tar.gz 04:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:52 INFO - Installing collected packages: blessings 04:53:52 INFO - Running setup.py install for blessings 04:53:52 INFO - Successfully installed blessings 04:53:52 INFO - Cleaning up... 04:53:52 INFO - Return code: 0 04:53:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:53 INFO - Reading from file tmpfile_stdout 04:53:53 INFO - Current package versions: 04:53:53 INFO - argparse == 1.2.1 04:53:53 INFO - blessings == 1.6 04:53:53 INFO - blobuploader == 1.2.4 04:53:53 INFO - docopt == 0.6.1 04:53:53 INFO - functools32 == 3.2.3-2 04:53:53 INFO - jsonschema == 2.5.1 04:53:53 INFO - manifestparser == 1.1 04:53:53 INFO - mozInstall == 1.12 04:53:53 INFO - mozcrash == 0.17 04:53:53 INFO - mozdebug == 0.1 04:53:53 INFO - mozdevice == 0.48 04:53:53 INFO - mozfile == 1.2 04:53:53 INFO - mozhttpd == 0.7 04:53:53 INFO - mozinfo == 0.9 04:53:53 INFO - mozleak == 0.1 04:53:53 INFO - mozlog == 3.2 04:53:53 INFO - moznetwork == 0.27 04:53:53 INFO - mozprocess == 0.22 04:53:53 INFO - mozprofile == 0.28 04:53:53 INFO - mozrunner == 6.11 04:53:53 INFO - mozscreenshot == 0.1 04:53:53 INFO - mozsystemmonitor == 0.3 04:53:53 INFO - moztest == 0.7 04:53:53 INFO - mozversion == 1.4 04:53:53 INFO - psutil == 3.1.1 04:53:53 INFO - requests == 1.2.3 04:53:53 INFO - wsgiref == 0.1.2 04:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:53 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')]} 04:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:53 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')]} 04:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:53 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:53 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 04:53:53 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 04:53:53 INFO - Using env: {'DISPLAY': ':0', 04:53:53 INFO - 'HOME': '/home/cltbld', 04:53:53 INFO - 'LANG': 'en_US.UTF-8', 04:53:53 INFO - 'LANGUAGE': 'en_US:en', 04:53:53 INFO - 'LOGNAME': 'cltbld', 04:53:53 INFO - 'MAIL': '/var/mail/cltbld', 04:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:53 INFO - 'MOZ_NO_REMOTE': '1', 04:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:53 INFO - 'NO_EM_RESTART': '1', 04:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:53 INFO - 'PWD': '/builds/slave/test', 04:53:53 INFO - 'SHELL': '/bin/bash', 04:53:53 INFO - 'SHLVL': '1', 04:53:53 INFO - 'TERM': 'linux', 04:53:53 INFO - 'TMOUT': '86400', 04:53:53 INFO - 'USER': 'cltbld', 04:53:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:53 INFO - '_': '/tools/buildbot/bin/python'} 04:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 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)) 04:53:53 INFO - Cleaning up... 04:53:53 INFO - Return code: 0 04:53:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:53 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')]} 04:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:53 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')]} 04:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:53 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:53 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 04:53:53 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 04:53:53 INFO - Using env: {'DISPLAY': ':0', 04:53:53 INFO - 'HOME': '/home/cltbld', 04:53:53 INFO - 'LANG': 'en_US.UTF-8', 04:53:53 INFO - 'LANGUAGE': 'en_US:en', 04:53:53 INFO - 'LOGNAME': 'cltbld', 04:53:53 INFO - 'MAIL': '/var/mail/cltbld', 04:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:53 INFO - 'MOZ_NO_REMOTE': '1', 04:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:53 INFO - 'NO_EM_RESTART': '1', 04:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:53 INFO - 'PWD': '/builds/slave/test', 04:53:53 INFO - 'SHELL': '/bin/bash', 04:53:53 INFO - 'SHLVL': '1', 04:53:53 INFO - 'TERM': 'linux', 04:53:53 INFO - 'TMOUT': '86400', 04:53:53 INFO - 'USER': 'cltbld', 04:53:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:53 INFO - '_': '/tools/buildbot/bin/python'} 04:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:53 INFO - Cleaning up... 04:53:53 INFO - Return code: 0 04:53:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:53:53 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')]} 04:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:53 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')]} 04:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:53 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 0x7f2573b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', '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 04:53:53 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 04:53:53 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 04:53:53 INFO - Using env: {'DISPLAY': ':0', 04:53:53 INFO - 'HOME': '/home/cltbld', 04:53:53 INFO - 'LANG': 'en_US.UTF-8', 04:53:53 INFO - 'LANGUAGE': 'en_US:en', 04:53:53 INFO - 'LOGNAME': 'cltbld', 04:53:53 INFO - 'MAIL': '/var/mail/cltbld', 04:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:53 INFO - 'MOZ_NO_REMOTE': '1', 04:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:53 INFO - 'NO_EM_RESTART': '1', 04:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:53 INFO - 'PWD': '/builds/slave/test', 04:53:53 INFO - 'SHELL': '/bin/bash', 04:53:53 INFO - 'SHLVL': '1', 04:53:53 INFO - 'TERM': 'linux', 04:53:53 INFO - 'TMOUT': '86400', 04:53:53 INFO - 'USER': 'cltbld', 04:53:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:53 INFO - '_': '/tools/buildbot/bin/python'} 04:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:53 INFO - Downloading/unpacking flake8 04:53:53 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 04:53:53 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 04:53:53 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 04:53:53 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 04:53:53 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 04:53:53 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 04:53:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:53:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:53:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:53:56 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 04:53:56 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 04:53:56 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 04:53:56 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 04:53:56 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 04:53:56 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 04:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:53:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:56 INFO - no previously-included directories found matching 'docs/_build' 04:53:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:53:56 INFO - Running setup.py install for pep8 04:53:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:56 INFO - no previously-included directories found matching 'docs/_build' 04:53:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:53:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:53:56 INFO - Cleaning up... 04:53:56 INFO - Return code: 0 04:53:56 INFO - Running post-action listener: _resource_record_post_action 04:53:56 INFO - Running post-action listener: _start_resource_monitoring 04:53:56 INFO - Starting resource monitoring. 04:53:56 INFO - ##### 04:53:56 INFO - ##### Finished create-virtualenv step (success) 04:53:56 INFO - ##### 04:53:56 INFO - ##### 04:53:56 INFO - ##### Running install step. 04:53:56 INFO - ##### 04:53:56 INFO - Running pre-action listener: _resource_record_pre_action 04:53:56 INFO - Running main action method: install 04:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:56 INFO - Reading from file tmpfile_stdout 04:53:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:57 INFO - Reading from file tmpfile_stdout 04:53:57 INFO - Output received: 04:53:57 INFO - Usage: mozinstall [options] installer 04:53:57 INFO - Options: 04:53:57 INFO - -h, --help show this help message and exit 04:53:57 INFO - -d DEST, --destination=DEST 04:53:57 INFO - Directory to install application into. [default: 04:53:57 INFO - "/builds/slave/test"] 04:53:57 INFO - --app=APP Application being installed. [default: firefox] 04:53:57 INFO - mkdir: /builds/slave/test/build/application 04:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:54:13 INFO - Reading from file tmpfile_stdout 04:54:13 INFO - Output received: 04:54:13 INFO - /builds/slave/test/build/application/firefox/firefox 04:54:13 INFO - Running post-action listener: _resource_record_post_action 04:54:13 INFO - ##### 04:54:13 INFO - ##### Finished install step (success) 04:54:13 INFO - ##### 04:54:13 INFO - ##### 04:54:13 INFO - ##### Running run-tests step. 04:54:13 INFO - ##### 04:54:13 INFO - Running pre-action listener: _resource_record_pre_action 04:54:13 INFO - Running main action method: run_tests 04:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:13 INFO - Python 2.7.3 04:54:13 INFO - Return code: 0 04:54:13 INFO - grabbing minidump binary from tooltool 04:54:13 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')]} 04:54:13 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 0x1f471c0>, '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 0x1f480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f48550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:13 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 04:54:13 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 04:54:13 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 04:54:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:13 INFO - Return code: 0 04:54:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:54:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:54:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:54:14 INFO - Return code: 0 04:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 04:54:14 INFO - Using env: {'DISPLAY': ':0', 04:54:14 INFO - 'HOME': '/home/cltbld', 04:54:14 INFO - 'LANG': 'en_US.UTF-8', 04:54:14 INFO - 'LANGUAGE': 'en_US:en', 04:54:14 INFO - 'LOGNAME': 'cltbld', 04:54:14 INFO - 'MAIL': '/var/mail/cltbld', 04:54:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:14 INFO - 'MOZ_NO_REMOTE': '1', 04:54:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:14 INFO - 'NO_EM_RESTART': '1', 04:54:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:14 INFO - 'PWD': '/builds/slave/test', 04:54:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:14 INFO - 'SHELL': '/bin/bash', 04:54:14 INFO - 'SHLVL': '1', 04:54:14 INFO - 'TERM': 'linux', 04:54:14 INFO - 'TMOUT': '86400', 04:54:14 INFO - 'USER': 'cltbld', 04:54:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839', 04:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:14 INFO - '_': '/tools/buildbot/bin/python'} 04:54:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:54:14 INFO - mozversion application_buildid: 20160608033929 04:54:14 INFO - mozversion application_changeset: 2011b521c19712830278bf7af43dae1034a14a7f 04:54:14 INFO - mozversion application_display_name: Nightly 04:54:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:14 INFO - mozversion application_name: Firefox 04:54:14 INFO - mozversion application_remotingname: firefox 04:54:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:54:14 INFO - mozversion application_vendor: Mozilla 04:54:14 INFO - mozversion application_version: 50.0a1 04:54:14 INFO - mozversion platform_buildid: 20160608033929 04:54:14 INFO - mozversion platform_changeset: 2011b521c19712830278bf7af43dae1034a14a7f 04:54:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:54:14 INFO - mozversion platform_version: 50.0a1 04:54:14 INFO - using testdate: 1465386854 04:54:14 INFO - actual date: 1465386854 04:54:14 INFO - starting webserver on 'localhost:60566' 04:54:14 INFO - SUITE-START | Running 2 tests 04:54:14 INFO - TEST-START | dromaeo_css 04:54:14 INFO - operating with platform_type : linux_ 04:54:14 INFO - Initialising browser for dromaeo_css test... 04:54:14 INFO - TEST-INFO | started process 15441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvto71F/profile http://localhost:60566/getInfo.html) 04:54:19 INFO - PROCESS | 15441 | __metrics Screen width/height:1600/1200 04:54:19 INFO - PROCESS | 15441 | colorDepth:24 04:54:19 INFO - PROCESS | 15441 | Browser inner width/height: 1024/697 04:54:19 INFO - PROCESS | 15441 | __metrics 04:54:20 ERROR - PROCESS | 15441 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:54:21 INFO - TEST-INFO | 15441: exit 0 04:54:21 INFO - Browser initialized. 04:54:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:21 INFO - TEST-INFO | started process 15560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvto71F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:33 INFO - PROCESS | 15560 | RSS: Main: 168456192 04:54:33 INFO - PROCESS | 15560 | 04:55:22 INFO - PROCESS | 15560 | 1465386922733 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] 04:57:35 INFO - PROCESS | 15560 | Cycle 1(1): loaded http://localhost:60566/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60566/tests/dromaeo/cssquery-ext.html) 04:57:37 INFO - PROCESS | 15560 | RSS: Main: 169439232 04:57:37 INFO - PROCESS | 15560 | 05:00:39 INFO - PROCESS | 15560 | Cycle 1(1): loaded http://localhost:60566/tests/dromaeo/cssquery-ext.html (next: http://localhost:60566/tests/dromaeo/cssquery-jquery.html) 05:00:39 INFO - PROCESS | 15560 | RSS: Main: 170000384 05:00:39 INFO - PROCESS | 15560 | 05:03:41 INFO - PROCESS | 15560 | Cycle 1(1): loaded http://localhost:60566/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60566/tests/dromaeo/cssquery-mootools.html) 05:03:42 INFO - PROCESS | 15560 | RSS: Main: 171364352 05:03:42 INFO - PROCESS | 15560 | 05:06:44 INFO - PROCESS | 15560 | Cycle 1(1): loaded http://localhost:60566/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60566/tests/dromaeo/cssquery-prototype.html) 05:06:44 INFO - PROCESS | 15560 | RSS: Main: 168509440 05:06:44 INFO - PROCESS | 15560 | 05:09:47 INFO - PROCESS | 15560 | Cycle 1(1): loaded http://localhost:60566/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60566/tests/dromaeo/cssquery-yui.html) 05:09:48 INFO - PROCESS | 15560 | RSS: Main: 171184128 05:09:48 INFO - PROCESS | 15560 | 05:12:50 INFO - PROCESS | 15560 | Cycle 1(1): loaded http://localhost:60566/tests/dromaeo/cssquery-yui.html (next: http://localhost:60566/tests/dromaeo/cssquery-dojo.html) 05:12:51 INFO - PROCESS | 15560 | RSS: Main: 171913216 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - PROCESS | 15560 | __start_tp_report 05:12:51 INFO - PROCESS | 15560 | _x_x_mozilla_page_load 05:12:51 INFO - PROCESS | 15560 | _x_x_mozilla_page_load_details 05:12:51 INFO - PROCESS | 15560 | |i|pagename|runs| 05:12:51 INFO - PROCESS | 15560 | |0;dojo.html;2674.5319569075414;2746.5742809864473;2762.654668166479;2765.8063935524497;2774.042955180463;4794.640401969853;4820.831270905519;4845.515448455157;4904.607631389489;4972.825951091703;4816.710997340162;4879.414470263565;4888.853334399965;4895.363602731649;4901.754912254382;4416.757078360689;4463.107378524308;4470.575295346945;4470.7317560946285;4512.435945506812;4457.799399027052;4490.079533695601;4530.501644819067;4534.614557762594;4571.497135315112;4405;4522.23122069249;4524.97737511312;4538.1377538267625;4552.499225085238;4477.48508921475;4492;4501.504834468205;4534.8186072557055;4558.088382323548;4469.888252793674;4470.776461176961;4476.932846007313;4489.393931819195;4542.591166794971;4717.410323709536;4796.832110876103;4811.508432385972;4812.903741925177;4824.445188803263;5149.794008239666;5157.742112894341;5163.612729045337;5166.328377310963;5171.4311425743135;5048.848534543969;5187.351581052369;5196;5198.272241886101;5214.713190774506;4833.492483289274;4853.417589889165;4872.731999740048;4875.34182885313;4875.68308059975;5333.06671332523;5373.453520676335;5378.381486129067;5383.16560933056;5407.378151512627;5029.974850125726;5079.6952182869145;5119.129747942859;5120.462351453044;5136.820211292662;5204.843854684365;5227.137522308853;5247.55395791362;5251.501107394792;5278.313819203479;5202.84391468249;5203.817866374735;5208.453112423217;5222.268882356473;5254.448282930313;4940.975295123501;5082.898342033139;5169.638125331191;5182.974085129626;5185.9740701297005;4269.252880745857;4358.019445624773;4394.231009573312;4437.134758722018;4460.50934397216;3856.807159642007;3859.8842034739005;3867.555231148454;3913.0413048802657;3919.6668283195677;4334.8266069357505;4537.6143027843;4549.567791059844;4561.361409402686;4599.563041511118;5180.248863914711;5295.4969277918535;5328.760205790749;5335.146376579729;5338.332708411449;4495.9325610115875;4553.54464553542;4556.817727290938;4564.863054108382;4614.723116613014;4551.795169217393;4579.473360563511;4669.182892993713;4706.082313948816;4738.4550776660435;4811;4833.081714474239;4845.927311090407;4846.80612775485;4903.8528844134735;5181.740912954413;5182.559482444034;5196.53231209193;5205.06308864408;5242.580593552583;4791.616670666408;4846.273059041172;4880.487548807324;4896.877578060577;4917.9016419672125;5173.40505841818;5184.403793563789;5205.73971301441;5242.977619364187;5261.053010458001;5257.526822585985;5261.868453288698;5267.89464210706;5279.89440211186;5326.014687282865;4968.478309777422;5054.140796064751;5080.542751152414;5103.489651034867;5109.514596113363;5090.974545127398;5094.439611642642;5102.872428189325;5104.770285337095;5179.326687530597;4983.25251212321;5035.244713293036;5038.1183292924325;5043.5460808527405;5046.091703493406;4936.531029552187;4954.925676114789;4994.02616489781;5090.109230884655;5124.718140502308;4907.214845624683;4926.408830940167;4938.259261110862;4939.185034469272;4954.3311652926395 05:12:51 INFO - PROCESS | 15560 | |1;ext.html;553.6133421805829;588.8527868032992;591.1044767177724;597.7758340622266;625.0904933322017;35292.47061294079;38202.617973820255;38244.61755382446;38291.61708382915;38465;39320.21359572807;40190;40201.99495012626;40224.19551608966;40283;7598.734044308464;7764.262395072459;7778.611069446533;7781.922180778176;7791.259830316111;7727.806804829868;7734.5359278443475;7743.10954240264;7762.340201082915;7809.531428114303;7691.692332306729;7759.728409505668;7839.529628222296;7871;7881.133075361706;7776.30013298803;7825.060992680857;7827.295543401121;7835.569043702594;7846.019247594079;7680.846383072308;7715.112762032326;7717.073951125901;7750.496217745828;7770.339521140653;35951.64048359535;35973.82013089918;36025.45961810575;36187.27625447476;36388.636113639055;2344.7069116360453;2709.647745793034;2789.079603730764;2797.1888152435768;2852.6291582094404;26850.5972410414;26956.326091847666;27219.319517012034;27564.310892227655;28079.157625271273;3275.24669326054;3385.1029477188317;3416.419208734521;3458;3474.5309383233443;254606;254931;256254;256696;257494;27992.44015119727;55950.440495595336;56395;56446.15330770042;56505;33525.49711754326;33539.66460335365;33748.32503349919;33861.66138338585;33987.49018764721;13815.654608634864;13915.095518791246;13985.650358741113;14038.36827342772;14045.08706934046;11714.297142171497;11763.235389699643;11793.877102121529;11811.055115590732;11852.585159519376;7874.72438464651;7907.881381779278;7972.242636949481;7992.800179995546;7995.040595128622;3124.703153200442;3174.1429813950103;3194.185482701896;3196.9840150799096;3203.6475987641343;859.5358506406595;932.6828878181451;955.7323949294208;998.2762497189625;1042.7705904700954;26830.731692683214;28110.2972425691;28463.57304640432;28516.28709282243;28803.56794648082;975.5805003848413;987.1658448610913;1028.6142696488816;1034.8292531732332;1077.9568817247223;14691.926540367229;15036.022658527161;15037.323320450607;15193;15316.23418829054;116288;116699;117100.41449792866;377666;386530;49800;50080.499195007586;50422.747886261066;50488;50612;1171.84765980422;1176.0195571753616;1208.848893888264;1215.8297838302644;1239.5909349914687;26045.739542604333;27763.30591735142;27764;28426.573601395583;28438.715612843607;42256.788716056224;42347.15305693931;42702;42797.78601107099;42958.14083718371;332013;333178;333898;334529;335311;25158.371040724127;25204.117855874956;25277.368065797767;25426.491470170862;25711.871440642677;37842;37847.43228851514;37972;37976;43254.783726081165;36634.8168259157;36696.449553257255;37176;37363.813180933925;37876.242475150895;35620.64379356277;36775;36849.263014739015;36943.261134776614;37266.44100338552;34963.47554786731;35198;35392;35534.822325888206;35721.285574288886;31318.530222047142;32800.671993279764;33001.66998330082;33024.834875825465;33269.33461330712;24552.508949821262;25335.493290133727;25411.745882540938;25499.617505737056;25553.872230638728 05:12:51 INFO - PROCESS | 15560 | |2;jquery.html;358.90489020409615;366.95229620149377;369.359161854183;376.5895174260056;387.56399051067547;15762.84237157628;16076.598085047865;16568.75146872798;16608.833911660895;16659.66680666386;16051.91974040131;16354.83645163548;17483.737743933852;17519.03645299508;17520.474385768415;4736.194846876022;5037.899242015157;5081.923771143436;5093.847184584469;5110.080185566597;3654.926901461969;4971;5461.590380721442;5780.797672081478;5784.537237021049;5839.357670656224;5844.64932104073;5844.795432159875;5860.384659610743;5863.853403664921;5686.317641882959;5738.971305143489;5824.941750582525;5826.213461182729;5846.50304724099;4971.925421118686;5108.361454818148;5110.361204849394;5113.974430127825;5125.513076257749;18965;19134.23463061476;19328.1302341395;19401.611967760567;19408.514787130436;1884.1521315408122;1898.7057006164066;1926.6050459655737;1933.2170470959284;2183.9407887174707;12773.23360598367;13273.269970151638;13493.662658433617;13580.456781728719;13686.31568421575;1712.3921008042091;1734.2976094681674;1761.8942863428235;1792.103948025987;1867.141115087048;62877.37122628761;65193.34806651873;66030.3396966029;66183;66403.66798166027;9226.723198304062;9239.39943903644;9707.757306067404;9750.26872984529;9876.753081172885;13033.934830325788;13049.543265985834;13075.673108172372;13225.669358266121;13235;7549.5847728374365;7551.924480755122;7563.924360756432;7695.846083078307;7809.882851757228;7370.115586129698;7394.371478424394;7476.588787616624;7562.508436951691;7607.771766846893;5980.13288073227;6075.483583895419;6109.541784366191;6179.412955769195;6193;1608.4290077022722;1609.9758503622454;1681.8065922419078;1689.054129687379;1701.0049121264199;843.7932706486828;878.7495563764425;901.7970956534728;930.5347326336831;954.9188318992824;16231.350745970265;16765.329386824633;16780.664386712197;16850.57873553171;17152.39966601188;837.4723923927886;874.5059041641452;883.3349136877033;895.9372843900865;948.966786162481;9625.663101791404;9800.506096617504;9865.75335616601;9984.20126389887;10012.44931528773;334874;336243;340351.982400879;358084;369078;41778.79110604488;57749.71125144347;66023;66313.33686663168;66811.33188668148;884.3765145572356;889.9085757986571;892.5225004622625;910.4810258152921;922.7093465558462;15293;15347;15596.610084747972;15599.688006240038;15613.687726245184;22754.43113922099;22775.202867899545;33277.50083748697;34211.65788342085;34751.47872781961;44236;44262.33606495841;44480.33279500745;44602.10795784131;44753;7318.853622927618;7523.3229009389415;7575.583342916192;7625.50434221796;7666.271704188093;11239.943800280946;11431.428428578703;11494.080473562262;11531.423428828693;11535.192536522363;9204.493752843659;9320.347575669639;9640.807183856143;9901.950490247791;10081.042300981395;9673.903260967581;9750.512474376112;9784.315097943076;9796.16732577739;10029.348092373972;9513.23894088485;9514.143727064597;9551.283653725859;9622.085901839315;10196.898031019891;7379.889301660587;7472.36484898768;7653.540787552764;7697.575948449555;7770.805729856799;9167.862482062908;9370.34407591462;9394;9430.387024843638;9881.654142105279 05:12:51 INFO - PROCESS | 15560 | |3;mootools.html;1385.2450414524087;1440.5318271561741;1560.1887018750251;1722.4229882989198;1768.5136587438453;6805.455563554916;7450.552966821994;7513.924860751391;8046.879296810545;8059.637316320765;7567.545947243169;7875.645595948182;7879.527228366302;7913.089994650617;7932.1671224521315;2095.1619352259104;2141.0472339808794;2142.485803407179;2148.0870629982273;2155.3641675705703;2122.1511395441794;2140.0369833574878;2146.894349410055;2150.5376344086017;2166.588348213842;2080.625487412265;2093.57081798231;2093.80108889656;2106.968395474069;2114.746230452348;2071.0473182336145;2078.802513761198;2081.708560801489;2082.302428686392;2083.14591017682;2024.068928292987;2089.958200835975;2115.9259425920172;2130.403487023636;2139.967900481494;7711.498752581064;7720.189380115064;7760.456768026241;7767.611619419063;7769.572673503011;4642.79107440166;4723.504032076617;4726.054789042171;4755.833545825914;4787.6648634595595;2758.7792976562027;2893.971060289391;2900.941981160365;2942.9852850735824;2948.9262768430963;878.0813921581365;913.2283220678516;921.2767977137981;923.5059243304867;931.9887921605067;10407.479626018669;10738.355698658028;10766.623168189075;10773.4613269337;10799.190060745397;4225.218334608107;4268.359746038119;4328.891777705582;4338.284183109751;4345.478542574848;9008.864867027;9081.818363632823;9107.635694572144;9133.178013978773;9186.311026673025;4575.9771201143785;4619.19164146273;4632.5830675239395;4650.279206722963;4655.6973796703105;3704.0554658561896;4162.791860406967;4210.305299625527;4216.072464057902;4371.737695738202;3667.908302292464;3749.1564398010228;3817.5037245158505;3868.1490072184074;3872.457855900176;1172.9589464368705;1179.0626451970704;1205.8673545909942;1206.4932728254155;1215.4044518186024;676.631235976394;684.4832151725416;784.019975031211;815.9714409995622;839.8026463781007;4804.783784729696;4993.251012348177;5048.8232911848645;5110.7955681773055;5137.306463627438;418.4518281051832;422.86045604950294;424.24696164308597;425.3131193123146;431.9265724826787;3529.5588051493564;3548.2193917338145;3614.4397618369194;3616.385214513539;3719.75821571597;9349.158575728217;9587.274290627754;9726.416415015121;9751.21990240779;9831.80336393268;9518.666846660333;9569.521523923777;9659.227261819038;9680.419174849532;9699.51502424876;7096.361327480551;7244.746433874789;7245.203027666952;7247.565146091251;7396.3713084387355;5154.922676159936;5182.53357197854;5193.584513238856;5221.086309895829;5295;8861.689840855797;8979.955100224457;9026.86459703118;9031.819363612822;9097.954510227672;8608.354373421893;8930.955345223492;8937.46375217463;8951.686690965786;9063.818723625358;6207.441330280297;6778.694958726967;6795.048693182859;6904.13698287714;6999;7542.434317426105;7564.735234266995;7570.886436703564;7571.507851989603;7613.505122167263;6675.966620166868;6844.555103918229;6888.552244104118;6894.310568943066;7000.579965202104;6763.2898545652;6777.830554236183;6820.283870193757;6823.38589526945;6934.237233904368;6454.709538070892;6481.643509606828;6512.934870651422;6550.115734375799;6608.372204640552;4499.685022048425;4566.26939689648;4568.588827005586;4573.3368661544555;4629.375034370317;4554.612857907115;4585.518520555293;4629.513901040477;4724.740139292372;4819.3252944588485 05:12:51 INFO - PROCESS | 15560 | |4;prototype.html;286.37141474463556;290.9839958802266;291.26891502329147;297.509109968552;297.85702862625936;5008.724520151391;5014.648974571782;5016.573591244749;5016.724080175589;5022.271770593262;4957.50424957504;4959.454460009405;4968.478309777475;4970;4970.552650261476;3651.361011822927;3725.4970578971897;3841.692664586826;3853.5953724858905;3863.98068009661;3856.382978723405;3873.9612603873884;3874.593167717391;3880.5731369549326;3890.455336252927;3835.4822099016556;3843.8078096095223;3851.6340947609933;3857;3858.13192031792;3751.9249615007548;3759.4548790425233;3825.1202223488476;3840.1743625120594;3854.5952674969003;3302.5871766029245;3314.8176850273226;3328.617209020945;3339.3655205510877;3350.229447227127;4794.161021821203;4806.663533552653;4816.783244753994;4838.491958344393;4849.442314133885;4371.519132895411;4378.540253273424;4411.492678341968;4415.315626077963;4428.778561071934;5046.26829109777;5200.193969934666;5203.840406231409;5241.24002019705;5269.314989051437;3637.345277849986;3643.143861192618;3668.926621467556;3670.614585468514;3672.3573374659595;5483.506484416422;5493.670379777226;5505.6696598204235;5508.394076651565;5523.502884740393;3444.1733983843696;3689.1330537323706;3691.9077023074638;3698.63013698628;3766.5856755756845;3711.758735682226;3727.0682329417646;3750.3436898542645;3759;3762.830672619739;4365.214261432909;4365.3670217818235;4375.387445757597;4376.431063961664;4390;5046.419661738873;5183.948160518422;5239.1355426354985;5261.421243663194;5263.605229607718;1272.815441760958;1273.40150129439;1290.148501988683;1294.7086905446388;1300.8699130087105;792.9643166057541;809.6478032056075;811.8011087283535;819.8770184472377;829.7801082713086;4498.685092043525;4613.354130421743;4631.652626053059;4632.2125238709505;4643.883902902455;5413.2692086568595;5437.619366644297;5439.619226654176;5440.455954404607;5447.782088716407;4502.8649140525185;4628.421447319085;4647.790849411717;4661.603763680125;4662.114198302312;2866.856657167133;2876.050903201938;2881.7118288171014;2890.6242188515357;2923.1584102015595;5048.469910659328;5054.974725126424;5081;5098.2097774844215;5109.335786347751;5412.56699464042;5553.666779993213;5558.249636299129;5569.944300557024;5588.860278492989;5117.820876269388;5118.850082965089;5135.845924622267;5174.53429191367;5180.766865491062;5380.623356365017;5387.81142660005;5421.322334708161;5473.480019398151;5484.546595152367;5017.996400719943;5247.842564723064;5248.399238232223;5290.365156181283;5315.441878602691;5014.72419016943;5045.192769156917;5151.4590967949325;5164.896702066013;5166.45752196029;3651.744377893522;3667.8532858685353;3678.7240956927803;3685.539307586552;3722.181120153562;5117.744112794271;5397.217403476396;5406.972965135149;5414.918776218438;5445.727713614224;5252.5535329497425;5256.922330922075;5267.2625832384265;5272.261883336259;5290.947090529199;5221.851192737592;5248.816291429782;5250.610972007804;5268.947310526845;5294.100002999422;4963.677360971526;5160.174372100446;5164.9741751291;5172.7413629319135;5176.844694659167;5052.494750524918;5149.124648809786;5265.21021846726;5310.548603368757;5312.62811603184;5157.613179011514;5167.888903885682;5169.948300516947;5228.712420816892;5230.660007099526 05:12:51 INFO - PROCESS | 15560 | |5;yui.html;581.5376775463509;663.3234101216761;697.8255436140964;715.3883429667634;742.1168809117148;11410.600628977987;11448.942755286222;11763.176577639568;11785.823212651818;12070.517179312817;12919.160254583445;12938.676533086678;13115.147515411492;13131.803022954664;13149.737005259889;631.6273398694792;777.506283509971;802.8675268580677;803.7267329108103;806.5322113174345;771.7106085218044;791.9762407127795;794.2653045932518;794.519315813933;799.6041959230189;837.3803385494721;845.4969293270494;846.0862268749767;849.7578190215789;849.889514363132;838.1576515601812;841.1966571923798;841.4446465332912;841.7685136587456;842.9409941304111;614.2904944788776;615.4645458451131;615.5168192968498;616.1589430427479;617.604732970899;13226.140300880412;13278.269695166762;13346.466141354334;13382.063255572113;13399.732005359838;13383.53157639478;13655.453781848713;13722.313884305744;14019.369128389146;14085.084469509551;9751.17115045222;9977.75055623608;9989.150922171624;10071.1943044557;10320.329178603442;3374.173327534745;3383.1034775784437;3419.692227699494;3495.4582039783872;3499.230169362736;49852.50147498551;51515.74242128803;51893.7405312971;55553;55723.44276557264;9050.230730387859;9143.634254629873;9385.859212111824;9393.342466027312;9418.670346537838;15890.92054539743;15900.204989750697;15934.60163495922;15945.681086378207;15948.521544353687;6732.461403087741;6867.244603093655;6877.071595334666;6993.895091573529;6998.860022799516;3550.9112272192883;3693.612170722089;3726.4224045272485;3737.1965027518672;3743.7753734776;2828.773698104188;2896.160113567042;2920.941581168365;2937;2940.2649337665584;475.8929240920765;481.12435367631275;493.7062447843599;498.2352089542535;499.1763590076403;493.1296262097401;543.8667526455964;546.7648910968322;557.7155650618214;642.6818724731195;7586.582737949356;7675.347595454337;7733.574653394005;7978.920210797934;8007.119216886138;506.3392273083661;521.2025600830735;538.0933127679793;546.1725485888882;549.6152693114756;3464.7574669772875;3670.22925185714;3682.8526858925343;3701.7964011979598;3724.329620668306;79755;88811.11188888158;90552.5472372647;91110.54444727734;92711.53644231736;61231;75787.24212757802;78207;79233.20766792374;80043;70489.64755176294;70599.64700176568;70921;71575.64212178906;71763.64118179376;7300.488965772557;7352.0442342495135;7352.37504812097;7367.557946523226;7515.6242187891485;42907.570924290354;43078.138437231704;43634;44168.116637666426;44411.777941110086;56968.715156423954;59646.70176649089;59748.70125649344;60870.69564652326;61126.69436652788;9480.715578532656;9550.426974381558;9906.554205060645;9939.254555908481;10003.599856005678;12131;12145.757084858431;12182.329971851634;12707.237565746085;12755.61733148007;10942.781144377228;10960.671179864297;11631.941840290745;11695.12286578493;11844.578650561987;10918.672439826818;11013.559457621606;11130.610428634958;11245.943770281096;11494.82757758651;10759.246852720235;11162.274452160584;11359.148063895405;11434.656960291204;11692.35692036946;9256.768580785534;9322.533873306444;9479.582706409821;9613.375130616487;9625.133737963617;9679.758006049906;10055.19558435338;10064;10162.187025038127;10182.389056656624 05:12:51 INFO - PROCESS | 15560 | __end_tp_report 05:12:51 INFO - PROCESS | 15560 | __start_cc_report 05:12:51 INFO - PROCESS | 15560 | _x_x_mozilla_cycle_collect,386 05:12:51 INFO - PROCESS | 15560 | __end_cc_report 05:12:51 INFO - PROCESS | 15560 | __startTimestamp1465387971029__endTimestamp 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - PROCESS | 15560 | ------- Summary: start ------- 05:12:51 INFO - PROCESS | 15560 | Number of tests: 6 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - PROCESS | 15560 | [#0] dojo.html Cycles:165 Average:4814.20 Median:4904.61 stddev:499.60 (10.2%) stddev-sans-first:472.09 05:12:51 INFO - PROCESS | 15560 | Values: 2674.5 2746.6 2762.7 2765.8 2774.0 4794.6 4820.8 4845.5 4904.6 4972.8 4816.7 4879.4 4888.9 4895.4 4901.8 4416.8 4463.1 4470.6 4470.7 4512.4 4457.8 4490.1 4530.5 4534.6 4571.5 4405.0 4522.2 4525.0 4538.1 4552.5 4477.5 4492.0 4501.5 4534.8 4558.1 4469.9 4470.8 4476.9 4489.4 4542.6 4717.4 4796.8 4811.5 4812.9 4824.4 5149.8 5157.7 5163.6 5166.3 5171.4 5048.8 5187.4 5196.0 5198.3 5214.7 4833.5 4853.4 4872.7 4875.3 4875.7 5333.1 5373.5 5378.4 5383.2 5407.4 5030.0 5079.7 5119.1 5120.5 5136.8 5204.8 5227.1 5247.6 5251.5 5278.3 5202.8 5203.8 5208.5 5222.3 5254.4 4941.0 5082.9 5169.6 5183.0 5186.0 4269.3 4358.0 4394.2 4437.1 4460.5 3856.8 3859.9 3867.6 3913.0 3919.7 4334.8 4537.6 4549.6 4561.4 4599.6 5180.2 5295.5 5328.8 5335.1 5338.3 4495.9 4553.5 4556.8 4564.9 4614.7 4551.8 4579.5 4669.2 4706.1 4738.5 4811.0 4833.1 4845.9 4846.8 4903.9 5181.7 5182.6 5196.5 5205.1 5242.6 4791.6 4846.3 4880.5 4896.9 4917.9 5173.4 5184.4 5205.7 5243.0 5261.1 5257.5 5261.9 5267.9 5279.9 5326.0 4968.5 5054.1 5080.5 5103.5 5109.5 5091.0 5094.4 5102.9 5104.8 5179.3 4983.3 5035.2 5038.1 5043.5 5046.1 4936.5 4954.9 4994.0 5090.1 5124.7 4907.2 4926.4 4938.3 4939.2 4954.3 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - PROCESS | 15560 | [#1] ext.html Cycles:180 Average:42196.80 Median:35342.24 stddev:75311.50 (213.1%) stddev-sans-first:75457.86 05:12:51 INFO - PROCESS | 15560 | Values: 553.6 588.9 591.1 597.8 625.1 35292.5 38202.6 38244.6 38291.6 38465.0 39320.2 40190.0 40202.0 40224.2 40283.0 7598.7 7764.3 7778.6 7781.9 7791.3 7727.8 7734.5 7743.1 7762.3 7809.5 7691.7 7759.7 7839.5 7871.0 7881.1 7776.3 7825.1 7827.3 7835.6 7846.0 7680.8 7715.1 7717.1 7750.5 7770.3 35951.6 35973.8 36025.5 36187.3 36388.6 2344.7 2709.6 2789.1 2797.2 2852.6 26850.6 26956.3 27219.3 27564.3 28079.2 3275.2 3385.1 3416.4 3458.0 3474.5 254606.0 254931.0 256254.0 256696.0 257494.0 27992.4 55950.4 56395.0 56446.2 56505.0 33525.5 33539.7 33748.3 33861.7 33987.5 13815.7 13915.1 13985.7 14038.4 14045.1 11714.3 11763.2 11793.9 11811.1 11852.6 7874.7 7907.9 7972.2 7992.8 7995.0 3124.7 3174.1 3194.2 3197.0 3203.6 859.5 932.7 955.7 998.3 1042.8 26830.7 28110.3 28463.6 28516.3 28803.6 975.6 987.2 1028.6 1034.8 1078.0 14691.9 15036.0 15037.3 15193.0 15316.2 116288.0 116699.0 117100.4 377666.0 386530.0 49800.0 50080.5 50422.7 50488.0 50612.0 1171.8 1176.0 1208.8 1215.8 1239.6 26045.7 27763.3 27764.0 28426.6 28438.7 42256.8 42347.2 42702.0 42797.8 42958.1 332013.0 333178.0 333898.0 334529.0 335311.0 25158.4 25204.1 25277.4 25426.5 25711.9 37842.0 37847.4 37972.0 37976.0 43254.8 36634.8 36696.4 37176.0 37363.8 37876.2 35620.6 36775.0 36849.3 36943.3 37266.4 34963.5 35198.0 35392.0 35534.8 35721.3 31318.5 32800.7 33001.7 33024.8 33269.3 24552.5 25335.5 25411.7 25499.6 25553.9 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - PROCESS | 15560 | [#2] jquery.html Cycles:180 Average:22200.91 Median:5119.74 stddev:57187.18 (1117.0%) stddev-sans-first:57324.09 05:12:51 INFO - PROCESS | 15560 | Values: 358.9 367.0 369.4 376.6 387.6 15762.8 16076.6 16568.8 16608.8 16659.7 16051.9 16354.8 17483.7 17519.0 17520.5 4736.2 5037.9 5081.9 5093.8 5110.1 3654.9 4971.0 5461.6 5780.8 5784.5 5839.4 5844.6 5844.8 5860.4 5863.9 5686.3 5739.0 5824.9 5826.2 5846.5 4971.9 5108.4 5110.4 5114.0 5125.5 18965.0 19134.2 19328.1 19401.6 19408.5 1884.2 1898.7 1926.6 1933.2 2183.9 12773.2 13273.3 13493.7 13580.5 13686.3 1712.4 1734.3 1761.9 1792.1 1867.1 62877.4 65193.3 66030.3 66183.0 66403.7 9226.7 9239.4 9707.8 9750.3 9876.8 13033.9 13049.5 13075.7 13225.7 13235.0 7549.6 7551.9 7563.9 7695.8 7809.9 7370.1 7394.4 7476.6 7562.5 7607.8 5980.1 6075.5 6109.5 6179.4 6193.0 1608.4 1610.0 1681.8 1689.1 1701.0 843.8 878.7 901.8 930.5 954.9 16231.4 16765.3 16780.7 16850.6 17152.4 837.5 874.5 883.3 895.9 949.0 9625.7 9800.5 9865.8 9984.2 10012.4 334874.0 336243.0 340352.0 358084.0 369078.0 41778.8 57749.7 66023.0 66313.3 66811.3 884.4 889.9 892.5 910.5 922.7 15293.0 15347.0 15596.6 15599.7 15613.7 22754.4 22775.2 33277.5 34211.7 34751.5 44236.0 44262.3 44480.3 44602.1 44753.0 7318.9 7523.3 7575.6 7625.5 7666.3 11239.9 11431.4 11494.1 11531.4 11535.2 9204.5 9320.3 9640.8 9902.0 10081.0 9673.9 9750.5 9784.3 9796.2 10029.3 9513.2 9514.1 9551.3 9622.1 10196.9 7379.9 7472.4 7653.5 7697.6 7770.8 9167.9 9370.3 9394.0 9430.4 9881.7 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - PROCESS | 15560 | [#3] mootools.html Cycles:180 Average:5134.87 Median:4906.29 stddev:2907.10 (59.3%) stddev-sans-first:2901.60 05:12:51 INFO - PROCESS | 15560 | Values: 1385.2 1440.5 1560.2 1722.4 1768.5 6805.5 7450.6 7513.9 8046.9 8059.6 7567.5 7875.6 7879.5 7913.1 7932.2 2095.2 2141.0 2142.5 2148.1 2155.4 2122.2 2140.0 2146.9 2150.5 2166.6 2080.6 2093.6 2093.8 2107.0 2114.7 2071.0 2078.8 2081.7 2082.3 2083.1 2024.1 2090.0 2115.9 2130.4 2140.0 7711.5 7720.2 7760.5 7767.6 7769.6 4642.8 4723.5 4726.1 4755.8 4787.7 2758.8 2894.0 2900.9 2943.0 2948.9 878.1 913.2 921.3 923.5 932.0 10407.5 10738.4 10766.6 10773.5 10799.2 4225.2 4268.4 4328.9 4338.3 4345.5 9008.9 9081.8 9107.6 9133.2 9186.3 4576.0 4619.2 4632.6 4650.3 4655.7 3704.1 4162.8 4210.3 4216.1 4371.7 3667.9 3749.2 3817.5 3868.1 3872.5 1173.0 1179.1 1205.9 1206.5 1215.4 676.6 684.5 784.0 816.0 839.8 4804.8 4993.3 5048.8 5110.8 5137.3 418.5 422.9 424.2 425.3 431.9 3529.6 3548.2 3614.4 3616.4 3719.8 9349.2 9587.3 9726.4 9751.2 9831.8 9518.7 9569.5 9659.2 9680.4 9699.5 7096.4 7244.7 7245.2 7247.6 7396.4 5154.9 5182.5 5193.6 5221.1 5295.0 8861.7 8980.0 9026.9 9031.8 9098.0 8608.4 8931.0 8937.5 8951.7 9063.8 6207.4 6778.7 6795.0 6904.1 6999.0 7542.4 7564.7 7570.9 7571.5 7613.5 6676.0 6844.6 6888.6 6894.3 7000.6 6763.3 6777.8 6820.3 6823.4 6934.2 6454.7 6481.6 6512.9 6550.1 6608.4 4499.7 4566.3 4568.6 4573.3 4629.4 4554.6 4585.5 4629.5 4724.7 4819.3 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - PROCESS | 15560 | [#4] prototype.html Cycles:180 Average:4326.04 Median:4989.64 stddev:1288.40 (25.8%) stddev-sans-first:1255.83 05:12:51 INFO - PROCESS | 15560 | Values: 286.4 291.0 291.3 297.5 297.9 5008.7 5014.6 5016.6 5016.7 5022.3 4957.5 4959.5 4968.5 4970.0 4970.6 3651.4 3725.5 3841.7 3853.6 3864.0 3856.4 3874.0 3874.6 3880.6 3890.5 3835.5 3843.8 3851.6 3857.0 3858.1 3751.9 3759.5 3825.1 3840.2 3854.6 3302.6 3314.8 3328.6 3339.4 3350.2 4794.2 4806.7 4816.8 4838.5 4849.4 4371.5 4378.5 4411.5 4415.3 4428.8 5046.3 5200.2 5203.8 5241.2 5269.3 3637.3 3643.1 3668.9 3670.6 3672.4 5483.5 5493.7 5505.7 5508.4 5523.5 3444.2 3689.1 3691.9 3698.6 3766.6 3711.8 3727.1 3750.3 3759.0 3762.8 4365.2 4365.4 4375.4 4376.4 4390.0 5046.4 5183.9 5239.1 5261.4 5263.6 1272.8 1273.4 1290.1 1294.7 1300.9 793.0 809.6 811.8 819.9 829.8 4498.7 4613.4 4631.7 4632.2 4643.9 5413.3 5437.6 5439.6 5440.5 5447.8 4502.9 4628.4 4647.8 4661.6 4662.1 2866.9 2876.1 2881.7 2890.6 2923.2 5048.5 5055.0 5081.0 5098.2 5109.3 5412.6 5553.7 5558.2 5569.9 5588.9 5117.8 5118.9 5135.8 5174.5 5180.8 5380.6 5387.8 5421.3 5473.5 5484.5 5018.0 5247.8 5248.4 5290.4 5315.4 5014.7 5045.2 5151.5 5164.9 5166.5 3651.7 3667.9 3678.7 3685.5 3722.2 5117.7 5397.2 5407.0 5414.9 5445.7 5252.6 5256.9 5267.3 5272.3 5290.9 5221.9 5248.8 5250.6 5268.9 5294.1 4963.7 5160.2 5165.0 5172.7 5176.8 5052.5 5149.1 5265.2 5310.5 5312.6 5157.6 5167.9 5169.9 5228.7 5230.7 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - PROCESS | 15560 | [#5] yui.html Cycles:180 Average:16533.81 Median:546.47 stddev:23134.74 (4233.5%) stddev-sans-first:23168.63 05:12:51 INFO - PROCESS | 15560 | Values: 581.5 663.3 697.8 715.4 742.1 11410.6 11448.9 11763.2 11785.8 12070.5 12919.2 12938.7 13115.1 13131.8 13149.7 631.6 777.5 802.9 803.7 806.5 771.7 792.0 794.3 794.5 799.6 837.4 845.5 846.1 849.8 849.9 838.2 841.2 841.4 841.8 842.9 614.3 615.5 615.5 616.2 617.6 13226.1 13278.3 13346.5 13382.1 13399.7 13383.5 13655.5 13722.3 14019.4 14085.1 9751.2 9977.8 9989.2 10071.2 10320.3 3374.2 3383.1 3419.7 3495.5 3499.2 49852.5 51515.7 51893.7 55553.0 55723.4 9050.2 9143.6 9385.9 9393.3 9418.7 15890.9 15900.2 15934.6 15945.7 15948.5 6732.5 6867.2 6877.1 6993.9 6998.9 3550.9 3693.6 3726.4 3737.2 3743.8 2828.8 2896.2 2920.9 2937.0 2940.3 475.9 481.1 493.7 498.2 499.2 493.1 543.9 546.8 557.7 642.7 7586.6 7675.3 7733.6 7978.9 8007.1 506.3 521.2 538.1 546.2 549.6 3464.8 3670.2 3682.9 3701.8 3724.3 79755.0 88811.1 90552.5 91110.5 92711.5 61231.0 75787.2 78207.0 79233.2 80043.0 70489.6 70599.6 70921.0 71575.6 71763.6 7300.5 7352.0 7352.4 7367.6 7515.6 42907.6 43078.1 43634.0 44168.1 44411.8 56968.7 59646.7 59748.7 60870.7 61126.7 9480.7 9550.4 9906.6 9939.3 10003.6 12131.0 12145.8 12182.3 12707.2 12755.6 10942.8 10960.7 11631.9 11695.1 11844.6 10918.7 11013.6 11130.6 11245.9 11494.8 10759.2 11162.3 11359.1 11434.7 11692.4 9256.8 9322.5 9479.6 9613.4 9625.1 9679.8 10055.2 10064.0 10162.2 10182.4 05:12:51 INFO - PROCESS | 15560 | -------- Summary: end -------- 05:12:51 INFO - PROCESS | 15560 | 05:12:51 INFO - TEST-INFO | 15560: exit 0 05:12:51 INFO - TEST-OK | dromaeo_css | took 1117567ms 05:12:51 INFO - TEST-START | kraken 05:12:51 INFO - operating with platform_type : linux_ 05:12:51 INFO - Initialising browser for kraken test... 05:12:51 INFO - TEST-INFO | started process 15797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbhVVKv/profile http://localhost:60566/getInfo.html) 05:12:56 INFO - PROCESS | 15797 | __metrics Screen width/height:1600/1200 05:12:56 INFO - PROCESS | 15797 | colorDepth:24 05:12:56 INFO - PROCESS | 15797 | Browser inner width/height: 1024/697 05:12:56 INFO - PROCESS | 15797 | __metrics 05:12:57 ERROR - PROCESS | 15797 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:12:58 INFO - TEST-INFO | 15797: exit 0 05:12:58 INFO - Browser initialized. 05:12:58 INFO - Running cycle 1/1 for kraken test... 05:12:58 INFO - TEST-INFO | started process 15915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbhVVKv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:10 INFO - PROCESS | 15915 | RSS: Main: 168550400 05:13:10 INFO - PROCESS | 15915 | 05:13:13 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60566/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:14 INFO - PROCESS | 15915 | RSS: Main: 173195264 05:13:14 INFO - PROCESS | 15915 | 05:13:16 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60566/tests/kraken/driver.html?testName=audio-dft) 05:13:17 INFO - PROCESS | 15915 | RSS: Main: 172716032 05:13:17 INFO - PROCESS | 15915 | 05:13:20 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60566/tests/kraken/driver.html?testName=audio-fft) 05:13:21 INFO - PROCESS | 15915 | RSS: Main: 167985152 05:13:21 INFO - PROCESS | 15915 | 05:13:23 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60566/tests/kraken/driver.html?testName=audio-oscillator) 05:13:23 INFO - PROCESS | 15915 | RSS: Main: 168468480 05:13:23 INFO - PROCESS | 15915 | 05:13:26 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60566/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:26 INFO - PROCESS | 15915 | RSS: Main: 168296448 05:13:26 INFO - PROCESS | 15915 | 05:13:29 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60566/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:30 INFO - PROCESS | 15915 | RSS: Main: 168353792 05:13:30 INFO - PROCESS | 15915 | 05:13:34 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60566/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:34 INFO - PROCESS | 15915 | RSS: Main: 166785024 05:13:34 INFO - PROCESS | 15915 | 05:13:37 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60566/tests/kraken/driver.html?testName=json-parse-financial) 05:13:38 INFO - PROCESS | 15915 | RSS: Main: 167387136 05:13:38 INFO - PROCESS | 15915 | 05:13:40 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60566/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:40 INFO - PROCESS | 15915 | RSS: Main: 168357888 05:13:40 INFO - PROCESS | 15915 | 05:13:42 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60566/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:43 INFO - PROCESS | 15915 | RSS: Main: 167624704 05:13:43 INFO - PROCESS | 15915 | 05:13:45 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60566/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:46 INFO - PROCESS | 15915 | RSS: Main: 168280064 05:13:46 INFO - PROCESS | 15915 | 05:13:48 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60566/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:49 INFO - PROCESS | 15915 | RSS: Main: 168751104 05:13:49 INFO - PROCESS | 15915 | 05:13:52 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60566/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:53 INFO - PROCESS | 15915 | RSS: Main: 168091648 05:13:53 INFO - PROCESS | 15915 | 05:13:54 INFO - PROCESS | 15915 | Cycle 1(1): loaded http://localhost:60566/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60566/tests/kraken/driver.html?testName=ai-astar) 05:13:55 INFO - PROCESS | 15915 | RSS: Main: 169136128 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | __start_tp_report 05:13:55 INFO - PROCESS | 15915 | _x_x_mozilla_page_load 05:13:55 INFO - PROCESS | 15915 | _x_x_mozilla_page_load_details 05:13:55 INFO - PROCESS | 15915 | |i|pagename|runs| 05:13:55 INFO - PROCESS | 15915 | |0;ai-astar;114;110;115;115;116;115;114;117;115;115 05:13:55 INFO - PROCESS | 15915 | |1;audio-beat-detection;154;140;159;198;137;162;155;136;184;153 05:13:55 INFO - PROCESS | 15915 | |2;audio-dft;163;165;166;178;164;163;163;164;163;163 05:13:55 INFO - PROCESS | 15915 | |3;audio-fft;76;76;76;165;76;76;78;78;158;76 05:13:55 INFO - PROCESS | 15915 | |4;audio-oscillator;87;88;142;87;87;87;140;87;86;138 05:13:55 INFO - PROCESS | 15915 | |5;imaging-gaussian-blur;117;118;117;118;117;118;118;118;118;118 05:13:55 INFO - PROCESS | 15915 | |6;imaging-darkroom;148;149;147;147;148;148;148;148;148;149 05:13:55 INFO - PROCESS | 15915 | |7;imaging-desaturate;95;99;96;95;95;96;95;95;95;95 05:13:55 INFO - PROCESS | 15915 | |8;json-parse-financial;62;63;63;63;64;66;63;66;64;63 05:13:55 INFO - PROCESS | 15915 | |9;json-stringify-tinderbox;65;64;65;65;65;65;65;64;65;65 05:13:55 INFO - PROCESS | 15915 | |10;stanford-crypto-aes;84;84;84;89;93;95;92;85;113;90 05:13:55 INFO - PROCESS | 15915 | |11;stanford-crypto-ccm;135;130;133;132;143;138;136;147;155;132 05:13:55 INFO - PROCESS | 15915 | |12;stanford-crypto-pbkdf2;174;173;175;171;176;172;172;178;172;171 05:13:55 INFO - PROCESS | 15915 | |13;stanford-crypto-sha256-iterative;67;74;68;69;69;70;69;70;68;66 05:13:55 INFO - PROCESS | 15915 | __end_tp_report 05:13:55 INFO - PROCESS | 15915 | __start_cc_report 05:13:55 INFO - PROCESS | 15915 | _x_x_mozilla_cycle_collect,979 05:13:55 INFO - PROCESS | 15915 | __end_cc_report 05:13:55 INFO - PROCESS | 15915 | __startTimestamp1465388035233__endTimestamp 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | ------- Summary: start ------- 05:13:55 INFO - PROCESS | 15915 | Number of tests: 14 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.84 (1.6%) stddev-sans-first:1.94 05:13:55 INFO - PROCESS | 15915 | Values: 114.0 110.0 115.0 115.0 116.0 115.0 114.0 117.0 115.0 115.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#1] audio-beat-detection Cycles:10 Average:157.80 Median:157.00 stddev:19.98 (12.7%) stddev-sans-first:21.14 05:13:55 INFO - PROCESS | 15915 | Values: 154.0 140.0 159.0 198.0 137.0 162.0 155.0 136.0 184.0 153.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.00 stddev:4.61 (2.8%) stddev-sans-first:4.82 05:13:55 INFO - PROCESS | 15915 | Values: 163.0 165.0 166.0 178.0 164.0 163.0 163.0 164.0 163.0 163.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:35.89 (47.2%) stddev-sans-first:37.50 05:13:55 INFO - PROCESS | 15915 | Values: 76.0 76.0 76.0 165.0 76.0 76.0 78.0 78.0 158.0 76.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:87.00 stddev:25.62 (29.5%) stddev-sans-first:26.52 05:13:55 INFO - PROCESS | 15915 | Values: 87.0 88.0 142.0 87.0 87.0 87.0 140.0 87.0 86.0 138.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:13:55 INFO - PROCESS | 15915 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:13:55 INFO - PROCESS | 15915 | Values: 148.0 149.0 147.0 147.0 148.0 148.0 148.0 148.0 148.0 149.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 05:13:55 INFO - PROCESS | 15915 | Values: 95.0 99.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.50 stddev:1.34 (2.1%) stddev-sans-first:1.27 05:13:55 INFO - PROCESS | 15915 | Values: 62.0 63.0 63.0 63.0 64.0 66.0 63.0 66.0 64.0 63.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 05:13:55 INFO - PROCESS | 15915 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:89.50 stddev:8.77 (9.8%) stddev-sans-first:8.94 05:13:55 INFO - PROCESS | 15915 | Values: 84.0 84.0 84.0 89.0 93.0 95.0 92.0 85.0 113.0 90.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:137.00 stddev:7.95 (5.8%) stddev-sans-first:8.35 05:13:55 INFO - PROCESS | 15915 | Values: 135.0 130.0 133.0 132.0 143.0 138.0 136.0 147.0 155.0 132.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:173.50 stddev:2.32 (1.3%) stddev-sans-first:2.45 05:13:55 INFO - PROCESS | 15915 | Values: 174.0 173.0 175.0 171.0 176.0 172.0 172.0 178.0 172.0 171.0 05:13:55 INFO - PROCESS | 15915 | 05:13:55 INFO - PROCESS | 15915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.16 (3.1%) stddev-sans-first:2.17 05:13:55 INFO - PROCESS | 15915 | Values: 67.0 74.0 68.0 69.0 69.0 70.0 69.0 70.0 68.0 66.0 05:13:55 INFO - PROCESS | 15915 | -------- Summary: end -------- 05:13:55 INFO - PROCESS | 15915 | 05:13:56 INFO - TEST-INFO | 15915: exit 0 05:13:56 INFO - TEST-OK | kraken | took 64484ms 05:13:56 INFO - SUITE-END | took 1182s 05:13:56 INFO - Completed test suite (00:19:42) 05:13:56 INFO - javascript benchmark 05:13:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6306.276316637754, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.5319569075414, 2746.5742809864473, 2762.654668166479, 2765.8063935524497, 2774.042955180463, 4794.640401969853, 4820.831270905519, 4845.515448455157, 4904.607631389489, 4972.825951091703, 4816.710997340162, 4879.414470263565, 4888.853334399965, 4895.363602731649, 4901.754912254382, 4416.757078360689, 4463.107378524308, 4470.575295346945, 4470.7317560946285, 4512.435945506812, 4457.799399027052, 4490.079533695601, 4530.501644819067, 4534.614557762594, 4571.497135315112, 4405.0, 4522.23122069249, 4524.97737511312, 4538.1377538267625, 4552.499225085238, 4477.48508921475, 4492.0, 4501.504834468205, 4534.8186072557055, 4558.088382323548, 4469.888252793674, 4470.776461176961, 4476.932846007313, 4489.393931819195, 4542.591166794971, 4717.410323709536, 4796.832110876103, 4811.508432385972, 4812.903741925177, 4824.445188803263, 5149.794008239666, 5157.742112894341, 5163.612729045337, 5166.328377310963, 5171.4311425743135, 5048.848534543969, 5187.351581052369, 5196.0, 5198.272241886101, 5214.713190774506, 4833.492483289274, 4853.417589889165, 4872.731999740048, 4875.34182885313, 4875.68308059975, 5333.06671332523, 5373.453520676335, 5378.381486129067, 5383.16560933056, 5407.378151512627, 5029.974850125726, 5079.6952182869145, 5119.129747942859, 5120.462351453044, 5136.820211292662, 5204.843854684365, 5227.137522308853, 5247.55395791362, 5251.501107394792, 5278.313819203479, 5202.84391468249, 5203.817866374735, 5208.453112423217, 5222.268882356473, 5254.448282930313, 4940.975295123501, 5082.898342033139, 5169.638125331191, 5182.974085129626, 5185.9740701297005, 4269.252880745857, 4358.019445624773, 4394.231009573312, 4437.134758722018, 4460.50934397216, 3856.807159642007, 3859.8842034739005, 3867.555231148454, 3913.0413048802657, 3919.6668283195677, 4334.8266069357505, 4537.6143027843, 4549.567791059844, 4561.361409402686, 4599.563041511118, 5180.248863914711, 5295.4969277918535, 5328.760205790749, 5335.146376579729, 5338.332708411449, 4495.9325610115875, 4553.54464553542, 4556.817727290938, 4564.863054108382, 4614.723116613014, 4551.795169217393, 4579.473360563511, 4669.182892993713, 4706.082313948816, 4738.4550776660435, 4811.0, 4833.081714474239, 4845.927311090407, 4846.80612775485, 4903.8528844134735, 5181.740912954413, 5182.559482444034, 5196.53231209193, 5205.06308864408, 5242.580593552583, 4791.616670666408, 4846.273059041172, 4880.487548807324, 4896.877578060577, 4917.9016419672125, 5173.40505841818, 5184.403793563789, 5205.73971301441, 5242.977619364187, 5261.053010458001, 5257.526822585985, 5261.868453288698, 5267.89464210706, 5279.89440211186, 5326.014687282865, 4968.478309777422, 5054.140796064751, 5080.542751152414, 5103.489651034867, 5109.514596113363, 5090.974545127398, 5094.439611642642, 5102.872428189325, 5104.770285337095, 5179.326687530597, 4983.25251212321, 5035.244713293036, 5038.1183292924325, 5043.5460808527405, 5046.091703493406, 4936.531029552187, 4954.925676114789, 4994.02616489781, 5090.109230884655, 5124.718140502308, 4907.214845624683, 4926.408830940167, 4938.259261110862, 4939.185034469272, 4954.3311652926395], "value": 4782.790228637825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6133421805829, 588.8527868032992, 591.1044767177724, 597.7758340622266, 625.0904933322017, 35292.47061294079, 38202.617973820255, 38244.61755382446, 38291.61708382915, 38465.0, 39320.21359572807, 40190.0, 40201.99495012626, 40224.19551608966, 40283.0, 7598.734044308464, 7764.262395072459, 7778.611069446533, 7781.922180778176, 7791.259830316111, 7727.806804829868, 7734.5359278443475, 7743.10954240264, 7762.340201082915, 7809.531428114303, 7691.692332306729, 7759.728409505668, 7839.529628222296, 7871.0, 7881.133075361706, 7776.30013298803, 7825.060992680857, 7827.295543401121, 7835.569043702594, 7846.019247594079, 7680.846383072308, 7715.112762032326, 7717.073951125901, 7750.496217745828, 7770.339521140653, 35951.64048359535, 35973.82013089918, 36025.45961810575, 36187.27625447476, 36388.636113639055, 2344.7069116360453, 2709.647745793034, 2789.079603730764, 2797.1888152435768, 2852.6291582094404, 26850.5972410414, 26956.326091847666, 27219.319517012034, 27564.310892227655, 28079.157625271273, 3275.24669326054, 3385.1029477188317, 3416.419208734521, 3458.0, 3474.5309383233443, 254606.0, 254931.0, 256254.0, 256696.0, 257494.0, 27992.44015119727, 55950.440495595336, 56395.0, 56446.15330770042, 56505.0, 33525.49711754326, 33539.66460335365, 33748.32503349919, 33861.66138338585, 33987.49018764721, 13815.654608634864, 13915.095518791246, 13985.650358741113, 14038.36827342772, 14045.08706934046, 11714.297142171497, 11763.235389699643, 11793.877102121529, 11811.055115590732, 11852.585159519376, 7874.72438464651, 7907.881381779278, 7972.242636949481, 7992.800179995546, 7995.040595128622, 3124.703153200442, 3174.1429813950103, 3194.185482701896, 3196.9840150799096, 3203.6475987641343, 859.5358506406595, 932.6828878181451, 955.7323949294208, 998.2762497189625, 1042.7705904700954, 26830.731692683214, 28110.2972425691, 28463.57304640432, 28516.28709282243, 28803.56794648082, 975.5805003848413, 987.1658448610913, 1028.6142696488816, 1034.8292531732332, 1077.9568817247223, 14691.926540367229, 15036.022658527161, 15037.323320450607, 15193.0, 15316.23418829054, 116288.0, 116699.0, 117100.41449792866, 377666.0, 386530.0, 49800.0, 50080.499195007586, 50422.747886261066, 50488.0, 50612.0, 1171.84765980422, 1176.0195571753616, 1208.848893888264, 1215.8297838302644, 1239.5909349914687, 26045.739542604333, 27763.30591735142, 27764.0, 28426.573601395583, 28438.715612843607, 42256.788716056224, 42347.15305693931, 42702.0, 42797.78601107099, 42958.14083718371, 332013.0, 333178.0, 333898.0, 334529.0, 335311.0, 25158.371040724127, 25204.117855874956, 25277.368065797767, 25426.491470170862, 25711.871440642677, 37842.0, 37847.43228851514, 37972.0, 37976.0, 43254.783726081165, 36634.8168259157, 36696.449553257255, 37176.0, 37363.813180933925, 37876.242475150895, 35620.64379356277, 36775.0, 36849.263014739015, 36943.261134776614, 37266.44100338552, 34963.47554786731, 35198.0, 35392.0, 35534.822325888206, 35721.285574288886, 31318.530222047142, 32800.671993279764, 33001.66998330082, 33024.834875825465, 33269.33461330712, 24552.508949821262, 25335.493290133727, 25411.745882540938, 25499.617505737056, 25553.872230638728], "value": 16217.086595653476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.90489020409615, 366.95229620149377, 369.359161854183, 376.5895174260056, 387.56399051067547, 15762.84237157628, 16076.598085047865, 16568.75146872798, 16608.833911660895, 16659.66680666386, 16051.91974040131, 16354.83645163548, 17483.737743933852, 17519.03645299508, 17520.474385768415, 4736.194846876022, 5037.899242015157, 5081.923771143436, 5093.847184584469, 5110.080185566597, 3654.926901461969, 4971.0, 5461.590380721442, 5780.797672081478, 5784.537237021049, 5839.357670656224, 5844.64932104073, 5844.795432159875, 5860.384659610743, 5863.853403664921, 5686.317641882959, 5738.971305143489, 5824.941750582525, 5826.213461182729, 5846.50304724099, 4971.925421118686, 5108.361454818148, 5110.361204849394, 5113.974430127825, 5125.513076257749, 18965.0, 19134.23463061476, 19328.1302341395, 19401.611967760567, 19408.514787130436, 1884.1521315408122, 1898.7057006164066, 1926.6050459655737, 1933.2170470959284, 2183.9407887174707, 12773.23360598367, 13273.269970151638, 13493.662658433617, 13580.456781728719, 13686.31568421575, 1712.3921008042091, 1734.2976094681674, 1761.8942863428235, 1792.103948025987, 1867.141115087048, 62877.37122628761, 65193.34806651873, 66030.3396966029, 66183.0, 66403.66798166027, 9226.723198304062, 9239.39943903644, 9707.757306067404, 9750.26872984529, 9876.753081172885, 13033.934830325788, 13049.543265985834, 13075.673108172372, 13225.669358266121, 13235.0, 7549.5847728374365, 7551.924480755122, 7563.924360756432, 7695.846083078307, 7809.882851757228, 7370.115586129698, 7394.371478424394, 7476.588787616624, 7562.508436951691, 7607.771766846893, 5980.13288073227, 6075.483583895419, 6109.541784366191, 6179.412955769195, 6193.0, 1608.4290077022722, 1609.9758503622454, 1681.8065922419078, 1689.054129687379, 1701.0049121264199, 843.7932706486828, 878.7495563764425, 901.7970956534728, 930.5347326336831, 954.9188318992824, 16231.350745970265, 16765.329386824633, 16780.664386712197, 16850.57873553171, 17152.39966601188, 837.4723923927886, 874.5059041641452, 883.3349136877033, 895.9372843900865, 948.966786162481, 9625.663101791404, 9800.506096617504, 9865.75335616601, 9984.20126389887, 10012.44931528773, 334874.0, 336243.0, 340351.982400879, 358084.0, 369078.0, 41778.79110604488, 57749.71125144347, 66023.0, 66313.33686663168, 66811.33188668148, 884.3765145572356, 889.9085757986571, 892.5225004622625, 910.4810258152921, 922.7093465558462, 15293.0, 15347.0, 15596.610084747972, 15599.688006240038, 15613.687726245184, 22754.43113922099, 22775.202867899545, 33277.50083748697, 34211.65788342085, 34751.47872781961, 44236.0, 44262.33606495841, 44480.33279500745, 44602.10795784131, 44753.0, 7318.853622927618, 7523.3229009389415, 7575.583342916192, 7625.50434221796, 7666.271704188093, 11239.943800280946, 11431.428428578703, 11494.080473562262, 11531.423428828693, 11535.192536522363, 9204.493752843659, 9320.347575669639, 9640.807183856143, 9901.950490247791, 10081.042300981395, 9673.903260967581, 9750.512474376112, 9784.315097943076, 9796.16732577739, 10029.348092373972, 9513.23894088485, 9514.143727064597, 9551.283653725859, 9622.085901839315, 10196.898031019891, 7379.889301660587, 7472.36484898768, 7653.540787552764, 7697.575948449555, 7770.805729856799, 9167.862482062908, 9370.34407591462, 9394.0, 9430.387024843638, 9881.654142105279], "value": 8120.928465013105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.2450414524087, 1440.5318271561741, 1560.1887018750251, 1722.4229882989198, 1768.5136587438453, 6805.455563554916, 7450.552966821994, 7513.924860751391, 8046.879296810545, 8059.637316320765, 7567.545947243169, 7875.645595948182, 7879.527228366302, 7913.089994650617, 7932.1671224521315, 2095.1619352259104, 2141.0472339808794, 2142.485803407179, 2148.0870629982273, 2155.3641675705703, 2122.1511395441794, 2140.0369833574878, 2146.894349410055, 2150.5376344086017, 2166.588348213842, 2080.625487412265, 2093.57081798231, 2093.80108889656, 2106.968395474069, 2114.746230452348, 2071.0473182336145, 2078.802513761198, 2081.708560801489, 2082.302428686392, 2083.14591017682, 2024.068928292987, 2089.958200835975, 2115.9259425920172, 2130.403487023636, 2139.967900481494, 7711.498752581064, 7720.189380115064, 7760.456768026241, 7767.611619419063, 7769.572673503011, 4642.79107440166, 4723.504032076617, 4726.054789042171, 4755.833545825914, 4787.6648634595595, 2758.7792976562027, 2893.971060289391, 2900.941981160365, 2942.9852850735824, 2948.9262768430963, 878.0813921581365, 913.2283220678516, 921.2767977137981, 923.5059243304867, 931.9887921605067, 10407.479626018669, 10738.355698658028, 10766.623168189075, 10773.4613269337, 10799.190060745397, 4225.218334608107, 4268.359746038119, 4328.891777705582, 4338.284183109751, 4345.478542574848, 9008.864867027, 9081.818363632823, 9107.635694572144, 9133.178013978773, 9186.311026673025, 4575.9771201143785, 4619.19164146273, 4632.5830675239395, 4650.279206722963, 4655.6973796703105, 3704.0554658561896, 4162.791860406967, 4210.305299625527, 4216.072464057902, 4371.737695738202, 3667.908302292464, 3749.1564398010228, 3817.5037245158505, 3868.1490072184074, 3872.457855900176, 1172.9589464368705, 1179.0626451970704, 1205.8673545909942, 1206.4932728254155, 1215.4044518186024, 676.631235976394, 684.4832151725416, 784.019975031211, 815.9714409995622, 839.8026463781007, 4804.783784729696, 4993.251012348177, 5048.8232911848645, 5110.7955681773055, 5137.306463627438, 418.4518281051832, 422.86045604950294, 424.24696164308597, 425.3131193123146, 431.9265724826787, 3529.5588051493564, 3548.2193917338145, 3614.4397618369194, 3616.385214513539, 3719.75821571597, 9349.158575728217, 9587.274290627754, 9726.416415015121, 9751.21990240779, 9831.80336393268, 9518.666846660333, 9569.521523923777, 9659.227261819038, 9680.419174849532, 9699.51502424876, 7096.361327480551, 7244.746433874789, 7245.203027666952, 7247.565146091251, 7396.3713084387355, 5154.922676159936, 5182.53357197854, 5193.584513238856, 5221.086309895829, 5295.0, 8861.689840855797, 8979.955100224457, 9026.86459703118, 9031.819363612822, 9097.954510227672, 8608.354373421893, 8930.955345223492, 8937.46375217463, 8951.686690965786, 9063.818723625358, 6207.441330280297, 6778.694958726967, 6795.048693182859, 6904.13698287714, 6999.0, 7542.434317426105, 7564.735234266995, 7570.886436703564, 7571.507851989603, 7613.505122167263, 6675.966620166868, 6844.555103918229, 6888.552244104118, 6894.310568943066, 7000.579965202104, 6763.2898545652, 6777.830554236183, 6820.283870193757, 6823.38589526945, 6934.237233904368, 6454.709538070892, 6481.643509606828, 6512.934870651422, 6550.115734375799, 6608.372204640552, 4499.685022048425, 4566.26939689648, 4568.588827005586, 4573.3368661544555, 4629.375034370317, 4554.612857907115, 4585.518520555293, 4629.513901040477, 4724.740139292372, 4819.3252944588485], "value": 4052.2388361104354, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.37141474463556, 290.9839958802266, 291.26891502329147, 297.509109968552, 297.85702862625936, 5008.724520151391, 5014.648974571782, 5016.573591244749, 5016.724080175589, 5022.271770593262, 4957.50424957504, 4959.454460009405, 4968.478309777475, 4970.0, 4970.552650261476, 3651.361011822927, 3725.4970578971897, 3841.692664586826, 3853.5953724858905, 3863.98068009661, 3856.382978723405, 3873.9612603873884, 3874.593167717391, 3880.5731369549326, 3890.455336252927, 3835.4822099016556, 3843.8078096095223, 3851.6340947609933, 3857.0, 3858.13192031792, 3751.9249615007548, 3759.4548790425233, 3825.1202223488476, 3840.1743625120594, 3854.5952674969003, 3302.5871766029245, 3314.8176850273226, 3328.617209020945, 3339.3655205510877, 3350.229447227127, 4794.161021821203, 4806.663533552653, 4816.783244753994, 4838.491958344393, 4849.442314133885, 4371.519132895411, 4378.540253273424, 4411.492678341968, 4415.315626077963, 4428.778561071934, 5046.26829109777, 5200.193969934666, 5203.840406231409, 5241.24002019705, 5269.314989051437, 3637.345277849986, 3643.143861192618, 3668.926621467556, 3670.614585468514, 3672.3573374659595, 5483.506484416422, 5493.670379777226, 5505.6696598204235, 5508.394076651565, 5523.502884740393, 3444.1733983843696, 3689.1330537323706, 3691.9077023074638, 3698.63013698628, 3766.5856755756845, 3711.758735682226, 3727.0682329417646, 3750.3436898542645, 3759.0, 3762.830672619739, 4365.214261432909, 4365.3670217818235, 4375.387445757597, 4376.431063961664, 4390.0, 5046.419661738873, 5183.948160518422, 5239.1355426354985, 5261.421243663194, 5263.605229607718, 1272.815441760958, 1273.40150129439, 1290.148501988683, 1294.7086905446388, 1300.8699130087105, 792.9643166057541, 809.6478032056075, 811.8011087283535, 819.8770184472377, 829.7801082713086, 4498.685092043525, 4613.354130421743, 4631.652626053059, 4632.2125238709505, 4643.883902902455, 5413.2692086568595, 5437.619366644297, 5439.619226654176, 5440.455954404607, 5447.782088716407, 4502.8649140525185, 4628.421447319085, 4647.790849411717, 4661.603763680125, 4662.114198302312, 2866.856657167133, 2876.050903201938, 2881.7118288171014, 2890.6242188515357, 2923.1584102015595, 5048.469910659328, 5054.974725126424, 5081.0, 5098.2097774844215, 5109.335786347751, 5412.56699464042, 5553.666779993213, 5558.249636299129, 5569.944300557024, 5588.860278492989, 5117.820876269388, 5118.850082965089, 5135.845924622267, 5174.53429191367, 5180.766865491062, 5380.623356365017, 5387.81142660005, 5421.322334708161, 5473.480019398151, 5484.546595152367, 5017.996400719943, 5247.842564723064, 5248.399238232223, 5290.365156181283, 5315.441878602691, 5014.72419016943, 5045.192769156917, 5151.4590967949325, 5164.896702066013, 5166.45752196029, 3651.744377893522, 3667.8532858685353, 3678.7240956927803, 3685.539307586552, 3722.181120153562, 5117.744112794271, 5397.217403476396, 5406.972965135149, 5414.918776218438, 5445.727713614224, 5252.5535329497425, 5256.922330922075, 5267.2625832384265, 5272.261883336259, 5290.947090529199, 5221.851192737592, 5248.816291429782, 5250.610972007804, 5268.947310526845, 5294.100002999422, 4963.677360971526, 5160.174372100446, 5164.9741751291, 5172.7413629319135, 5176.844694659167, 5052.494750524918, 5149.124648809786, 5265.21021846726, 5310.548603368757, 5312.62811603184, 5157.613179011514, 5167.888903885682, 5169.948300516947, 5228.712420816892, 5230.660007099526], "value": 3906.031644196368, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.5376775463509, 663.3234101216761, 697.8255436140964, 715.3883429667634, 742.1168809117148, 11410.600628977987, 11448.942755286222, 11763.176577639568, 11785.823212651818, 12070.517179312817, 12919.160254583445, 12938.676533086678, 13115.147515411492, 13131.803022954664, 13149.737005259889, 631.6273398694792, 777.506283509971, 802.8675268580677, 803.7267329108103, 806.5322113174345, 771.7106085218044, 791.9762407127795, 794.2653045932518, 794.519315813933, 799.6041959230189, 837.3803385494721, 845.4969293270494, 846.0862268749767, 849.7578190215789, 849.889514363132, 838.1576515601812, 841.1966571923798, 841.4446465332912, 841.7685136587456, 842.9409941304111, 614.2904944788776, 615.4645458451131, 615.5168192968498, 616.1589430427479, 617.604732970899, 13226.140300880412, 13278.269695166762, 13346.466141354334, 13382.063255572113, 13399.732005359838, 13383.53157639478, 13655.453781848713, 13722.313884305744, 14019.369128389146, 14085.084469509551, 9751.17115045222, 9977.75055623608, 9989.150922171624, 10071.1943044557, 10320.329178603442, 3374.173327534745, 3383.1034775784437, 3419.692227699494, 3495.4582039783872, 3499.230169362736, 49852.50147498551, 51515.74242128803, 51893.7405312971, 55553.0, 55723.44276557264, 9050.230730387859, 9143.634254629873, 9385.859212111824, 9393.342466027312, 9418.670346537838, 15890.92054539743, 15900.204989750697, 15934.60163495922, 15945.681086378207, 15948.521544353687, 6732.461403087741, 6867.244603093655, 6877.071595334666, 6993.895091573529, 6998.860022799516, 3550.9112272192883, 3693.612170722089, 3726.4224045272485, 3737.1965027518672, 3743.7753734776, 2828.773698104188, 2896.160113567042, 2920.941581168365, 2937.0, 2940.2649337665584, 475.8929240920765, 481.12435367631275, 493.7062447843599, 498.2352089542535, 499.1763590076403, 493.1296262097401, 543.8667526455964, 546.7648910968322, 557.7155650618214, 642.6818724731195, 7586.582737949356, 7675.347595454337, 7733.574653394005, 7978.920210797934, 8007.119216886138, 506.3392273083661, 521.2025600830735, 538.0933127679793, 546.1725485888882, 549.6152693114756, 3464.7574669772875, 3670.22925185714, 3682.8526858925343, 3701.7964011979598, 3724.329620668306, 79755.0, 88811.11188888158, 90552.5472372647, 91110.54444727734, 92711.53644231736, 61231.0, 75787.24212757802, 78207.0, 79233.20766792374, 80043.0, 70489.64755176294, 70599.64700176568, 70921.0, 71575.64212178906, 71763.64118179376, 7300.488965772557, 7352.0442342495135, 7352.37504812097, 7367.557946523226, 7515.6242187891485, 42907.570924290354, 43078.138437231704, 43634.0, 44168.116637666426, 44411.777941110086, 56968.715156423954, 59646.70176649089, 59748.70125649344, 60870.69564652326, 61126.69436652788, 9480.715578532656, 9550.426974381558, 9906.554205060645, 9939.254555908481, 10003.599856005678, 12131.0, 12145.757084858431, 12182.329971851634, 12707.237565746085, 12755.61733148007, 10942.781144377228, 10960.671179864297, 11631.941840290745, 11695.12286578493, 11844.578650561987, 10918.672439826818, 11013.559457621606, 11130.610428634958, 11245.943770281096, 11494.82757758651, 10759.246852720235, 11162.274452160584, 11359.148063895405, 11434.656960291204, 11692.35692036946, 9256.768580785534, 9322.533873306444, 9479.582706409821, 9613.375130616487, 9625.133737963617, 9679.758006049906, 10055.19558435338, 10064.0, 10162.187025038127, 10182.389056656624], "value": 6308.153860857764, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 115.0, 115.0, 116.0, 115.0, 114.0, 117.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 140.0, 159.0, 198.0, 137.0, 162.0, 155.0, 136.0, 184.0, 153.0], "value": 157.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 178.0, 164.0, 163.0, 163.0, 164.0, 163.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 165.0, 76.0, 76.0, 78.0, 78.0, 158.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 142.0, 87.0, 87.0, 87.0, 140.0, 87.0, 86.0, 138.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 64.0, 66.0, 63.0, 66.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 89.0, 93.0, 95.0, 92.0, 85.0, 113.0, 90.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 130.0, 133.0, 132.0, 143.0, 138.0, 136.0, 147.0, 155.0, 132.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 175.0, 171.0, 176.0, 172.0, 172.0, 178.0, 172.0, 171.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 68.0, 69.0, 69.0, 70.0, 69.0, 70.0, 68.0, 66.0], "value": 69.0, "unit": "score"}]}]} 05:13:56 INFO - Return code: 0 05:13:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:56 ERROR - # TBPL SUCCESS # 05:13:56 INFO - Running post-action listener: _resource_record_post_action 05:13:56 INFO - ##### 05:13:56 INFO - ##### Finished run-tests step (success) 05:13:56 INFO - ##### 05:13:56 INFO - Running post-run listener: _resource_record_post_run 05:13:56 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547835904; Read time: 12; Write time: 541756 05:13:56 INFO - TinderboxPrint: CPU usage
13.4% 05:13:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:13:56 INFO - TinderboxPrint: I/O write bytes / time
547,835,904 / 541,756 05:13:56 INFO - TinderboxPrint: CPU idle
8,281.3 (86.5%) 05:13:56 INFO - TinderboxPrint: CPU user
1,232.6 (12.9%) 05:13:56 INFO - TinderboxPrint: Swap in / out
0 / 0 05:13:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252166144; Read time: 0; Write time: 282580 05:13:56 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295669760; Read time: 12; Write time: 259176 05:13:57 INFO - Running post-run listener: _upload_blobber_files 05:13:57 INFO - Blob upload gear active. 05:13:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:57 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 05:13:57 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:13:57 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:13:57 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:01 INFO - (blobuploader) - INFO - Done attempting. 05:14:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:14:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:14:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:02 INFO - (blobuploader) - INFO - Done attempting. 05:14:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:14:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:14:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:02 INFO - (blobuploader) - INFO - Done attempting. 05:14:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:02 INFO - Return code: 0 05:14:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fada62d2f007635038e696a71d053fbe39ebbf57fe9237b699dba0b7ef2c18e7e05dad419698cb77902dda2a804d5593037cd50d8baaf840fdb23f13fe353531", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a52d919b2a2bf0d2ae3a1017c6aaec13f9a6b34c027fcf571f6354477197c03c804505125cdbc5a4298138728f97a1fad1f6640dcb892ebee5f3790ae705d484", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f41e5fd326bd2d24d32e10c371e5fb59838c05eceb7eb6c62fc61d6b8d4484eac2705c723b69663dd16f8654803d5dc5f190efc02b88b293e1ed9cad130ede7"} 05:14:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:02 INFO - Contents: 05:14:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fada62d2f007635038e696a71d053fbe39ebbf57fe9237b699dba0b7ef2c18e7e05dad419698cb77902dda2a804d5593037cd50d8baaf840fdb23f13fe353531", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a52d919b2a2bf0d2ae3a1017c6aaec13f9a6b34c027fcf571f6354477197c03c804505125cdbc5a4298138728f97a1fad1f6640dcb892ebee5f3790ae705d484", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f41e5fd326bd2d24d32e10c371e5fb59838c05eceb7eb6c62fc61d6b8d4484eac2705c723b69663dd16f8654803d5dc5f190efc02b88b293e1ed9cad130ede7"} 05:14:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:02 INFO - Copying logs to upload dir... 05:14:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.987067 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-08 05:14:02.526696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 05:14:02.529897) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839 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/Fx-Team-Non-PGO/sha512/fada62d2f007635038e696a71d053fbe39ebbf57fe9237b699dba0b7ef2c18e7e05dad419698cb77902dda2a804d5593037cd50d8baaf840fdb23f13fe353531", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a52d919b2a2bf0d2ae3a1017c6aaec13f9a6b34c027fcf571f6354477197c03c804505125cdbc5a4298138728f97a1fad1f6640dcb892ebee5f3790ae705d484", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f41e5fd326bd2d24d32e10c371e5fb59838c05eceb7eb6c62fc61d6b8d4484eac2705c723b69663dd16f8654803d5dc5f190efc02b88b293e1ed9cad130ede7"} build_url:https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/AiLchl9tRoS9WgxPQOvdYg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fada62d2f007635038e696a71d053fbe39ebbf57fe9237b699dba0b7ef2c18e7e05dad419698cb77902dda2a804d5593037cd50d8baaf840fdb23f13fe353531", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a52d919b2a2bf0d2ae3a1017c6aaec13f9a6b34c027fcf571f6354477197c03c804505125cdbc5a4298138728f97a1fad1f6640dcb892ebee5f3790ae705d484", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f41e5fd326bd2d24d32e10c371e5fb59838c05eceb7eb6c62fc61d6b8d4484eac2705c723b69663dd16f8654803d5dc5f190efc02b88b293e1ed9cad130ede7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 05:14:02.562184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:14:02.562817) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465386795.405357-1830513839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:14:02.642207) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 05:14:02.642535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 05:14:02.642836) ========= ========= Total master_lag: 0.18 =========