builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1465560205.56 results: success (0) buildid: 20160610023030 builduid: 7960a9e2ffba41f0adfd78a3aa8ac46b revision: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.571256) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.571890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.572575) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.606027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.606554) ========= 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=eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 05:03: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.5M=0s 2016-06-10 05:03:25 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095393 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.793221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.793533) ========= 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=eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022229 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.853583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.853901) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9c0dce75ed0c21e0b05ba72c348da23b27e80888 --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 9c0dce75ed0c21e0b05ba72c348da23b27e80888 --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=eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 05:03:26,020 truncating revision to first 12 chars 2016-06-10 05:03:26,020 Setting DEBUG logging. 2016-06-10 05:03:26,020 attempt 1/10 2016-06-10 05:03:26,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9c0dce75ed0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 05:03:26,344 unpacking tar archive at: fx-team-9c0dce75ed0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.511526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.511830) ========= script_repo_revision: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.512223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.512494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.520929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-10 05:03:26.521302) ========= /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=eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:03:26 INFO - MultiFileLogger online at 20160610 05:03:26 in /builds/slave/test 05:03:26 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 05:03:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:03:26 INFO - {'append_to_log': False, 05:03:26 INFO - 'base_work_dir': '/builds/slave/test', 05:03:26 INFO - 'blob_upload_branch': 'Fx-Team', 05:03:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:03:26 INFO - 'branch': 'Fx-Team', 05:03:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:26 INFO - 'config_files': ('talos/linux_config.py',), 05:03:26 INFO - 'default_actions': ('clobber', 05:03:26 INFO - 'read-buildbot-config', 05:03:26 INFO - 'download-and-extract', 05:03:26 INFO - 'populate-webroot', 05:03:26 INFO - 'create-virtualenv', 05:03:26 INFO - 'install', 05:03:26 INFO - 'run-tests'), 05:03:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:26 INFO - 'download_minidump_stackwalk': True, 05:03:26 INFO - 'download_symbols': 'ondemand', 05:03:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:26 INFO - 'installer_path': 'installer.exe', 05:03:26 INFO - 'log_level': 'info', 05:03:26 INFO - 'log_name': 'talos', 05:03:26 INFO - 'log_to_console': True, 05:03:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:03:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:03:26 INFO - 'opt_config_files': (), 05:03:26 INFO - 'pip_index': False, 05:03:26 INFO - 'sps_profile': False, 05:03:26 INFO - 'sps_profile_interval': 0, 05:03:26 INFO - 'suite': 'dromaeojs-e10s', 05:03:26 INFO - 'system_bits': '32', 05:03:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:26 INFO - 'title': 'talos-linux64-ix-010', 05:03:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:26 INFO - 'use_talos_json': True, 05:03:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:03:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:26 INFO - 'work_dir': 'build'} 05:03:26 INFO - ##### 05:03:26 INFO - ##### Running clobber step. 05:03:26 INFO - ##### 05:03:26 INFO - Running pre-action listener: _resource_record_pre_action 05:03:26 INFO - Running main action method: clobber 05:03:26 INFO - rmtree: /builds/slave/test/build 05:03:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:03:27 INFO - Running post-action listener: _resource_record_post_action 05:03:27 INFO - ##### 05:03:27 INFO - ##### Finished clobber step (success) 05:03:27 INFO - ##### 05:03:27 INFO - ##### 05:03:27 INFO - ##### Running read-buildbot-config step. 05:03:27 INFO - ##### 05:03:27 INFO - Running pre-action listener: _resource_record_pre_action 05:03:27 INFO - Running main action method: read_buildbot_config 05:03:27 INFO - Using buildbot properties: 05:03:27 INFO - { 05:03:27 INFO - "project": "", 05:03:27 INFO - "product": "firefox", 05:03:27 INFO - "script_repo_revision": "production", 05:03:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:03:27 INFO - "repository": "", 05:03:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:03:27 INFO - "buildid": "20160610023030", 05:03:27 INFO - "pgo_build": "True", 05:03:27 INFO - "basedir": "/builds/slave/test", 05:03:27 INFO - "buildnumber": 456, 05:03:27 INFO - "slavename": "talos-linux64-ix-010", 05:03:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:03:27 INFO - "platform": "ubuntu64_hw", 05:03:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:03:27 INFO - "branch": "fx-team", 05:03:27 INFO - "repo_path": "integration/fx-team", 05:03:27 INFO - "revision": "9c0dce75ed0c21e0b05ba72c348da23b27e80888", 05:03:27 INFO - "stage_platform": "linux64-pgo", 05:03:27 INFO - "builduid": "7960a9e2ffba41f0adfd78a3aa8ac46b", 05:03:27 INFO - "slavebuilddir": "test" 05:03:27 INFO - } 05:03:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:03:27 INFO - Running post-action listener: _resource_record_post_action 05:03:27 INFO - ##### 05:03:27 INFO - ##### Finished read-buildbot-config step (success) 05:03:27 INFO - ##### 05:03:27 INFO - ##### 05:03:27 INFO - ##### Running download-and-extract step. 05:03:27 INFO - ##### 05:03:27 INFO - Running pre-action listener: _resource_record_pre_action 05:03:27 INFO - Running main action method: download_and_extract 05:03:27 INFO - mkdir: /builds/slave/test/build/tests 05:03: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')]} 05:03:27 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:03:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:33 INFO - Downloaded 1361 bytes. 05:03:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:33 INFO - Using the following test package requirements: 05:03:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:03:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:03:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:33 INFO - u'jsshell-linux-x86_64.zip'], 05:03:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:03:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:03:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:03:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:03:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:03:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:03:33 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')]} 05:03:33 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:43 INFO - Downloaded 24452446 bytes. 05:03:43 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'] 05:03:43 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 05:03:44 INFO - Return code: 0 05:03:44 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 05:03: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')]} 05:03:44 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:52 INFO - Downloaded 24452446 bytes. 05:03:52 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'] 05:03:52 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 05:03:54 INFO - Return code: 0 05:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:54 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:03:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:56 INFO - Downloaded 10833377 bytes. 05:03:56 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'] 05:03:56 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 05:03:56 INFO - Return code: 0 05:03: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')]} 05:03:56 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:58 INFO - Downloaded 59292349 bytes. 05:03:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:58 INFO - mkdir: /builds/slave/test/properties 05:03:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:58 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:58 INFO - Contents: 05:03:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:59 INFO - Running post-action listener: _resource_record_post_action 05:03:59 INFO - Running post-action listener: set_extra_try_arguments 05:03:59 INFO - ##### 05:03:59 INFO - ##### Finished download-and-extract step (success) 05:03:59 INFO - ##### 05:03:59 INFO - ##### 05:03:59 INFO - ##### Running populate-webroot step. 05:03:59 INFO - ##### 05:03:59 INFO - Running pre-action listener: _resource_record_pre_action 05:03:59 INFO - Running main action method: populate_webroot 05:03:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:59 INFO - '--tppagecycles', 05:03:59 INFO - '7'], 05:03:59 INFO - 'tests': ['tsvgm']}}, 05:03:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:59 INFO - 'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:59 INFO - 'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['damp', 'tps']}, 05:03:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:59 INFO - 'tests': ['damp', 'tps']}, 05:03:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['dromaeo_dom']}, 05:03:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['a11yr', 05:03:59 INFO - 'ts_paint', 05:03:59 INFO - 'tpaint', 05:03:59 INFO - 'sessionrestore', 05:03:59 INFO - 'sessionrestore_no_auto_restore', 05:03:59 INFO - 'tabpaint']}, 05:03:59 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:59 INFO - 'ts_paint', 05:03:59 INFO - 'tpaint', 05:03:59 INFO - 'sessionrestore', 05:03:59 INFO - 'sessionrestore_no_auto_restore', 05:03:59 INFO - 'tabpaint']}, 05:03:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:59 INFO - 'ts_paint', 05:03:59 INFO - 'tpaint', 05:03:59 INFO - 'sessionrestore', 05:03:59 INFO - 'sessionrestore_no_auto_restore', 05:03:59 INFO - 'tabpaint']}, 05:03:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:59 INFO - 'ts_paint', 05:03:59 INFO - 'tpaint', 05:03:59 INFO - 'sessionrestore', 05:03:59 INFO - 'sessionrestore_no_auto_restore', 05:03:59 INFO - 'tabpaint']}, 05:03:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['a11yr', 05:03:59 INFO - 'ts_paint', 05:03:59 INFO - 'tpaint', 05:03:59 INFO - 'sessionrestore', 05:03:59 INFO - 'sessionrestore_no_auto_restore', 05:03:59 INFO - 'tabpaint']}, 05:03:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['a11yr', 05:03:59 INFO - 'ts_paint', 05:03:59 INFO - 'tpaint', 05:03:59 INFO - 'sessionrestore', 05:03:59 INFO - 'sessionrestore_no_auto_restore', 05:03:59 INFO - 'tabpaint']}, 05:03:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['tsvgx', 05:03:59 INFO - 'tsvgr_opacity', 05:03:59 INFO - 'tart', 05:03:59 INFO - 'tscrollx', 05:03:59 INFO - 'cart']}, 05:03:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:59 INFO - 'tsvgr_opacity', 05:03:59 INFO - 'tart', 05:03:59 INFO - 'tscrollx', 05:03:59 INFO - 'cart']}, 05:03:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:59 INFO - 'talos_options': ['--disable-e10s'], 05:03:59 INFO - 'tests': ['tp5o']}, 05:03:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:59 INFO - 'tests': ['tp5o']}, 05:03:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:59 INFO - 'talos_options': ['--disable-e10s', 05:03:59 INFO - '--xperf_path', 05:03:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:59 INFO - 'tests': ['tp5n']}, 05:03:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:59 INFO - 'talos_options': ['--xperf_path', 05:03:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:59 INFO - 'tests': ['tp5n']}}, 05:03:59 INFO - 'talos.zip': {'path': '', 05:03:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:59 INFO - Running post-action listener: _resource_record_post_action 05:03:59 INFO - ##### 05:03:59 INFO - ##### Finished populate-webroot step (success) 05:03:59 INFO - ##### 05:03:59 INFO - ##### 05:03:59 INFO - ##### Running create-virtualenv step. 05:03:59 INFO - ##### 05:03:59 INFO - Running pre-action listener: _resource_record_pre_action 05:03:59 INFO - Running main action method: create_virtualenv 05:03:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:03:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:59 INFO - Using real prefix '/usr' 05:03:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:04:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:02 INFO - Installing pip.................done. 05:04:02 INFO - Return code: 0 05:04:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:04:02 INFO - Using env: {'DISPLAY': ':0', 05:04:02 INFO - 'HOME': '/home/cltbld', 05:04:02 INFO - 'LANG': 'en_US.UTF-8', 05:04:02 INFO - 'LANGUAGE': 'en_US:en', 05:04:02 INFO - 'LOGNAME': 'cltbld', 05:04:02 INFO - 'MAIL': '/var/mail/cltbld', 05:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:02 INFO - 'MOZ_NO_REMOTE': '1', 05:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:02 INFO - 'NO_EM_RESTART': '1', 05:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:02 INFO - 'PWD': '/builds/slave/test', 05:04:02 INFO - 'SHELL': '/bin/bash', 05:04:02 INFO - 'SHLVL': '1', 05:04:02 INFO - 'TERM': 'linux', 05:04:02 INFO - 'TMOUT': '86400', 05:04:02 INFO - 'USER': 'cltbld', 05:04:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:02 INFO - '_': '/tools/buildbot/bin/python'} 05:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:04:02 INFO - Cleaning up... 05:04:02 INFO - Return code: 0 05:04:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:04:02 INFO - Using env: {'DISPLAY': ':0', 05:04:02 INFO - 'HOME': '/home/cltbld', 05:04:02 INFO - 'LANG': 'en_US.UTF-8', 05:04:02 INFO - 'LANGUAGE': 'en_US:en', 05:04:02 INFO - 'LOGNAME': 'cltbld', 05:04:02 INFO - 'MAIL': '/var/mail/cltbld', 05:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:02 INFO - 'MOZ_NO_REMOTE': '1', 05:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:02 INFO - 'NO_EM_RESTART': '1', 05:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:02 INFO - 'PWD': '/builds/slave/test', 05:04:02 INFO - 'SHELL': '/bin/bash', 05:04:02 INFO - 'SHLVL': '1', 05:04:02 INFO - 'TERM': 'linux', 05:04:02 INFO - 'TMOUT': '86400', 05:04:02 INFO - 'USER': 'cltbld', 05:04:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:02 INFO - '_': '/tools/buildbot/bin/python'} 05:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:02 INFO - Downloading/unpacking psutil>=3.1.1 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:04 INFO - Installing collected packages: psutil 05:04:04 INFO - Running setup.py install for psutil 05:04:04 INFO - building 'psutil._psutil_linux' extension 05:04:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:04:04 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 05:04:04 INFO - building 'psutil._psutil_posix' extension 05:04:04 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 05:04:04 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 05:04:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:05 INFO - Successfully installed psutil 05:04:05 INFO - Cleaning up... 05:04:05 INFO - Return code: 0 05:04:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:04:05 INFO - Using env: {'DISPLAY': ':0', 05:04:05 INFO - 'HOME': '/home/cltbld', 05:04:05 INFO - 'LANG': 'en_US.UTF-8', 05:04:05 INFO - 'LANGUAGE': 'en_US:en', 05:04:05 INFO - 'LOGNAME': 'cltbld', 05:04:05 INFO - 'MAIL': '/var/mail/cltbld', 05:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:05 INFO - 'MOZ_NO_REMOTE': '1', 05:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:05 INFO - 'NO_EM_RESTART': '1', 05:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:05 INFO - 'PWD': '/builds/slave/test', 05:04:05 INFO - 'SHELL': '/bin/bash', 05:04:05 INFO - 'SHLVL': '1', 05:04:05 INFO - 'TERM': 'linux', 05:04:05 INFO - 'TMOUT': '86400', 05:04:05 INFO - 'USER': 'cltbld', 05:04:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:05 INFO - '_': '/tools/buildbot/bin/python'} 05:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:04:07 INFO - Installing collected packages: mozsystemmonitor 05:04:07 INFO - Running setup.py install for mozsystemmonitor 05:04:07 INFO - Successfully installed mozsystemmonitor 05:04:07 INFO - Cleaning up... 05:04:07 INFO - Return code: 0 05:04:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:04:07 INFO - Using env: {'DISPLAY': ':0', 05:04:07 INFO - 'HOME': '/home/cltbld', 05:04:07 INFO - 'LANG': 'en_US.UTF-8', 05:04:07 INFO - 'LANGUAGE': 'en_US:en', 05:04:07 INFO - 'LOGNAME': 'cltbld', 05:04:07 INFO - 'MAIL': '/var/mail/cltbld', 05:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:07 INFO - 'MOZ_NO_REMOTE': '1', 05:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:07 INFO - 'NO_EM_RESTART': '1', 05:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:07 INFO - 'PWD': '/builds/slave/test', 05:04:07 INFO - 'SHELL': '/bin/bash', 05:04:07 INFO - 'SHLVL': '1', 05:04:07 INFO - 'TERM': 'linux', 05:04:07 INFO - 'TMOUT': '86400', 05:04:07 INFO - 'USER': 'cltbld', 05:04:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:07 INFO - '_': '/tools/buildbot/bin/python'} 05:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:09 INFO - warning: no files found matching '*.txt' 05:04:09 INFO - no previously-included directories found matching 'build' 05:04:09 INFO - no previously-included directories found matching 'dist' 05:04:09 INFO - no previously-included directories found matching '.git*' 05:04:09 INFO - Installing collected packages: jsonschema, functools32 05:04:09 INFO - Running setup.py install for functools32 05:04:09 INFO - warning: no files found matching '*.txt' 05:04:09 INFO - no previously-included directories found matching 'build' 05:04:09 INFO - no previously-included directories found matching 'dist' 05:04:09 INFO - no previously-included directories found matching '.git*' 05:04:09 INFO - Successfully installed jsonschema functools32 05:04:09 INFO - Cleaning up... 05:04:10 INFO - Return code: 0 05:04:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:10 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 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:10 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 05:04:10 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 05:04:10 INFO - Using env: {'DISPLAY': ':0', 05:04:10 INFO - 'HOME': '/home/cltbld', 05:04:10 INFO - 'LANG': 'en_US.UTF-8', 05:04:10 INFO - 'LANGUAGE': 'en_US:en', 05:04:10 INFO - 'LOGNAME': 'cltbld', 05:04:10 INFO - 'MAIL': '/var/mail/cltbld', 05:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:10 INFO - 'MOZ_NO_REMOTE': '1', 05:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:10 INFO - 'NO_EM_RESTART': '1', 05:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:10 INFO - 'PWD': '/builds/slave/test', 05:04:10 INFO - 'SHELL': '/bin/bash', 05:04:10 INFO - 'SHLVL': '1', 05:04:10 INFO - 'TERM': 'linux', 05:04:10 INFO - 'TMOUT': '86400', 05:04:10 INFO - 'USER': 'cltbld', 05:04:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:10 INFO - '_': '/tools/buildbot/bin/python'} 05:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:10 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:12 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:04:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:12 INFO - Downloading docopt-0.6.1.tar.gz 05:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:12 INFO - Running setup.py install for blobuploader 05:04:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:04:12 INFO - Running setup.py install for requests 05:04:13 INFO - Running setup.py install for docopt 05:04:13 INFO - Successfully installed blobuploader requests docopt 05:04:13 INFO - Cleaning up... 05:04:13 INFO - Return code: 0 05:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:13 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 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:13 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 05:04:13 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 05:04:13 INFO - Using env: {'DISPLAY': ':0', 05:04:13 INFO - 'HOME': '/home/cltbld', 05:04:13 INFO - 'LANG': 'en_US.UTF-8', 05:04:13 INFO - 'LANGUAGE': 'en_US:en', 05:04:13 INFO - 'LOGNAME': 'cltbld', 05:04:13 INFO - 'MAIL': '/var/mail/cltbld', 05:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:13 INFO - 'MOZ_NO_REMOTE': '1', 05:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:13 INFO - 'NO_EM_RESTART': '1', 05:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:13 INFO - 'PWD': '/builds/slave/test', 05:04:13 INFO - 'SHELL': '/bin/bash', 05:04:13 INFO - 'SHLVL': '1', 05:04:13 INFO - 'TERM': 'linux', 05:04:13 INFO - 'TMOUT': '86400', 05:04:13 INFO - 'USER': 'cltbld', 05:04:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:13 INFO - '_': '/tools/buildbot/bin/python'} 05:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:13 INFO - Running setup.py (path:/tmp/pip-_EXUWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:13 INFO - Running setup.py (path:/tmp/pip-iHTaNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:13 INFO - Running setup.py (path:/tmp/pip-py0NYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:13 INFO - Running setup.py (path:/tmp/pip-jjRYo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:13 INFO - Running setup.py (path:/tmp/pip-p5BpG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:14 INFO - Running setup.py (path:/tmp/pip-h4oU6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:14 INFO - Running setup.py (path:/tmp/pip-kzgDLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:14 INFO - Running setup.py (path:/tmp/pip-DJa3EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:14 INFO - Running setup.py (path:/tmp/pip-cp7Dtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:14 INFO - Running setup.py (path:/tmp/pip-gz9FHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:14 INFO - Running setup.py (path:/tmp/pip-p8Ohjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:14 INFO - Running setup.py (path:/tmp/pip-DfCNsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:14 INFO - Running setup.py (path:/tmp/pip-rtCteZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:14 INFO - Running setup.py (path:/tmp/pip-eknZGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:14 INFO - Running setup.py (path:/tmp/pip-QzhDZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:14 INFO - Running setup.py (path:/tmp/pip-GUWXcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:14 INFO - Running setup.py (path:/tmp/pip-FtGgwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:14 INFO - Running setup.py install for manifestparser 05:04:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Running setup.py install for mozcrash 05:04:15 INFO - Running setup.py install for mozdebug 05:04:15 INFO - Running setup.py install for mozdevice 05:04:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Running setup.py install for mozfile 05:04:15 INFO - Running setup.py install for mozhttpd 05:04:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Running setup.py install for mozinfo 05:04:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Running setup.py install for mozInstall 05:04:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Running setup.py install for mozleak 05:04:15 INFO - Running setup.py install for mozlog 05:04:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:04:15 INFO - Running setup.py install for moznetwork 05:04:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:04:16 INFO - Running setup.py install for mozprocess 05:04:16 INFO - Running setup.py install for mozprofile 05:04:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:04:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:04:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:04:16 INFO - Running setup.py install for mozrunner 05:04:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:04:16 INFO - Running setup.py install for mozscreenshot 05:04:16 INFO - Running setup.py install for moztest 05:04:16 INFO - Running setup.py install for mozversion 05:04:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:04:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:16 INFO - Cleaning up... 05:04:16 INFO - Return code: 0 05:04:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:16 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')]} 05:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:16 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')]} 05:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:16 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 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:16 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 05:04:16 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 05:04:16 INFO - Using env: {'DISPLAY': ':0', 05:04:16 INFO - 'HOME': '/home/cltbld', 05:04:16 INFO - 'LANG': 'en_US.UTF-8', 05:04:16 INFO - 'LANGUAGE': 'en_US:en', 05:04:16 INFO - 'LOGNAME': 'cltbld', 05:04:16 INFO - 'MAIL': '/var/mail/cltbld', 05:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:16 INFO - 'MOZ_NO_REMOTE': '1', 05:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:16 INFO - 'NO_EM_RESTART': '1', 05:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:16 INFO - 'PWD': '/builds/slave/test', 05:04:16 INFO - 'SHELL': '/bin/bash', 05:04:16 INFO - 'SHLVL': '1', 05:04:16 INFO - 'TERM': 'linux', 05:04:16 INFO - 'TMOUT': '86400', 05:04:16 INFO - 'USER': 'cltbld', 05:04:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:16 INFO - '_': '/tools/buildbot/bin/python'} 05:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:16 INFO - Running setup.py (path:/tmp/pip-XNgnhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:17 INFO - Running setup.py (path:/tmp/pip-_r5jJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:17 INFO - Running setup.py (path:/tmp/pip-KXdKP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:17 INFO - Running setup.py (path:/tmp/pip-8Geo9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:17 INFO - Running setup.py (path:/tmp/pip-2i0QgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:17 INFO - Running setup.py (path:/tmp/pip-ux7rR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:17 INFO - Running setup.py (path:/tmp/pip-rJJKDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:17 INFO - Running setup.py (path:/tmp/pip-cp8IGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:17 INFO - Running setup.py (path:/tmp/pip-zmTBcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:17 INFO - Running setup.py (path:/tmp/pip-OSqj0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:17 INFO - Running setup.py (path:/tmp/pip-Y0oOAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:17 INFO - Running setup.py (path:/tmp/pip-V0UtL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:17 INFO - Running setup.py (path:/tmp/pip-qGNjgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:17 INFO - Running setup.py (path:/tmp/pip-7xrAgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:17 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)) 05:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:17 INFO - Running setup.py (path:/tmp/pip-GDb78e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:18 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)) 05:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:18 INFO - Running setup.py (path:/tmp/pip-onnxn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:18 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)) 05:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:18 INFO - Running setup.py (path:/tmp/pip-gRNUfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:18 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)) 05:04:18 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)) 05:04:18 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)) 05:04:18 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)) 05:04:18 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)) 05:04:18 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)) 05:04:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:20 INFO - Downloading blessings-1.6.tar.gz 05:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:20 INFO - Installing collected packages: blessings 05:04:20 INFO - Running setup.py install for blessings 05:04:20 INFO - Successfully installed blessings 05:04:20 INFO - Cleaning up... 05:04:20 INFO - Return code: 0 05:04:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:04:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:20 INFO - Reading from file tmpfile_stdout 05:04:20 INFO - Current package versions: 05:04:20 INFO - argparse == 1.2.1 05:04:20 INFO - blessings == 1.6 05:04:20 INFO - blobuploader == 1.2.4 05:04:20 INFO - docopt == 0.6.1 05:04:20 INFO - functools32 == 3.2.3-2 05:04:20 INFO - jsonschema == 2.5.1 05:04:20 INFO - manifestparser == 1.1 05:04:20 INFO - mozInstall == 1.12 05:04:20 INFO - mozcrash == 0.17 05:04:20 INFO - mozdebug == 0.1 05:04:20 INFO - mozdevice == 0.48 05:04:20 INFO - mozfile == 1.2 05:04:20 INFO - mozhttpd == 0.7 05:04:20 INFO - mozinfo == 0.9 05:04:20 INFO - mozleak == 0.1 05:04:20 INFO - mozlog == 3.2 05:04:20 INFO - moznetwork == 0.27 05:04:20 INFO - mozprocess == 0.22 05:04:20 INFO - mozprofile == 0.28 05:04:20 INFO - mozrunner == 6.11 05:04:20 INFO - mozscreenshot == 0.1 05:04:20 INFO - mozsystemmonitor == 0.3 05:04:20 INFO - moztest == 0.7 05:04:20 INFO - mozversion == 1.4 05:04:20 INFO - psutil == 3.1.1 05:04:20 INFO - requests == 1.2.3 05:04:20 INFO - wsgiref == 0.1.2 05:04:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:20 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 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:20 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 05:04:20 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 05:04:20 INFO - Using env: {'DISPLAY': ':0', 05:04:20 INFO - 'HOME': '/home/cltbld', 05:04:20 INFO - 'LANG': 'en_US.UTF-8', 05:04:20 INFO - 'LANGUAGE': 'en_US:en', 05:04:20 INFO - 'LOGNAME': 'cltbld', 05:04:20 INFO - 'MAIL': '/var/mail/cltbld', 05:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:20 INFO - 'MOZ_NO_REMOTE': '1', 05:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:20 INFO - 'NO_EM_RESTART': '1', 05:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:20 INFO - 'PWD': '/builds/slave/test', 05:04:20 INFO - 'SHELL': '/bin/bash', 05:04:20 INFO - 'SHLVL': '1', 05:04:20 INFO - 'TERM': 'linux', 05:04:20 INFO - 'TMOUT': '86400', 05:04:20 INFO - 'USER': 'cltbld', 05:04:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:20 INFO - '_': '/tools/buildbot/bin/python'} 05:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 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)) 05:04:20 INFO - Cleaning up... 05:04:20 INFO - Return code: 0 05:04:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:04:20 INFO - Using env: {'DISPLAY': ':0', 05:04:20 INFO - 'HOME': '/home/cltbld', 05:04:20 INFO - 'LANG': 'en_US.UTF-8', 05:04:20 INFO - 'LANGUAGE': 'en_US:en', 05:04:20 INFO - 'LOGNAME': 'cltbld', 05:04:20 INFO - 'MAIL': '/var/mail/cltbld', 05:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:20 INFO - 'MOZ_NO_REMOTE': '1', 05:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:20 INFO - 'NO_EM_RESTART': '1', 05:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:20 INFO - 'PWD': '/builds/slave/test', 05:04:20 INFO - 'SHELL': '/bin/bash', 05:04:20 INFO - 'SHLVL': '1', 05:04:20 INFO - 'TERM': 'linux', 05:04:20 INFO - 'TMOUT': '86400', 05:04:20 INFO - 'USER': 'cltbld', 05:04:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:20 INFO - '_': '/tools/buildbot/bin/python'} 05:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:04:20 INFO - Cleaning up... 05:04:20 INFO - Return code: 0 05:04:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff41abd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', '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 05:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:04:20 INFO - Using env: {'DISPLAY': ':0', 05:04:20 INFO - 'HOME': '/home/cltbld', 05:04:20 INFO - 'LANG': 'en_US.UTF-8', 05:04:20 INFO - 'LANGUAGE': 'en_US:en', 05:04:20 INFO - 'LOGNAME': 'cltbld', 05:04:20 INFO - 'MAIL': '/var/mail/cltbld', 05:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:20 INFO - 'MOZ_NO_REMOTE': '1', 05:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:20 INFO - 'NO_EM_RESTART': '1', 05:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:20 INFO - 'PWD': '/builds/slave/test', 05:04:20 INFO - 'SHELL': '/bin/bash', 05:04:20 INFO - 'SHLVL': '1', 05:04:20 INFO - 'TERM': 'linux', 05:04:20 INFO - 'TMOUT': '86400', 05:04:20 INFO - 'USER': 'cltbld', 05:04:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:20 INFO - '_': '/tools/buildbot/bin/python'} 05:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:21 INFO - Downloading/unpacking flake8 05:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:04:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:04:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:04:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:23 INFO - no previously-included directories found matching 'docs/_build' 05:04:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:04:23 INFO - Running setup.py install for pep8 05:04:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:23 INFO - no previously-included directories found matching 'docs/_build' 05:04:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:04:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:04:23 INFO - Cleaning up... 05:04:24 INFO - Return code: 0 05:04:24 INFO - Running post-action listener: _resource_record_post_action 05:04:24 INFO - Running post-action listener: _start_resource_monitoring 05:04:24 INFO - Starting resource monitoring. 05:04:24 INFO - ##### 05:04:24 INFO - ##### Finished create-virtualenv step (success) 05:04:24 INFO - ##### 05:04:24 INFO - ##### 05:04:24 INFO - ##### Running install step. 05:04:24 INFO - ##### 05:04:24 INFO - Running pre-action listener: _resource_record_pre_action 05:04:24 INFO - Running main action method: install 05:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:24 INFO - Reading from file tmpfile_stdout 05:04:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:04:24 INFO - Reading from file tmpfile_stdout 05:04:24 INFO - Output received: 05:04:24 INFO - Usage: mozinstall [options] installer 05:04:24 INFO - Options: 05:04:24 INFO - -h, --help show this help message and exit 05:04:24 INFO - -d DEST, --destination=DEST 05:04:24 INFO - Directory to install application into. [default: 05:04:24 INFO - "/builds/slave/test"] 05:04:24 INFO - --app=APP Application being installed. [default: firefox] 05:04:24 INFO - mkdir: /builds/slave/test/build/application 05:04:24 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'] 05:04:24 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 05:04:41 INFO - Reading from file tmpfile_stdout 05:04:41 INFO - Output received: 05:04:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:04:41 INFO - Running post-action listener: _resource_record_post_action 05:04:41 INFO - ##### 05:04:41 INFO - ##### Finished install step (success) 05:04:41 INFO - ##### 05:04:41 INFO - ##### 05:04:41 INFO - ##### Running run-tests step. 05:04:41 INFO - ##### 05:04:41 INFO - Running pre-action listener: _resource_record_pre_action 05:04:41 INFO - Running main action method: run_tests 05:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:04:41 INFO - Python 2.7.3 05:04:41 INFO - Return code: 0 05:04:41 INFO - grabbing minidump binary from tooltool 05:04: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')]} 05:04:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a1c0>, '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 0x2b1b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:04:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:04:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:04:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:04:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:41 INFO - Return code: 0 05:04:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:04:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:04:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:04:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:04:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:04:42 INFO - Return code: 0 05:04:42 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/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 05:04:42 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/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 05:04:42 INFO - Using env: {'DISPLAY': ':0', 05:04:42 INFO - 'HOME': '/home/cltbld', 05:04:42 INFO - 'LANG': 'en_US.UTF-8', 05:04:42 INFO - 'LANGUAGE': 'en_US:en', 05:04:42 INFO - 'LOGNAME': 'cltbld', 05:04:42 INFO - 'MAIL': '/var/mail/cltbld', 05:04:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:04:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:42 INFO - 'MOZ_NO_REMOTE': '1', 05:04:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:42 INFO - 'NO_EM_RESTART': '1', 05:04:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:42 INFO - 'PWD': '/builds/slave/test', 05:04:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:04:42 INFO - 'SHELL': '/bin/bash', 05:04:42 INFO - 'SHLVL': '1', 05:04:42 INFO - 'TERM': 'linux', 05:04:42 INFO - 'TMOUT': '86400', 05:04:42 INFO - 'USER': 'cltbld', 05:04:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594', 05:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:42 INFO - '_': '/tools/buildbot/bin/python'} 05:04:42 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/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 05:04:42 INFO - mozversion application_buildid: 20160610023030 05:04:42 INFO - mozversion application_changeset: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 05:04:42 INFO - mozversion application_display_name: Nightly 05:04:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:42 INFO - mozversion application_name: Firefox 05:04:42 INFO - mozversion application_remotingname: firefox 05:04:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:04:42 INFO - mozversion application_vendor: Mozilla 05:04:42 INFO - mozversion application_version: 50.0a1 05:04:42 INFO - mozversion platform_buildid: 20160610023030 05:04:42 INFO - mozversion platform_changeset: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 05:04:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:04:42 INFO - mozversion platform_version: 50.0a1 05:04:42 INFO - using testdate: 1465560282 05:04:42 INFO - actual date: 1465560282 05:04:42 INFO - starting webserver on 'localhost:35455' 05:04:42 INFO - SUITE-START | Running 2 tests 05:04:42 INFO - TEST-START | dromaeo_css 05:04:42 INFO - operating with platform_type : linux_ 05:04:42 INFO - Initialising browser for dromaeo_css test... 05:04:42 INFO - TEST-INFO | started process 17534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpthu40o/profile http://localhost:35455/getInfo.html) 05:04:47 INFO - PROCESS | 17534 | __metrics Screen width/height:1600/1200 05:04:47 INFO - PROCESS | 17534 | colorDepth:24 05:04:47 INFO - PROCESS | 17534 | Browser inner width/height: 1024/697 05:04:47 INFO - PROCESS | 17534 | __metrics 05:04:48 ERROR - PROCESS | 17534 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:04:49 INFO - TEST-INFO | 17534: exit 0 05:04:49 INFO - Browser initialized. 05:04:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:49 INFO - TEST-INFO | started process 17655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpthu40o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:01 INFO - PROCESS | 17655 | RSS: Main: 185085952 05:05:01 INFO - PROCESS | 17655 | 05:05:50 INFO - PROCESS | 17655 | 1465560350894 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] 05:07:58 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:35455/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35455/tests/dromaeo/cssquery-ext.html) 05:07:59 INFO - PROCESS | 17655 | RSS: Main: 188002304 05:07:59 INFO - PROCESS | 17655 | 05:11:02 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:35455/tests/dromaeo/cssquery-ext.html (next: http://localhost:35455/tests/dromaeo/cssquery-jquery.html) 05:11:02 INFO - PROCESS | 17655 | RSS: Main: 187359232 05:11:02 INFO - PROCESS | 17655 | 05:14:04 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:35455/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35455/tests/dromaeo/cssquery-mootools.html) 05:14:05 INFO - PROCESS | 17655 | RSS: Main: 188379136 05:14:05 INFO - PROCESS | 17655 | 05:17:06 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:35455/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35455/tests/dromaeo/cssquery-prototype.html) 05:17:07 INFO - PROCESS | 17655 | RSS: Main: 185806848 05:17:07 INFO - PROCESS | 17655 | 05:20:09 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:35455/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35455/tests/dromaeo/cssquery-yui.html) 05:20:10 INFO - PROCESS | 17655 | RSS: Main: 187781120 05:20:10 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:35455/tests/dromaeo/cssquery-yui.html (next: http://localhost:35455/tests/dromaeo/cssquery-dojo.html) 05:23:13 INFO - PROCESS | 17655 | RSS: Main: 188768256 05:23:13 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | __start_tp_report 05:23:13 INFO - PROCESS | 17655 | _x_x_mozilla_page_load 05:23:13 INFO - PROCESS | 17655 | _x_x_mozilla_page_load_details 05:23:13 INFO - PROCESS | 17655 | |i|pagename|runs| 05:23:13 INFO - PROCESS | 17655 | |0;dojo.html;3071.3243086520965;3082.522209057594;3116.158637167964;3117.8129312241267;3132.7023932726383;5345.812896548621;5352.57179425646;5374.301340825692;5404.972975135129;5438.293021907147;5236.738163091849;5312.681239125655;5348.358197016354;5422.213779002052;5547.55619550436;4716.504766999476;4787.066522028206;4926.359573255471;4966.627502937276;4982.651214414992;813.692821026211;4776.259679749644;4841.467438581753;4943.57979571735;4970.105381031413;4895.877603059934;4949.851504454836;4958.281049247875;4961.107000739866;4961.5286547777905;4973.378327709036;4974.850754477371;4979.128652485801;4980.900381992376;5001.599872010231;4899.755012249373;4973.726445045521;5016.372953380827;5022.4224214215465;5027.145385284511;5409.161579955114;5477.616566840323;5488.9725551372385;5511.724413779335;5523.143912693539;5694.5159661428825;5741.856453588652;5774.797882074149;5781.4507621775865;5797.420257974169;5920.555958303102;5939.168516407706;5962.373950735154;5984.940150598525;6025.216721826178;5540.612157149001;5561.443855614447;5562.610617256793;5571.387147413781;5574.219609254707;5723.255976723082;5899.911501327483;5949.315828679757;6039.184710064085;6053.092036194606;5634.239377684042;5643.548516118701;5643.802466913638;5717.456841600041;5721.427857214246;5789.334226563999;5794.82615521535;5805.7387417566315;5815.098659707752;5827.446392592697;5691.544676425876;5716.228309178207;5758.539316854642;5767;5805.071188609887;5755.913661295084;5759.481646651738;5776;5778.191053252548;5799.594028418054;4392.648588112943;4438;4446.6220371268155;4453.1761624099645;4496.235639941217;3891.805409729502;3915.8433662653742;3937.114149316381;3986.5216174059296;4006.659433948147;5488.9725551372785;5572.108462645957;5572.888542229132;5584.972075139598;5659.915101273484;5722.7710891563875;5888.764449422061;5901.734421951022;5906.202662640574;5935.792247271324;5462.399136095027;5527.226188333637;5559.777608895599;5585.58108141891;5587.329520457572;4887.584555312767;4915.680480768739;4918.631102667243;4934.654574179773;4964.404271487372;5887.646741195542;5993.250843644544;6015.037593984942;6027.819165425044;6031.095335699592;5875.236219291465;5931.377205393372;5942.376050514634;5947.810437912522;5949.464548190684;6099.268087829489;6105.267367915879;6112.144299798121;6121.418465245794;6134.38656134383;5588.692621905834;5714.200011998407;5747.252857128547;5816.982028145142;5835.912461312999;5901.704914754331;5906.675132867562;5934.3175534814045;5937.643741375531;5964;5756.0502517084215;5761.567882408753;5764.625299355528;5764.625299355528;5773.6824474654295;5520.751566179451;5565.666060036411;5632.324121105494;5674.06377947634;5745.080787074048;5459.7270136492225;5559.72201389937;5592.189132575672;5599.776008959596;5603.943960560342;5645.294338207724;5664.122061080539;5696.800611978727;5702.97346477638;5704.0588302929555;5478.233047373451;5480.506754392124;5481.177823326373;5536.058869992031;5566.666000040011 05:23:13 INFO - PROCESS | 17655 | |1;ext.html;570.7545755325209;623.4139908486022;637.4804534304542;638.1863124516241;655.4854439265177;40601.390979135336;44095.77952110239;44735.32897006548;44757.55242447575;44849.77575112124;45433;46341;46495.76752116235;46500.302495462594;46586;8952.8657070144;9126.406783559081;9128.543572821365;9139.314551408637;9148.8627670585;8859;8897.911020889806;8951.23914467271;8954.641814327419;8980.685676001342;8933.776655583597;8936.910630893706;8946.64213431462;8994.730158095268;9031.412958157698;8931;8974.32692548055;9024.954875225614;9029.819403611891;9030.45817250967;8865;8952.8657070144;8958.148975847284;8962.058983806672;8970.955145224298;42682.78658606718;42743.35884961728;42840.78579607082;42963.78518107421;43031.78484107591;2977.5384815353655;3308.4044871923043;3577.749557530974;3635.1820840310984;4063.79681015948;28717.846559924343;29750.85124574385;31020.689793102007;32162.678373216204;32266;4120.423140760266;4146.813393397304;4218.2196293685765;4256.4679415073115;4306.289462238727;302194;302841;305650;305701;306072;34177.487337689956;34321.14197145091;34388.82805585956;34418.31163376718;34457.31085378329;34928.30143397118;36103.81948090243;36121.81939090288;38324.6167538321;38348.8082559591;17291.308347665952;17315.39396121155;17351.47945561635;17429.215685293937;17456.47630571085;12845.743085138432;12921.224726516439;12940.547080852126;12953.481860725655;12967.546135885199;19604.803951960297;19668;19725.309614163434;19774.30789922346;19851.404457866287;7291.4531410144455;7380.741674041383;7462.96268518654;7473.813154671177;7489.026426564621;1013.5894962540183;1025.2054657640388;1064.8722153341648;1081.7079388565044;1118.692359601116;32800.01599952005;33448.83275583606;33452;33571.32857342839;33747.83126084354;1062.1661995333625;1117.1398023521842;1120.249432879956;1129.740159763259;1145.1754736589642;16663.416780412626;17463.738043929097;17490.912545437444;17493.475195743893;17729.113544322732;592579;593714;602697;604628;604918;58475;58911;58941.70529147413;59171.40828591659;59266;1314.6056183145017;1349.7637913364924;1358.5788405594296;1359.429039803285;1374.9037567370187;31047.379052418375;31492.212694682818;32391.51412728764;32593.511097334034;33384.83307583447;49824.50175498199;51053.74473127611;51147.74426127994;51193;51252.48747512477;463622;468571;469527;470973;471444;27794.166175014783;28392.29019274452;28777;28778.712212877603;28884.42231155323;44181.77909110434;47276.527234728586;48390.75804620954;48855.267170991756;49392.753036234586;39243;40584.188316234104;41368.37947430851;42057.369139463546;42475;41134;41513.79243103886;42040.36939445972;42281;42681.146377071665;36598.63401366059;40664;42642;43102.568974309856;43541.78229108834;32783;35886.28227435489;35970.28059438849;36539.63460365469;36544.63455365519;27828.72171278261;28346;28428.282424635814;28457.857710711312;28474.57288140638 05:23:13 INFO - PROCESS | 17655 | |2;jquery.html;381.130554629542;384.97112716546246;385.79167249685173;397.8687033279018;409.94875640544933;16893.408730694428;18841.15214815333;19717.60564788707;19790.10944507497;19861.702074468896;18538.073096345197;18672.719909201373;18703.251869925185;18896.62206755864;19163.23347066116;5487.122060470326;5565.053940830068;5744.195812586241;5746.540276777848;5752.050911599602;5614.9157762633595;5653.095504719246;5658.0381335172915;5665.971670141644;5675.063614503602;5628.352739434956;5630.71846407678;5644.6613203207935;5696.829095127153;6055.848603784896;5326.467353264681;6099.603525770833;6115.296740874812;6157.753689852379;6172.22847144107;5430.402655707869;5462.617616766828;5476.17857321401;5488.807891723811;5491.752871120809;13361.398737056856;14836.406543738238;21972.450688732748;22472;22480.662790058162;2077.044559502631;2120.459282882855;2179.302623160589;2246.0791075658904;2338.871362075085;9650.662226822027;10162.237832162544;10252.641157559525;10327.32872363294;10456.52945617449;1876.9061546922735;1887.2262372427376;1946.6009468059015;1964.165229777339;2026.2199053364413;70542.64728676324;72423.27576724219;78959;83036;84634.57682711609;10258.538365773558;10454.477276136162;10777.353358798497;10859.40273284961;10954.507047182897;15073.472428464951;15113.924430377778;15120.848791512164;15158.242087895562;15214.771778423332;7810.726624568227;7832.490888092256;8064.717734879251;8085.827555004492;8291.419600628018;7449.813754656068;7468.813279668052;7505.099388073466;7577.242275772489;7732.574708391093;4468.810282961325;4559.658025648089;4589.5181005994555;4616.630669546428;4628.60656844172;1877.9718304225448;1891.6405882882484;1904.4667493101954;1962.1366598696527;1991.7012448132607;886.822635472908;941.0730430525927;950.7432993091827;1011.9494025298706;1021.8007488539663;17683.911580442273;18120.456386308433;18745.625087498447;19153.946532940823;19363;957.2868213181224;978.1734434402919;985.2807450560987;1033.1992705653029;1130.1580322659672;10542.42016689074;10881.727956801144;10910.672679819618;10954.287971281841;10977.725556861142;559505;561131;563189;567405;570751;81195.18804811877;96993.51503242439;97348;97381.5130924355;100037.49981250193;1045.984310235347;1061.9946900265295;1090.8036553420302;1095.2169199022737;1099.5272033025876;16728.74906876422;16784.41254556085;17208;17308.91345543264;17595.912020439817;43006.78496607497;43262.78368608137;44556.331655025846;44688.32967505555;44738.77630611826;59177.704111479165;60056.39943600508;62531.687341563;63212.36787632249;63945.68027159834;8373.49759014461;8552.273056789994;8638.870416943626;8813.559322033745;8849.380543361904;6385.521085918482;11684.88315116838;13380.799288010492;13623.455061797416;13685.31573421305;11345;11566.016888564567;11682.357470338873;11718.765624687629;11730.76538469243;11581.305121692725;11785.175037747274;11984.520619175135;11993.160478766751;12069.215500992408;11854.822177667169;12015.219010764273;12138.786121387791;12151.635450936486;12246.265224086583;7374.668139933823;7742;7813.257740514642;8562.957185214034;8688.826223475622;8942.68700595476;10746.623868164577;11288.604898828502;11510.194286399872;12018.218815776947 05:23:13 INFO - PROCESS | 17655 | |3;mootools.html;1461.3496993837744;1470.3383477435154;1590.6182516196109;1745.5985123421606;1764.426561367556;7976.880346794803;8273.379496537762;8478;8930.464172149676;8936.910630893697;8505.957470212656;8765.868511972325;8824.294056475483;8845;8874.822503549925;2180.7601163871923;2218.090582861027;2223.844330896838;2228.888555572215;2230.10795681727;2205.0518277140823;2240.8879556022134;2245.5845668551287;2246.4608493961414;2248.55028994201;2237.2281562860785;2239.0931672672514;2245.932622021342;2246.8764217968005;2260.2541161416775;2114.629939760551;2122.8301735861096;2127.393692797545;2127.4574983379216;2129.765725770164;2114.7990940860595;2116.481462041794;2119.13115622594;2122.862013969087;2128.4146859613575;8850.468971861708;8905.28757699389;8912.153345432174;8934.463932164026;8952.239059679934;5304.973475132639;5384.515393614593;5403.594730395197;5408.4591540845995;5410.404855465896;3164.0068147839024;3273.5759944424253;3284.50732390141;3348.8493017814258;3356.2616224430585;1057.428988346292;1089.6730980705756;1093.5844379135876;1104;1113.5545781687308;12173.2696038238;12296.385180740926;12320.75358492825;12362.505499779998;12509.687257818536;4610.631149508032;4637.86086417408;4746.810127594927;4747.715137091716;4780.617550595944;10349.74125646865;10371.274010819321;10389.376637401629;10394.064534191959;10396.896031039592;5347.438518955453;5375.6774593524515;5375.892482150335;5377.569794416438;5389.407165211824;4320.848770293024;4779.617630589544;4786.95213047872;4906.509349065136;4916.631252656065;3848.7883166425554;3874.8450061997205;3875.96124038756;3953.347697629916;4020.19596080785;1238.993805030987;1257.1388598809845;1257.861635220125;1260.8423947006625;1273.554256010389;862.8015556421933;969.5927710361665;970.3935040599625;975.3903810118676;981.2738573455734;5789.928000119713;5803.883922321615;5896.823095307148;5939.138824870456;6011.218541589566;443.5697373547654;447.6061066261734;448.47080445075125;449.46962584151015;976.1507488485064;4010.6590939770444;4013.819378127991;4039.5354534228354;4054.736442131311;4082.7754473503646;10911.127109831194;11160.497777599865;11176.10591152722;11188.384638844942;11285.830712539318;11242.213045086766;11264.0425563828;11326.716832079099;11341.376224307578;11376.715582110348;7871.134175240719;8172.509649420935;8183.79540511492;8333.958330208432;8352.791180220422;5923.614965027432;6220.129181914445;6221.191245138103;6324.083007963912;6393.1688880445245;10296.279260451696;10562.366258024544;10647.988441098083;10676;10807.108755967516;10711.303765255234;10833.51249193804;10875.836862446911;10900.236983411085;10981.945090274497;7568.621568921421;7662.501937374052;7745.225477452435;7832.255935686101;8035.83928321442;8567.186117318844;8624.698135565224;8664.653413863627;8701.259748050288;8731.214190722865;7591.202923692933;7759.961200193963;7902;7936.6428510716005;7969.8406031880195;7537.585432801029;7673.654685539276;7690.2694244046725;7723.691052358067;7860.449768516149;6807.455403567604;6858.41703455192;6868.9313106870295;6872.209695885037;6889.965550172417;4904.362432883702;5035.5719763819025;5070.8225212117395;5082.923756143735;5138.871528211825;4946.060248552763;5012.348394708664;5032.949670503248;5034.320366750442;5063.468335824686 05:23:13 INFO - PROCESS | 17655 | |4;prototype.html;317.9395914776192;328.875027489554;331.9767616266861;334.11959486752414;336.90566641340405;5406.864558442731;5545.556355491561;5563.998480273554;5611.354694210162;5619.241402410678;5522.641028333155;5589.329280486337;5628.746706398211;5640.661560306385;5641.746121424536;4395.978020109895;4415.293553031515;4420.093880754438;4443.089166720814;4460.910781784379;4138.855140070098;4363.323684828857;4388.561143885618;4442.577955094261;4476.709013914102;4298.570142985708;4310.224159651261;4315;4342.370356298351;4388.758618275993;4360.454943132108;4365.170617582649;4385.605295523418;4402.405675233835;4413.933790993137;3753.774773513598;3762.830672619739;3846.4614953906475;3848.461215429842;3861.5945325740954;5387.622866399353;5395.298611180521;5423.186522021689;5455.781768729285;5539.667619942817;4845.491223421525;4909.3126962225315;4910.926336104962;4958.380202474691;4981.729658936984;5761.9135712964335;5885.411458854123;5924.555658325643;5927.7925272615685;5948.196993405922;4179.352200408942;4214.157168566299;4215.473065866767;4228.4080228768;4229.577042295777;6134.78528251509;6135.723892424851;6155.768221683607;6194.96902515489;6223.751049957997;4178.519470260959;4206.390073439396;4247.640754958384;4269.914601707948;4273.722208056466;4301.720388174758;4305.440292761921;4323.762193079411;4328;4338.154059958341;4913.385826771653;4925.1873440881855;4985.601151907838;4992.975035124801;5007.574356179693;5618.410066942912;5872.559558033165;5897.262842144732;5899.262592175978;5987.730552125165;1457.3077788050591;1466.2375564706292;1474.6165996840898;1480.7630779075296;1485.8811295096366;908.9704388285467;927.6892241099173;928.326962951868;931.743770463128;947.1522986926662;5029.7736601853;5053.216751403538;5069.721165335868;5095.274028394791;5154;5322.4411436799355;5322.574194064466;5382.255049924488;5395.433479484597;5407.594430417735;5028.039064764745;5061.493850614983;5135.281060651511;5157.793688252503;5663.32040155184;3197.7441804655573;3219.6780321968085;3237.514372844092;3249.8862539810993;3256.46268365717;6061.7575296987625;6220.222472190976;6236.968815155895;6250.281217659936;6280.685965701697;6123.846903827351;6187.84530386744;6232.158658581124;6258.9374106259265;6264.154339164245;6184.412480814405;6197;6203.2245969253845;6211.192544969125;6224.657643829632;5753.712314384347;6055.636661800306;6057.242844644419;6058.27300723916;6093.116498107838;5990.520758339235;6012.488938440281;6018.217631708025;6037.275526936795;6045.153678484928;5593.720313984366;6148.877022459436;6307.621542707452;6318.578319877991;6325.557210995186;4180.623743863067;4192.434021407071;4205.17998990194;4216.388623649615;4227.492700875791;5962.612430192197;6048.274207095177;6055.1522786809;6072.848178795565;6085.482733967662;5716.28546431696;5885.970570147122;5886.411358864079;5915.881682366415;5942.376050514634;5842.620229685227;5856.677882716321;5897.823065308047;5904.675242861684;5918.378570250062;5462.317210348707;5715.914261286167;5737.483626473638;5763.221965034667;5796.797112101225;5812.912806307824;5820.73806678692;5875.794347197828;5877.206577112035;5959.463648271676;5720.08478643415;5728.820504619809;5741.684207368635;5743.827685169452;5753.453421924911 05:23:13 INFO - PROCESS | 17655 | |5;yui.html;691.7613423368939;696.3315217391304;727.1421518021455;735.6836560279078;811.0551207842864;15010.324535395906;16355.672886542292;16381.836181638195;16386.508404747863;16417.343306267736;14025.789613155785;14037.578872633838;14050.859491405083;14090.929545352285;14137.081089729161;666.7932940788347;788.9092754333268;794.1978601612356;808.107041718901;810.7365106340434;795.0578564401203;798.704479342644;799.0850476204743;802.1697543042952;803.9758807235793;852.0542198160038;854.4958474500044;854.6581367453007;854.8632218844986;856.9228769410752;842.6208206307156;843.9071702112763;846.2764336492334;846.6909578004046;850.4387104510993;619.2878190081398;619.9008158694587;621.3910367839497;621.9222597175353;623.1649589550025;13935.372908219155;13945.16329020252;14026.579202623938;14057.71884562303;14065.296735163303;14354;14367.928160359235;14400.423983040666;14957.326920288613;15167.620809479851;12100.6369808905;12209.816852747215;12310.75378492425;12349.753004939941;12719.872801272053;3918.1575961168487;3964.5242570891387;4088.3049881520215;4135.7932103395015;4137.420761093449;76870.23129768687;77350.22649773487;77911.22088779096;78119.60940195262;78329.86680532772;10494.842577361345;10711.571537138583;10768;10830.566777328819;11050.502727377287;22786.65820012701;23031.424214394774;23078.076876924733;23125;23276.7672323278;8249.917500825035;8678.783030424163;8701.30389568833;8732.825343493094;8894.822103557892;4463.330500424962;4563.498015218323;4699.436067671902;4797.592204662573;4935.555799978019;3554.662307080823;3644.726645501545;3668.926621467556;3674.338619048597;3728.7762734236035;674.1101745695635;679.9422049125781;689.8137502874296;695.7599628128288;702.5047341624143;620.314552419579;684.6953105867841;710.7761055267574;712.0861247340781;728.7595093619093;9734.172595329335;9926.900730992742;10147.847782283272;10240.078392944672;10369.585216591402;555.3419198250086;678.9524733268722;706.494856177825;736.5323019882413;757.6817736550662;4556.154757323289;4884.12085824555;5026.246063090565;5046.823361182414;5102.132637451642;117944.41027794806;126433;127045;130955.34522327517;131098.34450827684;69529;78244;81562;91259;109543;97339.51330243303;98278;98729;99987;100526.49736751123;9602.357286134675;9728.9027109728;9784.706458806248;9787.46168960714;9925.454100024568;50128.49871501384;51362;52359.47640523546;53008.73495632497;54467.72766136144;79635;80942;82526.58736706278;83505;85187.5740621293;13343.66640833948;13419.463221471031;13419.798703019267;13507.662308441975;13856.307184640526;14071.718565628425;14496.111366887604;14783.778243326144;14805.851941480447;15578.688426231638;14265.64335891611;14472.421103156177;14597.92701036488;14616.488422905148;14947.775783363475;14154.858451415354;14436;14790.03864748788;14900.850991489946;15062.341163071595;14130.222837744022;14329.283535822959;14476.855231447971;14543.272836357928;14693.795930610493;10983.560657573928;11269.436528173723;11370.374629395463;11423.086153107564;11600.662610746142;11269.267497612629;11823.503643821405;12054.457549410474;12114.818277725664;12155.331456769962 05:23:13 INFO - PROCESS | 17655 | __end_tp_report 05:23:13 INFO - PROCESS | 17655 | __start_cc_report 05:23:13 INFO - PROCESS | 17655 | _x_x_mozilla_cycle_collect,370 05:23:13 INFO - PROCESS | 17655 | __end_cc_report 05:23:13 INFO - PROCESS | 17655 | __startTimestamp1465561393543__endTimestamp 05:23:13 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | ------- Summary: start ------- 05:23:13 INFO - PROCESS | 17655 | Number of tests: 6 05:23:13 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | [#0] dojo.html Cycles:165 Average:5381.24 Median:5588.69 stddev:724.65 (13.0%) stddev-sans-first:703.85 05:23:13 INFO - PROCESS | 17655 | Values: 3071.3 3082.5 3116.2 3117.8 3132.7 5345.8 5352.6 5374.3 5405.0 5438.3 5236.7 5312.7 5348.4 5422.2 5547.6 4716.5 4787.1 4926.4 4966.6 4982.7 813.7 4776.3 4841.5 4943.6 4970.1 4895.9 4949.9 4958.3 4961.1 4961.5 4973.4 4974.9 4979.1 4980.9 5001.6 4899.8 4973.7 5016.4 5022.4 5027.1 5409.2 5477.6 5489.0 5511.7 5523.1 5694.5 5741.9 5774.8 5781.5 5797.4 5920.6 5939.2 5962.4 5984.9 6025.2 5540.6 5561.4 5562.6 5571.4 5574.2 5723.3 5899.9 5949.3 6039.2 6053.1 5634.2 5643.5 5643.8 5717.5 5721.4 5789.3 5794.8 5805.7 5815.1 5827.4 5691.5 5716.2 5758.5 5767.0 5805.1 5755.9 5759.5 5776.0 5778.2 5799.6 4392.6 4438.0 4446.6 4453.2 4496.2 3891.8 3915.8 3937.1 3986.5 4006.7 5489.0 5572.1 5572.9 5585.0 5659.9 5722.8 5888.8 5901.7 5906.2 5935.8 5462.4 5527.2 5559.8 5585.6 5587.3 4887.6 4915.7 4918.6 4934.7 4964.4 5887.6 5993.3 6015.0 6027.8 6031.1 5875.2 5931.4 5942.4 5947.8 5949.5 6099.3 6105.3 6112.1 6121.4 6134.4 5588.7 5714.2 5747.3 5817.0 5835.9 5901.7 5906.7 5934.3 5937.6 5964.0 5756.1 5761.6 5764.6 5764.6 5773.7 5520.8 5565.7 5632.3 5674.1 5745.1 5459.7 5559.7 5592.2 5599.8 5603.9 5645.3 5664.1 5696.8 5703.0 5704.1 5478.2 5480.5 5481.2 5536.1 5566.7 05:23:13 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | [#1] ext.html Cycles:180 Average:60535.91 Median:22627.21 stddev:126164.85 (557.6%) stddev-sans-first:126438.45 05:23:13 INFO - PROCESS | 17655 | Values: 570.8 623.4 637.5 638.2 655.5 40601.4 44095.8 44735.3 44757.6 44849.8 45433.0 46341.0 46495.8 46500.3 46586.0 8952.9 9126.4 9128.5 9139.3 9148.9 8859.0 8897.9 8951.2 8954.6 8980.7 8933.8 8936.9 8946.6 8994.7 9031.4 8931.0 8974.3 9025.0 9029.8 9030.5 8865.0 8952.9 8958.1 8962.1 8971.0 42682.8 42743.4 42840.8 42963.8 43031.8 2977.5 3308.4 3577.7 3635.2 4063.8 28717.8 29750.9 31020.7 32162.7 32266.0 4120.4 4146.8 4218.2 4256.5 4306.3 302194.0 302841.0 305650.0 305701.0 306072.0 34177.5 34321.1 34388.8 34418.3 34457.3 34928.3 36103.8 36121.8 38324.6 38348.8 17291.3 17315.4 17351.5 17429.2 17456.5 12845.7 12921.2 12940.5 12953.5 12967.5 19604.8 19668.0 19725.3 19774.3 19851.4 7291.5 7380.7 7463.0 7473.8 7489.0 1013.6 1025.2 1064.9 1081.7 1118.7 32800.0 33448.8 33452.0 33571.3 33747.8 1062.2 1117.1 1120.2 1129.7 1145.2 16663.4 17463.7 17490.9 17493.5 17729.1 592579.0 593714.0 602697.0 604628.0 604918.0 58475.0 58911.0 58941.7 59171.4 59266.0 1314.6 1349.8 1358.6 1359.4 1374.9 31047.4 31492.2 32391.5 32593.5 33384.8 49824.5 51053.7 51147.7 51193.0 51252.5 463622.0 468571.0 469527.0 470973.0 471444.0 27794.2 28392.3 28777.0 28778.7 28884.4 44181.8 47276.5 48390.8 48855.3 49392.8 39243.0 40584.2 41368.4 42057.4 42475.0 41134.0 41513.8 42040.4 42281.0 42681.1 36598.6 40664.0 42642.0 43102.6 43541.8 32783.0 35886.3 35970.3 36539.6 36544.6 27828.7 28346.0 28428.3 28457.9 28474.6 05:23:13 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | [#2] jquery.html Cycles:180 Average:30977.25 Median:12409.77 stddev:92802.41 (747.8%) stddev-sans-first:93034.31 05:23:13 INFO - PROCESS | 17655 | Values: 381.1 385.0 385.8 397.9 409.9 16893.4 18841.2 19717.6 19790.1 19861.7 18538.1 18672.7 18703.3 18896.6 19163.2 5487.1 5565.1 5744.2 5746.5 5752.1 5614.9 5653.1 5658.0 5666.0 5675.1 5628.4 5630.7 5644.7 5696.8 6055.8 5326.5 6099.6 6115.3 6157.8 6172.2 5430.4 5462.6 5476.2 5488.8 5491.8 13361.4 14836.4 21972.5 22472.0 22480.7 2077.0 2120.5 2179.3 2246.1 2338.9 9650.7 10162.2 10252.6 10327.3 10456.5 1876.9 1887.2 1946.6 1964.2 2026.2 70542.6 72423.3 78959.0 83036.0 84634.6 10258.5 10454.5 10777.4 10859.4 10954.5 15073.5 15113.9 15120.8 15158.2 15214.8 7810.7 7832.5 8064.7 8085.8 8291.4 7449.8 7468.8 7505.1 7577.2 7732.6 4468.8 4559.7 4589.5 4616.6 4628.6 1878.0 1891.6 1904.5 1962.1 1991.7 886.8 941.1 950.7 1011.9 1021.8 17683.9 18120.5 18745.6 19153.9 19363.0 957.3 978.2 985.3 1033.2 1130.2 10542.4 10881.7 10910.7 10954.3 10977.7 559505.0 561131.0 563189.0 567405.0 570751.0 81195.2 96993.5 97348.0 97381.5 100037.5 1046.0 1062.0 1090.8 1095.2 1099.5 16728.7 16784.4 17208.0 17308.9 17595.9 43006.8 43262.8 44556.3 44688.3 44738.8 59177.7 60056.4 62531.7 63212.4 63945.7 8373.5 8552.3 8638.9 8813.6 8849.4 6385.5 11684.9 13380.8 13623.5 13685.3 11345.0 11566.0 11682.4 11718.8 11730.8 11581.3 11785.2 11984.5 11993.2 12069.2 11854.8 12015.2 12138.8 12151.6 12246.3 7374.7 7742.0 7813.3 8563.0 8688.8 8942.7 10746.6 11288.6 11510.2 12018.2 05:23:13 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | [#3] mootools.html Cycles:180 Average:5828.72 Median:4624.25 stddev:3415.93 (73.9%) stddev-sans-first:3409.74 05:23:13 INFO - PROCESS | 17655 | Values: 1461.3 1470.3 1590.6 1745.6 1764.4 7976.9 8273.4 8478.0 8930.5 8936.9 8506.0 8765.9 8824.3 8845.0 8874.8 2180.8 2218.1 2223.8 2228.9 2230.1 2205.1 2240.9 2245.6 2246.5 2248.6 2237.2 2239.1 2245.9 2246.9 2260.3 2114.6 2122.8 2127.4 2127.5 2129.8 2114.8 2116.5 2119.1 2122.9 2128.4 8850.5 8905.3 8912.2 8934.5 8952.2 5305.0 5384.5 5403.6 5408.5 5410.4 3164.0 3273.6 3284.5 3348.8 3356.3 1057.4 1089.7 1093.6 1104.0 1113.6 12173.3 12296.4 12320.8 12362.5 12509.7 4610.6 4637.9 4746.8 4747.7 4780.6 10349.7 10371.3 10389.4 10394.1 10396.9 5347.4 5375.7 5375.9 5377.6 5389.4 4320.8 4779.6 4787.0 4906.5 4916.6 3848.8 3874.8 3876.0 3953.3 4020.2 1239.0 1257.1 1257.9 1260.8 1273.6 862.8 969.6 970.4 975.4 981.3 5789.9 5803.9 5896.8 5939.1 6011.2 443.6 447.6 448.5 449.5 976.2 4010.7 4013.8 4039.5 4054.7 4082.8 10911.1 11160.5 11176.1 11188.4 11285.8 11242.2 11264.0 11326.7 11341.4 11376.7 7871.1 8172.5 8183.8 8334.0 8352.8 5923.6 6220.1 6221.2 6324.1 6393.2 10296.3 10562.4 10648.0 10676.0 10807.1 10711.3 10833.5 10875.8 10900.2 10981.9 7568.6 7662.5 7745.2 7832.3 8035.8 8567.2 8624.7 8664.7 8701.3 8731.2 7591.2 7760.0 7902.0 7936.6 7969.8 7537.6 7673.7 7690.3 7723.7 7860.4 6807.5 6858.4 6868.9 6872.2 6890.0 4904.4 5035.6 5070.8 5082.9 5138.9 4946.1 5012.3 5032.9 5034.3 5063.5 05:23:13 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | [#4] prototype.html Cycles:180 Average:4894.37 Median:5531.15 stddev:1448.78 (26.2%) stddev-sans-first:1411.53 05:23:13 INFO - PROCESS | 17655 | Values: 317.9 328.9 332.0 334.1 336.9 5406.9 5545.6 5564.0 5611.4 5619.2 5522.6 5589.3 5628.7 5640.7 5641.7 4396.0 4415.3 4420.1 4443.1 4460.9 4138.9 4363.3 4388.6 4442.6 4476.7 4298.6 4310.2 4315.0 4342.4 4388.8 4360.5 4365.2 4385.6 4402.4 4413.9 3753.8 3762.8 3846.5 3848.5 3861.6 5387.6 5395.3 5423.2 5455.8 5539.7 4845.5 4909.3 4910.9 4958.4 4981.7 5761.9 5885.4 5924.6 5927.8 5948.2 4179.4 4214.2 4215.5 4228.4 4229.6 6134.8 6135.7 6155.8 6195.0 6223.8 4178.5 4206.4 4247.6 4269.9 4273.7 4301.7 4305.4 4323.8 4328.0 4338.2 4913.4 4925.2 4985.6 4993.0 5007.6 5618.4 5872.6 5897.3 5899.3 5987.7 1457.3 1466.2 1474.6 1480.8 1485.9 909.0 927.7 928.3 931.7 947.2 5029.8 5053.2 5069.7 5095.3 5154.0 5322.4 5322.6 5382.3 5395.4 5407.6 5028.0 5061.5 5135.3 5157.8 5663.3 3197.7 3219.7 3237.5 3249.9 3256.5 6061.8 6220.2 6237.0 6250.3 6280.7 6123.8 6187.8 6232.2 6258.9 6264.2 6184.4 6197.0 6203.2 6211.2 6224.7 5753.7 6055.6 6057.2 6058.3 6093.1 5990.5 6012.5 6018.2 6037.3 6045.2 5593.7 6148.9 6307.6 6318.6 6325.6 4180.6 4192.4 4205.2 4216.4 4227.5 5962.6 6048.3 6055.2 6072.8 6085.5 5716.3 5886.0 5886.4 5915.9 5942.4 5842.6 5856.7 5897.8 5904.7 5918.4 5462.3 5715.9 5737.5 5763.2 5796.8 5812.9 5820.7 5875.8 5877.2 5959.5 5720.1 5728.8 5741.7 5743.8 5753.5 05:23:13 INFO - PROCESS | 17655 | 05:23:13 INFO - PROCESS | 17655 | [#5] yui.html Cycles:180 Average:21575.14 Median:4509.74 stddev:31529.90 (699.2%) stddev-sans-first:31579.36 05:23:13 INFO - PROCESS | 17655 | Values: 691.8 696.3 727.1 735.7 811.1 15010.3 16355.7 16381.8 16386.5 16417.3 14025.8 14037.6 14050.9 14090.9 14137.1 666.8 788.9 794.2 808.1 810.7 795.1 798.7 799.1 802.2 804.0 852.1 854.5 854.7 854.9 856.9 842.6 843.9 846.3 846.7 850.4 619.3 619.9 621.4 621.9 623.2 13935.4 13945.2 14026.6 14057.7 14065.3 14354.0 14367.9 14400.4 14957.3 15167.6 12100.6 12209.8 12310.8 12349.8 12719.9 3918.2 3964.5 4088.3 4135.8 4137.4 76870.2 77350.2 77911.2 78119.6 78329.9 10494.8 10711.6 10768.0 10830.6 11050.5 22786.7 23031.4 23078.1 23125.0 23276.8 8249.9 8678.8 8701.3 8732.8 8894.8 4463.3 4563.5 4699.4 4797.6 4935.6 3554.7 3644.7 3668.9 3674.3 3728.8 674.1 679.9 689.8 695.8 702.5 620.3 684.7 710.8 712.1 728.8 9734.2 9926.9 10147.8 10240.1 10369.6 555.3 679.0 706.5 736.5 757.7 4556.2 4884.1 5026.2 5046.8 5102.1 117944.4 126433.0 127045.0 130955.3 131098.3 69529.0 78244.0 81562.0 91259.0 109543.0 97339.5 98278.0 98729.0 99987.0 100526.5 9602.4 9728.9 9784.7 9787.5 9925.5 50128.5 51362.0 52359.5 53008.7 54467.7 79635.0 80942.0 82526.6 83505.0 85187.6 13343.7 13419.5 13419.8 13507.7 13856.3 14071.7 14496.1 14783.8 14805.9 15578.7 14265.6 14472.4 14597.9 14616.5 14947.8 14154.9 14436.0 14790.0 14900.9 15062.3 14130.2 14329.3 14476.9 14543.3 14693.8 10983.6 11269.4 11370.4 11423.1 11600.7 11269.3 11823.5 12054.5 12114.8 12155.3 05:23:13 INFO - PROCESS | 17655 | -------- Summary: end -------- 05:23:13 INFO - PROCESS | 17655 | 05:23:14 INFO - TEST-INFO | 17655: exit 0 05:23:14 INFO - TEST-OK | dromaeo_css | took 1111922ms 05:23:14 INFO - TEST-START | kraken 05:23:14 INFO - operating with platform_type : linux_ 05:23:14 INFO - Initialising browser for kraken test... 05:23:14 INFO - TEST-INFO | started process 17899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAuISCI/profile http://localhost:35455/getInfo.html) 05:23:19 INFO - PROCESS | 17899 | __metrics Screen width/height:1600/1200 05:23:19 INFO - PROCESS | 17899 | colorDepth:24 05:23:19 INFO - PROCESS | 17899 | Browser inner width/height: 1024/697 05:23:19 INFO - PROCESS | 17899 | __metrics 05:23:20 ERROR - PROCESS | 17899 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:23:21 INFO - TEST-INFO | 17899: exit 0 05:23:21 INFO - Browser initialized. 05:23:21 INFO - Running cycle 1/1 for kraken test... 05:23:21 INFO - TEST-INFO | started process 18022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAuISCI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:33 INFO - PROCESS | 18022 | RSS: Main: 184696832 05:23:33 INFO - PROCESS | 18022 | 05:23:35 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35455/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:36 INFO - PROCESS | 18022 | RSS: Main: 189882368 05:23:36 INFO - PROCESS | 18022 | 05:23:39 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35455/tests/kraken/driver.html?testName=audio-dft) 05:23:39 INFO - PROCESS | 18022 | RSS: Main: 189140992 05:23:39 INFO - PROCESS | 18022 | 05:23:42 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35455/tests/kraken/driver.html?testName=audio-fft) 05:23:43 INFO - PROCESS | 18022 | RSS: Main: 183971840 05:23:43 INFO - PROCESS | 18022 | 05:23:45 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35455/tests/kraken/driver.html?testName=audio-oscillator) 05:23:46 INFO - PROCESS | 18022 | RSS: Main: 185229312 05:23:46 INFO - PROCESS | 18022 | 05:23:48 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35455/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:48 INFO - PROCESS | 18022 | RSS: Main: 185307136 05:23:48 INFO - PROCESS | 18022 | 05:23:51 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35455/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:52 INFO - PROCESS | 18022 | RSS: Main: 185098240 05:23:52 INFO - PROCESS | 18022 | 05:23:55 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35455/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:56 INFO - PROCESS | 18022 | RSS: Main: 183033856 05:23:56 INFO - PROCESS | 18022 | 05:23:59 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35455/tests/kraken/driver.html?testName=json-parse-financial) 05:24:00 INFO - PROCESS | 18022 | RSS: Main: 184967168 05:24:00 INFO - PROCESS | 18022 | 05:24:01 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35455/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:02 INFO - PROCESS | 18022 | RSS: Main: 184918016 05:24:02 INFO - PROCESS | 18022 | 05:24:04 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35455/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:04 INFO - PROCESS | 18022 | RSS: Main: 185049088 05:24:04 INFO - PROCESS | 18022 | 05:24:06 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35455/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:07 INFO - PROCESS | 18022 | RSS: Main: 185303040 05:24:07 INFO - PROCESS | 18022 | 05:24:10 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:10 INFO - PROCESS | 18022 | RSS: Main: 185376768 05:24:10 INFO - PROCESS | 18022 | 05:24:13 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:14 INFO - PROCESS | 18022 | RSS: Main: 185417728 05:24:14 INFO - PROCESS | 18022 | 05:24:15 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:35455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35455/tests/kraken/driver.html?testName=ai-astar) 05:24:15 INFO - PROCESS | 18022 | RSS: Main: 185749504 05:24:15 INFO - PROCESS | 18022 | 05:24:15 INFO - PROCESS | 18022 | __start_tp_report 05:24:15 INFO - PROCESS | 18022 | _x_x_mozilla_page_load 05:24:15 INFO - PROCESS | 18022 | _x_x_mozilla_page_load_details 05:24:15 INFO - PROCESS | 18022 | |i|pagename|runs| 05:24:15 INFO - PROCESS | 18022 | |0;ai-astar;112;105;115;109;111;110;110;110;109;110 05:24:15 INFO - PROCESS | 18022 | |1;audio-beat-detection;156;126;157;184;132;151;160;136;197;136 05:24:16 INFO - PROCESS | 18022 | |2;audio-dft;162;163;164;163;164;171;163;160;166;164 05:24:16 INFO - PROCESS | 18022 | |3;audio-fft;76;75;76;159;76;75;75;75;176;77 05:24:16 INFO - PROCESS | 18022 | |4;audio-oscillator;89;87;141;86;85;85;146;85;86;140 05:24:16 INFO - PROCESS | 18022 | |5;imaging-gaussian-blur;118;118;118;117;118;117;117;117;118;117 05:24:16 INFO - PROCESS | 18022 | |6;imaging-darkroom;147;147;147;147;148;147;147;148;147;147 05:24:16 INFO - PROCESS | 18022 | |7;imaging-desaturate;94;105;96;95;94;95;95;97;95;95 05:24:16 INFO - PROCESS | 18022 | |8;json-parse-financial;62;55;56;55;70;56;55;57;55;58 05:24:16 INFO - PROCESS | 18022 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;61;61;61 05:24:16 INFO - PROCESS | 18022 | |10;stanford-crypto-aes;81;82;81;86;82;82;80;80;104;90 05:24:16 INFO - PROCESS | 18022 | |11;stanford-crypto-ccm;135;138;137;123;136;123;136;129;126;127 05:24:16 INFO - PROCESS | 18022 | |12;stanford-crypto-pbkdf2;156;159;163;158;168;156;159;159;157;158 05:24:16 INFO - PROCESS | 18022 | |13;stanford-crypto-sha256-iterative;64;64;64;64;67;63;62;62;64;63 05:24:16 INFO - PROCESS | 18022 | __end_tp_report 05:24:16 INFO - PROCESS | 18022 | __start_cc_report 05:24:16 INFO - PROCESS | 18022 | _x_x_mozilla_cycle_collect,850 05:24:16 INFO - PROCESS | 18022 | __end_cc_report 05:24:16 INFO - PROCESS | 18022 | __startTimestamp1465561455996__endTimestamp 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | ------- Summary: start ------- 05:24:16 INFO - PROCESS | 18022 | Number of tests: 14 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:2.51 (2.3%) stddev-sans-first:2.57 05:24:16 INFO - PROCESS | 18022 | Values: 112.0 105.0 115.0 109.0 111.0 110.0 110.0 110.0 109.0 110.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:156.50 stddev:22.90 (14.6%) stddev-sans-first:24.27 05:24:16 INFO - PROCESS | 18022 | Values: 156.0 126.0 157.0 184.0 132.0 151.0 160.0 136.0 197.0 136.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.91 (1.8%) stddev-sans-first:2.99 05:24:16 INFO - PROCESS | 18022 | Values: 162.0 163.0 164.0 163.0 164.0 171.0 163.0 160.0 166.0 164.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:38.95 (51.6%) stddev-sans-first:40.76 05:24:16 INFO - PROCESS | 18022 | Values: 76.0 75.0 76.0 159.0 76.0 75.0 75.0 75.0 176.0 77.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.50 stddev:27.21 (31.8%) stddev-sans-first:28.39 05:24:16 INFO - PROCESS | 18022 | Values: 89.0 87.0 141.0 86.0 85.0 85.0 146.0 85.0 86.0 140.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:24:16 INFO - PROCESS | 18022 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:24:16 INFO - PROCESS | 18022 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:3.25 (3.4%) stddev-sans-first:3.35 05:24:16 INFO - PROCESS | 18022 | Values: 94.0 105.0 96.0 95.0 94.0 95.0 95.0 97.0 95.0 95.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:56.50 stddev:4.77 (8.4%) stddev-sans-first:4.82 05:24:16 INFO - PROCESS | 18022 | Values: 62.0 55.0 56.0 55.0 70.0 56.0 55.0 57.0 55.0 58.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:24:16 INFO - PROCESS | 18022 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:82.00 stddev:7.42 (9.0%) stddev-sans-first:7.74 05:24:16 INFO - PROCESS | 18022 | Values: 81.0 82.0 81.0 86.0 82.0 82.0 80.0 80.0 104.0 90.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:135.50 stddev:6.00 (4.4%) stddev-sans-first:6.19 05:24:16 INFO - PROCESS | 18022 | Values: 135.0 138.0 137.0 123.0 136.0 123.0 136.0 129.0 126.0 127.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.00 stddev:3.65 (2.3%) stddev-sans-first:3.67 05:24:16 INFO - PROCESS | 18022 | Values: 156.0 159.0 163.0 158.0 168.0 156.0 159.0 159.0 157.0 158.0 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - PROCESS | 18022 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.42 (2.2%) stddev-sans-first:1.50 05:24:16 INFO - PROCESS | 18022 | Values: 64.0 64.0 64.0 64.0 67.0 63.0 62.0 62.0 64.0 63.0 05:24:16 INFO - PROCESS | 18022 | -------- Summary: end -------- 05:24:16 INFO - PROCESS | 18022 | 05:24:16 INFO - TEST-INFO | 18022: exit 0 05:24:17 INFO - TEST-OK | kraken | took 62663ms 05:24:17 INFO - SUITE-END | took 1174s 05:24:17 INFO - Completed test suite (00:19:34) 05:24:17 INFO - javascript benchmark 05:24:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7283.400759844081, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.3243086520965, 3082.522209057594, 3116.158637167964, 3117.8129312241267, 3132.7023932726383, 5345.812896548621, 5352.57179425646, 5374.301340825692, 5404.972975135129, 5438.293021907147, 5236.738163091849, 5312.681239125655, 5348.358197016354, 5422.213779002052, 5547.55619550436, 4716.504766999476, 4787.066522028206, 4926.359573255471, 4966.627502937276, 4982.651214414992, 813.692821026211, 4776.259679749644, 4841.467438581753, 4943.57979571735, 4970.105381031413, 4895.877603059934, 4949.851504454836, 4958.281049247875, 4961.107000739866, 4961.5286547777905, 4973.378327709036, 4974.850754477371, 4979.128652485801, 4980.900381992376, 5001.599872010231, 4899.755012249373, 4973.726445045521, 5016.372953380827, 5022.4224214215465, 5027.145385284511, 5409.161579955114, 5477.616566840323, 5488.9725551372385, 5511.724413779335, 5523.143912693539, 5694.5159661428825, 5741.856453588652, 5774.797882074149, 5781.4507621775865, 5797.420257974169, 5920.555958303102, 5939.168516407706, 5962.373950735154, 5984.940150598525, 6025.216721826178, 5540.612157149001, 5561.443855614447, 5562.610617256793, 5571.387147413781, 5574.219609254707, 5723.255976723082, 5899.911501327483, 5949.315828679757, 6039.184710064085, 6053.092036194606, 5634.239377684042, 5643.548516118701, 5643.802466913638, 5717.456841600041, 5721.427857214246, 5789.334226563999, 5794.82615521535, 5805.7387417566315, 5815.098659707752, 5827.446392592697, 5691.544676425876, 5716.228309178207, 5758.539316854642, 5767.0, 5805.071188609887, 5755.913661295084, 5759.481646651738, 5776.0, 5778.191053252548, 5799.594028418054, 4392.648588112943, 4438.0, 4446.6220371268155, 4453.1761624099645, 4496.235639941217, 3891.805409729502, 3915.8433662653742, 3937.114149316381, 3986.5216174059296, 4006.659433948147, 5488.9725551372785, 5572.108462645957, 5572.888542229132, 5584.972075139598, 5659.915101273484, 5722.7710891563875, 5888.764449422061, 5901.734421951022, 5906.202662640574, 5935.792247271324, 5462.399136095027, 5527.226188333637, 5559.777608895599, 5585.58108141891, 5587.329520457572, 4887.584555312767, 4915.680480768739, 4918.631102667243, 4934.654574179773, 4964.404271487372, 5887.646741195542, 5993.250843644544, 6015.037593984942, 6027.819165425044, 6031.095335699592, 5875.236219291465, 5931.377205393372, 5942.376050514634, 5947.810437912522, 5949.464548190684, 6099.268087829489, 6105.267367915879, 6112.144299798121, 6121.418465245794, 6134.38656134383, 5588.692621905834, 5714.200011998407, 5747.252857128547, 5816.982028145142, 5835.912461312999, 5901.704914754331, 5906.675132867562, 5934.3175534814045, 5937.643741375531, 5964.0, 5756.0502517084215, 5761.567882408753, 5764.625299355528, 5764.625299355528, 5773.6824474654295, 5520.751566179451, 5565.666060036411, 5632.324121105494, 5674.06377947634, 5745.080787074048, 5459.7270136492225, 5559.72201389937, 5592.189132575672, 5599.776008959596, 5603.943960560342, 5645.294338207724, 5664.122061080539, 5696.800611978727, 5702.97346477638, 5704.0588302929555, 5478.233047373451, 5480.506754392124, 5481.177823326373, 5536.058869992031, 5566.666000040011], "value": 5332.443986728556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7545755325209, 623.4139908486022, 637.4804534304542, 638.1863124516241, 655.4854439265177, 40601.390979135336, 44095.77952110239, 44735.32897006548, 44757.55242447575, 44849.77575112124, 45433.0, 46341.0, 46495.76752116235, 46500.302495462594, 46586.0, 8952.8657070144, 9126.406783559081, 9128.543572821365, 9139.314551408637, 9148.8627670585, 8859.0, 8897.911020889806, 8951.23914467271, 8954.641814327419, 8980.685676001342, 8933.776655583597, 8936.910630893706, 8946.64213431462, 8994.730158095268, 9031.412958157698, 8931.0, 8974.32692548055, 9024.954875225614, 9029.819403611891, 9030.45817250967, 8865.0, 8952.8657070144, 8958.148975847284, 8962.058983806672, 8970.955145224298, 42682.78658606718, 42743.35884961728, 42840.78579607082, 42963.78518107421, 43031.78484107591, 2977.5384815353655, 3308.4044871923043, 3577.749557530974, 3635.1820840310984, 4063.79681015948, 28717.846559924343, 29750.85124574385, 31020.689793102007, 32162.678373216204, 32266.0, 4120.423140760266, 4146.813393397304, 4218.2196293685765, 4256.4679415073115, 4306.289462238727, 302194.0, 302841.0, 305650.0, 305701.0, 306072.0, 34177.487337689956, 34321.14197145091, 34388.82805585956, 34418.31163376718, 34457.31085378329, 34928.30143397118, 36103.81948090243, 36121.81939090288, 38324.6167538321, 38348.8082559591, 17291.308347665952, 17315.39396121155, 17351.47945561635, 17429.215685293937, 17456.47630571085, 12845.743085138432, 12921.224726516439, 12940.547080852126, 12953.481860725655, 12967.546135885199, 19604.803951960297, 19668.0, 19725.309614163434, 19774.30789922346, 19851.404457866287, 7291.4531410144455, 7380.741674041383, 7462.96268518654, 7473.813154671177, 7489.026426564621, 1013.5894962540183, 1025.2054657640388, 1064.8722153341648, 1081.7079388565044, 1118.692359601116, 32800.01599952005, 33448.83275583606, 33452.0, 33571.32857342839, 33747.83126084354, 1062.1661995333625, 1117.1398023521842, 1120.249432879956, 1129.740159763259, 1145.1754736589642, 16663.416780412626, 17463.738043929097, 17490.912545437444, 17493.475195743893, 17729.113544322732, 592579.0, 593714.0, 602697.0, 604628.0, 604918.0, 58475.0, 58911.0, 58941.70529147413, 59171.40828591659, 59266.0, 1314.6056183145017, 1349.7637913364924, 1358.5788405594296, 1359.429039803285, 1374.9037567370187, 31047.379052418375, 31492.212694682818, 32391.51412728764, 32593.511097334034, 33384.83307583447, 49824.50175498199, 51053.74473127611, 51147.74426127994, 51193.0, 51252.48747512477, 463622.0, 468571.0, 469527.0, 470973.0, 471444.0, 27794.166175014783, 28392.29019274452, 28777.0, 28778.712212877603, 28884.42231155323, 44181.77909110434, 47276.527234728586, 48390.75804620954, 48855.267170991756, 49392.753036234586, 39243.0, 40584.188316234104, 41368.37947430851, 42057.369139463546, 42475.0, 41134.0, 41513.79243103886, 42040.36939445972, 42281.0, 42681.146377071665, 36598.63401366059, 40664.0, 42642.0, 43102.568974309856, 43541.78229108834, 32783.0, 35886.28227435489, 35970.28059438849, 36539.63460365469, 36544.63455365519, 27828.72171278261, 28346.0, 28428.282424635814, 28457.857710711312, 28474.57288140638], "value": 19767.22227809184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.130554629542, 384.97112716546246, 385.79167249685173, 397.8687033279018, 409.94875640544933, 16893.408730694428, 18841.15214815333, 19717.60564788707, 19790.10944507497, 19861.702074468896, 18538.073096345197, 18672.719909201373, 18703.251869925185, 18896.62206755864, 19163.23347066116, 5487.122060470326, 5565.053940830068, 5744.195812586241, 5746.540276777848, 5752.050911599602, 5614.9157762633595, 5653.095504719246, 5658.0381335172915, 5665.971670141644, 5675.063614503602, 5628.352739434956, 5630.71846407678, 5644.6613203207935, 5696.829095127153, 6055.848603784896, 5326.467353264681, 6099.603525770833, 6115.296740874812, 6157.753689852379, 6172.22847144107, 5430.402655707869, 5462.617616766828, 5476.17857321401, 5488.807891723811, 5491.752871120809, 13361.398737056856, 14836.406543738238, 21972.450688732748, 22472.0, 22480.662790058162, 2077.044559502631, 2120.459282882855, 2179.302623160589, 2246.0791075658904, 2338.871362075085, 9650.662226822027, 10162.237832162544, 10252.641157559525, 10327.32872363294, 10456.52945617449, 1876.9061546922735, 1887.2262372427376, 1946.6009468059015, 1964.165229777339, 2026.2199053364413, 70542.64728676324, 72423.27576724219, 78959.0, 83036.0, 84634.57682711609, 10258.538365773558, 10454.477276136162, 10777.353358798497, 10859.40273284961, 10954.507047182897, 15073.472428464951, 15113.924430377778, 15120.848791512164, 15158.242087895562, 15214.771778423332, 7810.726624568227, 7832.490888092256, 8064.717734879251, 8085.827555004492, 8291.419600628018, 7449.813754656068, 7468.813279668052, 7505.099388073466, 7577.242275772489, 7732.574708391093, 4468.810282961325, 4559.658025648089, 4589.5181005994555, 4616.630669546428, 4628.60656844172, 1877.9718304225448, 1891.6405882882484, 1904.4667493101954, 1962.1366598696527, 1991.7012448132607, 886.822635472908, 941.0730430525927, 950.7432993091827, 1011.9494025298706, 1021.8007488539663, 17683.911580442273, 18120.456386308433, 18745.625087498447, 19153.946532940823, 19363.0, 957.2868213181224, 978.1734434402919, 985.2807450560987, 1033.1992705653029, 1130.1580322659672, 10542.42016689074, 10881.727956801144, 10910.672679819618, 10954.287971281841, 10977.725556861142, 559505.0, 561131.0, 563189.0, 567405.0, 570751.0, 81195.18804811877, 96993.51503242439, 97348.0, 97381.5130924355, 100037.49981250193, 1045.984310235347, 1061.9946900265295, 1090.8036553420302, 1095.2169199022737, 1099.5272033025876, 16728.74906876422, 16784.41254556085, 17208.0, 17308.91345543264, 17595.912020439817, 43006.78496607497, 43262.78368608137, 44556.331655025846, 44688.32967505555, 44738.77630611826, 59177.704111479165, 60056.39943600508, 62531.687341563, 63212.36787632249, 63945.68027159834, 8373.49759014461, 8552.273056789994, 8638.870416943626, 8813.559322033745, 8849.380543361904, 6385.521085918482, 11684.88315116838, 13380.799288010492, 13623.455061797416, 13685.31573421305, 11345.0, 11566.016888564567, 11682.357470338873, 11718.765624687629, 11730.76538469243, 11581.305121692725, 11785.175037747274, 11984.520619175135, 11993.160478766751, 12069.215500992408, 11854.822177667169, 12015.219010764273, 12138.786121387791, 12151.635450936486, 12246.265224086583, 7374.668139933823, 7742.0, 7813.257740514642, 8562.957185214034, 8688.826223475622, 8942.68700595476, 10746.623868164577, 11288.604898828502, 11510.194286399872, 12018.218815776947], "value": 9122.430937879166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.3496993837744, 1470.3383477435154, 1590.6182516196109, 1745.5985123421606, 1764.426561367556, 7976.880346794803, 8273.379496537762, 8478.0, 8930.464172149676, 8936.910630893697, 8505.957470212656, 8765.868511972325, 8824.294056475483, 8845.0, 8874.822503549925, 2180.7601163871923, 2218.090582861027, 2223.844330896838, 2228.888555572215, 2230.10795681727, 2205.0518277140823, 2240.8879556022134, 2245.5845668551287, 2246.4608493961414, 2248.55028994201, 2237.2281562860785, 2239.0931672672514, 2245.932622021342, 2246.8764217968005, 2260.2541161416775, 2114.629939760551, 2122.8301735861096, 2127.393692797545, 2127.4574983379216, 2129.765725770164, 2114.7990940860595, 2116.481462041794, 2119.13115622594, 2122.862013969087, 2128.4146859613575, 8850.468971861708, 8905.28757699389, 8912.153345432174, 8934.463932164026, 8952.239059679934, 5304.973475132639, 5384.515393614593, 5403.594730395197, 5408.4591540845995, 5410.404855465896, 3164.0068147839024, 3273.5759944424253, 3284.50732390141, 3348.8493017814258, 3356.2616224430585, 1057.428988346292, 1089.6730980705756, 1093.5844379135876, 1104.0, 1113.5545781687308, 12173.2696038238, 12296.385180740926, 12320.75358492825, 12362.505499779998, 12509.687257818536, 4610.631149508032, 4637.86086417408, 4746.810127594927, 4747.715137091716, 4780.617550595944, 10349.74125646865, 10371.274010819321, 10389.376637401629, 10394.064534191959, 10396.896031039592, 5347.438518955453, 5375.6774593524515, 5375.892482150335, 5377.569794416438, 5389.407165211824, 4320.848770293024, 4779.617630589544, 4786.95213047872, 4906.509349065136, 4916.631252656065, 3848.7883166425554, 3874.8450061997205, 3875.96124038756, 3953.347697629916, 4020.19596080785, 1238.993805030987, 1257.1388598809845, 1257.861635220125, 1260.8423947006625, 1273.554256010389, 862.8015556421933, 969.5927710361665, 970.3935040599625, 975.3903810118676, 981.2738573455734, 5789.928000119713, 5803.883922321615, 5896.823095307148, 5939.138824870456, 6011.218541589566, 443.5697373547654, 447.6061066261734, 448.47080445075125, 449.46962584151015, 976.1507488485064, 4010.6590939770444, 4013.819378127991, 4039.5354534228354, 4054.736442131311, 4082.7754473503646, 10911.127109831194, 11160.497777599865, 11176.10591152722, 11188.384638844942, 11285.830712539318, 11242.213045086766, 11264.0425563828, 11326.716832079099, 11341.376224307578, 11376.715582110348, 7871.134175240719, 8172.509649420935, 8183.79540511492, 8333.958330208432, 8352.791180220422, 5923.614965027432, 6220.129181914445, 6221.191245138103, 6324.083007963912, 6393.1688880445245, 10296.279260451696, 10562.366258024544, 10647.988441098083, 10676.0, 10807.108755967516, 10711.303765255234, 10833.51249193804, 10875.836862446911, 10900.236983411085, 10981.945090274497, 7568.621568921421, 7662.501937374052, 7745.225477452435, 7832.255935686101, 8035.83928321442, 8567.186117318844, 8624.698135565224, 8664.653413863627, 8701.259748050288, 8731.214190722865, 7591.202923692933, 7759.961200193963, 7902.0, 7936.6428510716005, 7969.8406031880195, 7537.585432801029, 7673.654685539276, 7690.2694244046725, 7723.691052358067, 7860.449768516149, 6807.455403567604, 6858.41703455192, 6868.9313106870295, 6872.209695885037, 6889.965550172417, 4904.362432883702, 5035.5719763819025, 5070.8225212117395, 5082.923756143735, 5138.871528211825, 4946.060248552763, 5012.348394708664, 5032.949670503248, 5034.320366750442, 5063.468335824686], "value": 4555.778857588702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9395914776192, 328.875027489554, 331.9767616266861, 334.11959486752414, 336.90566641340405, 5406.864558442731, 5545.556355491561, 5563.998480273554, 5611.354694210162, 5619.241402410678, 5522.641028333155, 5589.329280486337, 5628.746706398211, 5640.661560306385, 5641.746121424536, 4395.978020109895, 4415.293553031515, 4420.093880754438, 4443.089166720814, 4460.910781784379, 4138.855140070098, 4363.323684828857, 4388.561143885618, 4442.577955094261, 4476.709013914102, 4298.570142985708, 4310.224159651261, 4315.0, 4342.370356298351, 4388.758618275993, 4360.454943132108, 4365.170617582649, 4385.605295523418, 4402.405675233835, 4413.933790993137, 3753.774773513598, 3762.830672619739, 3846.4614953906475, 3848.461215429842, 3861.5945325740954, 5387.622866399353, 5395.298611180521, 5423.186522021689, 5455.781768729285, 5539.667619942817, 4845.491223421525, 4909.3126962225315, 4910.926336104962, 4958.380202474691, 4981.729658936984, 5761.9135712964335, 5885.411458854123, 5924.555658325643, 5927.7925272615685, 5948.196993405922, 4179.352200408942, 4214.157168566299, 4215.473065866767, 4228.4080228768, 4229.577042295777, 6134.78528251509, 6135.723892424851, 6155.768221683607, 6194.96902515489, 6223.751049957997, 4178.519470260959, 4206.390073439396, 4247.640754958384, 4269.914601707948, 4273.722208056466, 4301.720388174758, 4305.440292761921, 4323.762193079411, 4328.0, 4338.154059958341, 4913.385826771653, 4925.1873440881855, 4985.601151907838, 4992.975035124801, 5007.574356179693, 5618.410066942912, 5872.559558033165, 5897.262842144732, 5899.262592175978, 5987.730552125165, 1457.3077788050591, 1466.2375564706292, 1474.6165996840898, 1480.7630779075296, 1485.8811295096366, 908.9704388285467, 927.6892241099173, 928.326962951868, 931.743770463128, 947.1522986926662, 5029.7736601853, 5053.216751403538, 5069.721165335868, 5095.274028394791, 5154.0, 5322.4411436799355, 5322.574194064466, 5382.255049924488, 5395.433479484597, 5407.594430417735, 5028.039064764745, 5061.493850614983, 5135.281060651511, 5157.793688252503, 5663.32040155184, 3197.7441804655573, 3219.6780321968085, 3237.514372844092, 3249.8862539810993, 3256.46268365717, 6061.7575296987625, 6220.222472190976, 6236.968815155895, 6250.281217659936, 6280.685965701697, 6123.846903827351, 6187.84530386744, 6232.158658581124, 6258.9374106259265, 6264.154339164245, 6184.412480814405, 6197.0, 6203.2245969253845, 6211.192544969125, 6224.657643829632, 5753.712314384347, 6055.636661800306, 6057.242844644419, 6058.27300723916, 6093.116498107838, 5990.520758339235, 6012.488938440281, 6018.217631708025, 6037.275526936795, 6045.153678484928, 5593.720313984366, 6148.877022459436, 6307.621542707452, 6318.578319877991, 6325.557210995186, 4180.623743863067, 4192.434021407071, 4205.17998990194, 4216.388623649615, 4227.492700875791, 5962.612430192197, 6048.274207095177, 6055.1522786809, 6072.848178795565, 6085.482733967662, 5716.28546431696, 5885.970570147122, 5886.411358864079, 5915.881682366415, 5942.376050514634, 5842.620229685227, 5856.677882716321, 5897.823065308047, 5904.675242861684, 5918.378570250062, 5462.317210348707, 5715.914261286167, 5737.483626473638, 5763.221965034667, 5796.797112101225, 5812.912806307824, 5820.73806678692, 5875.794347197828, 5877.206577112035, 5959.463648271676, 5720.08478643415, 5728.820504619809, 5741.684207368635, 5743.827685169452, 5753.453421924911], "value": 4423.107646271463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.7613423368939, 696.3315217391304, 727.1421518021455, 735.6836560279078, 811.0551207842864, 15010.324535395906, 16355.672886542292, 16381.836181638195, 16386.508404747863, 16417.343306267736, 14025.789613155785, 14037.578872633838, 14050.859491405083, 14090.929545352285, 14137.081089729161, 666.7932940788347, 788.9092754333268, 794.1978601612356, 808.107041718901, 810.7365106340434, 795.0578564401203, 798.704479342644, 799.0850476204743, 802.1697543042952, 803.9758807235793, 852.0542198160038, 854.4958474500044, 854.6581367453007, 854.8632218844986, 856.9228769410752, 842.6208206307156, 843.9071702112763, 846.2764336492334, 846.6909578004046, 850.4387104510993, 619.2878190081398, 619.9008158694587, 621.3910367839497, 621.9222597175353, 623.1649589550025, 13935.372908219155, 13945.16329020252, 14026.579202623938, 14057.71884562303, 14065.296735163303, 14354.0, 14367.928160359235, 14400.423983040666, 14957.326920288613, 15167.620809479851, 12100.6369808905, 12209.816852747215, 12310.75378492425, 12349.753004939941, 12719.872801272053, 3918.1575961168487, 3964.5242570891387, 4088.3049881520215, 4135.7932103395015, 4137.420761093449, 76870.23129768687, 77350.22649773487, 77911.22088779096, 78119.60940195262, 78329.86680532772, 10494.842577361345, 10711.571537138583, 10768.0, 10830.566777328819, 11050.502727377287, 22786.65820012701, 23031.424214394774, 23078.076876924733, 23125.0, 23276.7672323278, 8249.917500825035, 8678.783030424163, 8701.30389568833, 8732.825343493094, 8894.822103557892, 4463.330500424962, 4563.498015218323, 4699.436067671902, 4797.592204662573, 4935.555799978019, 3554.662307080823, 3644.726645501545, 3668.926621467556, 3674.338619048597, 3728.7762734236035, 674.1101745695635, 679.9422049125781, 689.8137502874296, 695.7599628128288, 702.5047341624143, 620.314552419579, 684.6953105867841, 710.7761055267574, 712.0861247340781, 728.7595093619093, 9734.172595329335, 9926.900730992742, 10147.847782283272, 10240.078392944672, 10369.585216591402, 555.3419198250086, 678.9524733268722, 706.494856177825, 736.5323019882413, 757.6817736550662, 4556.154757323289, 4884.12085824555, 5026.246063090565, 5046.823361182414, 5102.132637451642, 117944.41027794806, 126433.0, 127045.0, 130955.34522327517, 131098.34450827684, 69529.0, 78244.0, 81562.0, 91259.0, 109543.0, 97339.51330243303, 98278.0, 98729.0, 99987.0, 100526.49736751123, 9602.357286134675, 9728.9027109728, 9784.706458806248, 9787.46168960714, 9925.454100024568, 50128.49871501384, 51362.0, 52359.47640523546, 53008.73495632497, 54467.72766136144, 79635.0, 80942.0, 82526.58736706278, 83505.0, 85187.5740621293, 13343.66640833948, 13419.463221471031, 13419.798703019267, 13507.662308441975, 13856.307184640526, 14071.718565628425, 14496.111366887604, 14783.778243326144, 14805.851941480447, 15578.688426231638, 14265.64335891611, 14472.421103156177, 14597.92701036488, 14616.488422905148, 14947.775783363475, 14154.858451415354, 14436.0, 14790.03864748788, 14900.850991489946, 15062.341163071595, 14130.222837744022, 14329.283535822959, 14476.855231447971, 14543.272836357928, 14693.795930610493, 10983.560657573928, 11269.436528173723, 11370.374629395463, 11423.086153107564, 11600.662610746142, 11269.267497612629, 11823.503643821405, 12054.457549410474, 12114.818277725664, 12155.331456769962], "value": 7703.523866770468, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 115.0, 109.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 157.0, 184.0, 132.0, 151.0, 160.0, 136.0, 197.0, 136.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 164.0, 171.0, 163.0, 160.0, 166.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 159.0, 76.0, 75.0, 75.0, 75.0, 176.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 141.0, 86.0, 85.0, 85.0, 146.0, 85.0, 86.0, 140.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 105.0, 96.0, 95.0, 94.0, 95.0, 95.0, 97.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 55.0, 56.0, 55.0, 70.0, 56.0, 55.0, 57.0, 55.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 86.0, 82.0, 82.0, 80.0, 80.0, 104.0, 90.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 137.0, 123.0, 136.0, 123.0, 136.0, 129.0, 126.0, 127.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 163.0, 158.0, 168.0, 156.0, 159.0, 159.0, 157.0, 158.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 67.0, 63.0, 62.0, 62.0, 64.0, 63.0], "value": 63.7, "unit": "score"}]}]} 05:24:17 INFO - Return code: 0 05:24:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:24:17 ERROR - # TBPL SUCCESS # 05:24:17 INFO - Running post-action listener: _resource_record_post_action 05:24:17 INFO - ##### 05:24:17 INFO - ##### Finished run-tests step (success) 05:24:17 INFO - ##### 05:24:17 INFO - Running post-run listener: _resource_record_post_run 05:24:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541954048; Read time: 20; Write time: 448664 05:24:17 INFO - TinderboxPrint: CPU usage
13.5% 05:24:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:24:17 INFO - TinderboxPrint: I/O write bytes / time
541,954,048 / 448,664 05:24:17 INFO - TinderboxPrint: CPU idle
8,231.8 (86.5%) 05:24:17 INFO - TinderboxPrint: CPU user
1,224.7 (12.9%) 05:24:17 INFO - TinderboxPrint: Swap in / out
0 / 0 05:24:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 248274944; Read time: 0; Write time: 196828 05:24:17 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287191040; Read time: 20; Write time: 250268 05:24:17 INFO - Running post-run listener: _upload_blobber_files 05:24:17 INFO - Blob upload gear active. 05:24:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:24:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:24:17 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'] 05:24:17 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 05:24:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:24:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:22 INFO - (blobuploader) - INFO - Done attempting. 05:24:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:24:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:23 INFO - (blobuploader) - INFO - Done attempting. 05:24:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:24:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:23 INFO - (blobuploader) - INFO - Done attempting. 05:24:23 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:23 INFO - Return code: 0 05:24:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/531c40bb78ed9f66269e78f6b2733db5d814791e50a1baef1294a917b11f7f76772b471ad03da11054066d130f56f6bf7dcc7c52d2b02c9913d8baec3126d94d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439b785ab86ac0c50eb1eb706c58c7044fef971e1399c2fc4c40a7858ab1b34c8f64648874d607d67acd1b434309e91ff238fad044a3d004b1c94050d0a03817", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84fbea6c3b8db0fbfd45fe409ee51526d0e4ba896a8d7af27430c2f4ef7576e957101d0ed0249b4eef41aa55ae35418a9e35045b3356fd0cfb888fde978b2338"} 05:24:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:23 INFO - Contents: 05:24:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/531c40bb78ed9f66269e78f6b2733db5d814791e50a1baef1294a917b11f7f76772b471ad03da11054066d130f56f6bf7dcc7c52d2b02c9913d8baec3126d94d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439b785ab86ac0c50eb1eb706c58c7044fef971e1399c2fc4c40a7858ab1b34c8f64648874d607d67acd1b434309e91ff238fad044a3d004b1c94050d0a03817", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84fbea6c3b8db0fbfd45fe409ee51526d0e4ba896a8d7af27430c2f4ef7576e957101d0ed0249b4eef41aa55ae35418a9e35045b3356fd0cfb888fde978b2338"} 05:24:23 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:23 INFO - Copying logs to upload dir... 05:24:23 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.287813 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-10 05:24:23.827394) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:24:23.830992) ========= 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=eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594 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/531c40bb78ed9f66269e78f6b2733db5d814791e50a1baef1294a917b11f7f76772b471ad03da11054066d130f56f6bf7dcc7c52d2b02c9913d8baec3126d94d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439b785ab86ac0c50eb1eb706c58c7044fef971e1399c2fc4c40a7858ab1b34c8f64648874d607d67acd1b434309e91ff238fad044a3d004b1c94050d0a03817", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84fbea6c3b8db0fbfd45fe409ee51526d0e4ba896a8d7af27430c2f4ef7576e957101d0ed0249b4eef41aa55ae35418a9e35045b3356fd0cfb888fde978b2338"} build_url:https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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/531c40bb78ed9f66269e78f6b2733db5d814791e50a1baef1294a917b11f7f76772b471ad03da11054066d130f56f6bf7dcc7c52d2b02c9913d8baec3126d94d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439b785ab86ac0c50eb1eb706c58c7044fef971e1399c2fc4c40a7858ab1b34c8f64648874d607d67acd1b434309e91ff238fad044a3d004b1c94050d0a03817", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84fbea6c3b8db0fbfd45fe409ee51526d0e4ba896a8d7af27430c2f4ef7576e957101d0ed0249b4eef41aa55ae35418a9e35045b3356fd0cfb888fde978b2338"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:24:23.858702) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:24:23.859094) ========= 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=eca2ab57546de7b41f256b19000001ef-1465558873.142465-685354594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:24:23.946931) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:24:23.947436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:24:23.947788) ========= ========= Total master_lag: 0.26 =========