builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1466618905.4 results: success (0) buildid: 20160622083013 builduid: d7a5aa66e5e0435b83f43372cd86b620 revision: b5fa754a35da091bb0c2b197317cd5627f6c8486 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.400152) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.401014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.401399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.421337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.421704) ========= 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=ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 11:08:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-22 11:08:26 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.403339 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.840177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.840624) ========= 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=ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.890781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:25.891196) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b5fa754a35da091bb0c2b197317cd5627f6c8486 --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 b5fa754a35da091bb0c2b197317cd5627f6c8486 --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=ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 11:08:26,176 truncating revision to first 12 chars 2016-06-22 11:08:26,176 Setting DEBUG logging. 2016-06-22 11:08:26,176 attempt 1/10 2016-06-22 11:08:26,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b5fa754a35da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 11:08:26,541 unpacking tar archive at: fx-team-b5fa754a35da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712208 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:26.617955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:26.618528) ========= script_repo_revision: b5fa754a35da091bb0c2b197317cd5627f6c8486 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:26.619019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:26.619339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 11:08:26.639623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-22 11:08:26.640443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:27 INFO - MultiFileLogger online at 20160622 11:08:27 in /builds/slave/test 11:08:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:08:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:27 INFO - {'append_to_log': False, 11:08:27 INFO - 'base_work_dir': '/builds/slave/test', 11:08:27 INFO - 'blob_upload_branch': 'Fx-Team', 11:08:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:27 INFO - 'branch': 'Fx-Team', 11:08:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:27 INFO - 'config_files': ('talos/linux_config.py',), 11:08:27 INFO - 'default_actions': ('clobber', 11:08:27 INFO - 'read-buildbot-config', 11:08:27 INFO - 'download-and-extract', 11:08:27 INFO - 'populate-webroot', 11:08:27 INFO - 'create-virtualenv', 11:08:27 INFO - 'install', 11:08:27 INFO - 'run-tests'), 11:08:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:27 INFO - 'download_minidump_stackwalk': True, 11:08:27 INFO - 'download_symbols': 'ondemand', 11:08:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:27 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:27 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:27 INFO - 'installer_path': 'installer.exe', 11:08:27 INFO - 'log_level': 'info', 11:08:27 INFO - 'log_name': 'talos', 11:08:27 INFO - 'log_to_console': True, 11:08:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:27 INFO - 'opt_config_files': (), 11:08:27 INFO - 'pip_index': False, 11:08:27 INFO - 'sps_profile': False, 11:08:27 INFO - 'sps_profile_interval': 0, 11:08:27 INFO - 'suite': 'dromaeojs-e10s', 11:08:27 INFO - 'system_bits': '32', 11:08:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:27 INFO - 'title': 'talos-linux64-ix-035', 11:08:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:27 INFO - 'use_talos_json': True, 11:08:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:27 INFO - 'work_dir': 'build'} 11:08:27 INFO - ##### 11:08:27 INFO - ##### Running clobber step. 11:08:27 INFO - ##### 11:08:27 INFO - Running pre-action listener: _resource_record_pre_action 11:08:27 INFO - Running main action method: clobber 11:08:27 INFO - rmtree: /builds/slave/test/build 11:08:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:27 INFO - Running post-action listener: _resource_record_post_action 11:08:27 INFO - ##### 11:08:27 INFO - ##### Finished clobber step (success) 11:08:27 INFO - ##### 11:08:27 INFO - ##### 11:08:27 INFO - ##### Running read-buildbot-config step. 11:08:27 INFO - ##### 11:08:27 INFO - Running pre-action listener: _resource_record_pre_action 11:08:27 INFO - Running main action method: read_buildbot_config 11:08:27 INFO - Using buildbot properties: 11:08:27 INFO - { 11:08:27 INFO - "project": "", 11:08:27 INFO - "product": "firefox", 11:08:27 INFO - "script_repo_revision": "production", 11:08:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:08:27 INFO - "repository": "", 11:08:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:08:27 INFO - "buildid": "20160622083013", 11:08:27 INFO - "pgo_build": "True", 11:08:27 INFO - "basedir": "/builds/slave/test", 11:08:27 INFO - "buildnumber": 492, 11:08:27 INFO - "slavename": "talos-linux64-ix-035", 11:08:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:08:27 INFO - "platform": "ubuntu64_hw", 11:08:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:08:27 INFO - "branch": "fx-team", 11:08:27 INFO - "repo_path": "integration/fx-team", 11:08:27 INFO - "revision": "b5fa754a35da091bb0c2b197317cd5627f6c8486", 11:08:27 INFO - "stage_platform": "linux64-pgo", 11:08:27 INFO - "builduid": "d7a5aa66e5e0435b83f43372cd86b620", 11:08:27 INFO - "slavebuilddir": "test" 11:08:27 INFO - } 11:08:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:08:27 INFO - Running post-action listener: _resource_record_post_action 11:08:27 INFO - ##### 11:08:27 INFO - ##### Finished read-buildbot-config step (success) 11:08:27 INFO - ##### 11:08:27 INFO - ##### 11:08:27 INFO - ##### Running download-and-extract step. 11:08:27 INFO - ##### 11:08:27 INFO - Running pre-action listener: _resource_record_pre_action 11:08:27 INFO - Running main action method: download_and_extract 11:08:27 INFO - mkdir: /builds/slave/test/build/tests 11:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:27 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:28 INFO - Downloaded 1361 bytes. 11:08:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:08:28 INFO - Using the following test package requirements: 11:08:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:08:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:28 INFO - u'jsshell-linux-x86_64.zip'], 11:08:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:08:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:08:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:28 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:30 INFO - Downloaded 24269679 bytes. 11:08:30 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'] 11:08:30 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 11:08:31 INFO - Return code: 0 11:08:31 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 11:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:31 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:33 INFO - Downloaded 24269679 bytes. 11:08:33 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'] 11:08:33 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 11:08:34 INFO - Return code: 0 11:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:34 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:36 INFO - Downloaded 14405384 bytes. 11:08:36 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'] 11:08:36 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 11:08:36 INFO - Return code: 0 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:36 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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 11:08:38 INFO - Downloaded 60167492 bytes. 11:08:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:38 INFO - mkdir: /builds/slave/test/properties 11:08:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:38 INFO - Contents: 11:08:38 INFO - build_url:https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:38 INFO - Running post-action listener: _resource_record_post_action 11:08:38 INFO - Running post-action listener: set_extra_try_arguments 11:08:38 INFO - ##### 11:08:38 INFO - ##### Finished download-and-extract step (success) 11:08:38 INFO - ##### 11:08:38 INFO - ##### 11:08:38 INFO - ##### Running populate-webroot step. 11:08:38 INFO - ##### 11:08:38 INFO - Running pre-action listener: _resource_record_pre_action 11:08:38 INFO - Running main action method: populate_webroot 11:08:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:38 INFO - '--tppagecycles', 11:08:38 INFO - '7'], 11:08:38 INFO - 'tests': ['tsvgm']}}, 11:08:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:08:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:08:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:08:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:38 INFO - 'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:38 INFO - 'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['damp', 'tps']}, 11:08:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:38 INFO - 'tests': ['damp', 'tps']}, 11:08:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['dromaeo_dom']}, 11:08:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['basic_compositor_video']}, 11:08:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:08:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['a11yr', 11:08:38 INFO - 'ts_paint', 11:08:38 INFO - 'tpaint', 11:08:38 INFO - 'sessionrestore', 11:08:38 INFO - 'sessionrestore_no_auto_restore', 11:08:38 INFO - 'tabpaint']}, 11:08:38 INFO - 'other-e10s': {'tests': ['a11yr', 11:08:38 INFO - 'ts_paint', 11:08:38 INFO - 'tpaint', 11:08:38 INFO - 'sessionrestore', 11:08:38 INFO - 'sessionrestore_no_auto_restore', 11:08:38 INFO - 'tabpaint']}, 11:08:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:08:38 INFO - 'ts_paint', 11:08:38 INFO - 'tpaint', 11:08:38 INFO - 'sessionrestore', 11:08:38 INFO - 'sessionrestore_no_auto_restore', 11:08:38 INFO - 'tabpaint']}, 11:08:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:08:38 INFO - 'ts_paint', 11:08:38 INFO - 'tpaint', 11:08:38 INFO - 'sessionrestore', 11:08:38 INFO - 'sessionrestore_no_auto_restore', 11:08:38 INFO - 'tabpaint']}, 11:08:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['a11yr', 11:08:38 INFO - 'ts_paint', 11:08:38 INFO - 'tpaint', 11:08:38 INFO - 'sessionrestore', 11:08:38 INFO - 'sessionrestore_no_auto_restore', 11:08:38 INFO - 'tabpaint']}, 11:08:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['a11yr', 11:08:38 INFO - 'ts_paint', 11:08:38 INFO - 'tpaint', 11:08:38 INFO - 'sessionrestore', 11:08:38 INFO - 'sessionrestore_no_auto_restore', 11:08:38 INFO - 'tabpaint']}, 11:08:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['tsvgx', 11:08:38 INFO - 'tsvgr_opacity', 11:08:38 INFO - 'tart', 11:08:38 INFO - 'tscrollx', 11:08:38 INFO - 'cart']}, 11:08:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:08:38 INFO - 'tsvgr_opacity', 11:08:38 INFO - 'tart', 11:08:38 INFO - 'tscrollx', 11:08:38 INFO - 'cart']}, 11:08:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:38 INFO - 'talos_options': ['--disable-e10s'], 11:08:38 INFO - 'tests': ['tp5o']}, 11:08:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:38 INFO - 'tests': ['tp5o']}, 11:08:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:38 INFO - 'talos_options': ['--disable-e10s', 11:08:38 INFO - '--xperf_path', 11:08:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:38 INFO - 'tests': ['tp5n']}, 11:08:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:38 INFO - 'talos_options': ['--xperf_path', 11:08:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:38 INFO - 'tests': ['tp5n']}}, 11:08:38 INFO - 'talos.zip': {'path': '', 11:08:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:38 INFO - Running post-action listener: _resource_record_post_action 11:08:38 INFO - ##### 11:08:38 INFO - ##### Finished populate-webroot step (success) 11:08:38 INFO - ##### 11:08:38 INFO - ##### 11:08:38 INFO - ##### Running create-virtualenv step. 11:08:38 INFO - ##### 11:08:38 INFO - Running pre-action listener: _resource_record_pre_action 11:08:38 INFO - Running main action method: create_virtualenv 11:08:38 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:38 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 11:08:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:39 INFO - Using real prefix '/usr' 11:08:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:39 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:41 INFO - Installing pip.................done. 11:08:41 INFO - Return code: 0 11:08:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:08:41 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 11:08:41 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 11:08:41 INFO - Using env: {'DISPLAY': ':0', 11:08:41 INFO - 'HOME': '/home/cltbld', 11:08:41 INFO - 'LANG': 'en_US.UTF-8', 11:08:41 INFO - 'LANGUAGE': 'en_US:en', 11:08:41 INFO - 'LOGNAME': 'cltbld', 11:08:41 INFO - 'MAIL': '/var/mail/cltbld', 11:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:41 INFO - 'MOZ_NO_REMOTE': '1', 11:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:41 INFO - 'NO_EM_RESTART': '1', 11:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:41 INFO - 'PWD': '/builds/slave/test', 11:08:41 INFO - 'SHELL': '/bin/bash', 11:08:41 INFO - 'SHLVL': '1', 11:08:41 INFO - 'TERM': 'linux', 11:08:41 INFO - 'TMOUT': '86400', 11:08:41 INFO - 'USER': 'cltbld', 11:08:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:41 INFO - '_': '/tools/buildbot/bin/python'} 11:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:41 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 11:08:41 INFO - Cleaning up... 11:08:41 INFO - Return code: 0 11:08:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:08:41 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 11:08:41 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 11:08:41 INFO - Using env: {'DISPLAY': ':0', 11:08:41 INFO - 'HOME': '/home/cltbld', 11:08:41 INFO - 'LANG': 'en_US.UTF-8', 11:08:41 INFO - 'LANGUAGE': 'en_US:en', 11:08:41 INFO - 'LOGNAME': 'cltbld', 11:08:41 INFO - 'MAIL': '/var/mail/cltbld', 11:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:41 INFO - 'MOZ_NO_REMOTE': '1', 11:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:41 INFO - 'NO_EM_RESTART': '1', 11:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:41 INFO - 'PWD': '/builds/slave/test', 11:08:41 INFO - 'SHELL': '/bin/bash', 11:08:41 INFO - 'SHLVL': '1', 11:08:41 INFO - 'TERM': 'linux', 11:08:41 INFO - 'TMOUT': '86400', 11:08:41 INFO - 'USER': 'cltbld', 11:08:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:41 INFO - '_': '/tools/buildbot/bin/python'} 11:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:41 INFO - Downloading/unpacking psutil>=3.1.1 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:43 INFO - Installing collected packages: psutil 11:08:43 INFO - Running setup.py install for psutil 11:08:44 INFO - building 'psutil._psutil_linux' extension 11:08:44 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 11:08:44 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 11:08:44 INFO - building 'psutil._psutil_posix' extension 11:08:44 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 11:08:44 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 11:08:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:44 INFO - Successfully installed psutil 11:08:44 INFO - Cleaning up... 11:08:44 INFO - Return code: 0 11:08:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:08:44 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')]} 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:44 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')]} 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:44 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:08:44 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 11:08:44 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 11:08:44 INFO - Using env: {'DISPLAY': ':0', 11:08:44 INFO - 'HOME': '/home/cltbld', 11:08:44 INFO - 'LANG': 'en_US.UTF-8', 11:08:44 INFO - 'LANGUAGE': 'en_US:en', 11:08:44 INFO - 'LOGNAME': 'cltbld', 11:08:44 INFO - 'MAIL': '/var/mail/cltbld', 11:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:44 INFO - 'MOZ_NO_REMOTE': '1', 11:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:44 INFO - 'NO_EM_RESTART': '1', 11:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:44 INFO - 'PWD': '/builds/slave/test', 11:08:44 INFO - 'SHELL': '/bin/bash', 11:08:44 INFO - 'SHLVL': '1', 11:08:44 INFO - 'TERM': 'linux', 11:08:44 INFO - 'TMOUT': '86400', 11:08:44 INFO - 'USER': 'cltbld', 11:08:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:44 INFO - '_': '/tools/buildbot/bin/python'} 11:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:08:46 INFO - Installing collected packages: mozsystemmonitor 11:08:46 INFO - Running setup.py install for mozsystemmonitor 11:08:46 INFO - Successfully installed mozsystemmonitor 11:08:46 INFO - Cleaning up... 11:08:46 INFO - Return code: 0 11:08:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:46 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:08:46 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 11:08:46 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 11:08:46 INFO - Using env: {'DISPLAY': ':0', 11:08:46 INFO - 'HOME': '/home/cltbld', 11:08:46 INFO - 'LANG': 'en_US.UTF-8', 11:08:46 INFO - 'LANGUAGE': 'en_US:en', 11:08:46 INFO - 'LOGNAME': 'cltbld', 11:08:46 INFO - 'MAIL': '/var/mail/cltbld', 11:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:46 INFO - 'MOZ_NO_REMOTE': '1', 11:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:46 INFO - 'NO_EM_RESTART': '1', 11:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:46 INFO - 'PWD': '/builds/slave/test', 11:08:46 INFO - 'SHELL': '/bin/bash', 11:08:46 INFO - 'SHLVL': '1', 11:08:46 INFO - 'TERM': 'linux', 11:08:46 INFO - 'TMOUT': '86400', 11:08:46 INFO - 'USER': 'cltbld', 11:08:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:46 INFO - '_': '/tools/buildbot/bin/python'} 11:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:46 INFO - Downloading/unpacking jsonschema==2.5.1 11:08:46 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 11:08:46 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 11:08:46 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 11:08:46 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 11:08:46 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 11:08:46 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 11:08:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:08:48 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 11:08:48 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 11:08:48 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 11:08:48 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 11:08:48 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 11:08:48 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 11:08:49 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:49 INFO - warning: no files found matching '*.txt' 11:08:49 INFO - no previously-included directories found matching 'build' 11:08:49 INFO - no previously-included directories found matching 'dist' 11:08:49 INFO - no previously-included directories found matching '.git*' 11:08:49 INFO - Installing collected packages: jsonschema, functools32 11:08:49 INFO - Running setup.py install for functools32 11:08:49 INFO - warning: no files found matching '*.txt' 11:08:49 INFO - no previously-included directories found matching 'build' 11:08:49 INFO - no previously-included directories found matching 'dist' 11:08:49 INFO - no previously-included directories found matching '.git*' 11:08:49 INFO - Successfully installed jsonschema functools32 11:08:49 INFO - Cleaning up... 11:08:49 INFO - Return code: 0 11:08:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:08: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')]} 11:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:49 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:08:49 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 11:08:49 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 11:08:49 INFO - Using env: {'DISPLAY': ':0', 11:08:49 INFO - 'HOME': '/home/cltbld', 11:08:49 INFO - 'LANG': 'en_US.UTF-8', 11:08:49 INFO - 'LANGUAGE': 'en_US:en', 11:08:49 INFO - 'LOGNAME': 'cltbld', 11:08:49 INFO - 'MAIL': '/var/mail/cltbld', 11:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:49 INFO - 'MOZ_NO_REMOTE': '1', 11:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:49 INFO - 'NO_EM_RESTART': '1', 11:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:49 INFO - 'PWD': '/builds/slave/test', 11:08:49 INFO - 'SHELL': '/bin/bash', 11:08:49 INFO - 'SHLVL': '1', 11:08:49 INFO - 'TERM': 'linux', 11:08:49 INFO - 'TMOUT': '86400', 11:08:49 INFO - 'USER': 'cltbld', 11:08:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:49 INFO - '_': '/tools/buildbot/bin/python'} 11:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:49 INFO - Downloading/unpacking blobuploader==1.2.4 11:08:49 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 11:08:49 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 11:08:49 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 11:08:49 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 11:08:49 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 11:08:49 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 11:08:51 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08:51 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 11:08:51 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 11:08:51 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 11:08:51 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 11:08:51 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 11:08:51 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 11:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:08:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08:51 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 11:08:51 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 11:08:51 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 11:08:51 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 11:08:51 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 11:08:51 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 11:08:52 INFO - Downloading docopt-0.6.1.tar.gz 11:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:52 INFO - Running setup.py install for blobuploader 11:08:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:08:52 INFO - Running setup.py install for requests 11:08:52 INFO - Running setup.py install for docopt 11:08:52 INFO - Successfully installed blobuploader requests docopt 11:08:52 INFO - Cleaning up... 11:08:52 INFO - Return code: 0 11:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:52 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')]} 11:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:52 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')]} 11:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:52 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:08:52 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 11:08:52 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 11:08:52 INFO - Using env: {'DISPLAY': ':0', 11:08:52 INFO - 'HOME': '/home/cltbld', 11:08:52 INFO - 'LANG': 'en_US.UTF-8', 11:08:52 INFO - 'LANGUAGE': 'en_US:en', 11:08:52 INFO - 'LOGNAME': 'cltbld', 11:08:52 INFO - 'MAIL': '/var/mail/cltbld', 11:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:52 INFO - 'MOZ_NO_REMOTE': '1', 11:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:52 INFO - 'NO_EM_RESTART': '1', 11:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:52 INFO - 'PWD': '/builds/slave/test', 11:08:52 INFO - 'SHELL': '/bin/bash', 11:08:52 INFO - 'SHLVL': '1', 11:08:52 INFO - 'TERM': 'linux', 11:08:52 INFO - 'TMOUT': '86400', 11:08:52 INFO - 'USER': 'cltbld', 11:08:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:52 INFO - '_': '/tools/buildbot/bin/python'} 11:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:53 INFO - Running setup.py (path:/tmp/pip-NOtyoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:53 INFO - Running setup.py (path:/tmp/pip-1iNi51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:53 INFO - Running setup.py (path:/tmp/pip-qC6ED0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:53 INFO - Running setup.py (path:/tmp/pip-5OctDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:53 INFO - Running setup.py (path:/tmp/pip-byGiJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:53 INFO - Running setup.py (path:/tmp/pip-teOW_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:53 INFO - Running setup.py (path:/tmp/pip-9GsYkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:53 INFO - Running setup.py (path:/tmp/pip-JJiun7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:53 INFO - Running setup.py (path:/tmp/pip-_C3A9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:53 INFO - Running setup.py (path:/tmp/pip-Mb3AXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:53 INFO - Running setup.py (path:/tmp/pip-9tl_u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:53 INFO - Running setup.py (path:/tmp/pip-WMzzWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:53 INFO - Running setup.py (path:/tmp/pip-46mP3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:53 INFO - Running setup.py (path:/tmp/pip-JEDPt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:54 INFO - Running setup.py (path:/tmp/pip-zoIH4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:54 INFO - Running setup.py (path:/tmp/pip-iZz0PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:54 INFO - Running setup.py (path:/tmp/pip-ISS9x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:54 INFO - Running setup.py install for manifestparser 11:08:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:08:54 INFO - Running setup.py install for mozcrash 11:08:54 INFO - Running setup.py install for mozdebug 11:08:54 INFO - Running setup.py install for mozdevice 11:08:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:08:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:08:54 INFO - Running setup.py install for mozfile 11:08:54 INFO - Running setup.py install for mozhttpd 11:08:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:08:54 INFO - Running setup.py install for mozinfo 11:08:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:08:54 INFO - Running setup.py install for mozInstall 11:08:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Running setup.py install for mozleak 11:08:55 INFO - Running setup.py install for mozlog 11:08:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Running setup.py install for moznetwork 11:08:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Running setup.py install for mozprocess 11:08:55 INFO - Running setup.py install for mozprofile 11:08:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Running setup.py install for mozrunner 11:08:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:08:55 INFO - Running setup.py install for mozscreenshot 11:08:55 INFO - Running setup.py install for moztest 11:08:55 INFO - Running setup.py install for mozversion 11:08:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:08:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:56 INFO - Cleaning up... 11:08:56 INFO - Return code: 0 11:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08: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')]} 11:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:56 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:08:56 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 11:08:56 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 11:08:56 INFO - Using env: {'DISPLAY': ':0', 11:08:56 INFO - 'HOME': '/home/cltbld', 11:08:56 INFO - 'LANG': 'en_US.UTF-8', 11:08:56 INFO - 'LANGUAGE': 'en_US:en', 11:08:56 INFO - 'LOGNAME': 'cltbld', 11:08:56 INFO - 'MAIL': '/var/mail/cltbld', 11:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:56 INFO - 'MOZ_NO_REMOTE': '1', 11:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:56 INFO - 'NO_EM_RESTART': '1', 11:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:56 INFO - 'PWD': '/builds/slave/test', 11:08:56 INFO - 'SHELL': '/bin/bash', 11:08:56 INFO - 'SHLVL': '1', 11:08:56 INFO - 'TERM': 'linux', 11:08:56 INFO - 'TMOUT': '86400', 11:08:56 INFO - 'USER': 'cltbld', 11:08:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:56 INFO - '_': '/tools/buildbot/bin/python'} 11:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:56 INFO - Running setup.py (path:/tmp/pip-P4_FI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:56 INFO - Running setup.py (path:/tmp/pip-SLZLwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:56 INFO - Running setup.py (path:/tmp/pip-FKdtaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:56 INFO - Running setup.py (path:/tmp/pip-Qp0vFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:56 INFO - Running setup.py (path:/tmp/pip-CVDTxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:56 INFO - Running setup.py (path:/tmp/pip-1poVOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:56 INFO - Running setup.py (path:/tmp/pip-HEHDE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:56 INFO - Running setup.py (path:/tmp/pip-vx54Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:56 INFO - Running setup.py (path:/tmp/pip-Rsey7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:56 INFO - Running setup.py (path:/tmp/pip-fIVWsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:56 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)) 11:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:56 INFO - Running setup.py (path:/tmp/pip-P3F3AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:57 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)) 11:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:57 INFO - Running setup.py (path:/tmp/pip-XtOblB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:57 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)) 11:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:57 INFO - Running setup.py (path:/tmp/pip-aDhxRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:57 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)) 11:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:57 INFO - Running setup.py (path:/tmp/pip-FuNznA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:57 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)) 11:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:57 INFO - Running setup.py (path:/tmp/pip-rFM0fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:57 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)) 11:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:57 INFO - Running setup.py (path:/tmp/pip-3s7dwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:57 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)) 11:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:57 INFO - Running setup.py (path:/tmp/pip-OAC0pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:57 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)) 11:08:57 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)) 11:08:57 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)) 11:08:57 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)) 11:08:57 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)) 11:08:57 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)) 11:08:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:59 INFO - Downloading blessings-1.6.tar.gz 11:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:59 INFO - Installing collected packages: blessings 11:08:59 INFO - Running setup.py install for blessings 11:08:59 INFO - Successfully installed blessings 11:08:59 INFO - Cleaning up... 11:08:59 INFO - Return code: 0 11:08:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:59 INFO - Reading from file tmpfile_stdout 11:08:59 INFO - Current package versions: 11:08:59 INFO - argparse == 1.2.1 11:08:59 INFO - blessings == 1.6 11:08:59 INFO - blobuploader == 1.2.4 11:08:59 INFO - docopt == 0.6.1 11:08:59 INFO - functools32 == 3.2.3-2 11:08:59 INFO - jsonschema == 2.5.1 11:08:59 INFO - manifestparser == 1.1 11:08:59 INFO - mozInstall == 1.12 11:08:59 INFO - mozcrash == 0.17 11:08:59 INFO - mozdebug == 0.1 11:08:59 INFO - mozdevice == 0.48 11:08:59 INFO - mozfile == 1.2 11:08:59 INFO - mozhttpd == 0.7 11:08:59 INFO - mozinfo == 0.9 11:08:59 INFO - mozleak == 0.1 11:08:59 INFO - mozlog == 3.2 11:08:59 INFO - moznetwork == 0.27 11:08:59 INFO - mozprocess == 0.22 11:08:59 INFO - mozprofile == 0.28 11:08:59 INFO - mozrunner == 6.11 11:08:59 INFO - mozscreenshot == 0.1 11:08:59 INFO - mozsystemmonitor == 0.3 11:08:59 INFO - moztest == 0.7 11:08:59 INFO - mozversion == 1.4 11:08:59 INFO - psutil == 3.1.1 11:08:59 INFO - requests == 1.2.3 11:08:59 INFO - wsgiref == 0.1.2 11:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08: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')]} 11:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:59 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:08:59 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 11:08:59 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 11:08:59 INFO - Using env: {'DISPLAY': ':0', 11:08:59 INFO - 'HOME': '/home/cltbld', 11:08:59 INFO - 'LANG': 'en_US.UTF-8', 11:08:59 INFO - 'LANGUAGE': 'en_US:en', 11:08:59 INFO - 'LOGNAME': 'cltbld', 11:08:59 INFO - 'MAIL': '/var/mail/cltbld', 11:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:59 INFO - 'MOZ_NO_REMOTE': '1', 11:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:59 INFO - 'NO_EM_RESTART': '1', 11:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:59 INFO - 'PWD': '/builds/slave/test', 11:08:59 INFO - 'SHELL': '/bin/bash', 11:08:59 INFO - 'SHLVL': '1', 11:08:59 INFO - 'TERM': 'linux', 11:08:59 INFO - 'TMOUT': '86400', 11:08:59 INFO - 'USER': 'cltbld', 11:08:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:59 INFO - '_': '/tools/buildbot/bin/python'} 11:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 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)) 11:09:00 INFO - Cleaning up... 11:09:00 INFO - Return code: 0 11:09:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:00 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:09:00 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 11:09:00 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 11:09:00 INFO - Using env: {'DISPLAY': ':0', 11:09:00 INFO - 'HOME': '/home/cltbld', 11:09:00 INFO - 'LANG': 'en_US.UTF-8', 11:09:00 INFO - 'LANGUAGE': 'en_US:en', 11:09:00 INFO - 'LOGNAME': 'cltbld', 11:09:00 INFO - 'MAIL': '/var/mail/cltbld', 11:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:00 INFO - 'MOZ_NO_REMOTE': '1', 11:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:00 INFO - 'NO_EM_RESTART': '1', 11:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:00 INFO - 'PWD': '/builds/slave/test', 11:09:00 INFO - 'SHELL': '/bin/bash', 11:09:00 INFO - 'SHLVL': '1', 11:09:00 INFO - 'TERM': 'linux', 11:09:00 INFO - 'TMOUT': '86400', 11:09:00 INFO - 'USER': 'cltbld', 11:09:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:00 INFO - '_': '/tools/buildbot/bin/python'} 11:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:09:00 INFO - Cleaning up... 11:09:00 INFO - Return code: 0 11:09:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:00 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 0x7f08171bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', '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 11:09:00 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 11:09:00 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 11:09:00 INFO - Using env: {'DISPLAY': ':0', 11:09:00 INFO - 'HOME': '/home/cltbld', 11:09:00 INFO - 'LANG': 'en_US.UTF-8', 11:09:00 INFO - 'LANGUAGE': 'en_US:en', 11:09:00 INFO - 'LOGNAME': 'cltbld', 11:09:00 INFO - 'MAIL': '/var/mail/cltbld', 11:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:00 INFO - 'MOZ_NO_REMOTE': '1', 11:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:00 INFO - 'NO_EM_RESTART': '1', 11:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:00 INFO - 'PWD': '/builds/slave/test', 11:09:00 INFO - 'SHELL': '/bin/bash', 11:09:00 INFO - 'SHLVL': '1', 11:09:00 INFO - 'TERM': 'linux', 11:09:00 INFO - 'TMOUT': '86400', 11:09:00 INFO - 'USER': 'cltbld', 11:09:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:00 INFO - '_': '/tools/buildbot/bin/python'} 11:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:00 INFO - Downloading/unpacking flake8 11:09:00 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 11:09:00 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 11:09:00 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 11:09:00 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 11:09:00 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 11:09:00 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 11:09:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:09:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:09:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:03 INFO - no previously-included directories found matching 'docs/_build' 11:09:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:09:03 INFO - Running setup.py install for pep8 11:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:03 INFO - no previously-included directories found matching 'docs/_build' 11:09:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:09:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:09:03 INFO - Cleaning up... 11:09:03 INFO - Return code: 0 11:09:03 INFO - Running post-action listener: _resource_record_post_action 11:09:03 INFO - Running post-action listener: _start_resource_monitoring 11:09:03 INFO - Starting resource monitoring. 11:09:03 INFO - ##### 11:09:03 INFO - ##### Finished create-virtualenv step (success) 11:09:03 INFO - ##### 11:09:03 INFO - ##### 11:09:03 INFO - ##### Running install step. 11:09:03 INFO - ##### 11:09:03 INFO - Running pre-action listener: _resource_record_pre_action 11:09:03 INFO - Running main action method: install 11:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:03 INFO - Reading from file tmpfile_stdout 11:09:03 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:09:03 INFO - Reading from file tmpfile_stdout 11:09:03 INFO - Output received: 11:09:03 INFO - Usage: mozinstall [options] installer 11:09:03 INFO - Options: 11:09:03 INFO - -h, --help show this help message and exit 11:09:03 INFO - -d DEST, --destination=DEST 11:09:03 INFO - Directory to install application into. [default: 11:09:03 INFO - "/builds/slave/test"] 11:09:03 INFO - --app=APP Application being installed. [default: firefox] 11:09:03 INFO - mkdir: /builds/slave/test/build/application 11:09:03 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'] 11:09:03 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 11:09:20 INFO - Reading from file tmpfile_stdout 11:09:20 INFO - Output received: 11:09:20 INFO - /builds/slave/test/build/application/firefox/firefox 11:09:20 INFO - Running post-action listener: _resource_record_post_action 11:09:20 INFO - ##### 11:09:20 INFO - ##### Finished install step (success) 11:09:20 INFO - ##### 11:09:20 INFO - ##### 11:09:20 INFO - ##### Running run-tests step. 11:09:20 INFO - ##### 11:09:20 INFO - Running pre-action listener: _resource_record_pre_action 11:09:20 INFO - Running main action method: run_tests 11:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:20 INFO - Python 2.7.3 11:09:20 INFO - Return code: 0 11:09:20 INFO - grabbing minidump binary from tooltool 11:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:20 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 0x297a1c0>, '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 0x297b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:20 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 11:09:20 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 11:09:20 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 11:09:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:20 INFO - Return code: 0 11:09:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:09:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:09:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:09:21 INFO - Return code: 0 11:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:09:21 INFO - Using env: {'DISPLAY': ':0', 11:09:21 INFO - 'HOME': '/home/cltbld', 11:09:21 INFO - 'LANG': 'en_US.UTF-8', 11:09:21 INFO - 'LANGUAGE': 'en_US:en', 11:09:21 INFO - 'LOGNAME': 'cltbld', 11:09:21 INFO - 'MAIL': '/var/mail/cltbld', 11:09:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:21 INFO - 'MOZ_NO_REMOTE': '1', 11:09:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:21 INFO - 'NO_EM_RESTART': '1', 11:09:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:21 INFO - 'PWD': '/builds/slave/test', 11:09:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:09:21 INFO - 'SHELL': '/bin/bash', 11:09:21 INFO - 'SHLVL': '1', 11:09:21 INFO - 'TERM': 'linux', 11:09:21 INFO - 'TMOUT': '86400', 11:09:21 INFO - 'USER': 'cltbld', 11:09:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094', 11:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:21 INFO - '_': '/tools/buildbot/bin/python'} 11:09:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:09:21 INFO - mozversion application_buildid: 20160622083013 11:09:21 INFO - mozversion application_changeset: b5fa754a35da091bb0c2b197317cd5627f6c8486 11:09:21 INFO - mozversion application_display_name: Nightly 11:09:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:21 INFO - mozversion application_name: Firefox 11:09:21 INFO - mozversion application_remotingname: firefox 11:09:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:09:21 INFO - mozversion application_vendor: Mozilla 11:09:21 INFO - mozversion application_version: 50.0a1 11:09:21 INFO - mozversion platform_buildid: 20160622083013 11:09:21 INFO - mozversion platform_changeset: b5fa754a35da091bb0c2b197317cd5627f6c8486 11:09:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:09:21 INFO - mozversion platform_version: 50.0a1 11:09:21 INFO - using testdate: 1466618961 11:09:21 INFO - actual date: 1466618961 11:09:21 INFO - starting webserver on 'localhost:45852' 11:09:21 INFO - SUITE-START | Running 2 tests 11:09:21 INFO - TEST-START | dromaeo_css 11:09:21 INFO - operating with platform_type : linux_ 11:09:21 INFO - Initialising browser for dromaeo_css test... 11:09:21 INFO - TEST-INFO | started process 14525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jFGuA/profile http://localhost:45852/getInfo.html) 11:09:26 INFO - PROCESS | 14525 | __metrics Screen width/height:1600/1200 11:09:26 INFO - PROCESS | 14525 | colorDepth:24 11:09:26 INFO - PROCESS | 14525 | Browser inner width/height: 1024/697 11:09:26 INFO - PROCESS | 14525 | __metrics 11:09:27 ERROR - PROCESS | 14525 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:09:28 INFO - TEST-INFO | 14525: exit 0 11:09:28 INFO - Browser initialized. 11:09:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:28 INFO - TEST-INFO | started process 14645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jFGuA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:40 INFO - PROCESS | 14645 | RSS: Main: 184516608 11:09:40 INFO - PROCESS | 14645 | 11:10:29 INFO - PROCESS | 14645 | 1466619029626 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] 11:12:37 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45852/tests/dromaeo/cssquery-ext.html) 11:12:38 INFO - PROCESS | 14645 | RSS: Main: 188964864 11:12:38 INFO - PROCESS | 14645 | 11:15:40 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-ext.html (next: http://localhost:45852/tests/dromaeo/cssquery-jquery.html) 11:15:41 INFO - PROCESS | 14645 | RSS: Main: 187310080 11:15:41 INFO - PROCESS | 14645 | 11:18:43 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45852/tests/dromaeo/cssquery-mootools.html) 11:18:44 INFO - PROCESS | 14645 | RSS: Main: 188973056 11:18:44 INFO - PROCESS | 14645 | 11:21:45 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45852/tests/dromaeo/cssquery-prototype.html) 11:21:46 INFO - PROCESS | 14645 | RSS: Main: 186339328 11:21:46 INFO - PROCESS | 14645 | 11:24:48 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45852/tests/dromaeo/cssquery-yui.html) 11:24:49 INFO - PROCESS | 14645 | RSS: Main: 188846080 11:24:49 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-yui.html (next: http://localhost:45852/tests/dromaeo/cssquery-dojo.html) 11:27:52 INFO - PROCESS | 14645 | RSS: Main: 189661184 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | __start_tp_report 11:27:52 INFO - PROCESS | 14645 | _x_x_mozilla_page_load 11:27:52 INFO - PROCESS | 14645 | _x_x_mozilla_page_load_details 11:27:52 INFO - PROCESS | 14645 | |i|pagename|runs| 11:27:52 INFO - PROCESS | 14645 | |0;dojo.html;3095.040537433396;3152.1331633800687;3163.841807909604;3187.8406079696024;3190.5214217867333;5432.538234250089;5450.127979523277;5484.9177262341045;5497.285352904117;5523.420040895709;5311.256424100629;5423.755930983105;5432.972835135829;5507.311586051744;5607.635503692268;4923.13845077111;4981.1283025470575;5025.120603894322;5058.291839142523;5111.207762796773;716.7032089801139;4809.254565542329;4927.679700819435;4981.72600506972;5097.23541468779;5023.296738456619;5027.798888044474;5044.419891712463;5065.138926382506;5080.568151707109;5082.364704411949;5083.135866902636;5095.5159259870625;5097.770600322957;5112.079825631385;4840.370751802278;4917.72952487613;4921;4963.726995015273;4969.503049695038;5433.782648694048;5459.2902922619805;5462.590305727086;5466.234727138204;5492.862678433071;5600.18797274397;5810.651360918316;5837.9124313135335;5843.444872737083;5892.528597712173;5892;5956.315023772278;5970.880582388328;6029.216201893726;6055.364186760371;5593.74828132735;5639.6334238274385;5640.0693885508845;5643.548516118742;5645.125005624135;5811.476967072984;6018.247719035121;6098.237720284965;6139.263288405331;6144.692765361714;5818.185454036438;5909.6158749681135;5911.76352945886;5914.349421563625;5967.522598192134;5978.940210597925;5989.760409583568;5993.550483713739;5994.22075130239;5999.280086389661;5629.268195134607;5881.5000724938;5889.469947704727;5961.135635332853;5979.760809567656;5921.644701317935;5976.252968378953;5977.521798256129;5987.161797348374;6038.064100064497;4505.256632655575;4515.75163366018;4518.751468669189;4520.547945205519;4559.065391594781;3915.941260881089;3978;4014.9397759033636;4030.6976976726864;4033.032072302626;5450.236966824647;5503.064479038573;5544.279243698374;5586.692731899703;5639.2668953035845;5908.3205431375945;5913.9112913306335;5922.1412895130825;5929.347771745104;5945.732442040118;5328.893422131613;5571;5598.076317407664;5618.438156184349;5625.887482250332;5081;5084.49155084496;5095.363079615048;5095.949040509621;5121.615878809104;6119.969400152971;6126.908096378558;6138.294096178996;6143.447089761943;6145.20112385396;5787.276590426281;5843.766249349978;5869.6771677556435;5910.083936989773;5979.073243647242;6123.387661234019;6131.233595800525;6144.2319710036245;6165.106059621419;6194.349593292639;5633.943660563506;5788.131780232999;5837.29952405714;5853.180554722428;5853.824385268449;5872.442117998783;5915.349311575809;5932.199153114274;5961.165436838933;5975.611585246945;5827.621204621686;5836.795712150054;5842.503387212135;5842.561807864342;5845.444682755132;5583.972080139573;5777.046787280052;5787.739551720267;5787.739551720267;5805.448482394166;5641.915371269516;5689.800856969986;5721.685307308138;5725.541956643542;5758.2514273144225;5763.51010164124;5801.593888427769;5810.970945145416;5811.418858114154;5812.360640329645;5489.094299440707;5669.688167150846;5675.460831221028;5689.288838895138;5695.658260504383 11:27:52 INFO - PROCESS | 14645 | |1;ext.html;578.0144853025591;619.7861737700493;622.9719662615182;640.4908098062042;642.8007317731507;38821.02947426312;43140.78429607848;43199.136017279634;43615;43648;42014.789926050325;42792.3581146283;42883.57116428835;43059.0623421946;43137.35293970585;8700.825983480343;8903.37676362655;8933.240674542672;8935.240504557089;8935.240504557121;8727.301815854747;8793.604287807031;8850.468971861677;8859.778505537348;8886.422382545146;8924.955375223115;8943.239824614915;8944.642214311452;8979.595918183697;9001.369904106716;8812.603432845537;8885.777855553599;8890.86663700045;8893.288536917064;8908.331875109392;8830.602622881986;8846.867296990551;8901.688440904538;8926.553672316359;8946.150115738994;40407.39388909169;41040.38439423411;41142.588574114176;41164;41248.1750364991;2958.60058892049;3268.9375952815194;3363.3441478911623;3567.7680950738118;3573.2674801665858;30293.697063029307;31437.528437073463;31441.8427907859;32807.6719232807;33616.83191584051;4338.566143385668;4371.978140109279;4413.987905792479;4471.597556219956;4597.494275629678;344766;346593;347798;348718.99999999744;349478;33902;35380.11549711227;61863;62263;62272;37267;37360.252794943946;37424.62575374266;37717.245655087296;37839.62160378416;13700.10949288313;13799.931000344934;13814.723705525834;13816.309184540733;13834.654133646538;12290.078244131726;12292.078094142975;12350.567730129402;12384.62846114618;12398.07014473918;8328.125546817619;8398.244158025807;8406.453580517247;8408.117147699526;8419;3196.8081915085168;3249.935001300008;3286.342731453719;3297.093299342652;3320.5351250824906;987.0820137272262;989.391524212604;1136.7442325476702;1161.8315344275202;1190.6666133482638;32529.186770330456;32737.67262327346;32794.836025820194;32955.352232388286;32964.67035329616;1072;1135.3585224348217;1137.8805225451374;1159.373938073431;1193.5762804204383;16293.918530407273;16617.41839035628;16887.66224675524;16955.321787128625;17102.828971710373;590777;592142;600384;600770;602969;58183.41816581865;58530.414695853346;58565.121523177186;58659.70670146622;58748.706256468446;1296.9027322950817;1338.4846833968993;1343.5230493174781;1344.0591585889915;1352.5536572931105;29987.55018674678;30644.854860159576;31363.529547056354;31546;31792.841035795598;50667.23999139942;51317.48682513127;51364;51390.48609513857;51496.22755658593;479700;481282;482660;483001;486102;27686.44627107487;28855.278618034718;28882.71117288884;28944;28953.42093158083;47822.76088619535;48403.51596484131;48617.270740939624;48753.75623121862;49364.50635493599;41426.171476570904;42027.57972420237;42490.36264456098;42633.57366426296;43061.56938430575;40386.596134038286;41188.794056029525;42047.42596879177;42779.786101069294;45266.54733452755;35887.82056089703;40549;41511.58488415077;41754.79122604368;42165.367519486615;33283.667163329024;37994.81002594969;38102.61897381102;38521.61478385292;38624.80687596544;28620.284492887844;28745.712542874302;28845.27886802847;29370.853145734134;29381.85309073441 11:27:52 INFO - PROCESS | 14645 | |2;jquery.html;376.51617671292394;379.2699054320433;398.986035488758;399.4567388351843;413.9896502587435;14054.064861838702;17664.558386040357;17770.82229177708;19247.230110795568;19353.806461935375;17367.218475168615;18249.81750182498;18408;18417.815821841778;18598.72101918469;5152.536271735543;5277.366715994086;5344.946550534483;5356.437574054727;5357.49103835137;5199.194124910645;5248.239005344223;5304.655197412175;5334.333208348957;5338.412774594792;5323.627346085776;5334.146536554133;5473.8357849264585;5794.565407594426;5805.3323867755325;5866.354700982888;5888.205092312526;5914.674692891889;5949.583529152961;5954.940450595482;5604.971975140139;5755;5770.307563092414;5783.5951483396175;5806;22588.66117008246;22792.202272920535;23179.3046208614;23193.304200874;23728;2380.155044959049;2408.494216214597;2577.4845030993874;2683.610876422908;2756.9310767230777;9831.262655300881;9995.850062249;10152.441615711134;10298.578081031994;10437.478126093665;1827.2549715022255;1879.9342023029128;1885.1422602715732;1907.8473722102337;2001.0095002973476;82112.58943705243;83356.16643833545;84988.57505712431;85610.14389856084;85703.57148214281;10593.84109238362;10745.570177192825;10809.83785243222;10910.127189824794;10941.890581094247;11675.416229188506;12396.132270740962;14768.926155369154;14843.257837108102;14947.850521494864;7428.405727541784;7549.320561149523;7671.578063206577;7868.960655196687;7873.763787086396;7668.463207575528;7832.490888092256;7861.842763144705;8005.759827205193;8026.277635012877;3859.7877116758286;4000.979995100006;4060.5330387005874;4062.5734297898293;4132.2561938850695;1887.5281179705073;1960.4314748722995;1981.2372236688977;2017.1427143463968;2020.9797902020791;409.8913787846223;450.37398016756737;1005.5073014222978;1006.8640733500883;1100.471773548701;10899.237053406345;11686;11714.297142171497;11747.17769756126;11868.821967670492;436.1669211805436;454.3956537804712;455.7561704488083;459.9793009314589;462.16348409379134;6096.085587161872;6165.290991535941;6209;6239.594426362272;6240.500759939194;429926;447684;467213.9917901234;470973;485844;95840;97129.51435242778;98314.5084274574;98606.50696746471;99357.50321248347;488.16280079663545;491.38822166402343;493.98024079037157;500.96743711658627;501.64633933077096;10703.464826758787;11366.431678416211;11376.488058037574;11439.771204576029;11441.256318339281;32052.5192122123;38872;40585.391219132325;42041;43879.34180987224;60889.39110608837;62441.68779156257;62718.68640656768;63124.368756313685;63129.68435157795;8813.559322033745;8814.427062240933;8816.162464565856;8929.821403571763;9104.863427048733;9468.526573671426;13709.794353084912;13869.583912482642;14271.286435678383;14326.212058336474;10862.302617536003;11057;11231.831522527005;12162.574309899112;12284.0786940978;11410.657680269605;11923.701907452383;11978.64064078079;12006.279623222634;12316.876831231573;12555.372231388577;12794.296313702836;12850;12867;13062.412191451218;7675.424343174396;8765.780855478664;8786.297096232414;8851.822963540822;8966.327525435488;12004.75990480203;12386.938065309616;12474.812877807022;12593.433295501542;12621.747565048465 11:27:52 INFO - PROCESS | 14645 | |3;mootools.html;1448.5437087317493;1457.4680241711776;1569.4036266218834;1701.3364787732778;1710.2731339180853;7929.563873986928;8937.285017198617;8977.730668079968;9530.380525265862;9533.332666713333;8988.505632190243;9226.67706630268;9296.628134874614;9310.86033709495;9358.672446464376;2342.3441436397793;2362.61016932206;2380.143148466551;2380.7738264864897;2390.3665528634924;2307.9653805192934;2324.5931961906686;2346.9530609387803;2352.176738141654;2363.2555744940373;2302.9078836846506;2310;2332.895019724108;2357.905683772647;2358.7169539655265;2253.256425379621;2287.9199228026937;2297.563462942044;2337.520808234308;2343.718753749544;2318.8492747971327;2342.7891489765834;2347.3310106619533;2351.2828587280874;2353.1058197884695;9417.246620270362;9466.337356385056;9469.242460603135;9513.476758778264;9522.85715714265;5126.589872810204;5136.64043516954;5240.895182096375;5266.131088370453;5289.153735402318;3325.2376240592525;3338.21551935295;3411.096059544223;3433.8283085845856;3512.5960514540643;1087.0977089016098;1104.729341311384;1111.5164903267105;1126.5043380912373;1144.0447226565743;12840.486380544768;12921.418536165802;12935.870641293655;12957.28734919579;12965.87034129656;4553.658475614342;4592.6555508337005;4670.089332580114;4675.696079754805;4678.8596342109795;10807.189460790472;10829.512671929782;10882.673519794418;10893.128549716004;10905.127589792955;5275.762590683428;5284.920726189111;5290.65610735301;5297.708626025606;5304.9734751326;4155.605217504332;4831.4685384607665;4835.709857408567;4946.9010619787405;4995.575376093;3865.555461121951;3924.5290565131795;3958.3072962231495;3982.38273067675;4019.4975628046495;1242.2981015726086;1262.6527704881232;1266.9429875655617;1276.7063575377715;1292.3796577642784;886.8182022685334;984.8818141823027;984.9409035457895;989.8614194012844;1006.6879267427121;6144.324124346318;6365.395287447777;6412.487001039905;6431.5819471734185;6516;412.7894773665452;421.70059257927215;424.41642741230805;431.5641202385613;447.74702293204234;4302.09655972243;4316.848910288125;4370.956290437055;4407.184670835905;4409.603135717736;11417.942910285396;11801.232919860182;11887.28676279426;11889.70275743096;11937.52249909994;10824.296420732628;11704.47329870158;11740.70648233801;11784.823227651592;11857.5849845255;7949.284564389232;8272.37957153204;8318.584070796436;8336.333093352518;8337.833243335099;6113.510919126548;6348.682565871595;6406.967965160145;6410.102585637921;6462.192225971754;10822.404767737535;10831.512581933674;10913.399763012792;10930.562777489129;10935.015848573667;10565.52455139536;10936.945315273373;11191.2725672831;11226.607068752555;11375.26060806078;7319.890201646873;7920.495105929855;8197.672093116209;8295.502269863828;8431.283340915845;9177.219936305222;9224.40041397307;9291.396059256127;9298.95350523243;9310.48792316402;7920.287174154123;7931.167227441036;7965.880511792212;8216.46592971455;8305.875411868707;8032.156623554442;8183.386246031452;8201.835963280582;8216.055153657406;8252.46358986688;7401.111866576045;7440.441966852616;7508.962455187689;7517.135529414188;7522.172561018174;5078.314427552233;5108.514691104339;5116.1814109743755;5175.301334319969;5194.532492075731;5088.109580823415;5104.897902041864;5130.7178105204575;5210.192420174879;5243.816466423809 11:27:52 INFO - PROCESS | 14645 | |4;prototype.html;294.8260526289489;300.6122102487791;300.94883869742154;311.3337457840221;314.7560640503609;5417.6478528895595;5596.720163991794;5602.635828671138;5707.629004114735;5762.683052432119;5492.505674489295;5530.175042236063;5613.361719991597;5621.241132447119;5626.859328516779;4327.805248763805;4343.827166664999;4357.12857428514;4360.389545463638;4372.038151606642;4343.19650864591;4345.6523478121835;4353.912921741563;4365.170617582665;4417.249067658489;4301.376160542067;4336.501302350239;4350.695451318409;4365.36702178184;4374.343848422746;4320.762358070305;4342.32693932441;4352.847650332224;4406.801693923781;4413.4041904342985;3670.541182352206;3781.867634632802;3816.217675376569;3816.427535869614;3819.5416550013897;5421.159720243369;5475.890482190334;5491.148871924858;5496.780128794843;5513.917291240635;4944.901101977976;4975.4527002029745;5013.222950442687;5013.395713371722;5016.54851063406;5672.359946802974;5845.766169353221;5874.5006674432725;5879.617824841414;5938.7624495020145;4136.855210067663;4145.854895078688;4151.543330233671;4165.229432554987;4180.1816209948465;6141.385861413867;6146.29317628474;6171.475424588871;6180.87638247237;6195.101710252034;3888.3389823730035;4120.464339635828;4140.523839758406;4271.1671224111;4316.223079845595;4144.461220041375;4171.541130475645;4178.540360560336;4181.456410666594;4195.748255104642;4775.403074615673;4818.578519336804;4835;4872.342233798463;4873.731944743002;5900.76396944126;5904.704764761745;5970.955082860482;5974.641521508724;6007.429294217042;1432.3268064009899;1446.002258441672;1448.341004842794;1450.3038541500139;1453.9636509087145;871.289898732531;885.6413152673049;888.3248730964514;904.8009437923646;907.9409838360617;4942.728149951788;4960.801567937314;5041.420236672756;5082.856357319647;5154.407243167084;5410.862709229832;5455.61810673257;5458.972705136449;5468.48049435303;5475.67145971243;4725.976370118127;5013.974930125326;5028.645122888846;5096.261042148868;5104.464031276737;2805.621241132462;2841.943161136766;2865.8710358033936;2867.9426411471654;2877.812942158753;5425.131978883439;5444.509994100471;5533.253010843485;5535.169724541351;5597.552195824324;5394.811181608703;5683.460071293221;6168.938310616926;6193.411625895533;6205.596636218631;6281.842953926189;6299.874002520016;6323.494120470444;6336.873262534724;6358.393058845851;5889.823305300848;6101.688137050555;6111.633302001894;6144.078388241799;6209.285932117684;5999.790007349722;6028.2766068072115;6038.678726700209;6038.818835434944;6081.027035674271;5699.544036477155;6320.841978950563;6345.206849143857;6354;6374.808755737336;4234.724742891703;4249.893752656085;4282.743035417885;4290.069468739142;4294.3558466230315;5992.250968628921;6035.305939816802;6044.576879618385;6057.727402266997;6060.424259695322;5733.254676891977;5861.9706901465215;5863.149843272617;5868.063539032024;5911.467967882912;5796.739146738322;5826.650400975955;5836.774277401793;5868.2077919480325;5868.413158684098;5743;5754.68349240779;5763.682997435181;5773.336066352424;5794;5665.376808550974;5887.940170769302;5907.734151963086;5919.720907450576;5920.809300558821;5758.424157584208;5790.565707571865;5794.681292528951;5795.797147099831;5859.091840764689 11:27:52 INFO - PROCESS | 14645 | |5;yui.html;644.3717375558828;665.657186548927;737.3511310047157;771.2595907928388;831.9126491718371;14375.353109110089;15392.846071539281;15441.150736709476;15441.227938603068;15442.69114617707;14251.78622320666;14737.484188053393;14881.18153501557;15001.549953501413;15020.17389043602;778.9883151752714;792.9088154862206;794.4637369775407;794.6940427935228;798.8322452285028;762.1958833430729;789.1713700614332;789.8775689768095;793.115676021235;800.0599295827409;832.1886160993043;835.0897521701374;835.9247667709905;838.337713206566;841;822.2106777493583;826.6404114210337;829.5976451421056;830.0371568979954;833.2625626320689;607.5929127484596;608.0817964873073;608.3551435478407;610.8350745298789;612.996935015322;15602;15726.842731572766;15753.842461575467;15782.842171578252;15783.684326313525;14619.12285262877;14842.480513181987;14857.257137143208;14862.182579958098;14961.925190373979;12386.380680965916;12491.687707807287;12500.437480313407;12520.499180032788;12559.120861539695;3850.306944749944;4001.419794129864;4028.637422631977;4058.5738497457933;4059.817308221137;79510.20489795085;79610.60194699047;79871.60064199699;80260;80771.5961420195;11262.324260544394;11377.203595748384;11517;11725.944664980192;12158.148929574845;21301.573968520854;21383.144674213167;21403.14387424517;21423.67864482034;21504.247351342627;8235.8352832943;8414;8791.120887911286;8822.647094116292;8851.380403371702;4142.896427589334;4270.530241673413;4314.266574682311;4436.157130145262;4445.466544014739;3555.5377800886235;3651.8539258429896;3670.7614005089586;3673.7061035117126;3680.411134218512;617.9814605561751;633.33183491417;637.5186734015789;641.7433026789322;651.4039653716891;638.479639094146;661.5435349608755;705.6013352455846;714.5962531169872;770.1643716567474;9563.61745530185;9971.952944940676;10050.648227312155;10151.593936242467;10183.796324073477;587.4712758517369;607.9240094988127;707.1478867964194;735.9337659610661;747.1184002876549;4549.522300158502;4809.95190048102;4822.614190864792;4910.975445122752;4913.582345500672;113816.43091784487;117695;118400;118646.40676796561;119122;99600.50199748955;99910.50044749875;100218;102235.4888225569;102876.48561757144;85828;89744.5512772432;90634.54682726544;91465;93514.53242733743;9316.720498385059;9482.478463684563;9487.66793162236;9491.003444638214;9519.714408567754;51423;51791;52139.217911732114;52437;53032.55288406241;66320;67179.32820671731;69348.65325673542;74267.1433214174;78297;13372.465101395836;13682.31588420555;13698.863011369758;14007;14283.28583570838;15162.620934476727;15226.889087478812;15538.223088845738;15587.688246235239;15631.452899148475;14301.661500433183;14350.49773257931;14566.198859062853;14937.925310373379;15438;13480.73038539204;13854.783234682402;14230.430782768573;14699.706005880036;14788.556343309718;14026.438942442188;14302.642433939234;14464.13215207091;14482.855171448573;14769.92615036918;11377.317360958368;11471.655850324503;11497.338209540321;11554.711132221762;11865.466054027416;12014.63956081319;12061.396930153633;12099.076239939584;12340.259584424963;12464.75070498603 11:27:52 INFO - PROCESS | 14645 | __end_tp_report 11:27:52 INFO - PROCESS | 14645 | __start_cc_report 11:27:52 INFO - PROCESS | 14645 | _x_x_mozilla_cycle_collect,364 11:27:52 INFO - PROCESS | 14645 | __end_cc_report 11:27:52 INFO - PROCESS | 14645 | __startTimestamp1466620072331__endTimestamp 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | ------- Summary: start ------- 11:27:52 INFO - PROCESS | 14645 | Number of tests: 6 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | [#0] dojo.html Cycles:165 Average:5460.65 Median:5689.29 stddev:737.72 (13.0%) stddev-sans-first:716.27 11:27:52 INFO - PROCESS | 14645 | Values: 3095.0 3152.1 3163.8 3187.8 3190.5 5432.5 5450.1 5484.9 5497.3 5523.4 5311.3 5423.8 5433.0 5507.3 5607.6 4923.1 4981.1 5025.1 5058.3 5111.2 716.7 4809.3 4927.7 4981.7 5097.2 5023.3 5027.8 5044.4 5065.1 5080.6 5082.4 5083.1 5095.5 5097.8 5112.1 4840.4 4917.7 4921.0 4963.7 4969.5 5433.8 5459.3 5462.6 5466.2 5492.9 5600.2 5810.7 5837.9 5843.4 5892.5 5892.0 5956.3 5970.9 6029.2 6055.4 5593.7 5639.6 5640.1 5643.5 5645.1 5811.5 6018.2 6098.2 6139.3 6144.7 5818.2 5909.6 5911.8 5914.3 5967.5 5978.9 5989.8 5993.6 5994.2 5999.3 5629.3 5881.5 5889.5 5961.1 5979.8 5921.6 5976.3 5977.5 5987.2 6038.1 4505.3 4515.8 4518.8 4520.5 4559.1 3915.9 3978.0 4014.9 4030.7 4033.0 5450.2 5503.1 5544.3 5586.7 5639.3 5908.3 5913.9 5922.1 5929.3 5945.7 5328.9 5571.0 5598.1 5618.4 5625.9 5081.0 5084.5 5095.4 5095.9 5121.6 6120.0 6126.9 6138.3 6143.4 6145.2 5787.3 5843.8 5869.7 5910.1 5979.1 6123.4 6131.2 6144.2 6165.1 6194.3 5633.9 5788.1 5837.3 5853.2 5853.8 5872.4 5915.3 5932.2 5961.2 5975.6 5827.6 5836.8 5842.5 5842.6 5845.4 5584.0 5777.0 5787.7 5787.7 5805.4 5641.9 5689.8 5721.7 5725.5 5758.3 5763.5 5801.6 5811.0 5811.4 5812.4 5489.1 5669.7 5675.5 5689.3 5695.7 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | [#1] ext.html Cycles:180 Average:61874.51 Median:41468.88 stddev:129794.63 (313.0%) stddev-sans-first:130077.14 11:27:52 INFO - PROCESS | 14645 | Values: 578.0 619.8 623.0 640.5 642.8 38821.0 43140.8 43199.1 43615.0 43648.0 42014.8 42792.4 42883.6 43059.1 43137.4 8700.8 8903.4 8933.2 8935.2 8935.2 8727.3 8793.6 8850.5 8859.8 8886.4 8925.0 8943.2 8944.6 8979.6 9001.4 8812.6 8885.8 8890.9 8893.3 8908.3 8830.6 8846.9 8901.7 8926.6 8946.2 40407.4 41040.4 41142.6 41164.0 41248.2 2958.6 3268.9 3363.3 3567.8 3573.3 30293.7 31437.5 31441.8 32807.7 33616.8 4338.6 4372.0 4414.0 4471.6 4597.5 344766.0 346593.0 347798.0 348719.0 349478.0 33902.0 35380.1 61863.0 62263.0 62272.0 37267.0 37360.3 37424.6 37717.2 37839.6 13700.1 13799.9 13814.7 13816.3 13834.7 12290.1 12292.1 12350.6 12384.6 12398.1 8328.1 8398.2 8406.5 8408.1 8419.0 3196.8 3249.9 3286.3 3297.1 3320.5 987.1 989.4 1136.7 1161.8 1190.7 32529.2 32737.7 32794.8 32955.4 32964.7 1072.0 1135.4 1137.9 1159.4 1193.6 16293.9 16617.4 16887.7 16955.3 17102.8 590777.0 592142.0 600384.0 600770.0 602969.0 58183.4 58530.4 58565.1 58659.7 58748.7 1296.9 1338.5 1343.5 1344.1 1352.6 29987.6 30644.9 31363.5 31546.0 31792.8 50667.2 51317.5 51364.0 51390.5 51496.2 479700.0 481282.0 482660.0 483001.0 486102.0 27686.4 28855.3 28882.7 28944.0 28953.4 47822.8 48403.5 48617.3 48753.8 49364.5 41426.2 42027.6 42490.4 42633.6 43061.6 40386.6 41188.8 42047.4 42779.8 45266.5 35887.8 40549.0 41511.6 41754.8 42165.4 33283.7 37994.8 38102.6 38521.6 38624.8 28620.3 28745.7 28845.3 29370.9 29381.9 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | [#2] jquery.html Cycles:180 Average:27843.71 Median:2236.23 stddev:76527.77 (3422.2%) stddev-sans-first:76714.66 11:27:52 INFO - PROCESS | 14645 | Values: 376.5 379.3 399.0 399.5 414.0 14054.1 17664.6 17770.8 19247.2 19353.8 17367.2 18249.8 18408.0 18417.8 18598.7 5152.5 5277.4 5344.9 5356.4 5357.5 5199.2 5248.2 5304.7 5334.3 5338.4 5323.6 5334.1 5473.8 5794.6 5805.3 5866.4 5888.2 5914.7 5949.6 5954.9 5605.0 5755.0 5770.3 5783.6 5806.0 22588.7 22792.2 23179.3 23193.3 23728.0 2380.2 2408.5 2577.5 2683.6 2756.9 9831.3 9995.9 10152.4 10298.6 10437.5 1827.3 1879.9 1885.1 1907.8 2001.0 82112.6 83356.2 84988.6 85610.1 85703.6 10593.8 10745.6 10809.8 10910.1 10941.9 11675.4 12396.1 14768.9 14843.3 14947.9 7428.4 7549.3 7671.6 7869.0 7873.8 7668.5 7832.5 7861.8 8005.8 8026.3 3859.8 4001.0 4060.5 4062.6 4132.3 1887.5 1960.4 1981.2 2017.1 2021.0 409.9 450.4 1005.5 1006.9 1100.5 10899.2 11686.0 11714.3 11747.2 11868.8 436.2 454.4 455.8 460.0 462.2 6096.1 6165.3 6209.0 6239.6 6240.5 429926.0 447684.0 467214.0 470973.0 485844.0 95840.0 97129.5 98314.5 98606.5 99357.5 488.2 491.4 494.0 501.0 501.6 10703.5 11366.4 11376.5 11439.8 11441.3 32052.5 38872.0 40585.4 42041.0 43879.3 60889.4 62441.7 62718.7 63124.4 63129.7 8813.6 8814.4 8816.2 8929.8 9104.9 9468.5 13709.8 13869.6 14271.3 14326.2 10862.3 11057.0 11231.8 12162.6 12284.1 11410.7 11923.7 11978.6 12006.3 12316.9 12555.4 12794.3 12850.0 12867.0 13062.4 7675.4 8765.8 8786.3 8851.8 8966.3 12004.8 12386.9 12474.8 12593.4 12621.7 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | [#3] mootools.html Cycles:180 Average:6047.88 Median:2428.68 stddev:3577.60 (147.3%) stddev-sans-first:3570.94 11:27:52 INFO - PROCESS | 14645 | Values: 1448.5 1457.5 1569.4 1701.3 1710.3 7929.6 8937.3 8977.7 9530.4 9533.3 8988.5 9226.7 9296.6 9310.9 9358.7 2342.3 2362.6 2380.1 2380.8 2390.4 2308.0 2324.6 2347.0 2352.2 2363.3 2302.9 2310.0 2332.9 2357.9 2358.7 2253.3 2287.9 2297.6 2337.5 2343.7 2318.8 2342.8 2347.3 2351.3 2353.1 9417.2 9466.3 9469.2 9513.5 9522.9 5126.6 5136.6 5240.9 5266.1 5289.2 3325.2 3338.2 3411.1 3433.8 3512.6 1087.1 1104.7 1111.5 1126.5 1144.0 12840.5 12921.4 12935.9 12957.3 12965.9 4553.7 4592.7 4670.1 4675.7 4678.9 10807.2 10829.5 10882.7 10893.1 10905.1 5275.8 5284.9 5290.7 5297.7 5305.0 4155.6 4831.5 4835.7 4946.9 4995.6 3865.6 3924.5 3958.3 3982.4 4019.5 1242.3 1262.7 1266.9 1276.7 1292.4 886.8 984.9 984.9 989.9 1006.7 6144.3 6365.4 6412.5 6431.6 6516.0 412.8 421.7 424.4 431.6 447.7 4302.1 4316.8 4371.0 4407.2 4409.6 11417.9 11801.2 11887.3 11889.7 11937.5 10824.3 11704.5 11740.7 11784.8 11857.6 7949.3 8272.4 8318.6 8336.3 8337.8 6113.5 6348.7 6407.0 6410.1 6462.2 10822.4 10831.5 10913.4 10930.6 10935.0 10565.5 10936.9 11191.3 11226.6 11375.3 7319.9 7920.5 8197.7 8295.5 8431.3 9177.2 9224.4 9291.4 9299.0 9310.5 7920.3 7931.2 7965.9 8216.5 8305.9 8032.2 8183.4 8201.8 8216.1 8252.5 7401.1 7440.4 7509.0 7517.1 7522.2 5078.3 5108.5 5116.2 5175.3 5194.5 5088.1 5104.9 5130.7 5210.2 5243.8 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | [#4] prototype.html Cycles:180 Average:4851.52 Median:5483.52 stddev:1463.75 (26.7%) stddev-sans-first:1427.34 11:27:52 INFO - PROCESS | 14645 | Values: 294.8 300.6 300.9 311.3 314.8 5417.6 5596.7 5602.6 5707.6 5762.7 5492.5 5530.2 5613.4 5621.2 5626.9 4327.8 4343.8 4357.1 4360.4 4372.0 4343.2 4345.7 4353.9 4365.2 4417.2 4301.4 4336.5 4350.7 4365.4 4374.3 4320.8 4342.3 4352.8 4406.8 4413.4 3670.5 3781.9 3816.2 3816.4 3819.5 5421.2 5475.9 5491.1 5496.8 5513.9 4944.9 4975.5 5013.2 5013.4 5016.5 5672.4 5845.8 5874.5 5879.6 5938.8 4136.9 4145.9 4151.5 4165.2 4180.2 6141.4 6146.3 6171.5 6180.9 6195.1 3888.3 4120.5 4140.5 4271.2 4316.2 4144.5 4171.5 4178.5 4181.5 4195.7 4775.4 4818.6 4835.0 4872.3 4873.7 5900.8 5904.7 5971.0 5974.6 6007.4 1432.3 1446.0 1448.3 1450.3 1454.0 871.3 885.6 888.3 904.8 907.9 4942.7 4960.8 5041.4 5082.9 5154.4 5410.9 5455.6 5459.0 5468.5 5475.7 4726.0 5014.0 5028.6 5096.3 5104.5 2805.6 2841.9 2865.9 2867.9 2877.8 5425.1 5444.5 5533.3 5535.2 5597.6 5394.8 5683.5 6168.9 6193.4 6205.6 6281.8 6299.9 6323.5 6336.9 6358.4 5889.8 6101.7 6111.6 6144.1 6209.3 5999.8 6028.3 6038.7 6038.8 6081.0 5699.5 6320.8 6345.2 6354.0 6374.8 4234.7 4249.9 4282.7 4290.1 4294.4 5992.3 6035.3 6044.6 6057.7 6060.4 5733.3 5862.0 5863.1 5868.1 5911.5 5796.7 5826.7 5836.8 5868.2 5868.4 5743.0 5754.7 5763.7 5773.3 5794.0 5665.4 5887.9 5907.7 5919.7 5920.8 5758.4 5790.6 5794.7 5795.8 5859.1 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - PROCESS | 14645 | [#5] yui.html Cycles:180 Average:21272.48 Median:4101.36 stddev:30550.38 (744.9%) stddev-sans-first:30596.82 11:27:52 INFO - PROCESS | 14645 | Values: 644.4 665.7 737.4 771.3 831.9 14375.4 15392.8 15441.2 15441.2 15442.7 14251.8 14737.5 14881.2 15001.5 15020.2 779.0 792.9 794.5 794.7 798.8 762.2 789.2 789.9 793.1 800.1 832.2 835.1 835.9 838.3 841.0 822.2 826.6 829.6 830.0 833.3 607.6 608.1 608.4 610.8 613.0 15602.0 15726.8 15753.8 15782.8 15783.7 14619.1 14842.5 14857.3 14862.2 14961.9 12386.4 12491.7 12500.4 12520.5 12559.1 3850.3 4001.4 4028.6 4058.6 4059.8 79510.2 79610.6 79871.6 80260.0 80771.6 11262.3 11377.2 11517.0 11725.9 12158.1 21301.6 21383.1 21403.1 21423.7 21504.2 8235.8 8414.0 8791.1 8822.6 8851.4 4142.9 4270.5 4314.3 4436.2 4445.5 3555.5 3651.9 3670.8 3673.7 3680.4 618.0 633.3 637.5 641.7 651.4 638.5 661.5 705.6 714.6 770.2 9563.6 9972.0 10050.6 10151.6 10183.8 587.5 607.9 707.1 735.9 747.1 4549.5 4810.0 4822.6 4911.0 4913.6 113816.4 117695.0 118400.0 118646.4 119122.0 99600.5 99910.5 100218.0 102235.5 102876.5 85828.0 89744.6 90634.5 91465.0 93514.5 9316.7 9482.5 9487.7 9491.0 9519.7 51423.0 51791.0 52139.2 52437.0 53032.6 66320.0 67179.3 69348.7 74267.1 78297.0 13372.5 13682.3 13698.9 14007.0 14283.3 15162.6 15226.9 15538.2 15587.7 15631.5 14301.7 14350.5 14566.2 14937.9 15438.0 13480.7 13854.8 14230.4 14699.7 14788.6 14026.4 14302.6 14464.1 14482.9 14769.9 11377.3 11471.7 11497.3 11554.7 11865.5 12014.6 12061.4 12099.1 12340.3 12464.8 11:27:52 INFO - PROCESS | 14645 | -------- Summary: end -------- 11:27:52 INFO - PROCESS | 14645 | 11:27:52 INFO - TEST-INFO | 14645: exit 0 11:27:53 INFO - TEST-OK | dromaeo_css | took 1111084ms 11:27:53 INFO - TEST-START | kraken 11:27:53 INFO - operating with platform_type : linux_ 11:27:53 INFO - Initialising browser for kraken test... 11:27:53 INFO - TEST-INFO | started process 14886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvpJ61D/profile http://localhost:45852/getInfo.html) 11:27:57 INFO - PROCESS | 14886 | __metrics Screen width/height:1600/1200 11:27:57 INFO - PROCESS | 14886 | colorDepth:24 11:27:57 INFO - PROCESS | 14886 | Browser inner width/height: 1024/697 11:27:57 INFO - PROCESS | 14886 | __metrics 11:27:58 ERROR - PROCESS | 14886 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:27:59 INFO - TEST-INFO | 14886: exit 0 11:27:59 INFO - Browser initialized. 11:27:59 INFO - Running cycle 1/1 for kraken test... 11:27:59 INFO - TEST-INFO | started process 15004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvpJ61D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:11 INFO - PROCESS | 15004 | RSS: Main: 185098240 11:28:11 INFO - PROCESS | 15004 | 11:28:13 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:14 INFO - PROCESS | 15004 | RSS: Main: 191172608 11:28:14 INFO - PROCESS | 15004 | 11:28:17 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-dft) 11:28:17 INFO - PROCESS | 15004 | RSS: Main: 190529536 11:28:17 INFO - PROCESS | 15004 | 11:28:20 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-fft) 11:28:21 INFO - PROCESS | 15004 | RSS: Main: 185638912 11:28:21 INFO - PROCESS | 15004 | 11:28:23 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-oscillator) 11:28:24 INFO - PROCESS | 15004 | RSS: Main: 186413056 11:28:24 INFO - PROCESS | 15004 | 11:28:26 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:27 INFO - PROCESS | 15004 | RSS: Main: 186658816 11:28:27 INFO - PROCESS | 15004 | 11:28:30 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:31 INFO - PROCESS | 15004 | RSS: Main: 186892288 11:28:31 INFO - PROCESS | 15004 | 11:28:34 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-desaturate) 11:28:35 INFO - PROCESS | 15004 | RSS: Main: 184020992 11:28:35 INFO - PROCESS | 15004 | 11:28:38 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45852/tests/kraken/driver.html?testName=json-parse-financial) 11:28:38 INFO - PROCESS | 15004 | RSS: Main: 185335808 11:28:38 INFO - PROCESS | 15004 | 11:28:40 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45852/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:28:40 INFO - PROCESS | 15004 | RSS: Main: 185794560 11:28:40 INFO - PROCESS | 15004 | 11:28:42 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:28:43 INFO - PROCESS | 15004 | RSS: Main: 186171392 11:28:43 INFO - PROCESS | 15004 | 11:28:45 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:28:45 INFO - PROCESS | 15004 | RSS: Main: 186908672 11:28:45 INFO - PROCESS | 15004 | 11:28:48 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:28:49 INFO - PROCESS | 15004 | RSS: Main: 187035648 11:28:49 INFO - PROCESS | 15004 | 11:28:51 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:28:52 INFO - PROCESS | 15004 | RSS: Main: 186691584 11:28:52 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45852/tests/kraken/driver.html?testName=ai-astar) 11:28:54 INFO - PROCESS | 15004 | RSS: Main: 187772928 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | __start_tp_report 11:28:54 INFO - PROCESS | 15004 | _x_x_mozilla_page_load 11:28:54 INFO - PROCESS | 15004 | _x_x_mozilla_page_load_details 11:28:54 INFO - PROCESS | 15004 | |i|pagename|runs| 11:28:54 INFO - PROCESS | 15004 | |0;ai-astar;101;110;104;108;110;109;110;111;109;110 11:28:54 INFO - PROCESS | 15004 | |1;audio-beat-detection;164;126;152;187;127;162;154;126;183;132 11:28:54 INFO - PROCESS | 15004 | |2;audio-dft;163;164;161;162;164;167;163;164;164;164 11:28:54 INFO - PROCESS | 15004 | |3;audio-fft;74;76;74;169;75;76;76;73;172;74 11:28:54 INFO - PROCESS | 15004 | |4;audio-oscillator;85;85;155;86;88;86;142;85;86;137 11:28:54 INFO - PROCESS | 15004 | |5;imaging-gaussian-blur;117;117;118;117;117;118;118;117;118;118 11:28:54 INFO - PROCESS | 15004 | |6;imaging-darkroom;149;148;147;147;147;150;148;147;149;149 11:28:54 INFO - PROCESS | 15004 | |7;imaging-desaturate;95;95;95;96;95;95;96;96;96;96 11:28:54 INFO - PROCESS | 15004 | |8;json-parse-financial;56;56;53;53;54;53;53;53;53;55 11:28:54 INFO - PROCESS | 15004 | |9;json-stringify-tinderbox;63;62;61;62;63;62;61;62;62;62 11:28:54 INFO - PROCESS | 15004 | |10;stanford-crypto-aes;79;81;81;81;80;82;89;85;89;79 11:28:54 INFO - PROCESS | 15004 | |11;stanford-crypto-ccm;126;130;126;120;130;143;122;134;128;122 11:28:54 INFO - PROCESS | 15004 | |12;stanford-crypto-pbkdf2;157;165;163;162;161;159;167;161;163;161 11:28:54 INFO - PROCESS | 15004 | |13;stanford-crypto-sha256-iterative;65;63;64;64;62;63;68;64;65;64 11:28:54 INFO - PROCESS | 15004 | __end_tp_report 11:28:54 INFO - PROCESS | 15004 | __start_cc_report 11:28:54 INFO - PROCESS | 15004 | _x_x_mozilla_cycle_collect,934 11:28:54 INFO - PROCESS | 15004 | __end_cc_report 11:28:54 INFO - PROCESS | 15004 | __startTimestamp1466620134499__endTimestamp 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | ------- Summary: start ------- 11:28:54 INFO - PROCESS | 15004 | Number of tests: 14 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.19 (2.9%) stddev-sans-first:2.06 11:28:54 INFO - PROCESS | 15004 | Values: 101.0 110.0 104.0 108.0 110.0 109.0 110.0 111.0 109.0 110.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:158.00 stddev:23.11 (14.6%) stddev-sans-first:24.05 11:28:54 INFO - PROCESS | 15004 | Values: 164.0 126.0 152.0 187.0 127.0 162.0 154.0 126.0 183.0 132.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.58 (1.0%) stddev-sans-first:1.66 11:28:54 INFO - PROCESS | 15004 | Values: 163.0 164.0 161.0 162.0 164.0 167.0 163.0 164.0 164.0 164.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#3] audio-fft Cycles:10 Average:93.90 Median:74.50 stddev:40.39 (54.2%) stddev-sans-first:42.19 11:28:54 INFO - PROCESS | 15004 | Values: 74.0 76.0 74.0 169.0 75.0 76.0 76.0 73.0 172.0 74.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.50 stddev:28.76 (33.6%) stddev-sans-first:29.71 11:28:54 INFO - PROCESS | 15004 | Values: 85.0 85.0 155.0 86.0 88.0 86.0 142.0 85.0 86.0 137.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:28:54 INFO - PROCESS | 15004 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 11:28:54 INFO - PROCESS | 15004 | Values: 149.0 148.0 147.0 147.0 147.0 150.0 148.0 147.0 149.0 149.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:28:54 INFO - PROCESS | 15004 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.50 stddev:1.29 (2.4%) stddev-sans-first:1.12 11:28:54 INFO - PROCESS | 15004 | Values: 56.0 56.0 53.0 53.0 54.0 53.0 53.0 53.0 53.0 55.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 11:28:54 INFO - PROCESS | 15004 | Values: 63.0 62.0 61.0 62.0 63.0 62.0 61.0 62.0 62.0 62.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:81.50 stddev:3.78 (4.6%) stddev-sans-first:3.77 11:28:54 INFO - PROCESS | 15004 | Values: 79.0 81.0 81.0 81.0 80.0 82.0 89.0 85.0 89.0 79.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:129.00 stddev:6.77 (5.3%) stddev-sans-first:7.14 11:28:54 INFO - PROCESS | 15004 | Values: 126.0 130.0 126.0 120.0 130.0 143.0 122.0 134.0 128.0 122.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.50 stddev:2.85 (1.8%) stddev-sans-first:2.40 11:28:54 INFO - PROCESS | 15004 | Values: 157.0 165.0 163.0 162.0 161.0 159.0 167.0 161.0 163.0 161.0 11:28:54 INFO - PROCESS | 15004 | 11:28:54 INFO - PROCESS | 15004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.62 (2.5%) stddev-sans-first:1.69 11:28:54 INFO - PROCESS | 15004 | Values: 65.0 63.0 64.0 64.0 62.0 63.0 68.0 64.0 65.0 64.0 11:28:54 INFO - PROCESS | 15004 | -------- Summary: end -------- 11:28:54 INFO - PROCESS | 15004 | 11:28:55 INFO - TEST-INFO | 15004: exit 0 11:28:55 INFO - TEST-OK | kraken | took 62494ms 11:28:55 INFO - SUITE-END | took 1173s 11:28:55 INFO - Completed test suite (00:19:33) 11:28:55 INFO - javascript benchmark 11:28:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7156.758272422517, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.040537433396, 3152.1331633800687, 3163.841807909604, 3187.8406079696024, 3190.5214217867333, 5432.538234250089, 5450.127979523277, 5484.9177262341045, 5497.285352904117, 5523.420040895709, 5311.256424100629, 5423.755930983105, 5432.972835135829, 5507.311586051744, 5607.635503692268, 4923.13845077111, 4981.1283025470575, 5025.120603894322, 5058.291839142523, 5111.207762796773, 716.7032089801139, 4809.254565542329, 4927.679700819435, 4981.72600506972, 5097.23541468779, 5023.296738456619, 5027.798888044474, 5044.419891712463, 5065.138926382506, 5080.568151707109, 5082.364704411949, 5083.135866902636, 5095.5159259870625, 5097.770600322957, 5112.079825631385, 4840.370751802278, 4917.72952487613, 4921.0, 4963.726995015273, 4969.503049695038, 5433.782648694048, 5459.2902922619805, 5462.590305727086, 5466.234727138204, 5492.862678433071, 5600.18797274397, 5810.651360918316, 5837.9124313135335, 5843.444872737083, 5892.528597712173, 5892.0, 5956.315023772278, 5970.880582388328, 6029.216201893726, 6055.364186760371, 5593.74828132735, 5639.6334238274385, 5640.0693885508845, 5643.548516118742, 5645.125005624135, 5811.476967072984, 6018.247719035121, 6098.237720284965, 6139.263288405331, 6144.692765361714, 5818.185454036438, 5909.6158749681135, 5911.76352945886, 5914.349421563625, 5967.522598192134, 5978.940210597925, 5989.760409583568, 5993.550483713739, 5994.22075130239, 5999.280086389661, 5629.268195134607, 5881.5000724938, 5889.469947704727, 5961.135635332853, 5979.760809567656, 5921.644701317935, 5976.252968378953, 5977.521798256129, 5987.161797348374, 6038.064100064497, 4505.256632655575, 4515.75163366018, 4518.751468669189, 4520.547945205519, 4559.065391594781, 3915.941260881089, 3978.0, 4014.9397759033636, 4030.6976976726864, 4033.032072302626, 5450.236966824647, 5503.064479038573, 5544.279243698374, 5586.692731899703, 5639.2668953035845, 5908.3205431375945, 5913.9112913306335, 5922.1412895130825, 5929.347771745104, 5945.732442040118, 5328.893422131613, 5571.0, 5598.076317407664, 5618.438156184349, 5625.887482250332, 5081.0, 5084.49155084496, 5095.363079615048, 5095.949040509621, 5121.615878809104, 6119.969400152971, 6126.908096378558, 6138.294096178996, 6143.447089761943, 6145.20112385396, 5787.276590426281, 5843.766249349978, 5869.6771677556435, 5910.083936989773, 5979.073243647242, 6123.387661234019, 6131.233595800525, 6144.2319710036245, 6165.106059621419, 6194.349593292639, 5633.943660563506, 5788.131780232999, 5837.29952405714, 5853.180554722428, 5853.824385268449, 5872.442117998783, 5915.349311575809, 5932.199153114274, 5961.165436838933, 5975.611585246945, 5827.621204621686, 5836.795712150054, 5842.503387212135, 5842.561807864342, 5845.444682755132, 5583.972080139573, 5777.046787280052, 5787.739551720267, 5787.739551720267, 5805.448482394166, 5641.915371269516, 5689.800856969986, 5721.685307308138, 5725.541956643542, 5758.2514273144225, 5763.51010164124, 5801.593888427769, 5810.970945145416, 5811.418858114154, 5812.360640329645, 5489.094299440707, 5669.688167150846, 5675.460831221028, 5689.288838895138, 5695.658260504383], "value": 5411.292934725981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.0144853025591, 619.7861737700493, 622.9719662615182, 640.4908098062042, 642.8007317731507, 38821.02947426312, 43140.78429607848, 43199.136017279634, 43615.0, 43648.0, 42014.789926050325, 42792.3581146283, 42883.57116428835, 43059.0623421946, 43137.35293970585, 8700.825983480343, 8903.37676362655, 8933.240674542672, 8935.240504557089, 8935.240504557121, 8727.301815854747, 8793.604287807031, 8850.468971861677, 8859.778505537348, 8886.422382545146, 8924.955375223115, 8943.239824614915, 8944.642214311452, 8979.595918183697, 9001.369904106716, 8812.603432845537, 8885.777855553599, 8890.86663700045, 8893.288536917064, 8908.331875109392, 8830.602622881986, 8846.867296990551, 8901.688440904538, 8926.553672316359, 8946.150115738994, 40407.39388909169, 41040.38439423411, 41142.588574114176, 41164.0, 41248.1750364991, 2958.60058892049, 3268.9375952815194, 3363.3441478911623, 3567.7680950738118, 3573.2674801665858, 30293.697063029307, 31437.528437073463, 31441.8427907859, 32807.6719232807, 33616.83191584051, 4338.566143385668, 4371.978140109279, 4413.987905792479, 4471.597556219956, 4597.494275629678, 344766.0, 346593.0, 347798.0, 348718.99999999744, 349478.0, 33902.0, 35380.11549711227, 61863.0, 62263.0, 62272.0, 37267.0, 37360.252794943946, 37424.62575374266, 37717.245655087296, 37839.62160378416, 13700.10949288313, 13799.931000344934, 13814.723705525834, 13816.309184540733, 13834.654133646538, 12290.078244131726, 12292.078094142975, 12350.567730129402, 12384.62846114618, 12398.07014473918, 8328.125546817619, 8398.244158025807, 8406.453580517247, 8408.117147699526, 8419.0, 3196.8081915085168, 3249.935001300008, 3286.342731453719, 3297.093299342652, 3320.5351250824906, 987.0820137272262, 989.391524212604, 1136.7442325476702, 1161.8315344275202, 1190.6666133482638, 32529.186770330456, 32737.67262327346, 32794.836025820194, 32955.352232388286, 32964.67035329616, 1072.0, 1135.3585224348217, 1137.8805225451374, 1159.373938073431, 1193.5762804204383, 16293.918530407273, 16617.41839035628, 16887.66224675524, 16955.321787128625, 17102.828971710373, 590777.0, 592142.0, 600384.0, 600770.0, 602969.0, 58183.41816581865, 58530.414695853346, 58565.121523177186, 58659.70670146622, 58748.706256468446, 1296.9027322950817, 1338.4846833968993, 1343.5230493174781, 1344.0591585889915, 1352.5536572931105, 29987.55018674678, 30644.854860159576, 31363.529547056354, 31546.0, 31792.841035795598, 50667.23999139942, 51317.48682513127, 51364.0, 51390.48609513857, 51496.22755658593, 479700.0, 481282.0, 482660.0, 483001.0, 486102.0, 27686.44627107487, 28855.278618034718, 28882.71117288884, 28944.0, 28953.42093158083, 47822.76088619535, 48403.51596484131, 48617.270740939624, 48753.75623121862, 49364.50635493599, 41426.171476570904, 42027.57972420237, 42490.36264456098, 42633.57366426296, 43061.56938430575, 40386.596134038286, 41188.794056029525, 42047.42596879177, 42779.786101069294, 45266.54733452755, 35887.82056089703, 40549.0, 41511.58488415077, 41754.79122604368, 42165.367519486615, 33283.667163329024, 37994.81002594969, 38102.61897381102, 38521.61478385292, 38624.80687596544, 28620.284492887844, 28745.712542874302, 28845.27886802847, 29370.853145734134, 29381.85309073441], "value": 18967.100076790717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.51617671292394, 379.2699054320433, 398.986035488758, 399.4567388351843, 413.9896502587435, 14054.064861838702, 17664.558386040357, 17770.82229177708, 19247.230110795568, 19353.806461935375, 17367.218475168615, 18249.81750182498, 18408.0, 18417.815821841778, 18598.72101918469, 5152.536271735543, 5277.366715994086, 5344.946550534483, 5356.437574054727, 5357.49103835137, 5199.194124910645, 5248.239005344223, 5304.655197412175, 5334.333208348957, 5338.412774594792, 5323.627346085776, 5334.146536554133, 5473.8357849264585, 5794.565407594426, 5805.3323867755325, 5866.354700982888, 5888.205092312526, 5914.674692891889, 5949.583529152961, 5954.940450595482, 5604.971975140139, 5755.0, 5770.307563092414, 5783.5951483396175, 5806.0, 22588.66117008246, 22792.202272920535, 23179.3046208614, 23193.304200874, 23728.0, 2380.155044959049, 2408.494216214597, 2577.4845030993874, 2683.610876422908, 2756.9310767230777, 9831.262655300881, 9995.850062249, 10152.441615711134, 10298.578081031994, 10437.478126093665, 1827.2549715022255, 1879.9342023029128, 1885.1422602715732, 1907.8473722102337, 2001.0095002973476, 82112.58943705243, 83356.16643833545, 84988.57505712431, 85610.14389856084, 85703.57148214281, 10593.84109238362, 10745.570177192825, 10809.83785243222, 10910.127189824794, 10941.890581094247, 11675.416229188506, 12396.132270740962, 14768.926155369154, 14843.257837108102, 14947.850521494864, 7428.405727541784, 7549.320561149523, 7671.578063206577, 7868.960655196687, 7873.763787086396, 7668.463207575528, 7832.490888092256, 7861.842763144705, 8005.759827205193, 8026.277635012877, 3859.7877116758286, 4000.979995100006, 4060.5330387005874, 4062.5734297898293, 4132.2561938850695, 1887.5281179705073, 1960.4314748722995, 1981.2372236688977, 2017.1427143463968, 2020.9797902020791, 409.8913787846223, 450.37398016756737, 1005.5073014222978, 1006.8640733500883, 1100.471773548701, 10899.237053406345, 11686.0, 11714.297142171497, 11747.17769756126, 11868.821967670492, 436.1669211805436, 454.3956537804712, 455.7561704488083, 459.9793009314589, 462.16348409379134, 6096.085587161872, 6165.290991535941, 6209.0, 6239.594426362272, 6240.500759939194, 429926.0, 447684.0, 467213.9917901234, 470973.0, 485844.0, 95840.0, 97129.51435242778, 98314.5084274574, 98606.50696746471, 99357.50321248347, 488.16280079663545, 491.38822166402343, 493.98024079037157, 500.96743711658627, 501.64633933077096, 10703.464826758787, 11366.431678416211, 11376.488058037574, 11439.771204576029, 11441.256318339281, 32052.5192122123, 38872.0, 40585.391219132325, 42041.0, 43879.34180987224, 60889.39110608837, 62441.68779156257, 62718.68640656768, 63124.368756313685, 63129.68435157795, 8813.559322033745, 8814.427062240933, 8816.162464565856, 8929.821403571763, 9104.863427048733, 9468.526573671426, 13709.794353084912, 13869.583912482642, 14271.286435678383, 14326.212058336474, 10862.302617536003, 11057.0, 11231.831522527005, 12162.574309899112, 12284.0786940978, 11410.657680269605, 11923.701907452383, 11978.64064078079, 12006.279623222634, 12316.876831231573, 12555.372231388577, 12794.296313702836, 12850.0, 12867.0, 13062.412191451218, 7675.424343174396, 8765.780855478664, 8786.297096232414, 8851.822963540822, 8966.327525435488, 12004.75990480203, 12386.938065309616, 12474.812877807022, 12593.433295501542, 12621.747565048465], "value": 8365.563340271587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.5437087317493, 1457.4680241711776, 1569.4036266218834, 1701.3364787732778, 1710.2731339180853, 7929.563873986928, 8937.285017198617, 8977.730668079968, 9530.380525265862, 9533.332666713333, 8988.505632190243, 9226.67706630268, 9296.628134874614, 9310.86033709495, 9358.672446464376, 2342.3441436397793, 2362.61016932206, 2380.143148466551, 2380.7738264864897, 2390.3665528634924, 2307.9653805192934, 2324.5931961906686, 2346.9530609387803, 2352.176738141654, 2363.2555744940373, 2302.9078836846506, 2310.0, 2332.895019724108, 2357.905683772647, 2358.7169539655265, 2253.256425379621, 2287.9199228026937, 2297.563462942044, 2337.520808234308, 2343.718753749544, 2318.8492747971327, 2342.7891489765834, 2347.3310106619533, 2351.2828587280874, 2353.1058197884695, 9417.246620270362, 9466.337356385056, 9469.242460603135, 9513.476758778264, 9522.85715714265, 5126.589872810204, 5136.64043516954, 5240.895182096375, 5266.131088370453, 5289.153735402318, 3325.2376240592525, 3338.21551935295, 3411.096059544223, 3433.8283085845856, 3512.5960514540643, 1087.0977089016098, 1104.729341311384, 1111.5164903267105, 1126.5043380912373, 1144.0447226565743, 12840.486380544768, 12921.418536165802, 12935.870641293655, 12957.28734919579, 12965.87034129656, 4553.658475614342, 4592.6555508337005, 4670.089332580114, 4675.696079754805, 4678.8596342109795, 10807.189460790472, 10829.512671929782, 10882.673519794418, 10893.128549716004, 10905.127589792955, 5275.762590683428, 5284.920726189111, 5290.65610735301, 5297.708626025606, 5304.9734751326, 4155.605217504332, 4831.4685384607665, 4835.709857408567, 4946.9010619787405, 4995.575376093, 3865.555461121951, 3924.5290565131795, 3958.3072962231495, 3982.38273067675, 4019.4975628046495, 1242.2981015726086, 1262.6527704881232, 1266.9429875655617, 1276.7063575377715, 1292.3796577642784, 886.8182022685334, 984.8818141823027, 984.9409035457895, 989.8614194012844, 1006.6879267427121, 6144.324124346318, 6365.395287447777, 6412.487001039905, 6431.5819471734185, 6516.0, 412.7894773665452, 421.70059257927215, 424.41642741230805, 431.5641202385613, 447.74702293204234, 4302.09655972243, 4316.848910288125, 4370.956290437055, 4407.184670835905, 4409.603135717736, 11417.942910285396, 11801.232919860182, 11887.28676279426, 11889.70275743096, 11937.52249909994, 10824.296420732628, 11704.47329870158, 11740.70648233801, 11784.823227651592, 11857.5849845255, 7949.284564389232, 8272.37957153204, 8318.584070796436, 8336.333093352518, 8337.833243335099, 6113.510919126548, 6348.682565871595, 6406.967965160145, 6410.102585637921, 6462.192225971754, 10822.404767737535, 10831.512581933674, 10913.399763012792, 10930.562777489129, 10935.015848573667, 10565.52455139536, 10936.945315273373, 11191.2725672831, 11226.607068752555, 11375.26060806078, 7319.890201646873, 7920.495105929855, 8197.672093116209, 8295.502269863828, 8431.283340915845, 9177.219936305222, 9224.40041397307, 9291.396059256127, 9298.95350523243, 9310.48792316402, 7920.287174154123, 7931.167227441036, 7965.880511792212, 8216.46592971455, 8305.875411868707, 8032.156623554442, 8183.386246031452, 8201.835963280582, 8216.055153657406, 8252.46358986688, 7401.111866576045, 7440.441966852616, 7508.962455187689, 7517.135529414188, 7522.172561018174, 5078.314427552233, 5108.514691104339, 5116.1814109743755, 5175.301334319969, 5194.532492075731, 5088.109580823415, 5104.897902041864, 5130.7178105204575, 5210.192420174879, 5243.816466423809], "value": 4681.31253865062, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.8260526289489, 300.6122102487791, 300.94883869742154, 311.3337457840221, 314.7560640503609, 5417.6478528895595, 5596.720163991794, 5602.635828671138, 5707.629004114735, 5762.683052432119, 5492.505674489295, 5530.175042236063, 5613.361719991597, 5621.241132447119, 5626.859328516779, 4327.805248763805, 4343.827166664999, 4357.12857428514, 4360.389545463638, 4372.038151606642, 4343.19650864591, 4345.6523478121835, 4353.912921741563, 4365.170617582665, 4417.249067658489, 4301.376160542067, 4336.501302350239, 4350.695451318409, 4365.36702178184, 4374.343848422746, 4320.762358070305, 4342.32693932441, 4352.847650332224, 4406.801693923781, 4413.4041904342985, 3670.541182352206, 3781.867634632802, 3816.217675376569, 3816.427535869614, 3819.5416550013897, 5421.159720243369, 5475.890482190334, 5491.148871924858, 5496.780128794843, 5513.917291240635, 4944.901101977976, 4975.4527002029745, 5013.222950442687, 5013.395713371722, 5016.54851063406, 5672.359946802974, 5845.766169353221, 5874.5006674432725, 5879.617824841414, 5938.7624495020145, 4136.855210067663, 4145.854895078688, 4151.543330233671, 4165.229432554987, 4180.1816209948465, 6141.385861413867, 6146.29317628474, 6171.475424588871, 6180.87638247237, 6195.101710252034, 3888.3389823730035, 4120.464339635828, 4140.523839758406, 4271.1671224111, 4316.223079845595, 4144.461220041375, 4171.541130475645, 4178.540360560336, 4181.456410666594, 4195.748255104642, 4775.403074615673, 4818.578519336804, 4835.0, 4872.342233798463, 4873.731944743002, 5900.76396944126, 5904.704764761745, 5970.955082860482, 5974.641521508724, 6007.429294217042, 1432.3268064009899, 1446.002258441672, 1448.341004842794, 1450.3038541500139, 1453.9636509087145, 871.289898732531, 885.6413152673049, 888.3248730964514, 904.8009437923646, 907.9409838360617, 4942.728149951788, 4960.801567937314, 5041.420236672756, 5082.856357319647, 5154.407243167084, 5410.862709229832, 5455.61810673257, 5458.972705136449, 5468.48049435303, 5475.67145971243, 4725.976370118127, 5013.974930125326, 5028.645122888846, 5096.261042148868, 5104.464031276737, 2805.621241132462, 2841.943161136766, 2865.8710358033936, 2867.9426411471654, 2877.812942158753, 5425.131978883439, 5444.509994100471, 5533.253010843485, 5535.169724541351, 5597.552195824324, 5394.811181608703, 5683.460071293221, 6168.938310616926, 6193.411625895533, 6205.596636218631, 6281.842953926189, 6299.874002520016, 6323.494120470444, 6336.873262534724, 6358.393058845851, 5889.823305300848, 6101.688137050555, 6111.633302001894, 6144.078388241799, 6209.285932117684, 5999.790007349722, 6028.2766068072115, 6038.678726700209, 6038.818835434944, 6081.027035674271, 5699.544036477155, 6320.841978950563, 6345.206849143857, 6354.0, 6374.808755737336, 4234.724742891703, 4249.893752656085, 4282.743035417885, 4290.069468739142, 4294.3558466230315, 5992.250968628921, 6035.305939816802, 6044.576879618385, 6057.727402266997, 6060.424259695322, 5733.254676891977, 5861.9706901465215, 5863.149843272617, 5868.063539032024, 5911.467967882912, 5796.739146738322, 5826.650400975955, 5836.774277401793, 5868.2077919480325, 5868.413158684098, 5743.0, 5754.68349240779, 5763.682997435181, 5773.336066352424, 5794.0, 5665.376808550974, 5887.940170769302, 5907.734151963086, 5919.720907450576, 5920.809300558821, 5758.424157584208, 5790.565707571865, 5794.681292528951, 5795.797147099831, 5859.091840764689], "value": 4364.863284252946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.3717375558828, 665.657186548927, 737.3511310047157, 771.2595907928388, 831.9126491718371, 14375.353109110089, 15392.846071539281, 15441.150736709476, 15441.227938603068, 15442.69114617707, 14251.78622320666, 14737.484188053393, 14881.18153501557, 15001.549953501413, 15020.17389043602, 778.9883151752714, 792.9088154862206, 794.4637369775407, 794.6940427935228, 798.8322452285028, 762.1958833430729, 789.1713700614332, 789.8775689768095, 793.115676021235, 800.0599295827409, 832.1886160993043, 835.0897521701374, 835.9247667709905, 838.337713206566, 841.0, 822.2106777493583, 826.6404114210337, 829.5976451421056, 830.0371568979954, 833.2625626320689, 607.5929127484596, 608.0817964873073, 608.3551435478407, 610.8350745298789, 612.996935015322, 15602.0, 15726.842731572766, 15753.842461575467, 15782.842171578252, 15783.684326313525, 14619.12285262877, 14842.480513181987, 14857.257137143208, 14862.182579958098, 14961.925190373979, 12386.380680965916, 12491.687707807287, 12500.437480313407, 12520.499180032788, 12559.120861539695, 3850.306944749944, 4001.419794129864, 4028.637422631977, 4058.5738497457933, 4059.817308221137, 79510.20489795085, 79610.60194699047, 79871.60064199699, 80260.0, 80771.5961420195, 11262.324260544394, 11377.203595748384, 11517.0, 11725.944664980192, 12158.148929574845, 21301.573968520854, 21383.144674213167, 21403.14387424517, 21423.67864482034, 21504.247351342627, 8235.8352832943, 8414.0, 8791.120887911286, 8822.647094116292, 8851.380403371702, 4142.896427589334, 4270.530241673413, 4314.266574682311, 4436.157130145262, 4445.466544014739, 3555.5377800886235, 3651.8539258429896, 3670.7614005089586, 3673.7061035117126, 3680.411134218512, 617.9814605561751, 633.33183491417, 637.5186734015789, 641.7433026789322, 651.4039653716891, 638.479639094146, 661.5435349608755, 705.6013352455846, 714.5962531169872, 770.1643716567474, 9563.61745530185, 9971.952944940676, 10050.648227312155, 10151.593936242467, 10183.796324073477, 587.4712758517369, 607.9240094988127, 707.1478867964194, 735.9337659610661, 747.1184002876549, 4549.522300158502, 4809.95190048102, 4822.614190864792, 4910.975445122752, 4913.582345500672, 113816.43091784487, 117695.0, 118400.0, 118646.40676796561, 119122.0, 99600.50199748955, 99910.50044749875, 100218.0, 102235.4888225569, 102876.48561757144, 85828.0, 89744.5512772432, 90634.54682726544, 91465.0, 93514.53242733743, 9316.720498385059, 9482.478463684563, 9487.66793162236, 9491.003444638214, 9519.714408567754, 51423.0, 51791.0, 52139.217911732114, 52437.0, 53032.55288406241, 66320.0, 67179.32820671731, 69348.65325673542, 74267.1433214174, 78297.0, 13372.465101395836, 13682.31588420555, 13698.863011369758, 14007.0, 14283.28583570838, 15162.620934476727, 15226.889087478812, 15538.223088845738, 15587.688246235239, 15631.452899148475, 14301.661500433183, 14350.49773257931, 14566.198859062853, 14937.925310373379, 15438.0, 13480.73038539204, 13854.783234682402, 14230.430782768573, 14699.706005880036, 14788.556343309718, 14026.438942442188, 14302.642433939234, 14464.13215207091, 14482.855171448573, 14769.92615036918, 11377.317360958368, 11471.655850324503, 11497.338209540321, 11554.711132221762, 11865.466054027416, 12014.63956081319, 12061.396930153633, 12099.076239939584, 12340.259584424963, 12464.75070498603], "value": 7658.129361067123, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 104.0, 108.0, 110.0, 109.0, 110.0, 111.0, 109.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 126.0, 152.0, 187.0, 127.0, 162.0, 154.0, 126.0, 183.0, 132.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 162.0, 164.0, 167.0, 163.0, 164.0, 164.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 169.0, 75.0, 76.0, 76.0, 73.0, 172.0, 74.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 155.0, 86.0, 88.0, 86.0, 142.0, 85.0, 86.0, 137.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 147.0, 150.0, 148.0, 147.0, 149.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 63.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 81.0, 81.0, 80.0, 82.0, 89.0, 85.0, 89.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 126.0, 120.0, 130.0, 143.0, 122.0, 134.0, 128.0, 122.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 165.0, 163.0, 162.0, 161.0, 159.0, 167.0, 161.0, 163.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 62.0, 63.0, 68.0, 64.0, 65.0, 64.0], "value": 64.2, "unit": "score"}]}]} 11:28:55 INFO - Return code: 0 11:28:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:28:55 ERROR - # TBPL SUCCESS # 11:28:55 INFO - Running post-action listener: _resource_record_post_action 11:28:55 INFO - ##### 11:28:55 INFO - ##### Finished run-tests step (success) 11:28:55 INFO - ##### 11:28:55 INFO - Running post-run listener: _resource_record_post_run 11:28:55 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551452672; Read time: 8; Write time: 490872 11:28:55 INFO - TinderboxPrint: CPU usage
13.5% 11:28:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:28:55 INFO - TinderboxPrint: I/O write bytes / time
551,452,672 / 490,872 11:28:55 INFO - TinderboxPrint: CPU idle
8,226.7 (86.5%) 11:28:55 INFO - TinderboxPrint: CPU user
1,225.1 (12.9%) 11:28:55 INFO - TinderboxPrint: Swap in / out
0 / 0 11:28:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256335872; Read time: 0; Write time: 236936 11:28:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294936576; Read time: 8; Write time: 253916 11:28:56 INFO - Running post-run listener: _upload_blobber_files 11:28:56 INFO - Blob upload gear active. 11:28:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:28:56 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 11:28:56 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:28:56 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:28:56 INFO - (blobuploader) - INFO - Open directory for files ... 11:28:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:28:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:28:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:57 INFO - (blobuploader) - INFO - Done attempting. 11:28:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:28:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:29:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:01 INFO - (blobuploader) - INFO - Done attempting. 11:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:29:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:01 INFO - (blobuploader) - INFO - Done attempting. 11:29:01 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:01 INFO - Return code: 0 11:29:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98557a5d714adf92c27977c38fcb21da561e19e5e4e7b93a69738e7b4bc56d87cc7bd8bf2dbcd0b2e822491ee532ad0850ab7a91d8477fd15bb2e5c235d573d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb10dc07417f47039e32f6b8d66069931795e9bc07d4832a353f7335e449df803958cbb9faf605731ddfdeef32b3e9f8b6173807e380d1542cd3bf6d6a82df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/702a4632e7606640191c11adb718100dd2f946c523ca24309571688bea5c8329deff4c9a8f1c2e853a1e95c8c05159882788de4a1c4eada591a0311eb6d5b6bc"} 11:29:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:01 INFO - Contents: 11:29:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98557a5d714adf92c27977c38fcb21da561e19e5e4e7b93a69738e7b4bc56d87cc7bd8bf2dbcd0b2e822491ee532ad0850ab7a91d8477fd15bb2e5c235d573d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb10dc07417f47039e32f6b8d66069931795e9bc07d4832a353f7335e449df803958cbb9faf605731ddfdeef32b3e9f8b6173807e380d1542cd3bf6d6a82df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/702a4632e7606640191c11adb718100dd2f946c523ca24309571688bea5c8329deff4c9a8f1c2e853a1e95c8c05159882788de4a1c4eada591a0311eb6d5b6bc"} 11:29:01 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:01 INFO - Copying logs to upload dir... 11:29:01 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.120687 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-22 11:29:01.781047) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 11:29:01.785055) ========= 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=ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98557a5d714adf92c27977c38fcb21da561e19e5e4e7b93a69738e7b4bc56d87cc7bd8bf2dbcd0b2e822491ee532ad0850ab7a91d8477fd15bb2e5c235d573d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb10dc07417f47039e32f6b8d66069931795e9bc07d4832a353f7335e449df803958cbb9faf605731ddfdeef32b3e9f8b6173807e380d1542cd3bf6d6a82df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/702a4632e7606640191c11adb718100dd2f946c523ca24309571688bea5c8329deff4c9a8f1c2e853a1e95c8c05159882788de4a1c4eada591a0311eb6d5b6bc"} build_url:https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011582 build_url: 'https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98557a5d714adf92c27977c38fcb21da561e19e5e4e7b93a69738e7b4bc56d87cc7bd8bf2dbcd0b2e822491ee532ad0850ab7a91d8477fd15bb2e5c235d573d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb10dc07417f47039e32f6b8d66069931795e9bc07d4832a353f7335e449df803958cbb9faf605731ddfdeef32b3e9f8b6173807e380d1542cd3bf6d6a82df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/702a4632e7606640191c11adb718100dd2f946c523ca24309571688bea5c8329deff4c9a8f1c2e853a1e95c8c05159882788de4a1c4eada591a0311eb6d5b6bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 11:29:01.811732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:29:01.812112) ========= 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=ed14279e38b05397cf4aa391000001a4-1466615995.733816-642307094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:29:01.896410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 11:29:01.896781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 11:29:01.897103) ========= ========= Total master_lag: 0.17 =========