builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1467025595.28 results: success (0) buildid: 20160627032524 builduid: 624135410dcd40acb6d1f63b7a6fd65b revision: 7cf93d6c932bf2a643beb2ea304c3d57cfc95f3a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.282151) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.282637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.282934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.512257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.512587) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 04:06:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-27 04:06:35 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120277 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.646575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.646902) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013565 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.696171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:35.696542) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7cf93d6c932bf2a643beb2ea304c3d57cfc95f3a --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 7cf93d6c932bf2a643beb2ea304c3d57cfc95f3a --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=edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 04:06:35,934 truncating revision to first 12 chars 2016-06-27 04:06:35,935 Setting DEBUG logging. 2016-06-27 04:06:35,935 attempt 1/10 2016-06-27 04:06:35,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7cf93d6c932b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 04:06:36,315 unpacking tar archive at: fx-team-7cf93d6c932b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:36.466848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:36.467170) ========= script_repo_revision: 7cf93d6c932bf2a643beb2ea304c3d57cfc95f3a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:36.467582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:36.467846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:36.479283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-27 04:06:36.479572) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:06:36 INFO - MultiFileLogger online at 20160627 04:06:36 in /builds/slave/test 04:06:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:06:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:36 INFO - {'append_to_log': False, 04:06:36 INFO - 'base_work_dir': '/builds/slave/test', 04:06:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:06:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:36 INFO - 'branch': 'Fx-Team-Non-PGO', 04:06:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:36 INFO - 'config_files': ('talos/linux_config.py',), 04:06:36 INFO - 'default_actions': ('clobber', 04:06:36 INFO - 'read-buildbot-config', 04:06:36 INFO - 'download-and-extract', 04:06:36 INFO - 'populate-webroot', 04:06:36 INFO - 'create-virtualenv', 04:06:36 INFO - 'install', 04:06:36 INFO - 'run-tests'), 04:06:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:36 INFO - 'download_minidump_stackwalk': True, 04:06:36 INFO - 'download_symbols': 'ondemand', 04:06:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:36 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:36 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:36 INFO - 'installer_path': 'installer.exe', 04:06:36 INFO - 'log_level': 'info', 04:06:36 INFO - 'log_name': 'talos', 04:06:36 INFO - 'log_to_console': True, 04:06:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:06:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:06:36 INFO - 'opt_config_files': (), 04:06:36 INFO - 'pip_index': False, 04:06:36 INFO - 'sps_profile': False, 04:06:36 INFO - 'sps_profile_interval': 0, 04:06:36 INFO - 'suite': 'dromaeojs', 04:06:36 INFO - 'system_bits': '32', 04:06:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:36 INFO - 'title': 'talos-linux64-ix-033', 04:06:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:36 INFO - 'use_talos_json': True, 04:06:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:36 INFO - 'work_dir': 'build'} 04:06:36 INFO - ##### 04:06:36 INFO - ##### Running clobber step. 04:06:36 INFO - ##### 04:06:36 INFO - Running pre-action listener: _resource_record_pre_action 04:06:36 INFO - Running main action method: clobber 04:06:36 INFO - rmtree: /builds/slave/test/build 04:06:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:37 INFO - Running post-action listener: _resource_record_post_action 04:06:37 INFO - ##### 04:06:37 INFO - ##### Finished clobber step (success) 04:06:37 INFO - ##### 04:06:37 INFO - ##### 04:06:37 INFO - ##### Running read-buildbot-config step. 04:06:37 INFO - ##### 04:06:37 INFO - Running pre-action listener: _resource_record_pre_action 04:06:37 INFO - Running main action method: read_buildbot_config 04:06:37 INFO - Using buildbot properties: 04:06:37 INFO - { 04:06:37 INFO - "project": "", 04:06:37 INFO - "product": "firefox", 04:06:37 INFO - "script_repo_revision": "production", 04:06:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:06:37 INFO - "repository": "", 04:06:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:06:37 INFO - "buildid": "20160627032524", 04:06:37 INFO - "pgo_build": "False", 04:06:37 INFO - "basedir": "/builds/slave/test", 04:06:37 INFO - "buildnumber": 1777, 04:06:37 INFO - "slavename": "talos-linux64-ix-033", 04:06:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:06:37 INFO - "platform": "ubuntu64_hw", 04:06:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:06:37 INFO - "branch": "fx-team", 04:06:37 INFO - "repo_path": "integration/fx-team", 04:06:37 INFO - "revision": "7cf93d6c932bf2a643beb2ea304c3d57cfc95f3a", 04:06:37 INFO - "stage_platform": "linux64", 04:06:37 INFO - "builduid": "624135410dcd40acb6d1f63b7a6fd65b", 04:06:37 INFO - "slavebuilddir": "test" 04:06:37 INFO - } 04:06:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:06:37 INFO - Running post-action listener: _resource_record_post_action 04:06:37 INFO - ##### 04:06:37 INFO - ##### Finished read-buildbot-config step (success) 04:06:37 INFO - ##### 04:06:37 INFO - ##### 04:06:37 INFO - ##### Running download-and-extract step. 04:06:37 INFO - ##### 04:06:37 INFO - Running pre-action listener: _resource_record_pre_action 04:06:37 INFO - Running main action method: download_and_extract 04:06:37 INFO - mkdir: /builds/slave/test/build/tests 04:06: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:06:37 INFO - https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:38 INFO - Downloaded 1361 bytes. 04:06:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:38 INFO - Using the following test package requirements: 04:06:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:06:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:06:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:38 INFO - u'jsshell-linux-x86_64.zip'], 04:06:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:06:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:06:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:06:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:06:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:06:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:38 INFO - https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:41 INFO - Downloaded 22713197 bytes. 04:06:41 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:06:41 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:06:42 INFO - Return code: 0 04:06:42 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:06: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:06:42 INFO - https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:46 INFO - Downloaded 22713197 bytes. 04:06:46 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:06:46 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:06:47 INFO - Return code: 0 04:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:47 INFO - https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:06:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:48 INFO - Downloaded 14405240 bytes. 04:06:48 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:06:48 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:06:49 INFO - Return code: 0 04:06: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:06:49 INFO - https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:06:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRcwpL3jThepDXbTj_z62Q/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:06:50 INFO - Downloaded 56284287 bytes. 04:06:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:50 INFO - mkdir: /builds/slave/test/properties 04:06:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:50 INFO - Contents: 04:06:50 INFO - build_url:https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:51 INFO - Running post-action listener: _resource_record_post_action 04:06:51 INFO - Running post-action listener: set_extra_try_arguments 04:06:51 INFO - ##### 04:06:51 INFO - ##### Finished download-and-extract step (success) 04:06:51 INFO - ##### 04:06:51 INFO - ##### 04:06:51 INFO - ##### Running populate-webroot step. 04:06:51 INFO - ##### 04:06:51 INFO - Running pre-action listener: _resource_record_pre_action 04:06:51 INFO - Running main action method: populate_webroot 04:06:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:51 INFO - '--tppagecycles', 04:06:51 INFO - '7'], 04:06:51 INFO - 'tests': ['tsvgm']}}, 04:06:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:51 INFO - 'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:51 INFO - 'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['damp', 'tps']}, 04:06:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:51 INFO - 'tests': ['damp', 'tps']}, 04:06:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['dromaeo_dom']}, 04:06:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['basic_compositor_video']}, 04:06:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:06:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['a11yr', 04:06:51 INFO - 'ts_paint', 04:06:51 INFO - 'tpaint', 04:06:51 INFO - 'sessionrestore', 04:06:51 INFO - 'sessionrestore_no_auto_restore', 04:06:51 INFO - 'tabpaint']}, 04:06:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:51 INFO - 'ts_paint', 04:06:51 INFO - 'tpaint', 04:06:51 INFO - 'sessionrestore', 04:06:51 INFO - 'sessionrestore_no_auto_restore', 04:06:51 INFO - 'tabpaint']}, 04:06:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:06:51 INFO - 'ts_paint', 04:06:51 INFO - 'tpaint', 04:06:51 INFO - 'sessionrestore', 04:06:51 INFO - 'sessionrestore_no_auto_restore', 04:06:51 INFO - 'tabpaint']}, 04:06:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:06:51 INFO - 'ts_paint', 04:06:51 INFO - 'tpaint', 04:06:51 INFO - 'sessionrestore', 04:06:51 INFO - 'sessionrestore_no_auto_restore', 04:06:51 INFO - 'tabpaint']}, 04:06:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['a11yr', 04:06:51 INFO - 'ts_paint', 04:06:51 INFO - 'tpaint', 04:06:51 INFO - 'sessionrestore', 04:06:51 INFO - 'sessionrestore_no_auto_restore', 04:06:51 INFO - 'tabpaint']}, 04:06:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['a11yr', 04:06:51 INFO - 'ts_paint', 04:06:51 INFO - 'tpaint', 04:06:51 INFO - 'sessionrestore', 04:06:51 INFO - 'sessionrestore_no_auto_restore', 04:06:51 INFO - 'tabpaint']}, 04:06:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['tsvgx', 04:06:51 INFO - 'tsvgr_opacity', 04:06:51 INFO - 'tart', 04:06:51 INFO - 'tscrollx', 04:06:51 INFO - 'cart']}, 04:06:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:51 INFO - 'tsvgr_opacity', 04:06:51 INFO - 'tart', 04:06:51 INFO - 'tscrollx', 04:06:51 INFO - 'cart']}, 04:06:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:51 INFO - 'talos_options': ['--disable-e10s'], 04:06:51 INFO - 'tests': ['tp5o']}, 04:06:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:51 INFO - 'tests': ['tp5o']}, 04:06:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:51 INFO - 'talos_options': ['--disable-e10s', 04:06:51 INFO - '--xperf_path', 04:06:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:51 INFO - 'tests': ['tp5n']}, 04:06:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:51 INFO - 'talos_options': ['--xperf_path', 04:06:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:51 INFO - 'tests': ['tp5n']}}, 04:06:51 INFO - 'talos.zip': {'path': '', 04:06:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:51 INFO - Running post-action listener: _resource_record_post_action 04:06:51 INFO - ##### 04:06:51 INFO - ##### Finished populate-webroot step (success) 04:06:51 INFO - ##### 04:06:51 INFO - ##### 04:06:51 INFO - ##### Running create-virtualenv step. 04:06:51 INFO - ##### 04:06:51 INFO - Running pre-action listener: _resource_record_pre_action 04:06:51 INFO - Running main action method: create_virtualenv 04:06:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:51 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:06:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:51 INFO - Using real prefix '/usr' 04:06:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:53 INFO - Installing pip.................done. 04:06:53 INFO - Return code: 0 04:06:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06: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:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:06: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', 'pip>=1.5'] in /builds/slave/test/build 04:06: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 pip>=1.5 04:06:53 INFO - Using env: {'DISPLAY': ':0', 04:06:53 INFO - 'HOME': '/home/cltbld', 04:06:53 INFO - 'LANG': 'en_US.UTF-8', 04:06:53 INFO - 'LANGUAGE': 'en_US:en', 04:06:53 INFO - 'LOGNAME': 'cltbld', 04:06:53 INFO - 'MAIL': '/var/mail/cltbld', 04:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:53 INFO - 'MOZ_NO_REMOTE': '1', 04:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:53 INFO - 'NO_EM_RESTART': '1', 04:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:53 INFO - 'PWD': '/builds/slave/test', 04:06:53 INFO - 'SHELL': '/bin/bash', 04:06:53 INFO - 'SHLVL': '1', 04:06:53 INFO - 'TERM': 'linux', 04:06:53 INFO - 'TMOUT': '86400', 04:06:53 INFO - 'USER': 'cltbld', 04:06:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:53 INFO - '_': '/tools/buildbot/bin/python'} 04:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:54 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:06:54 INFO - Cleaning up... 04:06:54 INFO - Return code: 0 04:06:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:54 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:06:54 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:06:54 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:06:54 INFO - Using env: {'DISPLAY': ':0', 04:06:54 INFO - 'HOME': '/home/cltbld', 04:06:54 INFO - 'LANG': 'en_US.UTF-8', 04:06:54 INFO - 'LANGUAGE': 'en_US:en', 04:06:54 INFO - 'LOGNAME': 'cltbld', 04:06:54 INFO - 'MAIL': '/var/mail/cltbld', 04:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:54 INFO - 'MOZ_NO_REMOTE': '1', 04:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:54 INFO - 'NO_EM_RESTART': '1', 04:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:54 INFO - 'PWD': '/builds/slave/test', 04:06:54 INFO - 'SHELL': '/bin/bash', 04:06:54 INFO - 'SHLVL': '1', 04:06:54 INFO - 'TERM': 'linux', 04:06:54 INFO - 'TMOUT': '86400', 04:06:54 INFO - 'USER': 'cltbld', 04:06:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:54 INFO - '_': '/tools/buildbot/bin/python'} 04:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:54 INFO - Downloading/unpacking psutil>=3.1.1 04:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:56 INFO - Installing collected packages: psutil 04:06:56 INFO - Running setup.py install for psutil 04:06:56 INFO - building 'psutil._psutil_linux' extension 04:06:56 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:06:56 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:06:56 INFO - building 'psutil._psutil_posix' extension 04:06:56 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:06:56 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:06:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:56 INFO - Successfully installed psutil 04:06:56 INFO - Cleaning up... 04:06:56 INFO - Return code: 0 04:06:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:56 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:06:56 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:06:56 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:06:56 INFO - Using env: {'DISPLAY': ':0', 04:06:56 INFO - 'HOME': '/home/cltbld', 04:06:56 INFO - 'LANG': 'en_US.UTF-8', 04:06:56 INFO - 'LANGUAGE': 'en_US:en', 04:06:56 INFO - 'LOGNAME': 'cltbld', 04:06:56 INFO - 'MAIL': '/var/mail/cltbld', 04:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:56 INFO - 'MOZ_NO_REMOTE': '1', 04:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:56 INFO - 'NO_EM_RESTART': '1', 04:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:56 INFO - 'PWD': '/builds/slave/test', 04:06:56 INFO - 'SHELL': '/bin/bash', 04:06:56 INFO - 'SHLVL': '1', 04:06:56 INFO - 'TERM': 'linux', 04:06:56 INFO - 'TMOUT': '86400', 04:06:56 INFO - 'USER': 'cltbld', 04:06:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:56 INFO - '_': '/tools/buildbot/bin/python'} 04:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:06:57 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:06:57 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:06:57 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:06:57 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:06:57 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:06:57 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:06:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:06:58 INFO - Installing collected packages: mozsystemmonitor 04:06:58 INFO - Running setup.py install for mozsystemmonitor 04:06:59 INFO - Successfully installed mozsystemmonitor 04:06:59 INFO - Cleaning up... 04:06:59 INFO - Return code: 0 04:06:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:06:59 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:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:59 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:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:59 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:06:59 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:06:59 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:06:59 INFO - Using env: {'DISPLAY': ':0', 04:06:59 INFO - 'HOME': '/home/cltbld', 04:06:59 INFO - 'LANG': 'en_US.UTF-8', 04:06:59 INFO - 'LANGUAGE': 'en_US:en', 04:06:59 INFO - 'LOGNAME': 'cltbld', 04:06:59 INFO - 'MAIL': '/var/mail/cltbld', 04:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:59 INFO - 'MOZ_NO_REMOTE': '1', 04:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:59 INFO - 'NO_EM_RESTART': '1', 04:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:59 INFO - 'PWD': '/builds/slave/test', 04:06:59 INFO - 'SHELL': '/bin/bash', 04:06:59 INFO - 'SHLVL': '1', 04:06:59 INFO - 'TERM': 'linux', 04:06:59 INFO - 'TMOUT': '86400', 04:06:59 INFO - 'USER': 'cltbld', 04:06:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:59 INFO - '_': '/tools/buildbot/bin/python'} 04:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:07:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:01 INFO - warning: no files found matching '*.txt' 04:07:01 INFO - no previously-included directories found matching 'build' 04:07:01 INFO - no previously-included directories found matching 'dist' 04:07:01 INFO - no previously-included directories found matching '.git*' 04:07:01 INFO - Installing collected packages: jsonschema, functools32 04:07:01 INFO - Running setup.py install for functools32 04:07:01 INFO - warning: no files found matching '*.txt' 04:07:01 INFO - no previously-included directories found matching 'build' 04:07:01 INFO - no previously-included directories found matching 'dist' 04:07:01 INFO - no previously-included directories found matching '.git*' 04:07:01 INFO - Successfully installed jsonschema functools32 04:07:01 INFO - Cleaning up... 04:07:01 INFO - Return code: 0 04:07:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07:01 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:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:07:01 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:07:01 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:07:01 INFO - Using env: {'DISPLAY': ':0', 04:07:01 INFO - 'HOME': '/home/cltbld', 04:07:01 INFO - 'LANG': 'en_US.UTF-8', 04:07:01 INFO - 'LANGUAGE': 'en_US:en', 04:07:01 INFO - 'LOGNAME': 'cltbld', 04:07:01 INFO - 'MAIL': '/var/mail/cltbld', 04:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:01 INFO - 'MOZ_NO_REMOTE': '1', 04:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:01 INFO - 'NO_EM_RESTART': '1', 04:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:01 INFO - 'PWD': '/builds/slave/test', 04:07:01 INFO - 'SHELL': '/bin/bash', 04:07:01 INFO - 'SHLVL': '1', 04:07:01 INFO - 'TERM': 'linux', 04:07:01 INFO - 'TMOUT': '86400', 04:07:01 INFO - 'USER': 'cltbld', 04:07:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:01 INFO - '_': '/tools/buildbot/bin/python'} 04:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:03 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:07:03 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:07:03 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:07:03 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:07:03 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:07:03 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:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:04 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:07:04 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:07:04 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:07:04 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:07:04 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:07:04 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:07:04 INFO - Downloading docopt-0.6.1.tar.gz 04:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:04 INFO - Running setup.py install for blobuploader 04:07:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:04 INFO - Running setup.py install for requests 04:07:04 INFO - Running setup.py install for docopt 04:07:05 INFO - Successfully installed blobuploader requests docopt 04:07:05 INFO - Cleaning up... 04:07:05 INFO - Return code: 0 04:07:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:05 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:07:05 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:07:05 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:07:05 INFO - Using env: {'DISPLAY': ':0', 04:07:05 INFO - 'HOME': '/home/cltbld', 04:07:05 INFO - 'LANG': 'en_US.UTF-8', 04:07:05 INFO - 'LANGUAGE': 'en_US:en', 04:07:05 INFO - 'LOGNAME': 'cltbld', 04:07:05 INFO - 'MAIL': '/var/mail/cltbld', 04:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:05 INFO - 'MOZ_NO_REMOTE': '1', 04:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:05 INFO - 'NO_EM_RESTART': '1', 04:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:05 INFO - 'PWD': '/builds/slave/test', 04:07:05 INFO - 'SHELL': '/bin/bash', 04:07:05 INFO - 'SHLVL': '1', 04:07:05 INFO - 'TERM': 'linux', 04:07:05 INFO - 'TMOUT': '86400', 04:07:05 INFO - 'USER': 'cltbld', 04:07:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:05 INFO - '_': '/tools/buildbot/bin/python'} 04:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:05 INFO - Running setup.py (path:/tmp/pip-bRKaCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:05 INFO - Running setup.py (path:/tmp/pip-PPRrDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:05 INFO - Running setup.py (path:/tmp/pip-yGlEYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:05 INFO - Running setup.py (path:/tmp/pip-xzDQma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:05 INFO - Running setup.py (path:/tmp/pip-fwpdK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:05 INFO - Running setup.py (path:/tmp/pip-rPMMJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:05 INFO - Running setup.py (path:/tmp/pip-7k3Hhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:05 INFO - Running setup.py (path:/tmp/pip-qysIho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:05 INFO - Running setup.py (path:/tmp/pip-t4EN6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:05 INFO - Running setup.py (path:/tmp/pip-iwaNj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:06 INFO - Running setup.py (path:/tmp/pip-HKW76V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:06 INFO - Running setup.py (path:/tmp/pip-Itfkce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:06 INFO - Running setup.py (path:/tmp/pip-Nxz0FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:06 INFO - Running setup.py (path:/tmp/pip-79XrI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:06 INFO - Running setup.py (path:/tmp/pip-Ff9PnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:06 INFO - Running setup.py (path:/tmp/pip-ITQPx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:06 INFO - Running setup.py (path:/tmp/pip-6TO45O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:06 INFO - Running setup.py install for manifestparser 04:07:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:06 INFO - Running setup.py install for mozcrash 04:07:06 INFO - Running setup.py install for mozdebug 04:07:06 INFO - Running setup.py install for mozdevice 04:07:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:06 INFO - Running setup.py install for mozfile 04:07:07 INFO - Running setup.py install for mozhttpd 04:07:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Running setup.py install for mozinfo 04:07:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Running setup.py install for mozInstall 04:07:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Running setup.py install for mozleak 04:07:07 INFO - Running setup.py install for mozlog 04:07:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Running setup.py install for moznetwork 04:07:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Running setup.py install for mozprocess 04:07:07 INFO - Running setup.py install for mozprofile 04:07:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:07 INFO - Running setup.py install for mozrunner 04:07:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:08 INFO - Running setup.py install for mozscreenshot 04:07:08 INFO - Running setup.py install for moztest 04:07:08 INFO - Running setup.py install for mozversion 04:07:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:08 INFO - Cleaning up... 04:07:08 INFO - Return code: 0 04:07:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:08 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:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:08 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:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:08 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:07:08 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:07:08 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:07:08 INFO - Using env: {'DISPLAY': ':0', 04:07:08 INFO - 'HOME': '/home/cltbld', 04:07:08 INFO - 'LANG': 'en_US.UTF-8', 04:07:08 INFO - 'LANGUAGE': 'en_US:en', 04:07:08 INFO - 'LOGNAME': 'cltbld', 04:07:08 INFO - 'MAIL': '/var/mail/cltbld', 04:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:08 INFO - 'MOZ_NO_REMOTE': '1', 04:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:08 INFO - 'NO_EM_RESTART': '1', 04:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:08 INFO - 'PWD': '/builds/slave/test', 04:07:08 INFO - 'SHELL': '/bin/bash', 04:07:08 INFO - 'SHLVL': '1', 04:07:08 INFO - 'TERM': 'linux', 04:07:08 INFO - 'TMOUT': '86400', 04:07:08 INFO - 'USER': 'cltbld', 04:07:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:08 INFO - '_': '/tools/buildbot/bin/python'} 04:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:08 INFO - Running setup.py (path:/tmp/pip-Rm4onv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:08 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:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:08 INFO - Running setup.py (path:/tmp/pip-iFBI5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:08 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:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:08 INFO - Running setup.py (path:/tmp/pip-_aBWVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:08 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:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:08 INFO - Running setup.py (path:/tmp/pip-lvwIIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:08 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:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:08 INFO - Running setup.py (path:/tmp/pip-MZ0CKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:08 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:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:08 INFO - Running setup.py (path:/tmp/pip-byP8SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:09 INFO - Running setup.py (path:/tmp/pip-Ipa2QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:09 INFO - Running setup.py (path:/tmp/pip-zwpKwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:09 INFO - Running setup.py (path:/tmp/pip-qOLxnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:09 INFO - Running setup.py (path:/tmp/pip-hiAwM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:09 INFO - Running setup.py (path:/tmp/pip-OQ3rvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:09 INFO - Running setup.py (path:/tmp/pip-N7BDbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:09 INFO - Running setup.py (path:/tmp/pip-JfjfVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:09 INFO - Running setup.py (path:/tmp/pip-XNnp7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:09 INFO - Running setup.py (path:/tmp/pip-YAoM4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:09 INFO - Running setup.py (path:/tmp/pip-83S3FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:09 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:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:09 INFO - Running setup.py (path:/tmp/pip-cM0TwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:11 INFO - Downloading blessings-1.6.tar.gz 04:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:11 INFO - Installing collected packages: blessings 04:07:11 INFO - Running setup.py install for blessings 04:07:11 INFO - Successfully installed blessings 04:07:11 INFO - Cleaning up... 04:07:11 INFO - Return code: 0 04:07:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:12 INFO - Reading from file tmpfile_stdout 04:07:12 INFO - Current package versions: 04:07:12 INFO - argparse == 1.2.1 04:07:12 INFO - blessings == 1.6 04:07:12 INFO - blobuploader == 1.2.4 04:07:12 INFO - docopt == 0.6.1 04:07:12 INFO - functools32 == 3.2.3-2 04:07:12 INFO - jsonschema == 2.5.1 04:07:12 INFO - manifestparser == 1.1 04:07:12 INFO - mozInstall == 1.12 04:07:12 INFO - mozcrash == 0.17 04:07:12 INFO - mozdebug == 0.1 04:07:12 INFO - mozdevice == 0.48 04:07:12 INFO - mozfile == 1.2 04:07:12 INFO - mozhttpd == 0.7 04:07:12 INFO - mozinfo == 0.9 04:07:12 INFO - mozleak == 0.1 04:07:12 INFO - mozlog == 3.2 04:07:12 INFO - moznetwork == 0.27 04:07:12 INFO - mozprocess == 0.22 04:07:12 INFO - mozprofile == 0.28 04:07:12 INFO - mozrunner == 6.11 04:07:12 INFO - mozscreenshot == 0.1 04:07:12 INFO - mozsystemmonitor == 0.3 04:07:12 INFO - moztest == 0.7 04:07:12 INFO - mozversion == 1.4 04:07:12 INFO - psutil == 3.1.1 04:07:12 INFO - requests == 1.2.3 04:07:12 INFO - wsgiref == 0.1.2 04:07:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:12 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:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 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:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:07:12 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:07:12 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:07:12 INFO - Using env: {'DISPLAY': ':0', 04:07:12 INFO - 'HOME': '/home/cltbld', 04:07:12 INFO - 'LANG': 'en_US.UTF-8', 04:07:12 INFO - 'LANGUAGE': 'en_US:en', 04:07:12 INFO - 'LOGNAME': 'cltbld', 04:07:12 INFO - 'MAIL': '/var/mail/cltbld', 04:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:12 INFO - 'MOZ_NO_REMOTE': '1', 04:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:12 INFO - 'NO_EM_RESTART': '1', 04:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:12 INFO - 'PWD': '/builds/slave/test', 04:07:12 INFO - 'SHELL': '/bin/bash', 04:07:12 INFO - 'SHLVL': '1', 04:07:12 INFO - 'TERM': 'linux', 04:07:12 INFO - 'TMOUT': '86400', 04:07:12 INFO - 'USER': 'cltbld', 04:07:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:12 INFO - '_': '/tools/buildbot/bin/python'} 04:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:12 INFO - Cleaning up... 04:07:12 INFO - Return code: 0 04:07:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:12 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:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 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:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:07:12 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:07:12 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:07:12 INFO - Using env: {'DISPLAY': ':0', 04:07:12 INFO - 'HOME': '/home/cltbld', 04:07:12 INFO - 'LANG': 'en_US.UTF-8', 04:07:12 INFO - 'LANGUAGE': 'en_US:en', 04:07:12 INFO - 'LOGNAME': 'cltbld', 04:07:12 INFO - 'MAIL': '/var/mail/cltbld', 04:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:12 INFO - 'MOZ_NO_REMOTE': '1', 04:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:12 INFO - 'NO_EM_RESTART': '1', 04:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:12 INFO - 'PWD': '/builds/slave/test', 04:07:12 INFO - 'SHELL': '/bin/bash', 04:07:12 INFO - 'SHLVL': '1', 04:07:12 INFO - 'TERM': 'linux', 04:07:12 INFO - 'TMOUT': '86400', 04:07:12 INFO - 'USER': 'cltbld', 04:07:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:12 INFO - '_': '/tools/buildbot/bin/python'} 04:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:07:12 INFO - Cleaning up... 04:07:12 INFO - Return code: 0 04:07:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:12 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:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 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:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 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 0x7fce8a4fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', '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:07:12 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:07:12 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:07:12 INFO - Using env: {'DISPLAY': ':0', 04:07:12 INFO - 'HOME': '/home/cltbld', 04:07:12 INFO - 'LANG': 'en_US.UTF-8', 04:07:12 INFO - 'LANGUAGE': 'en_US:en', 04:07:12 INFO - 'LOGNAME': 'cltbld', 04:07:12 INFO - 'MAIL': '/var/mail/cltbld', 04:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:12 INFO - 'MOZ_NO_REMOTE': '1', 04:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:12 INFO - 'NO_EM_RESTART': '1', 04:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:12 INFO - 'PWD': '/builds/slave/test', 04:07:12 INFO - 'SHELL': '/bin/bash', 04:07:12 INFO - 'SHLVL': '1', 04:07:12 INFO - 'TERM': 'linux', 04:07:12 INFO - 'TMOUT': '86400', 04:07:12 INFO - 'USER': 'cltbld', 04:07:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:12 INFO - '_': '/tools/buildbot/bin/python'} 04:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:12 INFO - Downloading/unpacking flake8 04:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:14 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:07:14 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:07:14 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:07:14 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:07:14 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:07:14 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:07:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:14 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:07:14 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:07:14 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:07:14 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:07:14 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:07:14 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:07:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:15 INFO - no previously-included directories found matching 'docs/_build' 04:07:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:15 INFO - Running setup.py install for pep8 04:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:15 INFO - no previously-included directories found matching 'docs/_build' 04:07:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:15 INFO - Cleaning up... 04:07:15 INFO - Return code: 0 04:07:15 INFO - Running post-action listener: _resource_record_post_action 04:07:15 INFO - Running post-action listener: _start_resource_monitoring 04:07:15 INFO - Starting resource monitoring. 04:07:15 INFO - ##### 04:07:15 INFO - ##### Finished create-virtualenv step (success) 04:07:15 INFO - ##### 04:07:15 INFO - ##### 04:07:15 INFO - ##### Running install step. 04:07:15 INFO - ##### 04:07:15 INFO - Running pre-action listener: _resource_record_pre_action 04:07:15 INFO - Running main action method: install 04:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:15 INFO - Reading from file tmpfile_stdout 04:07:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:15 INFO - Reading from file tmpfile_stdout 04:07:15 INFO - Output received: 04:07:15 INFO - Usage: mozinstall [options] installer 04:07:15 INFO - Options: 04:07:15 INFO - -h, --help show this help message and exit 04:07:15 INFO - -d DEST, --destination=DEST 04:07:15 INFO - Directory to install application into. [default: 04:07:15 INFO - "/builds/slave/test"] 04:07:15 INFO - --app=APP Application being installed. [default: firefox] 04:07:15 INFO - mkdir: /builds/slave/test/build/application 04:07:15 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:07:15 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:07:32 INFO - Reading from file tmpfile_stdout 04:07:32 INFO - Output received: 04:07:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:07:32 INFO - Running post-action listener: _resource_record_post_action 04:07:32 INFO - ##### 04:07:32 INFO - ##### Finished install step (success) 04:07:32 INFO - ##### 04:07:32 INFO - ##### 04:07:32 INFO - ##### Running run-tests step. 04:07:32 INFO - ##### 04:07:32 INFO - Running pre-action listener: _resource_record_pre_action 04:07:32 INFO - Running main action method: run_tests 04:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:32 INFO - Python 2.7.3 04:07:32 INFO - Return code: 0 04:07:32 INFO - grabbing minidump binary from tooltool 04:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:32 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 0x29866f0>, '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 0x29875f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:32 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:07:32 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:07:32 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:07:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:32 INFO - Return code: 0 04:07:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:07:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:07:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:33 INFO - Return code: 0 04:07:33 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:07:33 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:07:33 INFO - Using env: {'DISPLAY': ':0', 04:07:33 INFO - 'HOME': '/home/cltbld', 04:07:33 INFO - 'LANG': 'en_US.UTF-8', 04:07:33 INFO - 'LANGUAGE': 'en_US:en', 04:07:33 INFO - 'LOGNAME': 'cltbld', 04:07:33 INFO - 'MAIL': '/var/mail/cltbld', 04:07:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:33 INFO - 'MOZ_NO_REMOTE': '1', 04:07:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:33 INFO - 'NO_EM_RESTART': '1', 04:07:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:33 INFO - 'PWD': '/builds/slave/test', 04:07:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:33 INFO - 'SHELL': '/bin/bash', 04:07:33 INFO - 'SHLVL': '1', 04:07:33 INFO - 'TERM': 'linux', 04:07:33 INFO - 'TMOUT': '86400', 04:07:33 INFO - 'USER': 'cltbld', 04:07:33 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313', 04:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:33 INFO - '_': '/tools/buildbot/bin/python'} 04:07:33 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:07:33 INFO - mozversion application_buildid: 20160627032524 04:07:33 INFO - mozversion application_changeset: 7cf93d6c932bf2a643beb2ea304c3d57cfc95f3a 04:07:33 INFO - mozversion application_display_name: Nightly 04:07:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:33 INFO - mozversion application_name: Firefox 04:07:33 INFO - mozversion application_remotingname: firefox 04:07:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:07:33 INFO - mozversion application_vendor: Mozilla 04:07:33 INFO - mozversion application_version: 50.0a1 04:07:33 INFO - mozversion platform_buildid: 20160627032524 04:07:33 INFO - mozversion platform_changeset: 7cf93d6c932bf2a643beb2ea304c3d57cfc95f3a 04:07:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:07:33 INFO - mozversion platform_version: 50.0a1 04:07:33 INFO - using testdate: 1467025653 04:07:33 INFO - actual date: 1467025653 04:07:33 INFO - starting webserver on 'localhost:43256' 04:07:33 INFO - SUITE-START | Running 2 tests 04:07:33 INFO - TEST-START | dromaeo_css 04:07:33 INFO - operating with platform_type : linux_ 04:07:33 INFO - Initialising browser for dromaeo_css test... 04:07:33 INFO - TEST-INFO | started process 3787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxLGR7r/profile http://localhost:43256/getInfo.html) 04:07:38 INFO - PROCESS | 3787 | __metrics Screen width/height:1600/1200 04:07:38 INFO - PROCESS | 3787 | colorDepth:24 04:07:38 INFO - PROCESS | 3787 | Browser inner width/height: 1024/697 04:07:38 INFO - PROCESS | 3787 | __metrics 04:07:39 INFO - PROCESS | 3787 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:41 INFO - TEST-INFO | 3787: exit 0 04:07:41 INFO - Browser initialized. 04:07:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:41 INFO - TEST-INFO | started process 3868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxLGR7r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:53 INFO - PROCESS | 3868 | RSS: Main: 175833088 04:07:53 INFO - PROCESS | 3868 | 04:08:44 INFO - PROCESS | 3868 | 1467025724052 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:10:56 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43256/tests/dromaeo/cssquery-ext.html) 04:10:58 INFO - PROCESS | 3868 | RSS: Main: 288059392 04:10:58 INFO - PROCESS | 3868 | 04:14:00 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-ext.html (next: http://localhost:43256/tests/dromaeo/cssquery-jquery.html) 04:14:01 INFO - PROCESS | 3868 | RSS: Main: 260747264 04:14:01 INFO - PROCESS | 3868 | 04:17:03 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43256/tests/dromaeo/cssquery-mootools.html) 04:17:04 INFO - PROCESS | 3868 | RSS: Main: 263331840 04:17:04 INFO - PROCESS | 3868 | 04:20:06 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43256/tests/dromaeo/cssquery-prototype.html) 04:20:06 INFO - PROCESS | 3868 | RSS: Main: 255692800 04:20:06 INFO - PROCESS | 3868 | 04:23:09 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43256/tests/dromaeo/cssquery-yui.html) 04:23:10 INFO - PROCESS | 3868 | RSS: Main: 236552192 04:23:10 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-yui.html (next: http://localhost:43256/tests/dromaeo/cssquery-dojo.html) 04:26:13 INFO - PROCESS | 3868 | RSS: Main: 271220736 04:26:13 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | __start_tp_report 04:26:13 INFO - PROCESS | 3868 | _x_x_mozilla_page_load 04:26:13 INFO - PROCESS | 3868 | _x_x_mozilla_page_load_details 04:26:13 INFO - PROCESS | 3868 | |i|pagename|runs| 04:26:13 INFO - PROCESS | 3868 | |0;dojo.html;2607.5958226474895;2628.8291261068043;2658.003248781706;2674.5453272943587;2681.222445490808;4646.790894409752;4702.365180700609;4776.593989510887;4803.975980120099;4828.927566086511;4747.976260118695;4769.523047695228;4778.665493415454;4811.037792441508;4825.71045737256;4369.475662920454;4427.756473393962;4448.421705178323;4481.619062379686;4596.747178905159;4488.7531185784765;4499.032707967786;4528.524504926984;4538.3873177120995;4563.4752003519525;4365.825366985317;4399.406080179167;4402.5597440255715;4453.888652783674;4470.642348612103;4411.691181617288;4432;4436.423264975532;4499.775011249424;4532.0709254602725;4448.933266001012;4466.955330446719;4469.664775141845;4477;4510.774461276923;4648.976755116203;4655.930161047553;4705.458872229703;4862.027594481083;4902.852914412573;5092.516210959953;5104.744762761847;5107.4892510749;5111.872203194913;5124.795008199668;5068.746562671889;5104.2088476286235;5116.846494605131;5118.334616499831;5121.923171152435;4791.47293797682;4791.928121078186;4835.637327200474;4836.347093142381;4846.9515304846855;5372.946270537323;5385.703786291713;5386.730663466811;5397.082495975694;5398.109311963561;5111.591072714174;5165.199394093921;5170.974145129326;5172.637915345965;5176.7152806596;5032.72320022395;5121.0526052679625;5188.92216616751;5248.265242866002;5264.947350526522;5165.509276618715;5170.379554453414;5170.431252562215;5172.043172013189;5204.0632686116105;5152.252923326172;5167.741612919339;5174.974125129425;5176.844694659167;5220.817271395483;4341.131773645284;4395.077033822869;4428.800703968329;4458.264386376277;4485.304777759453;3896.5713771485116;3897.590752970954;3904.511936007999;3924.7056470764805;3944.6449819516383;4528.954710452919;4543.954560454419;4546.61353784932;4582.816687332469;4596.057808149321;4998.2002879539095;5139.974300128475;5202.375714914235;5223.921641175385;5231.136862417658;4511.233090374644;4529.411176547028;4529.750863702462;4566.885827854264;4575.7483338416705;4683.133620280191;4712.952870471251;4747.454042785124;4751.311059896296;4792.9281060784115;4720.527947205252;4780.49804770508;4807.735574543433;4830.420349557935;4890.755462226945;5185.559227465556;5210.244514545446;5212.139996900621;5214.400343960341;5225.346831646044;4858.95141048585;4860.270959355983;4860.805567777249;4902.8774280643265;4912.091263116335;5009.123403404463;5043;5102.311187989574;5119.155339368963;5139.897202056013;5175.844724658266;5211.739413029258;5216.37403511581;5225.608079393985;5265.2365407015;4926.975365123151;5053.913408617165;5061.240813877947;5068.239764035424;5072.41667208261;4970.900581988412;5022.974885125551;5046.6719663221775;5064.113780088396;5083.593312534915;4991.051700176955;5005.4744251853035;5055.898882022412;5057.31726216956;5059.114654935445;4944.901101978012;5031.924521132113;5132.230165475059;5155.200943853709;5158.406783219978;4957.925631115609;4989.2516122580455;5016.097102521435;5017.046761115376;5065.7720402581235 04:26:13 INFO - PROCESS | 3868 | |1;ext.html;539.2027296537472;583.1427801132336;586.2613107484568;587.251254650321;599.388623603924;26463.338416539573;26861.865690671544;29203.853980730095;39415.21169576607;40685.38971915416;40892.59107408925;41212.38181427273;41288.38067428984;41310.17379652413;41358.17283654332;7817.140114587391;7915.643796029164;7965.96017019917;7967.880481792778;7970.163132871052;7791.883121753178;7882.684692612317;7891.684332626688;7894.2105789421175;7896.131425543185;7882.093559240703;7899.249571290718;7904.05151381835;7948.801279968018;7951.443398962075;7839.294463498284;7880.842383152305;7890.368770498375;7891.881621775678;7895.447318687694;7760.767176984699;7825.686972521093;7826.413019023539;7828.060632724109;7830.960845195795;37772.43341349882;38094.428583571265;38101;38141.61858381408;38239.808800956096;3109.9689003110134;3201.4237437261286;3685.281370132825;3725.701943844486;3773.7735735855936;27499.31251718703;29166.27084322888;29170.416591668047;29599.70400295991;30032.699673003208;3435.3988052090785;3492.1421843240196;3556.484309775068;3575.606683264839;3618.5476815398074;249167;251323;251887;251890;252009;31895;32697.18257043593;53173.734131329096;53844.461555384725;54134;33700.32599347999;33749.49375759316;33809.323813523595;33820;33903.49144762831;13192;13351.799723004162;13352.599422017354;13361.465541378431;13361.866381336256;10966.506507207196;11045.83431248532;11047.171462140212;11047.171462140212;11053.502592383362;7801.063872335356;7814.3748500119855;7839.490433121829;7899.644515996679;7913.32736717374;3022.30486987994;3064.739497142768;3073.231692076981;3111.175538482304;3147.2289289123855;864.8659457783928;892.8839250897472;916.1251005289932;948.3266880514774;952.4808979106404;27428.725712743017;27457.45085098287;27928.72071279302;28084;28439.43121137607;965.7489052846311;986.6152200641756;1004.8508331640454;1019.4291196929595;1026.384169498295;14345.426182952566;14697.77953330701;14838.777418338734;15176.013559118623;15189;374697;376796;377044;379393;381603;50045.749771250914;50559.24161137586;50563.49436505661;50680;50746.49253507492;1066.1204506282193;1133.365315423349;1163.3717792392013;1203.5005472728894;1214.8056310990553;28130.01544945917;28974.130776076752;29217.41565168727;29795.10614681563;29957.251068723457;41224.79387603043;41637.79181104196;41778.79110604428;41817.79091104647;41888;236822;238347;239496;239894;240421;22225.555488890455;24323;25015.249542513753;25321.62017569701;25443.491130177663;41395.58604413917;41557.58442415537;41700.1659966805;42014.36978445265;42239.577604224796;35652.64347356493;35850;36207.45688814722;36468.45297320595;36716.44925326176;35703.64296357003;35746;35900.337502481845;35983;36419.817900910326;35231.64768352284;35605;36128.819355903055;36250.274994499436;36400.81799590985;29551.85224073866;32317.838410807795;32518.512222317157;32622.673773261962;32672;24954;25285.3450387714;25355.61966570466;25380.873095634404;25766.87116564405 04:26:13 INFO - PROCESS | 3868 | |2;jquery.html;365.4226322410591;376.5462617545857;379.6298608856364;379.7209051347261;385.34299020170613;16635.334586616536;17396;17862.642747145048;17907.910460447678;17927.462176134704;15477.845221547781;16087.83912160878;16167.83832161678;16186.109763962977;16961.745573816403;4424.181526417615;4642.814287428499;4665.510121437251;4665.650076244296;4667.22990706533;3510.0873772819123;3681.3925702259094;4610.5389461053965;6567.310432404601;7072.434205263592;6787.389134977851;7059.894101588455;7144.607046612434;7189.1013623297085;7192.9640351798425;7072;7094.290570942916;7134.92865071353;7138.214796372395;7143.607101609384;3799.810009499514;6122.663253521055;6552.344765523457;6557.311482294338;6854.6229957352825;23214.651780223143;23316.13470922322;23477.29568112959;23528.176513821934;24073;2099.3177217404404;2145.345669570796;2177.0638625391075;2317.5712493188644;2534.961975570368;13501.392437340342;14287.714245715131;14315.642108947255;14774.039687420283;15006.324715387835;1757.4991127528722;1856.4152292028102;1876.7278744581959;1888.2069530797098;1934.2263094762068;55843;77357;78847.6057619714;79267.20732792656;80258.19741802565;15907.56831885136;16207.432739854048;16435.506934791974;16471.91764041172;16521;28365.149045528255;28440.431191376472;28686;28785.280367990967;28830.42339153205;8366.874496882552;8650.221480066824;8743.912560874436;8766.517841518778;9018.86471702925;7121.216666166718;7249.891251631229;7289.781306560705;7346.96326518364;7393.852122957511;8073.434859559775;8312.584370781558;8375.162483751697;8428.325733941392;8568.443051201652;2687.8521681307716;3113.4551453495546;3121.8751249949746;3231.3698828728643;3344.7324214062814;763.1795819494066;835.0688981785387;845.0830848529291;868.4789126524036;894.1148263219496;16475.6704865902;16487.587810304838;16693.332266709196;17180.22688978999;17357.826421735623;792.9920700793034;798.968041278354;817.2318021060184;865.4071960706935;885.8272636835756;9480.478573678376;9670.129688328085;9734.123928846439;9754.219662426989;9867.753306167404;397211;399060;399254;404100;407774;70593.64703176553;70749.64625176841;71781;72427.2757272431;73045;890.2388457868559;897.6364572348209;910.3081657940013;918.42598376015;921.7280902133887;14666.753325966985;14997.700045999238;15102.169380684169;15112.471063512725;15350.385984560493;33385;34158.8292058548;34626.653733463354;34940;35373.469397958535;43347.566524334354;45994;46581.534184659075;47362.52637473581;48045.27932080952;7640.885386719315;7671.117821450604;7696.15342312334;7792.532448052908;7904.525728456311;10602.151827853908;10900.291481053706;11231.943840280746;11525.308481491138;11584.826227606762;9058.184763371328;9680.515974201402;9728.708138755848;9840.803183936137;10012.498125280974;9669.226461883172;9758.51207439611;9880.40717556949;9913.405195688281;10015.649452269136;5374.570034397317;8291.709790157316;9864.950675246579;9972.700818975442;10513.264071515227;7706.449517909732;7707.768766937001;7894.407919405952;7914;8036.6383512740895;7802.765917022499;9892;9907.653232136841;10216.948915255376;10418.853926067975 04:26:13 INFO - PROCESS | 3868 | |3;mootools.html;1227.5396726227664;1396.5391420831124;1420.4673247532176;1505.1721553145774;1715.322447633185;7439.256074392558;7867.291943725064;7879.724209652656;8069.556174410405;8078.434509584316;7785.64964576594;7981.960090199555;7991.041075070985;7996.880046799288;8008.239217274364;2197.077227564419;2224.4661281292533;2225.6216443204694;2228.142165266376;2228.621134407155;2210.126999835064;2230.029936977412;2284.885755712216;2291.6218823894037;2292.6331786914097;2192.440927563469;2205.38249290199;2225.866448013124;2230.208276061999;2239.0931672672514;2130.7762684918016;2135.7757435469284;2150.494633761065;2152.1821707750955;2154.5260042790483;2129.829613630906;2140.3792900058966;2141.839362047853;2142.078906070389;2142.967855482169;7847.6468558914985;7907.565083920382;8003.159668234868;8016.078151012592;8048.436609437342;4621.69958952667;4726;4727.385439892826;4732.100900828866;4738.455077666078;2737.7809775218134;2838.162741991097;2880.7839412043973;2891.190466669336;2892.3781387001895;951.6383774165841;963.2775418436173;965.6234068713208;967.0716112531978;980.1864452504404;10974.890251097466;11053.889461105447;11147.21969462146;11184.944075279653;11196;3988.3818008208773;4123.4021066945725;4199.370094485852;4202.138561594866;4203.264428725022;8576.785580360542;8598.957005214934;8645.567721613894;8649;8652;4559.817607295738;4560.703554269028;4562.270036794097;4562.794674239667;4568.588827005586;3681.3557627415094;3832.5400951885954;3850.4609354690365;4146.108586653884;4277.850275240352;3334.183125134309;3428.245785927092;3432.673895979878;3499.3876071687355;3515.8417871195857;996.3374356053289;1028.095276156977;1035.7307100154014;1039.4646756920192;1040.7918416316768;684.0628339175362;764.8164440534232;813.8819871118654;829.3323874281141;845.7251393297203;5123.6157288202785;5167.896642067138;5232.73836308183;5380.515753582196;5597.076482380443;792.7989096518779;797.2346547314643;837.1879277101202;850.2177996243471;858.3433673239977;3494.982525087358;3644.9635503645154;3662.432322989941;3673.559172899269;3708.8873337998493;9814.263930205263;9924.454155021544;9972.750681232883;10045.246606504395;10068.395896246102;9960.452175130293;9966;9968.302218844756;9970.351927124859;9974.750631234132;7301.744438944612;7449.404047676173;7453.515521491086;7481.139668938033;7486.812829679193;5081.008056104795;5218.269442278008;5262.184361423985;5345.118055520951;5482.205080263419;9147.085291471067;9201.907980920105;9216.769580760534;9239.353245273036;9288.489133097473;8814.867776983223;9106.590203440728;9112.498812565107;9132.178103970675;9358.76603084901;6714.865702686016;7150.499465037606;7167.820804479721;7256.818579535343;7317.780466586011;7365.668544915385;7546.396288297033;7558.206388329147;7603.239676032353;7620.428467865043;6505.154329937078;6856.554323968926;6881.931180688129;6895.793126206222;6917.515773895779;6691.899621505779;6729.259781423942;6809.727610895508;6830.385265326145;6852.5203235773015;5891.793787217427;5954.7320370582565;6014.548908831767;6020.217371741821;6025.246844144482;4356.49900261474;4367.170237654836;4403.229434848825;4418.513963463952;4439.356293337512;4353.216421044242;4364.410804541346;4368.868933931987;4473.083017981371;4479.7536135511555 04:26:13 INFO - PROCESS | 3868 | |4;prototype.html;298.7893535057783;300.4531752210976;301.49349093522875;307.16604419002414;312.0762542873096;4988.154382878331;4991.151504244278;5002.524760147785;5015.5486006259425;5020.146575082235;4876.707397556141;4884.389451318585;4908.398548769158;4911.729854857981;4924.187509061009;3625.4743062255957;3733.309337772521;3800.619938006205;3860.86486972956;3885.805709714517;3825;3857.787821669807;3877.941830872525;3881.8835434936855;3882.9223415531674;3676.6874815640704;3867.168558759866;3871.9032024199337;3872.586505925345;3877.592852750463;3789.905252368685;3841.1741475582885;3841.5966323536186;3847.4222271078443;3873.1479074603685;3406.688424956385;3410.9829450852585;3415.1803567143706;3424.8630054797777;3440.776349537297;4614.215583350839;4634;4637.5130611286;4741.383620129395;4746.786394612251;4203.827940015792;4394.824207031715;4404.185225733249;4430.515777214637;4458.576435238647;5008.373953255843;5063.3417655704525;5078;5082.440931497532;5098.821541246076;3756.868509602178;3758.830852611639;3770.7549009314307;3777;3798.8480460781534;5197.870053248661;5309;5334.893302133935;5373.650712703662;5407.5133238008375;3827.9234415312094;3834.1948190880225;3837.9040523987123;3840.615938406193;3856.305864944281;3892.4355968384425;3892.5523564789846;3904.3752999520507;3917.4711413958753;3924.784136872442;4362.825486980549;4379.277419225856;4385.51759306476;4392.802323895432;4414.713043652152;4802.070736850518;5059.215821547666;5082.33929589151;5086.974565127225;5091.2363145527725;1284.9229046257256;1309.1425116548676;1316.789313709802;1336.712606789545;1340.4571148684797;843.8818565400849;865.1910463716446;866.7313132928687;867.1112110087086;893.9374243803002;4430.468343798765;4436.44544431946;4542.295944128666;4559.475660299108;4581.679282450196;5280.973595132;5293.682379057269;5296.470352964673;5318.7074710891275;5329.200619907045;4358.629516491071;4578.313253012075;4583.931241031387;4606.608438282784;4613.861584152481;2771.321026348517;2809.8595070246406;2811.1707046421357;2818.689944106147;2822.943541129166;4929.901401971941;4946.629002824802;4968.95651913095;4974.452810190876;4987.251912213197;5119.923201151985;5396.271503346998;5434.592405569519;5448.182772584144;5461.344638643388;4964.131277026506;4986.601071914238;5009.348784657971;5017;5033.709662103734;5313.601479889101;5347.839564813062;5362.034833729966;5368.704721240213;5380.246765452918;5134.4352121267375;5167.250748641502;5234.398044224963;5237.2667826505085;5249.737513124405;4974.363587298738;4976;5019.949800501949;5027.572656324253;5032.396112466381;3717.572479164931;3735.252949410183;3768.5477742671055;3782.9243415132096;3797.411401232813;5098.082345177903;5299.9470005301;5301.734913254245;5323.361196656426;5358.517733404013;5100.158473851773;5159.974200128975;5167.638265321391;5169.53474187325;5177.4822517747925;5173.301604283373;5183.585313175013;5190.532852043334;5212.739363031757;5213.765380557808;4842.4673285937815;4896.703165379411;5119.87200319995;5121.513456221653;5125.9487405126965;5060.822871199491;5159.793608255628;5166.664166829144;5166.974165129301;5168.53483186515;5048.929938725105;5059.822906198266;5062.367204099488;5065.189569668835;5069.92395114081 04:26:13 INFO - PROCESS | 3868 | |5;yui.html;553.6401339129568;581.2240658720608;629.89921612542;636.6530241018645;662.7945336945544;9162.35863489556;11032.779344413128;12056.276623402602;12539.686507837298;12606.936965315172;12856.74286514269;13023.869761302383;13376.866231337684;13396;13400.66498337542;760.532272652319;775.4688038693484;777.5334799120511;777.6150805351359;778.1129512355918;618.0482057631242;768.2164192523622;780.4224873593529;785.0304873481247;792.2790260862616;795.8090058385975;797.4218691448682;797.5135167547792;798.6366203377478;799.9720009799659;794.8688466403037;795.5266616363255;795.8845967334732;796.0487217774762;798.7284323330038;577.930648322204;581.4360070731384;582.3332284534227;584.7982446056146;586.5190543754123;11622.53509859613;11677.474513646906;11679.240849344766;11689.766204675943;11775.882241177564;11530.481128349244;11892.405379730979;12002.639920802303;12033.578824741093;12358;9941.204703623693;10026.598936042623;10183.745406364826;10376.84434733472;10473;3242.1732458223;3313.5526703894907;3334.133125387417;3416.24842534642;3424.092615456906;60757;61615.07577386388;62445.37554624441;62559.37440625581;62645.37354626441;8308.12764659714;8421.452605580618;8455.323574114056;8602.139786021347;8718.128187181232;16237.51287461378;16253.756193657104;16260.59348516273;16262.512124636043;16289.918550407172;6108.816735497942;6354.163029326482;6614.107095542136;6650.434713049348;6688.264290927994;3522.313148935984;3607.2424790793702;3688.4098544232793;3703.7407381483577;3711.1093337599323;2657.707652158261;2737.301987993049;2746.1212412027958;2747.5603903375363;2750.4499100180046;473.7867959418207;480.274785074533;481.3285466773831;487.74149700658705;487.7804987755524;541.20713155227;550.9283793106871;560.1122221279237;572.9656220626775;575.3584753000458;7656.540607563564;7689.692412303557;7861.567613781297;7967.804829275539;7996.24035716606;451.37709960255296;472.75653038685107;549.5027000564495;558.2965463515918;560.9747561359749;3517.4196257617205;3706.129059670975;3769.151940813295;3778.8677396290996;3833.6549710526187;87497.68753468704;88777;91709;93126.53436732772;94279.52860235654;74336;75520.62239688766;75874.24125758783;77107.61446192733;77147.61426192833;48188.518114818406;55485;68175.65912170407;69067;72597.6370118146;7043.260457652078;7132.393746531603;7161.427085833225;7188.173360063451;7435.182129965808;43733.56266437295;45159.87100322387;45375.31937020881;46018.30972535482;46127.53872461232;58077.709611451675;63119;63306;63398;63448.04827927677;8885.689000884939;8928.955355223183;9349.158575728217;9369.85945210836;9694.854577181206;10362.585496580052;10596;10769.838452423062;10796.838047429137;10847.511861966073;11000.944995274973;11112.333260004103;11248.043916267208;11506.30962142274;11743.41282935867;10843.783124337628;11334.206605537533;11361.602343917923;11410.714732131763;11838.526458941546;10424.530896109845;10630.787384252426;10755.085817705583;10755.247132700635;11686.590969316034;9099.727008189764;9207.86188207164;9389.154976052188;9510.429374237568;9807.411555306704;9734.853977190489;9795.510224488604;9828.31201815866;9842.385984538314;9938.85690728205 04:26:13 INFO - PROCESS | 3868 | __end_tp_report 04:26:13 INFO - PROCESS | 3868 | __start_cc_report 04:26:13 INFO - PROCESS | 3868 | _x_x_mozilla_cycle_collect,1128 04:26:13 INFO - PROCESS | 3868 | __end_cc_report 04:26:13 INFO - PROCESS | 3868 | __startTimestamp1467026773734__endTimestamp 04:26:13 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | ------- Summary: start ------- 04:26:13 INFO - PROCESS | 3868 | Number of tests: 6 04:26:13 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | [#0] dojo.html Cycles:165 Average:4791.76 Median:4902.85 stddev:501.34 (10.2%) stddev-sans-first:472.69 04:26:13 INFO - PROCESS | 3868 | Values: 2607.6 2628.8 2658.0 2674.5 2681.2 4646.8 4702.4 4776.6 4804.0 4828.9 4748.0 4769.5 4778.7 4811.0 4825.7 4369.5 4427.8 4448.4 4481.6 4596.7 4488.8 4499.0 4528.5 4538.4 4563.5 4365.8 4399.4 4402.6 4453.9 4470.6 4411.7 4432.0 4436.4 4499.8 4532.1 4448.9 4467.0 4469.7 4477.0 4510.8 4649.0 4655.9 4705.5 4862.0 4902.9 5092.5 5104.7 5107.5 5111.9 5124.8 5068.7 5104.2 5116.8 5118.3 5121.9 4791.5 4791.9 4835.6 4836.3 4847.0 5372.9 5385.7 5386.7 5397.1 5398.1 5111.6 5165.2 5171.0 5172.6 5176.7 5032.7 5121.1 5188.9 5248.3 5264.9 5165.5 5170.4 5170.4 5172.0 5204.1 5152.3 5167.7 5175.0 5176.8 5220.8 4341.1 4395.1 4428.8 4458.3 4485.3 3896.6 3897.6 3904.5 3924.7 3944.6 4529.0 4544.0 4546.6 4582.8 4596.1 4998.2 5140.0 5202.4 5223.9 5231.1 4511.2 4529.4 4529.8 4566.9 4575.7 4683.1 4713.0 4747.5 4751.3 4792.9 4720.5 4780.5 4807.7 4830.4 4890.8 5185.6 5210.2 5212.1 5214.4 5225.3 4859.0 4860.3 4860.8 4902.9 4912.1 5009.1 5043.0 5102.3 5119.2 5139.9 5175.8 5211.7 5216.4 5225.6 5265.2 4927.0 5053.9 5061.2 5068.2 5072.4 4970.9 5023.0 5046.7 5064.1 5083.6 4991.1 5005.5 5055.9 5057.3 5059.1 4944.9 5031.9 5132.2 5155.2 5158.4 4957.9 4989.3 5016.1 5017.0 5065.8 04:26:13 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | [#1] ext.html Cycles:180 Average:43586.09 Median:35941.67 stddev:78001.07 (217.0%) stddev-sans-first:78152.92 04:26:13 INFO - PROCESS | 3868 | Values: 539.2 583.1 586.3 587.3 599.4 26463.3 26861.9 29203.9 39415.2 40685.4 40892.6 41212.4 41288.4 41310.2 41358.2 7817.1 7915.6 7966.0 7967.9 7970.2 7791.9 7882.7 7891.7 7894.2 7896.1 7882.1 7899.2 7904.1 7948.8 7951.4 7839.3 7880.8 7890.4 7891.9 7895.4 7760.8 7825.7 7826.4 7828.1 7831.0 37772.4 38094.4 38101.0 38141.6 38239.8 3110.0 3201.4 3685.3 3725.7 3773.8 27499.3 29166.3 29170.4 29599.7 30032.7 3435.4 3492.1 3556.5 3575.6 3618.5 249167.0 251323.0 251887.0 251890.0 252009.0 31895.0 32697.2 53173.7 53844.5 54134.0 33700.3 33749.5 33809.3 33820.0 33903.5 13192.0 13351.8 13352.6 13361.5 13361.9 10966.5 11045.8 11047.2 11047.2 11053.5 7801.1 7814.4 7839.5 7899.6 7913.3 3022.3 3064.7 3073.2 3111.2 3147.2 864.9 892.9 916.1 948.3 952.5 27428.7 27457.5 27928.7 28084.0 28439.4 965.7 986.6 1004.9 1019.4 1026.4 14345.4 14697.8 14838.8 15176.0 15189.0 374697.0 376796.0 377044.0 379393.0 381603.0 50045.7 50559.2 50563.5 50680.0 50746.5 1066.1 1133.4 1163.4 1203.5 1214.8 28130.0 28974.1 29217.4 29795.1 29957.3 41224.8 41637.8 41778.8 41817.8 41888.0 236822.0 238347.0 239496.0 239894.0 240421.0 22225.6 24323.0 25015.2 25321.6 25443.5 41395.6 41557.6 41700.2 42014.4 42239.6 35652.6 35850.0 36207.5 36468.5 36716.4 35703.6 35746.0 35900.3 35983.0 36419.8 35231.6 35605.0 36128.8 36250.3 36400.8 29551.9 32317.8 32518.5 32622.7 32672.0 24954.0 25285.3 25355.6 25380.9 25766.9 04:26:13 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | [#2] jquery.html Cycles:180 Average:25431.26 Median:4666.44 stddev:66020.84 (1414.8%) stddev-sans-first:66179.22 04:26:13 INFO - PROCESS | 3868 | Values: 365.4 376.5 379.6 379.7 385.3 16635.3 17396.0 17862.6 17907.9 17927.5 15477.8 16087.8 16167.8 16186.1 16961.7 4424.2 4642.8 4665.5 4665.7 4667.2 3510.1 3681.4 4610.5 6567.3 7072.4 6787.4 7059.9 7144.6 7189.1 7193.0 7072.0 7094.3 7134.9 7138.2 7143.6 3799.8 6122.7 6552.3 6557.3 6854.6 23214.7 23316.1 23477.3 23528.2 24073.0 2099.3 2145.3 2177.1 2317.6 2535.0 13501.4 14287.7 14315.6 14774.0 15006.3 1757.5 1856.4 1876.7 1888.2 1934.2 55843.0 77357.0 78847.6 79267.2 80258.2 15907.6 16207.4 16435.5 16471.9 16521.0 28365.1 28440.4 28686.0 28785.3 28830.4 8366.9 8650.2 8743.9 8766.5 9018.9 7121.2 7249.9 7289.8 7347.0 7393.9 8073.4 8312.6 8375.2 8428.3 8568.4 2687.9 3113.5 3121.9 3231.4 3344.7 763.2 835.1 845.1 868.5 894.1 16475.7 16487.6 16693.3 17180.2 17357.8 793.0 799.0 817.2 865.4 885.8 9480.5 9670.1 9734.1 9754.2 9867.8 397211.0 399060.0 399254.0 404100.0 407774.0 70593.6 70749.6 71781.0 72427.3 73045.0 890.2 897.6 910.3 918.4 921.7 14666.8 14997.7 15102.2 15112.5 15350.4 33385.0 34158.8 34626.7 34940.0 35373.5 43347.6 45994.0 46581.5 47362.5 48045.3 7640.9 7671.1 7696.2 7792.5 7904.5 10602.2 10900.3 11231.9 11525.3 11584.8 9058.2 9680.5 9728.7 9840.8 10012.5 9669.2 9758.5 9880.4 9913.4 10015.6 5374.6 8291.7 9865.0 9972.7 10513.3 7706.4 7707.8 7894.4 7914.0 8036.6 7802.8 9892.0 9907.7 10216.9 10418.9 04:26:13 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | [#3] mootools.html Cycles:180 Average:5171.58 Median:5247.46 stddev:2965.17 (56.5%) stddev-sans-first:2958.68 04:26:13 INFO - PROCESS | 3868 | Values: 1227.5 1396.5 1420.5 1505.2 1715.3 7439.3 7867.3 7879.7 8069.6 8078.4 7785.6 7982.0 7991.0 7996.9 8008.2 2197.1 2224.5 2225.6 2228.1 2228.6 2210.1 2230.0 2284.9 2291.6 2292.6 2192.4 2205.4 2225.9 2230.2 2239.1 2130.8 2135.8 2150.5 2152.2 2154.5 2129.8 2140.4 2141.8 2142.1 2143.0 7847.6 7907.6 8003.2 8016.1 8048.4 4621.7 4726.0 4727.4 4732.1 4738.5 2737.8 2838.2 2880.8 2891.2 2892.4 951.6 963.3 965.6 967.1 980.2 10974.9 11053.9 11147.2 11184.9 11196.0 3988.4 4123.4 4199.4 4202.1 4203.3 8576.8 8599.0 8645.6 8649.0 8652.0 4559.8 4560.7 4562.3 4562.8 4568.6 3681.4 3832.5 3850.5 4146.1 4277.9 3334.2 3428.2 3432.7 3499.4 3515.8 996.3 1028.1 1035.7 1039.5 1040.8 684.1 764.8 813.9 829.3 845.7 5123.6 5167.9 5232.7 5380.5 5597.1 792.8 797.2 837.2 850.2 858.3 3495.0 3645.0 3662.4 3673.6 3708.9 9814.3 9924.5 9972.8 10045.2 10068.4 9960.5 9966.0 9968.3 9970.4 9974.8 7301.7 7449.4 7453.5 7481.1 7486.8 5081.0 5218.3 5262.2 5345.1 5482.2 9147.1 9201.9 9216.8 9239.4 9288.5 8814.9 9106.6 9112.5 9132.2 9358.8 6714.9 7150.5 7167.8 7256.8 7317.8 7365.7 7546.4 7558.2 7603.2 7620.4 6505.2 6856.6 6881.9 6895.8 6917.5 6691.9 6729.3 6809.7 6830.4 6852.5 5891.8 5954.7 6014.5 6020.2 6025.2 4356.5 4367.2 4403.2 4418.5 4439.4 4353.2 4364.4 4368.9 4473.1 4479.8 04:26:13 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | [#4] prototype.html Cycles:180 Average:4283.01 Median:4910.06 stddev:1235.73 (25.2%) stddev-sans-first:1202.47 04:26:13 INFO - PROCESS | 3868 | Values: 298.8 300.5 301.5 307.2 312.1 4988.2 4991.2 5002.5 5015.5 5020.1 4876.7 4884.4 4908.4 4911.7 4924.2 3625.5 3733.3 3800.6 3860.9 3885.8 3825.0 3857.8 3877.9 3881.9 3882.9 3676.7 3867.2 3871.9 3872.6 3877.6 3789.9 3841.2 3841.6 3847.4 3873.1 3406.7 3411.0 3415.2 3424.9 3440.8 4614.2 4634.0 4637.5 4741.4 4746.8 4203.8 4394.8 4404.2 4430.5 4458.6 5008.4 5063.3 5078.0 5082.4 5098.8 3756.9 3758.8 3770.8 3777.0 3798.8 5197.9 5309.0 5334.9 5373.7 5407.5 3827.9 3834.2 3837.9 3840.6 3856.3 3892.4 3892.6 3904.4 3917.5 3924.8 4362.8 4379.3 4385.5 4392.8 4414.7 4802.1 5059.2 5082.3 5087.0 5091.2 1284.9 1309.1 1316.8 1336.7 1340.5 843.9 865.2 866.7 867.1 893.9 4430.5 4436.4 4542.3 4559.5 4581.7 5281.0 5293.7 5296.5 5318.7 5329.2 4358.6 4578.3 4583.9 4606.6 4613.9 2771.3 2809.9 2811.2 2818.7 2822.9 4929.9 4946.6 4969.0 4974.5 4987.3 5119.9 5396.3 5434.6 5448.2 5461.3 4964.1 4986.6 5009.3 5017.0 5033.7 5313.6 5347.8 5362.0 5368.7 5380.2 5134.4 5167.3 5234.4 5237.3 5249.7 4974.4 4976.0 5019.9 5027.6 5032.4 3717.6 3735.3 3768.5 3782.9 3797.4 5098.1 5299.9 5301.7 5323.4 5358.5 5100.2 5160.0 5167.6 5169.5 5177.5 5173.3 5183.6 5190.5 5212.7 5213.8 4842.5 4896.7 5119.9 5121.5 5125.9 5060.8 5159.8 5166.7 5167.0 5168.5 5048.9 5059.8 5062.4 5065.2 5069.9 04:26:13 INFO - PROCESS | 3868 | 04:26:13 INFO - PROCESS | 3868 | [#5] yui.html Cycles:180 Average:16559.61 Median:576.64 stddev:23633.74 (4098.5%) stddev-sans-first:23669.48 04:26:13 INFO - PROCESS | 3868 | Values: 553.6 581.2 629.9 636.7 662.8 9162.4 11032.8 12056.3 12539.7 12606.9 12856.7 13023.9 13376.9 13396.0 13400.7 760.5 775.5 777.5 777.6 778.1 618.0 768.2 780.4 785.0 792.3 795.8 797.4 797.5 798.6 800.0 794.9 795.5 795.9 796.0 798.7 577.9 581.4 582.3 584.8 586.5 11622.5 11677.5 11679.2 11689.8 11775.9 11530.5 11892.4 12002.6 12033.6 12358.0 9941.2 10026.6 10183.7 10376.8 10473.0 3242.2 3313.6 3334.1 3416.2 3424.1 60757.0 61615.1 62445.4 62559.4 62645.4 8308.1 8421.5 8455.3 8602.1 8718.1 16237.5 16253.8 16260.6 16262.5 16289.9 6108.8 6354.2 6614.1 6650.4 6688.3 3522.3 3607.2 3688.4 3703.7 3711.1 2657.7 2737.3 2746.1 2747.6 2750.4 473.8 480.3 481.3 487.7 487.8 541.2 550.9 560.1 573.0 575.4 7656.5 7689.7 7861.6 7967.8 7996.2 451.4 472.8 549.5 558.3 561.0 3517.4 3706.1 3769.2 3778.9 3833.7 87497.7 88777.0 91709.0 93126.5 94279.5 74336.0 75520.6 75874.2 77107.6 77147.6 48188.5 55485.0 68175.7 69067.0 72597.6 7043.3 7132.4 7161.4 7188.2 7435.2 43733.6 45159.9 45375.3 46018.3 46127.5 58077.7 63119.0 63306.0 63398.0 63448.0 8885.7 8929.0 9349.2 9369.9 9694.9 10362.6 10596.0 10769.8 10796.8 10847.5 11000.9 11112.3 11248.0 11506.3 11743.4 10843.8 11334.2 11361.6 11410.7 11838.5 10424.5 10630.8 10755.1 10755.2 11686.6 9099.7 9207.9 9389.2 9510.4 9807.4 9734.9 9795.5 9828.3 9842.4 9938.9 04:26:13 INFO - PROCESS | 3868 | -------- Summary: end -------- 04:26:13 INFO - PROCESS | 3868 | 04:26:14 INFO - TEST-INFO | 3868: exit 0 04:26:14 INFO - TEST-OK | dromaeo_css | took 1121156ms 04:26:14 INFO - TEST-START | kraken 04:26:14 INFO - operating with platform_type : linux_ 04:26:14 INFO - Initialising browser for kraken test... 04:26:14 INFO - TEST-INFO | started process 4051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1M9l_V/profile http://localhost:43256/getInfo.html) 04:26:19 INFO - PROCESS | 4051 | __metrics Screen width/height:1600/1200 04:26:19 INFO - PROCESS | 4051 | colorDepth:24 04:26:19 INFO - PROCESS | 4051 | Browser inner width/height: 1024/697 04:26:19 INFO - PROCESS | 4051 | __metrics 04:26:20 INFO - PROCESS | 4051 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:21 INFO - TEST-INFO | 4051: exit 0 04:26:21 INFO - Browser initialized. 04:26:21 INFO - Running cycle 1/1 for kraken test... 04:26:21 INFO - TEST-INFO | started process 4135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1M9l_V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:34 INFO - PROCESS | 4135 | RSS: Main: 175509504 04:26:34 INFO - PROCESS | 4135 | 04:26:36 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:37 INFO - PROCESS | 4135 | RSS: Main: 232853504 04:26:37 INFO - PROCESS | 4135 | 04:26:40 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-dft) 04:26:41 INFO - PROCESS | 4135 | RSS: Main: 222732288 04:26:41 INFO - PROCESS | 4135 | 04:26:44 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-fft) 04:26:45 INFO - PROCESS | 4135 | RSS: Main: 288432128 04:26:45 INFO - PROCESS | 4135 | 04:26:47 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-oscillator) 04:26:47 INFO - PROCESS | 4135 | RSS: Main: 198180864 04:26:47 INFO - PROCESS | 4135 | 04:26:50 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:50 INFO - PROCESS | 4135 | RSS: Main: 201936896 04:26:50 INFO - PROCESS | 4135 | 04:26:53 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:54 INFO - PROCESS | 4135 | RSS: Main: 238170112 04:26:54 INFO - PROCESS | 4135 | 04:26:57 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:58 INFO - PROCESS | 4135 | RSS: Main: 234123264 04:26:58 INFO - PROCESS | 4135 | 04:27:01 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43256/tests/kraken/driver.html?testName=json-parse-financial) 04:27:02 INFO - PROCESS | 4135 | RSS: Main: 236699648 04:27:02 INFO - PROCESS | 4135 | 04:27:03 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:04 INFO - PROCESS | 4135 | RSS: Main: 222531584 04:27:04 INFO - PROCESS | 4135 | 04:27:06 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:06 INFO - PROCESS | 4135 | RSS: Main: 226021376 04:27:06 INFO - PROCESS | 4135 | 04:27:09 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:09 INFO - PROCESS | 4135 | RSS: Main: 234573824 04:27:09 INFO - PROCESS | 4135 | 04:27:12 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:13 INFO - PROCESS | 4135 | RSS: Main: 238931968 04:27:13 INFO - PROCESS | 4135 | 04:27:16 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:16 INFO - PROCESS | 4135 | RSS: Main: 239403008 04:27:16 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43256/tests/kraken/driver.html?testName=ai-astar) 04:27:18 INFO - PROCESS | 4135 | RSS: Main: 281796608 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | __start_tp_report 04:27:18 INFO - PROCESS | 4135 | _x_x_mozilla_page_load 04:27:18 INFO - PROCESS | 4135 | _x_x_mozilla_page_load_details 04:27:18 INFO - PROCESS | 4135 | |i|pagename|runs| 04:27:18 INFO - PROCESS | 4135 | |0;ai-astar;106;113;113;112;113;112;111;114;113;112 04:27:18 INFO - PROCESS | 4135 | |1;audio-beat-detection;163;134;134;187;130;137;163;129;190;132 04:27:18 INFO - PROCESS | 4135 | |2;audio-dft;162;163;164;163;164;163;165;165;165;163 04:27:18 INFO - PROCESS | 4135 | |3;audio-fft;76;75;76;120;78;78;75;75;99;77 04:27:18 INFO - PROCESS | 4135 | |4;audio-oscillator;89;87;117;86;87;87;121;87;86;127 04:27:18 INFO - PROCESS | 4135 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;117;118;118 04:27:18 INFO - PROCESS | 4135 | |6;imaging-darkroom;147;148;148;148;147;148;146;147;147;146 04:27:18 INFO - PROCESS | 4135 | |7;imaging-desaturate;94;95;94;96;94;95;95;95;95;95 04:27:18 INFO - PROCESS | 4135 | |8;json-parse-financial;63;63;64;64;64;64;63;64;64;65 04:27:18 INFO - PROCESS | 4135 | |9;json-stringify-tinderbox;65;64;65;64;65;64;64;64;64;64 04:27:18 INFO - PROCESS | 4135 | |10;stanford-crypto-aes;83;88;82;83;89;84;84;89;111;83 04:27:18 INFO - PROCESS | 4135 | |11;stanford-crypto-ccm;135;134;133;127;128;130;131;131;143;139 04:27:18 INFO - PROCESS | 4135 | |12;stanford-crypto-pbkdf2;171;180;171;174;172;170;183;170;168;165 04:27:18 INFO - PROCESS | 4135 | |13;stanford-crypto-sha256-iterative;66;68;69;68;66;72;68;67;67;66 04:27:18 INFO - PROCESS | 4135 | __end_tp_report 04:27:18 INFO - PROCESS | 4135 | __start_cc_report 04:27:18 INFO - PROCESS | 4135 | _x_x_mozilla_cycle_collect,1883 04:27:18 INFO - PROCESS | 4135 | __end_cc_report 04:27:18 INFO - PROCESS | 4135 | __startTimestamp1467026838755__endTimestamp 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | ------- Summary: start ------- 04:27:18 INFO - PROCESS | 4135 | Number of tests: 14 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.23 (2.0%) stddev-sans-first:0.88 04:27:18 INFO - PROCESS | 4135 | Values: 106.0 113.0 113.0 112.0 113.0 112.0 111.0 114.0 113.0 112.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:150.00 stddev:23.93 (16.0%) stddev-sans-first:24.91 04:27:18 INFO - PROCESS | 4135 | Values: 163.0 134.0 134.0 187.0 130.0 137.0 163.0 129.0 190.0 132.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.06 (0.6%) stddev-sans-first:0.93 04:27:18 INFO - PROCESS | 4135 | Values: 162.0 163.0 164.0 163.0 164.0 163.0 165.0 165.0 165.0 163.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:14.91 (19.5%) stddev-sans-first:15.60 04:27:18 INFO - PROCESS | 4135 | Values: 76.0 75.0 76.0 120.0 78.0 78.0 75.0 75.0 99.0 77.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:87.00 stddev:16.93 (19.5%) stddev-sans-first:17.68 04:27:18 INFO - PROCESS | 4135 | Values: 89.0 87.0 117.0 86.0 87.0 87.0 121.0 87.0 86.0 127.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:27:18 INFO - PROCESS | 4135 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 04:27:18 INFO - PROCESS | 4135 | Values: 147.0 148.0 148.0 148.0 147.0 148.0 146.0 147.0 147.0 146.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 04:27:18 INFO - PROCESS | 4135 | Values: 94.0 95.0 94.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 04:27:18 INFO - PROCESS | 4135 | Values: 63.0 63.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 65.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 04:27:18 INFO - PROCESS | 4135 | Values: 65.0 64.0 65.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.00 stddev:8.64 (10.3%) stddev-sans-first:9.01 04:27:18 INFO - PROCESS | 4135 | Values: 83.0 88.0 82.0 83.0 89.0 84.0 84.0 89.0 111.0 83.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:133.50 stddev:4.93 (3.7%) stddev-sans-first:5.18 04:27:18 INFO - PROCESS | 4135 | Values: 135.0 134.0 133.0 127.0 128.0 130.0 131.0 131.0 143.0 139.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:171.50 stddev:5.40 (3.1%) stddev-sans-first:5.70 04:27:18 INFO - PROCESS | 4135 | Values: 171.0 180.0 171.0 174.0 172.0 170.0 183.0 170.0 168.0 165.0 04:27:18 INFO - PROCESS | 4135 | 04:27:18 INFO - PROCESS | 4135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.83 (2.7%) stddev-sans-first:1.83 04:27:18 INFO - PROCESS | 4135 | Values: 66.0 68.0 69.0 68.0 66.0 72.0 68.0 67.0 67.0 66.0 04:27:18 INFO - PROCESS | 4135 | -------- Summary: end -------- 04:27:18 INFO - PROCESS | 4135 | 04:27:19 INFO - TEST-INFO | 4135: exit 0 04:27:19 INFO - TEST-OK | kraken | took 65446ms 04:27:19 INFO - SUITE-END | took 1186s 04:27:20 INFO - Completed test suite (00:19:47) 04:27:20 INFO - javascript benchmark 04:27:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.5958226474895, 2628.8291261068043, 2658.003248781706, 2674.5453272943587, 2681.222445490808, 4646.790894409752, 4702.365180700609, 4776.593989510887, 4803.975980120099, 4828.927566086511, 4747.976260118695, 4769.523047695228, 4778.665493415454, 4811.037792441508, 4825.71045737256, 4369.475662920454, 4427.756473393962, 4448.421705178323, 4481.619062379686, 4596.747178905159, 4488.7531185784765, 4499.032707967786, 4528.524504926984, 4538.3873177120995, 4563.4752003519525, 4365.825366985317, 4399.406080179167, 4402.5597440255715, 4453.888652783674, 4470.642348612103, 4411.691181617288, 4432.0, 4436.423264975532, 4499.775011249424, 4532.0709254602725, 4448.933266001012, 4466.955330446719, 4469.664775141845, 4477.0, 4510.774461276923, 4648.976755116203, 4655.930161047553, 4705.458872229703, 4862.027594481083, 4902.852914412573, 5092.516210959953, 5104.744762761847, 5107.4892510749, 5111.872203194913, 5124.795008199668, 5068.746562671889, 5104.2088476286235, 5116.846494605131, 5118.334616499831, 5121.923171152435, 4791.47293797682, 4791.928121078186, 4835.637327200474, 4836.347093142381, 4846.9515304846855, 5372.946270537323, 5385.703786291713, 5386.730663466811, 5397.082495975694, 5398.109311963561, 5111.591072714174, 5165.199394093921, 5170.974145129326, 5172.637915345965, 5176.7152806596, 5032.72320022395, 5121.0526052679625, 5188.92216616751, 5248.265242866002, 5264.947350526522, 5165.509276618715, 5170.379554453414, 5170.431252562215, 5172.043172013189, 5204.0632686116105, 5152.252923326172, 5167.741612919339, 5174.974125129425, 5176.844694659167, 5220.817271395483, 4341.131773645284, 4395.077033822869, 4428.800703968329, 4458.264386376277, 4485.304777759453, 3896.5713771485116, 3897.590752970954, 3904.511936007999, 3924.7056470764805, 3944.6449819516383, 4528.954710452919, 4543.954560454419, 4546.61353784932, 4582.816687332469, 4596.057808149321, 4998.2002879539095, 5139.974300128475, 5202.375714914235, 5223.921641175385, 5231.136862417658, 4511.233090374644, 4529.411176547028, 4529.750863702462, 4566.885827854264, 4575.7483338416705, 4683.133620280191, 4712.952870471251, 4747.454042785124, 4751.311059896296, 4792.9281060784115, 4720.527947205252, 4780.49804770508, 4807.735574543433, 4830.420349557935, 4890.755462226945, 5185.559227465556, 5210.244514545446, 5212.139996900621, 5214.400343960341, 5225.346831646044, 4858.95141048585, 4860.270959355983, 4860.805567777249, 4902.8774280643265, 4912.091263116335, 5009.123403404463, 5043.0, 5102.311187989574, 5119.155339368963, 5139.897202056013, 5175.844724658266, 5211.739413029258, 5216.37403511581, 5225.608079393985, 5265.2365407015, 4926.975365123151, 5053.913408617165, 5061.240813877947, 5068.239764035424, 5072.41667208261, 4970.900581988412, 5022.974885125551, 5046.6719663221775, 5064.113780088396, 5083.593312534915, 4991.051700176955, 5005.4744251853035, 5055.898882022412, 5057.31726216956, 5059.114654935445, 4944.901101978012, 5031.924521132113, 5132.230165475059, 5155.200943853709, 5158.406783219978, 4957.925631115609, 4989.2516122580455, 5016.097102521435, 5017.046761115376, 5065.7720402581235], "value": 4759.299632777213, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.2027296537472, 583.1427801132336, 586.2613107484568, 587.251254650321, 599.388623603924, 26463.338416539573, 26861.865690671544, 29203.853980730095, 39415.21169576607, 40685.38971915416, 40892.59107408925, 41212.38181427273, 41288.38067428984, 41310.17379652413, 41358.17283654332, 7817.140114587391, 7915.643796029164, 7965.96017019917, 7967.880481792778, 7970.163132871052, 7791.883121753178, 7882.684692612317, 7891.684332626688, 7894.2105789421175, 7896.131425543185, 7882.093559240703, 7899.249571290718, 7904.05151381835, 7948.801279968018, 7951.443398962075, 7839.294463498284, 7880.842383152305, 7890.368770498375, 7891.881621775678, 7895.447318687694, 7760.767176984699, 7825.686972521093, 7826.413019023539, 7828.060632724109, 7830.960845195795, 37772.43341349882, 38094.428583571265, 38101.0, 38141.61858381408, 38239.808800956096, 3109.9689003110134, 3201.4237437261286, 3685.281370132825, 3725.701943844486, 3773.7735735855936, 27499.31251718703, 29166.27084322888, 29170.416591668047, 29599.70400295991, 30032.699673003208, 3435.3988052090785, 3492.1421843240196, 3556.484309775068, 3575.606683264839, 3618.5476815398074, 249167.0, 251323.0, 251887.0, 251890.0, 252009.0, 31895.0, 32697.18257043593, 53173.734131329096, 53844.461555384725, 54134.0, 33700.32599347999, 33749.49375759316, 33809.323813523595, 33820.0, 33903.49144762831, 13192.0, 13351.799723004162, 13352.599422017354, 13361.465541378431, 13361.866381336256, 10966.506507207196, 11045.83431248532, 11047.171462140212, 11047.171462140212, 11053.502592383362, 7801.063872335356, 7814.3748500119855, 7839.490433121829, 7899.644515996679, 7913.32736717374, 3022.30486987994, 3064.739497142768, 3073.231692076981, 3111.175538482304, 3147.2289289123855, 864.8659457783928, 892.8839250897472, 916.1251005289932, 948.3266880514774, 952.4808979106404, 27428.725712743017, 27457.45085098287, 27928.72071279302, 28084.0, 28439.43121137607, 965.7489052846311, 986.6152200641756, 1004.8508331640454, 1019.4291196929595, 1026.384169498295, 14345.426182952566, 14697.77953330701, 14838.777418338734, 15176.013559118623, 15189.0, 374697.0, 376796.0, 377044.0, 379393.0, 381603.0, 50045.749771250914, 50559.24161137586, 50563.49436505661, 50680.0, 50746.49253507492, 1066.1204506282193, 1133.365315423349, 1163.3717792392013, 1203.5005472728894, 1214.8056310990553, 28130.01544945917, 28974.130776076752, 29217.41565168727, 29795.10614681563, 29957.251068723457, 41224.79387603043, 41637.79181104196, 41778.79110604428, 41817.79091104647, 41888.0, 236822.0, 238347.0, 239496.0, 239894.0, 240421.0, 22225.555488890455, 24323.0, 25015.249542513753, 25321.62017569701, 25443.491130177663, 41395.58604413917, 41557.58442415537, 41700.1659966805, 42014.36978445265, 42239.577604224796, 35652.64347356493, 35850.0, 36207.45688814722, 36468.45297320595, 36716.44925326176, 35703.64296357003, 35746.0, 35900.337502481845, 35983.0, 36419.817900910326, 35231.64768352284, 35605.0, 36128.819355903055, 36250.274994499436, 36400.81799590985, 29551.85224073866, 32317.838410807795, 32518.512222317157, 32622.673773261962, 32672.0, 24954.0, 25285.3450387714, 25355.61966570466, 25380.873095634404, 25766.87116564405], "value": 16281.080655850832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4226322410591, 376.5462617545857, 379.6298608856364, 379.7209051347261, 385.34299020170613, 16635.334586616536, 17396.0, 17862.642747145048, 17907.910460447678, 17927.462176134704, 15477.845221547781, 16087.83912160878, 16167.83832161678, 16186.109763962977, 16961.745573816403, 4424.181526417615, 4642.814287428499, 4665.510121437251, 4665.650076244296, 4667.22990706533, 3510.0873772819123, 3681.3925702259094, 4610.5389461053965, 6567.310432404601, 7072.434205263592, 6787.389134977851, 7059.894101588455, 7144.607046612434, 7189.1013623297085, 7192.9640351798425, 7072.0, 7094.290570942916, 7134.92865071353, 7138.214796372395, 7143.607101609384, 3799.810009499514, 6122.663253521055, 6552.344765523457, 6557.311482294338, 6854.6229957352825, 23214.651780223143, 23316.13470922322, 23477.29568112959, 23528.176513821934, 24073.0, 2099.3177217404404, 2145.345669570796, 2177.0638625391075, 2317.5712493188644, 2534.961975570368, 13501.392437340342, 14287.714245715131, 14315.642108947255, 14774.039687420283, 15006.324715387835, 1757.4991127528722, 1856.4152292028102, 1876.7278744581959, 1888.2069530797098, 1934.2263094762068, 55843.0, 77357.0, 78847.6057619714, 79267.20732792656, 80258.19741802565, 15907.56831885136, 16207.432739854048, 16435.506934791974, 16471.91764041172, 16521.0, 28365.149045528255, 28440.431191376472, 28686.0, 28785.280367990967, 28830.42339153205, 8366.874496882552, 8650.221480066824, 8743.912560874436, 8766.517841518778, 9018.86471702925, 7121.216666166718, 7249.891251631229, 7289.781306560705, 7346.96326518364, 7393.852122957511, 8073.434859559775, 8312.584370781558, 8375.162483751697, 8428.325733941392, 8568.443051201652, 2687.8521681307716, 3113.4551453495546, 3121.8751249949746, 3231.3698828728643, 3344.7324214062814, 763.1795819494066, 835.0688981785387, 845.0830848529291, 868.4789126524036, 894.1148263219496, 16475.6704865902, 16487.587810304838, 16693.332266709196, 17180.22688978999, 17357.826421735623, 792.9920700793034, 798.968041278354, 817.2318021060184, 865.4071960706935, 885.8272636835756, 9480.478573678376, 9670.129688328085, 9734.123928846439, 9754.219662426989, 9867.753306167404, 397211.0, 399060.0, 399254.0, 404100.0, 407774.0, 70593.64703176553, 70749.64625176841, 71781.0, 72427.2757272431, 73045.0, 890.2388457868559, 897.6364572348209, 910.3081657940013, 918.42598376015, 921.7280902133887, 14666.753325966985, 14997.700045999238, 15102.169380684169, 15112.471063512725, 15350.385984560493, 33385.0, 34158.8292058548, 34626.653733463354, 34940.0, 35373.469397958535, 43347.566524334354, 45994.0, 46581.534184659075, 47362.52637473581, 48045.27932080952, 7640.885386719315, 7671.117821450604, 7696.15342312334, 7792.532448052908, 7904.525728456311, 10602.151827853908, 10900.291481053706, 11231.943840280746, 11525.308481491138, 11584.826227606762, 9058.184763371328, 9680.515974201402, 9728.708138755848, 9840.803183936137, 10012.498125280974, 9669.226461883172, 9758.51207439611, 9880.40717556949, 9913.405195688281, 10015.649452269136, 5374.570034397317, 8291.709790157316, 9864.950675246579, 9972.700818975442, 10513.264071515227, 7706.449517909732, 7707.768766937001, 7894.407919405952, 7914.0, 8036.6383512740895, 7802.765917022499, 9892.0, 9907.653232136841, 10216.948915255376, 10418.853926067975], "value": 9018.3245310475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.5396726227664, 1396.5391420831124, 1420.4673247532176, 1505.1721553145774, 1715.322447633185, 7439.256074392558, 7867.291943725064, 7879.724209652656, 8069.556174410405, 8078.434509584316, 7785.64964576594, 7981.960090199555, 7991.041075070985, 7996.880046799288, 8008.239217274364, 2197.077227564419, 2224.4661281292533, 2225.6216443204694, 2228.142165266376, 2228.621134407155, 2210.126999835064, 2230.029936977412, 2284.885755712216, 2291.6218823894037, 2292.6331786914097, 2192.440927563469, 2205.38249290199, 2225.866448013124, 2230.208276061999, 2239.0931672672514, 2130.7762684918016, 2135.7757435469284, 2150.494633761065, 2152.1821707750955, 2154.5260042790483, 2129.829613630906, 2140.3792900058966, 2141.839362047853, 2142.078906070389, 2142.967855482169, 7847.6468558914985, 7907.565083920382, 8003.159668234868, 8016.078151012592, 8048.436609437342, 4621.69958952667, 4726.0, 4727.385439892826, 4732.100900828866, 4738.455077666078, 2737.7809775218134, 2838.162741991097, 2880.7839412043973, 2891.190466669336, 2892.3781387001895, 951.6383774165841, 963.2775418436173, 965.6234068713208, 967.0716112531978, 980.1864452504404, 10974.890251097466, 11053.889461105447, 11147.21969462146, 11184.944075279653, 11196.0, 3988.3818008208773, 4123.4021066945725, 4199.370094485852, 4202.138561594866, 4203.264428725022, 8576.785580360542, 8598.957005214934, 8645.567721613894, 8649.0, 8652.0, 4559.817607295738, 4560.703554269028, 4562.270036794097, 4562.794674239667, 4568.588827005586, 3681.3557627415094, 3832.5400951885954, 3850.4609354690365, 4146.108586653884, 4277.850275240352, 3334.183125134309, 3428.245785927092, 3432.673895979878, 3499.3876071687355, 3515.8417871195857, 996.3374356053289, 1028.095276156977, 1035.7307100154014, 1039.4646756920192, 1040.7918416316768, 684.0628339175362, 764.8164440534232, 813.8819871118654, 829.3323874281141, 845.7251393297203, 5123.6157288202785, 5167.896642067138, 5232.73836308183, 5380.515753582196, 5597.076482380443, 792.7989096518779, 797.2346547314643, 837.1879277101202, 850.2177996243471, 858.3433673239977, 3494.982525087358, 3644.9635503645154, 3662.432322989941, 3673.559172899269, 3708.8873337998493, 9814.263930205263, 9924.454155021544, 9972.750681232883, 10045.246606504395, 10068.395896246102, 9960.452175130293, 9966.0, 9968.302218844756, 9970.351927124859, 9974.750631234132, 7301.744438944612, 7449.404047676173, 7453.515521491086, 7481.139668938033, 7486.812829679193, 5081.008056104795, 5218.269442278008, 5262.184361423985, 5345.118055520951, 5482.205080263419, 9147.085291471067, 9201.907980920105, 9216.769580760534, 9239.353245273036, 9288.489133097473, 8814.867776983223, 9106.590203440728, 9112.498812565107, 9132.178103970675, 9358.76603084901, 6714.865702686016, 7150.499465037606, 7167.820804479721, 7256.818579535343, 7317.780466586011, 7365.668544915385, 7546.396288297033, 7558.206388329147, 7603.239676032353, 7620.428467865043, 6505.154329937078, 6856.554323968926, 6881.931180688129, 6895.793126206222, 6917.515773895779, 6691.899621505779, 6729.259781423942, 6809.727610895508, 6830.385265326145, 6852.5203235773015, 5891.793787217427, 5954.7320370582565, 6014.548908831767, 6020.217371741821, 6025.246844144482, 4356.49900261474, 4367.170237654836, 4403.229434848825, 4418.513963463952, 4439.356293337512, 4353.216421044242, 4364.410804541346, 4368.868933931987, 4473.083017981371, 4479.7536135511555], "value": 4125.955245397293, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7893535057783, 300.4531752210976, 301.49349093522875, 307.16604419002414, 312.0762542873096, 4988.154382878331, 4991.151504244278, 5002.524760147785, 5015.5486006259425, 5020.146575082235, 4876.707397556141, 4884.389451318585, 4908.398548769158, 4911.729854857981, 4924.187509061009, 3625.4743062255957, 3733.309337772521, 3800.619938006205, 3860.86486972956, 3885.805709714517, 3825.0, 3857.787821669807, 3877.941830872525, 3881.8835434936855, 3882.9223415531674, 3676.6874815640704, 3867.168558759866, 3871.9032024199337, 3872.586505925345, 3877.592852750463, 3789.905252368685, 3841.1741475582885, 3841.5966323536186, 3847.4222271078443, 3873.1479074603685, 3406.688424956385, 3410.9829450852585, 3415.1803567143706, 3424.8630054797777, 3440.776349537297, 4614.215583350839, 4634.0, 4637.5130611286, 4741.383620129395, 4746.786394612251, 4203.827940015792, 4394.824207031715, 4404.185225733249, 4430.515777214637, 4458.576435238647, 5008.373953255843, 5063.3417655704525, 5078.0, 5082.440931497532, 5098.821541246076, 3756.868509602178, 3758.830852611639, 3770.7549009314307, 3777.0, 3798.8480460781534, 5197.870053248661, 5309.0, 5334.893302133935, 5373.650712703662, 5407.5133238008375, 3827.9234415312094, 3834.1948190880225, 3837.9040523987123, 3840.615938406193, 3856.305864944281, 3892.4355968384425, 3892.5523564789846, 3904.3752999520507, 3917.4711413958753, 3924.784136872442, 4362.825486980549, 4379.277419225856, 4385.51759306476, 4392.802323895432, 4414.713043652152, 4802.070736850518, 5059.215821547666, 5082.33929589151, 5086.974565127225, 5091.2363145527725, 1284.9229046257256, 1309.1425116548676, 1316.789313709802, 1336.712606789545, 1340.4571148684797, 843.8818565400849, 865.1910463716446, 866.7313132928687, 867.1112110087086, 893.9374243803002, 4430.468343798765, 4436.44544431946, 4542.295944128666, 4559.475660299108, 4581.679282450196, 5280.973595132, 5293.682379057269, 5296.470352964673, 5318.7074710891275, 5329.200619907045, 4358.629516491071, 4578.313253012075, 4583.931241031387, 4606.608438282784, 4613.861584152481, 2771.321026348517, 2809.8595070246406, 2811.1707046421357, 2818.689944106147, 2822.943541129166, 4929.901401971941, 4946.629002824802, 4968.95651913095, 4974.452810190876, 4987.251912213197, 5119.923201151985, 5396.271503346998, 5434.592405569519, 5448.182772584144, 5461.344638643388, 4964.131277026506, 4986.601071914238, 5009.348784657971, 5017.0, 5033.709662103734, 5313.601479889101, 5347.839564813062, 5362.034833729966, 5368.704721240213, 5380.246765452918, 5134.4352121267375, 5167.250748641502, 5234.398044224963, 5237.2667826505085, 5249.737513124405, 4974.363587298738, 4976.0, 5019.949800501949, 5027.572656324253, 5032.396112466381, 3717.572479164931, 3735.252949410183, 3768.5477742671055, 3782.9243415132096, 3797.411401232813, 5098.082345177903, 5299.9470005301, 5301.734913254245, 5323.361196656426, 5358.517733404013, 5100.158473851773, 5159.974200128975, 5167.638265321391, 5169.53474187325, 5177.4822517747925, 5173.301604283373, 5183.585313175013, 5190.532852043334, 5212.739363031757, 5213.765380557808, 4842.4673285937815, 4896.703165379411, 5119.87200319995, 5121.513456221653, 5125.9487405126965, 5060.822871199491, 5159.793608255628, 5166.664166829144, 5166.974165129301, 5168.53483186515, 5048.929938725105, 5059.822906198266, 5062.367204099488, 5065.189569668835, 5069.92395114081], "value": 3888.5697563096223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6401339129568, 581.2240658720608, 629.89921612542, 636.6530241018645, 662.7945336945544, 9162.35863489556, 11032.779344413128, 12056.276623402602, 12539.686507837298, 12606.936965315172, 12856.74286514269, 13023.869761302383, 13376.866231337684, 13396.0, 13400.66498337542, 760.532272652319, 775.4688038693484, 777.5334799120511, 777.6150805351359, 778.1129512355918, 618.0482057631242, 768.2164192523622, 780.4224873593529, 785.0304873481247, 792.2790260862616, 795.8090058385975, 797.4218691448682, 797.5135167547792, 798.6366203377478, 799.9720009799659, 794.8688466403037, 795.5266616363255, 795.8845967334732, 796.0487217774762, 798.7284323330038, 577.930648322204, 581.4360070731384, 582.3332284534227, 584.7982446056146, 586.5190543754123, 11622.53509859613, 11677.474513646906, 11679.240849344766, 11689.766204675943, 11775.882241177564, 11530.481128349244, 11892.405379730979, 12002.639920802303, 12033.578824741093, 12358.0, 9941.204703623693, 10026.598936042623, 10183.745406364826, 10376.84434733472, 10473.0, 3242.1732458223, 3313.5526703894907, 3334.133125387417, 3416.24842534642, 3424.092615456906, 60757.0, 61615.07577386388, 62445.37554624441, 62559.37440625581, 62645.37354626441, 8308.12764659714, 8421.452605580618, 8455.323574114056, 8602.139786021347, 8718.128187181232, 16237.51287461378, 16253.756193657104, 16260.59348516273, 16262.512124636043, 16289.918550407172, 6108.816735497942, 6354.163029326482, 6614.107095542136, 6650.434713049348, 6688.264290927994, 3522.313148935984, 3607.2424790793702, 3688.4098544232793, 3703.7407381483577, 3711.1093337599323, 2657.707652158261, 2737.301987993049, 2746.1212412027958, 2747.5603903375363, 2750.4499100180046, 473.7867959418207, 480.274785074533, 481.3285466773831, 487.74149700658705, 487.7804987755524, 541.20713155227, 550.9283793106871, 560.1122221279237, 572.9656220626775, 575.3584753000458, 7656.540607563564, 7689.692412303557, 7861.567613781297, 7967.804829275539, 7996.24035716606, 451.37709960255296, 472.75653038685107, 549.5027000564495, 558.2965463515918, 560.9747561359749, 3517.4196257617205, 3706.129059670975, 3769.151940813295, 3778.8677396290996, 3833.6549710526187, 87497.68753468704, 88777.0, 91709.0, 93126.53436732772, 94279.52860235654, 74336.0, 75520.62239688766, 75874.24125758783, 77107.61446192733, 77147.61426192833, 48188.518114818406, 55485.0, 68175.65912170407, 69067.0, 72597.6370118146, 7043.260457652078, 7132.393746531603, 7161.427085833225, 7188.173360063451, 7435.182129965808, 43733.56266437295, 45159.87100322387, 45375.31937020881, 46018.30972535482, 46127.53872461232, 58077.709611451675, 63119.0, 63306.0, 63398.0, 63448.04827927677, 8885.689000884939, 8928.955355223183, 9349.158575728217, 9369.85945210836, 9694.854577181206, 10362.585496580052, 10596.0, 10769.838452423062, 10796.838047429137, 10847.511861966073, 11000.944995274973, 11112.333260004103, 11248.043916267208, 11506.30962142274, 11743.41282935867, 10843.783124337628, 11334.206605537533, 11361.602343917923, 11410.714732131763, 11838.526458941546, 10424.530896109845, 10630.787384252426, 10755.085817705583, 10755.247132700635, 11686.590969316034, 9099.727008189764, 9207.86188207164, 9389.154976052188, 9510.429374237568, 9807.411555306704, 9734.853977190489, 9795.510224488604, 9828.31201815866, 9842.385984538314, 9938.85690728205], "value": 6144.709004710275, "unit": "score"}], "name": "dromaeo_css", "value": 6402.787622112137, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 113.0, 112.0, 113.0, 112.0, 111.0, 114.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 134.0, 187.0, 130.0, 137.0, 163.0, 129.0, 190.0, 132.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 164.0, 163.0, 165.0, 165.0, 165.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 120.0, 78.0, 78.0, 75.0, 75.0, 99.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 117.0, 86.0, 87.0, 87.0, 121.0, 87.0, 86.0, 127.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 82.0, 83.0, 89.0, 84.0, 84.0, 89.0, 111.0, 83.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 133.0, 127.0, 128.0, 130.0, 131.0, 131.0, 143.0, 139.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 180.0, 171.0, 174.0, 172.0, 170.0, 183.0, 170.0, 168.0, 165.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 68.0, 66.0, 72.0, 68.0, 67.0, 67.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1554.1999999999998, "alertThreshold": 2.0}]} 04:27:20 INFO - Return code: 0 04:27:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:27:20 INFO - # TBPL SUCCESS # 04:27:20 INFO - Running post-action listener: _resource_record_post_action 04:27:20 INFO - ##### 04:27:20 INFO - ##### Finished run-tests step (success) 04:27:20 INFO - ##### 04:27:20 INFO - Running post-run listener: _resource_record_post_run 04:27:20 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 542535680; Read time: 0; Write time: 713916 04:27:20 INFO - TinderboxPrint: CPU usage
13.2% 04:27:20 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:27:20 INFO - TinderboxPrint: I/O write bytes / time
542,535,680 / 713,916 04:27:20 INFO - TinderboxPrint: CPU idle
8,342.0 (86.8%) 04:27:20 INFO - TinderboxPrint: CPU user
1,213.3 (12.6%) 04:27:20 INFO - TinderboxPrint: Swap in / out
0 / 0 04:27:20 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 250757120; Read time: 0; Write time: 375844 04:27:20 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289730560; Read time: 0; Write time: 337868 04:27:21 INFO - Running post-run listener: _upload_blobber_files 04:27:21 INFO - Blob upload gear active. 04:27:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:21 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 04:27:21 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'] 04:27:21 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 04:27:21 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:27:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:26 INFO - (blobuploader) - INFO - Done attempting. 04:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:27 INFO - (blobuploader) - INFO - Done attempting. 04:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:27:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:28 INFO - (blobuploader) - INFO - Done attempting. 04:27:28 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:28 INFO - Return code: 0 04:27:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e8c29cfedddbfb536101319449098d47eb19b7439b5b86ae7cadec802a691cc2a3794f6cfd0fe83cfabe9448db8a7cb6b0f5e8d289944970f0b8d8094f0c380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c6b3869959fc59eccbaf3c6b3996bd3b021caf7accf3e2be7581db42f043bd2f3af3d61d606dd5754fd6dc6af17ac244b08b9b0a326e4eee95644aa1220b00c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58c69b664e8d15f8e3fa7b68e3a99bbccb0dbe72b12303386c08209186daaae458e4ebd3a7701ed5d3b9a79d5ee0e62b7a1883eb0851060d48da142500c6b870"} 04:27:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:28 INFO - Contents: 04:27:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e8c29cfedddbfb536101319449098d47eb19b7439b5b86ae7cadec802a691cc2a3794f6cfd0fe83cfabe9448db8a7cb6b0f5e8d289944970f0b8d8094f0c380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c6b3869959fc59eccbaf3c6b3996bd3b021caf7accf3e2be7581db42f043bd2f3af3d61d606dd5754fd6dc6af17ac244b08b9b0a326e4eee95644aa1220b00c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58c69b664e8d15f8e3fa7b68e3a99bbccb0dbe72b12303386c08209186daaae458e4ebd3a7701ed5d3b9a79d5ee0e62b7a1883eb0851060d48da142500c6b870"} 04:27:28 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:28 INFO - Copying logs to upload dir... 04:27:28 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.568131 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-27 04:27:28.080916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 04:27:28.084674) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e8c29cfedddbfb536101319449098d47eb19b7439b5b86ae7cadec802a691cc2a3794f6cfd0fe83cfabe9448db8a7cb6b0f5e8d289944970f0b8d8094f0c380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c6b3869959fc59eccbaf3c6b3996bd3b021caf7accf3e2be7581db42f043bd2f3af3d61d606dd5754fd6dc6af17ac244b08b9b0a326e4eee95644aa1220b00c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58c69b664e8d15f8e3fa7b68e3a99bbccb0dbe72b12303386c08209186daaae458e4ebd3a7701ed5d3b9a79d5ee0e62b7a1883eb0851060d48da142500c6b870"} build_url:https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/RRcwpL3jThepDXbTj_z62Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e8c29cfedddbfb536101319449098d47eb19b7439b5b86ae7cadec802a691cc2a3794f6cfd0fe83cfabe9448db8a7cb6b0f5e8d289944970f0b8d8094f0c380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c6b3869959fc59eccbaf3c6b3996bd3b021caf7accf3e2be7581db42f043bd2f3af3d61d606dd5754fd6dc6af17ac244b08b9b0a326e4eee95644aa1220b00c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58c69b664e8d15f8e3fa7b68e3a99bbccb0dbe72b12303386c08209186daaae458e4ebd3a7701ed5d3b9a79d5ee0e62b7a1883eb0851060d48da142500c6b870"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 04:27:28.113620) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:27:28.114290) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467025591.887816-1688917313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:27:28.197411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 04:27:28.197764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 04:27:28.198066) ========= ========= Total master_lag: 0.19 =========