builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1465333345.63 results: success (0) buildid: 20160607113037 builduid: cb0b9d95df9d43d19caeab2c92d1f6aa revision: 3cf6f6e8022b9759ed2d914ad16f5a754de00366 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.633431) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.633924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.634234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.658525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.658887) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 14:02:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-06-07 14:02:26 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077883 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.751108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.751668) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013755 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.802783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:25.803277) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cf6f6e8022b9759ed2d914ad16f5a754de00366 --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 3cf6f6e8022b9759ed2d914ad16f5a754de00366 --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=5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 14:02:26,261 truncating revision to first 12 chars 2016-06-07 14:02:26,261 Setting DEBUG logging. 2016-06-07 14:02:26,261 attempt 1/10 2016-06-07 14:02:26,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cf6f6e8022b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 14:02:26,566 unpacking tar archive at: fx-team-3cf6f6e8022b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:26.452081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:26.452699) ========= script_repo_revision: 3cf6f6e8022b9759ed2d914ad16f5a754de00366 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:26.453598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:26.454052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:26.465317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-07 14:02:26.465919) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:27 INFO - MultiFileLogger online at 20160607 14:02:27 in /builds/slave/test 14:02:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:02:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:02:27 INFO - {'append_to_log': False, 14:02:27 INFO - 'base_work_dir': '/builds/slave/test', 14:02:27 INFO - 'blob_upload_branch': 'Fx-Team', 14:02:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:02:27 INFO - 'branch': 'Fx-Team', 14:02:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:27 INFO - 'config_files': ('talos/linux_config.py',), 14:02:27 INFO - 'default_actions': ('clobber', 14:02:27 INFO - 'read-buildbot-config', 14:02:27 INFO - 'download-and-extract', 14:02:27 INFO - 'populate-webroot', 14:02:27 INFO - 'create-virtualenv', 14:02:27 INFO - 'install', 14:02:27 INFO - 'run-tests'), 14:02:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:27 INFO - 'download_minidump_stackwalk': True, 14:02:27 INFO - 'download_symbols': 'ondemand', 14:02:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:27 INFO - 'installer_path': 'installer.exe', 14:02:27 INFO - 'log_level': 'info', 14:02:27 INFO - 'log_name': 'talos', 14:02:27 INFO - 'log_to_console': True, 14:02:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:27 INFO - 'opt_config_files': (), 14:02:27 INFO - 'pip_index': False, 14:02:27 INFO - 'sps_profile': False, 14:02:27 INFO - 'sps_profile_interval': 0, 14:02:27 INFO - 'suite': 'dromaeojs', 14:02:27 INFO - 'system_bits': '32', 14:02:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:27 INFO - 'title': 'talos-linux64-ix-051', 14:02:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:27 INFO - 'use_talos_json': True, 14:02:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:02:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:27 INFO - 'work_dir': 'build'} 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running clobber step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: clobber 14:02:27 INFO - rmtree: /builds/slave/test/build 14:02:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:02:27 INFO - Running post-action listener: _resource_record_post_action 14:02:27 INFO - ##### 14:02:27 INFO - ##### Finished clobber step (success) 14:02:27 INFO - ##### 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running read-buildbot-config step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: read_buildbot_config 14:02:27 INFO - Using buildbot properties: 14:02:27 INFO - { 14:02:27 INFO - "project": "", 14:02:27 INFO - "product": "firefox", 14:02:27 INFO - "script_repo_revision": "production", 14:02:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:02:27 INFO - "repository": "", 14:02:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:02:27 INFO - "buildid": "20160607113037", 14:02:27 INFO - "pgo_build": "True", 14:02:27 INFO - "basedir": "/builds/slave/test", 14:02:27 INFO - "buildnumber": 169, 14:02:27 INFO - "slavename": "talos-linux64-ix-051", 14:02:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:02:27 INFO - "platform": "ubuntu64_hw", 14:02:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:02:27 INFO - "branch": "fx-team", 14:02:27 INFO - "repo_path": "integration/fx-team", 14:02:27 INFO - "revision": "3cf6f6e8022b9759ed2d914ad16f5a754de00366", 14:02:27 INFO - "stage_platform": "linux64-pgo", 14:02:27 INFO - "builduid": "cb0b9d95df9d43d19caeab2c92d1f6aa", 14:02:27 INFO - "slavebuilddir": "test" 14:02:27 INFO - } 14:02:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:02:27 INFO - Running post-action listener: _resource_record_post_action 14:02:27 INFO - ##### 14:02:27 INFO - ##### Finished read-buildbot-config step (success) 14:02:27 INFO - ##### 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running download-and-extract step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: download_and_extract 14:02:27 INFO - mkdir: /builds/slave/test/build/tests 14:02: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')]} 14:02:27 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:02:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:02:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:02:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:30 INFO - Downloaded 1361 bytes. 14:02:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:02:30 INFO - Using the following test package requirements: 14:02:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:02:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'jsshell-linux-x86_64.zip'], 14:02:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02:30 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')]} 14:02:30 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:02:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:02:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:31 INFO - Downloaded 24446682 bytes. 14:02:31 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'] 14:02:31 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 14:02:32 INFO - Return code: 0 14:02:32 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 14:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:32 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:02:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:02:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:34 INFO - Downloaded 24446682 bytes. 14:02:34 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'] 14:02:34 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 14:02:35 INFO - Return code: 0 14:02:35 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')]} 14:02:35 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:36 INFO - Downloaded 10833369 bytes. 14:02:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:02:36 INFO - Return code: 0 14:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:36 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:42 INFO - Downloaded 59172803 bytes. 14:02:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:02:42 INFO - mkdir: /builds/slave/test/properties 14:02:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:42 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:42 INFO - Contents: 14:02:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:02:43 INFO - Running post-action listener: _resource_record_post_action 14:02:43 INFO - Running post-action listener: set_extra_try_arguments 14:02:43 INFO - ##### 14:02:43 INFO - ##### Finished download-and-extract step (success) 14:02:43 INFO - ##### 14:02:43 INFO - ##### 14:02:43 INFO - ##### Running populate-webroot step. 14:02:43 INFO - ##### 14:02:43 INFO - Running pre-action listener: _resource_record_pre_action 14:02:43 INFO - Running main action method: populate_webroot 14:02:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:43 INFO - '--tppagecycles', 14:02:43 INFO - '7'], 14:02:43 INFO - 'tests': ['tsvgm']}}, 14:02:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:02:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:02:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:02:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:43 INFO - 'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:43 INFO - 'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['damp', 'tps']}, 14:02:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:43 INFO - 'tests': ['damp', 'tps']}, 14:02:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['dromaeo_dom']}, 14:02:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['a11yr', 14:02:43 INFO - 'ts_paint', 14:02:43 INFO - 'tpaint', 14:02:43 INFO - 'sessionrestore', 14:02:43 INFO - 'sessionrestore_no_auto_restore', 14:02:43 INFO - 'tabpaint']}, 14:02:43 INFO - 'other-e10s': {'tests': ['a11yr', 14:02:43 INFO - 'ts_paint', 14:02:43 INFO - 'tpaint', 14:02:43 INFO - 'sessionrestore', 14:02:43 INFO - 'sessionrestore_no_auto_restore', 14:02:43 INFO - 'tabpaint']}, 14:02:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:02:43 INFO - 'ts_paint', 14:02:43 INFO - 'tpaint', 14:02:43 INFO - 'sessionrestore', 14:02:43 INFO - 'sessionrestore_no_auto_restore', 14:02:43 INFO - 'tabpaint']}, 14:02:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:02:43 INFO - 'ts_paint', 14:02:43 INFO - 'tpaint', 14:02:43 INFO - 'sessionrestore', 14:02:43 INFO - 'sessionrestore_no_auto_restore', 14:02:43 INFO - 'tabpaint']}, 14:02:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['a11yr', 14:02:43 INFO - 'ts_paint', 14:02:43 INFO - 'tpaint', 14:02:43 INFO - 'sessionrestore', 14:02:43 INFO - 'sessionrestore_no_auto_restore', 14:02:43 INFO - 'tabpaint']}, 14:02:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['a11yr', 14:02:43 INFO - 'ts_paint', 14:02:43 INFO - 'tpaint', 14:02:43 INFO - 'sessionrestore', 14:02:43 INFO - 'sessionrestore_no_auto_restore', 14:02:43 INFO - 'tabpaint']}, 14:02:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['tsvgx', 14:02:43 INFO - 'tsvgr_opacity', 14:02:43 INFO - 'tart', 14:02:43 INFO - 'tscrollx', 14:02:43 INFO - 'cart']}, 14:02:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:02:43 INFO - 'tsvgr_opacity', 14:02:43 INFO - 'tart', 14:02:43 INFO - 'tscrollx', 14:02:43 INFO - 'cart']}, 14:02:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:43 INFO - 'talos_options': ['--disable-e10s'], 14:02:43 INFO - 'tests': ['tp5o']}, 14:02:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:43 INFO - 'tests': ['tp5o']}, 14:02:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:43 INFO - 'talos_options': ['--disable-e10s', 14:02:43 INFO - '--xperf_path', 14:02:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:43 INFO - 'tests': ['tp5n']}, 14:02:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:43 INFO - 'talos_options': ['--xperf_path', 14:02:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:43 INFO - 'tests': ['tp5n']}}, 14:02:43 INFO - 'talos.zip': {'path': '', 14:02:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:43 INFO - Running post-action listener: _resource_record_post_action 14:02:43 INFO - ##### 14:02:43 INFO - ##### Finished populate-webroot step (success) 14:02:43 INFO - ##### 14:02:43 INFO - ##### 14:02:43 INFO - ##### Running create-virtualenv step. 14:02:43 INFO - ##### 14:02:43 INFO - Running pre-action listener: _resource_record_pre_action 14:02:43 INFO - Running main action method: create_virtualenv 14:02:43 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:43 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 14:02:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:43 INFO - Using real prefix '/usr' 14:02:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:44 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:46 INFO - Installing pip.................done. 14:02:46 INFO - Return code: 0 14:02:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:02:46 INFO - Using env: {'DISPLAY': ':0', 14:02:46 INFO - 'HOME': '/home/cltbld', 14:02:46 INFO - 'LANG': 'en_US.UTF-8', 14:02:46 INFO - 'LANGUAGE': 'en_US:en', 14:02:46 INFO - 'LOGNAME': 'cltbld', 14:02:46 INFO - 'MAIL': '/var/mail/cltbld', 14:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:46 INFO - 'MOZ_NO_REMOTE': '1', 14:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:46 INFO - 'NO_EM_RESTART': '1', 14:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:46 INFO - 'PWD': '/builds/slave/test', 14:02:46 INFO - 'SHELL': '/bin/bash', 14:02:46 INFO - 'SHLVL': '1', 14:02:46 INFO - 'TERM': 'linux', 14:02:46 INFO - 'TMOUT': '86400', 14:02:46 INFO - 'USER': 'cltbld', 14:02:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:46 INFO - '_': '/tools/buildbot/bin/python'} 14:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:46 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 14:02:46 INFO - Cleaning up... 14:02:46 INFO - Return code: 0 14:02:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:02:46 INFO - Using env: {'DISPLAY': ':0', 14:02:46 INFO - 'HOME': '/home/cltbld', 14:02:46 INFO - 'LANG': 'en_US.UTF-8', 14:02:46 INFO - 'LANGUAGE': 'en_US:en', 14:02:46 INFO - 'LOGNAME': 'cltbld', 14:02:46 INFO - 'MAIL': '/var/mail/cltbld', 14:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:46 INFO - 'MOZ_NO_REMOTE': '1', 14:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:46 INFO - 'NO_EM_RESTART': '1', 14:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:46 INFO - 'PWD': '/builds/slave/test', 14:02:46 INFO - 'SHELL': '/bin/bash', 14:02:46 INFO - 'SHLVL': '1', 14:02:46 INFO - 'TERM': 'linux', 14:02:46 INFO - 'TMOUT': '86400', 14:02:46 INFO - 'USER': 'cltbld', 14:02:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:46 INFO - '_': '/tools/buildbot/bin/python'} 14:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:46 INFO - Downloading/unpacking psutil>=3.1.1 14:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:48 INFO - Installing collected packages: psutil 14:02:48 INFO - Running setup.py install for psutil 14:02:48 INFO - building 'psutil._psutil_linux' extension 14:02:48 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 14:02:48 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 14:02:48 INFO - building 'psutil._psutil_posix' extension 14:02:48 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 14:02:48 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 14:02:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:49 INFO - Successfully installed psutil 14:02:49 INFO - Cleaning up... 14:02:49 INFO - Return code: 0 14:02:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:02:49 INFO - Using env: {'DISPLAY': ':0', 14:02:49 INFO - 'HOME': '/home/cltbld', 14:02:49 INFO - 'LANG': 'en_US.UTF-8', 14:02:49 INFO - 'LANGUAGE': 'en_US:en', 14:02:49 INFO - 'LOGNAME': 'cltbld', 14:02:49 INFO - 'MAIL': '/var/mail/cltbld', 14:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:49 INFO - 'MOZ_NO_REMOTE': '1', 14:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:49 INFO - 'NO_EM_RESTART': '1', 14:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:49 INFO - 'PWD': '/builds/slave/test', 14:02:49 INFO - 'SHELL': '/bin/bash', 14:02:49 INFO - 'SHLVL': '1', 14:02:49 INFO - 'TERM': 'linux', 14:02:49 INFO - 'TMOUT': '86400', 14:02:49 INFO - 'USER': 'cltbld', 14:02:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:49 INFO - '_': '/tools/buildbot/bin/python'} 14:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:02:51 INFO - Installing collected packages: mozsystemmonitor 14:02:51 INFO - Running setup.py install for mozsystemmonitor 14:02:51 INFO - Successfully installed mozsystemmonitor 14:02:51 INFO - Cleaning up... 14:02:51 INFO - Return code: 0 14:02:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:51 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 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:02:51 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 14:02:51 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 14:02:51 INFO - Using env: {'DISPLAY': ':0', 14:02:51 INFO - 'HOME': '/home/cltbld', 14:02:51 INFO - 'LANG': 'en_US.UTF-8', 14:02:51 INFO - 'LANGUAGE': 'en_US:en', 14:02:51 INFO - 'LOGNAME': 'cltbld', 14:02:51 INFO - 'MAIL': '/var/mail/cltbld', 14:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:51 INFO - 'MOZ_NO_REMOTE': '1', 14:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:51 INFO - 'NO_EM_RESTART': '1', 14:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:51 INFO - 'PWD': '/builds/slave/test', 14:02:51 INFO - 'SHELL': '/bin/bash', 14:02:51 INFO - 'SHLVL': '1', 14:02:51 INFO - 'TERM': 'linux', 14:02:51 INFO - 'TMOUT': '86400', 14:02:51 INFO - 'USER': 'cltbld', 14:02:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:51 INFO - '_': '/tools/buildbot/bin/python'} 14:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:51 INFO - Downloading/unpacking jsonschema==2.5.1 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:53 INFO - warning: no files found matching '*.txt' 14:02:53 INFO - no previously-included directories found matching 'build' 14:02:53 INFO - no previously-included directories found matching 'dist' 14:02:53 INFO - no previously-included directories found matching '.git*' 14:02:53 INFO - Installing collected packages: jsonschema, functools32 14:02:53 INFO - Running setup.py install for functools32 14:02:53 INFO - warning: no files found matching '*.txt' 14:02:53 INFO - no previously-included directories found matching 'build' 14:02:53 INFO - no previously-included directories found matching 'dist' 14:02:53 INFO - no previously-included directories found matching '.git*' 14:02:53 INFO - Successfully installed jsonschema functools32 14:02:53 INFO - Cleaning up... 14:02:54 INFO - Return code: 0 14:02:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:02:54 INFO - Using env: {'DISPLAY': ':0', 14:02:54 INFO - 'HOME': '/home/cltbld', 14:02:54 INFO - 'LANG': 'en_US.UTF-8', 14:02:54 INFO - 'LANGUAGE': 'en_US:en', 14:02:54 INFO - 'LOGNAME': 'cltbld', 14:02:54 INFO - 'MAIL': '/var/mail/cltbld', 14:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:54 INFO - 'MOZ_NO_REMOTE': '1', 14:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:54 INFO - 'NO_EM_RESTART': '1', 14:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:54 INFO - 'PWD': '/builds/slave/test', 14:02:54 INFO - 'SHELL': '/bin/bash', 14:02:54 INFO - 'SHLVL': '1', 14:02:54 INFO - 'TERM': 'linux', 14:02:54 INFO - 'TMOUT': '86400', 14:02:54 INFO - 'USER': 'cltbld', 14:02:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:54 INFO - '_': '/tools/buildbot/bin/python'} 14:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:56 INFO - Downloading docopt-0.6.1.tar.gz 14:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:56 INFO - Running setup.py install for blobuploader 14:02:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:56 INFO - Running setup.py install for requests 14:02:57 INFO - Running setup.py install for docopt 14:02:57 INFO - Successfully installed blobuploader requests docopt 14:02:57 INFO - Cleaning up... 14:02:57 INFO - Return code: 0 14:02:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:57 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 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:02:57 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 14:02:57 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 14:02:57 INFO - Using env: {'DISPLAY': ':0', 14:02:57 INFO - 'HOME': '/home/cltbld', 14:02:57 INFO - 'LANG': 'en_US.UTF-8', 14:02:57 INFO - 'LANGUAGE': 'en_US:en', 14:02:57 INFO - 'LOGNAME': 'cltbld', 14:02:57 INFO - 'MAIL': '/var/mail/cltbld', 14:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:57 INFO - 'MOZ_NO_REMOTE': '1', 14:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:57 INFO - 'NO_EM_RESTART': '1', 14:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:57 INFO - 'PWD': '/builds/slave/test', 14:02:57 INFO - 'SHELL': '/bin/bash', 14:02:57 INFO - 'SHLVL': '1', 14:02:57 INFO - 'TERM': 'linux', 14:02:57 INFO - 'TMOUT': '86400', 14:02:57 INFO - 'USER': 'cltbld', 14:02:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:57 INFO - '_': '/tools/buildbot/bin/python'} 14:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:57 INFO - Running setup.py (path:/tmp/pip-3y0edS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:57 INFO - Running setup.py (path:/tmp/pip-mT4Zka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:57 INFO - Running setup.py (path:/tmp/pip-QfkS9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:57 INFO - Running setup.py (path:/tmp/pip-ccS9kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:57 INFO - Running setup.py (path:/tmp/pip-LorW9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:58 INFO - Running setup.py (path:/tmp/pip-ctMmwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:58 INFO - Running setup.py (path:/tmp/pip-NdqNrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:58 INFO - Running setup.py (path:/tmp/pip-XmSCEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:58 INFO - Running setup.py (path:/tmp/pip-FeCL8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:58 INFO - Running setup.py (path:/tmp/pip-NOvDFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:58 INFO - Running setup.py (path:/tmp/pip-MvsJtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:58 INFO - Running setup.py (path:/tmp/pip-JZ7zuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:58 INFO - Running setup.py (path:/tmp/pip-vOYYL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:58 INFO - Running setup.py (path:/tmp/pip-iZFqI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:58 INFO - Running setup.py (path:/tmp/pip-BkjfbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:58 INFO - Running setup.py (path:/tmp/pip-zhFAkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:58 INFO - Running setup.py (path:/tmp/pip-m_EbvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:58 INFO - Running setup.py install for manifestparser 14:02:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozcrash 14:02:59 INFO - Running setup.py install for mozdebug 14:02:59 INFO - Running setup.py install for mozdevice 14:02:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozfile 14:02:59 INFO - Running setup.py install for mozhttpd 14:02:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozinfo 14:02:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozInstall 14:02:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozleak 14:02:59 INFO - Running setup.py install for mozlog 14:02:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for moznetwork 14:03:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Running setup.py install for mozprocess 14:03:00 INFO - Running setup.py install for mozprofile 14:03:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Running setup.py install for mozrunner 14:03:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Running setup.py install for mozscreenshot 14:03:00 INFO - Running setup.py install for moztest 14:03:00 INFO - Running setup.py install for mozversion 14:03:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:00 INFO - Cleaning up... 14:03:00 INFO - Return code: 0 14:03:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:00 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 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:03:00 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 14:03:00 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 14:03:00 INFO - Using env: {'DISPLAY': ':0', 14:03:00 INFO - 'HOME': '/home/cltbld', 14:03:00 INFO - 'LANG': 'en_US.UTF-8', 14:03:00 INFO - 'LANGUAGE': 'en_US:en', 14:03:00 INFO - 'LOGNAME': 'cltbld', 14:03:00 INFO - 'MAIL': '/var/mail/cltbld', 14:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:00 INFO - 'MOZ_NO_REMOTE': '1', 14:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:00 INFO - 'NO_EM_RESTART': '1', 14:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:00 INFO - 'PWD': '/builds/slave/test', 14:03:00 INFO - 'SHELL': '/bin/bash', 14:03:00 INFO - 'SHLVL': '1', 14:03:00 INFO - 'TERM': 'linux', 14:03:00 INFO - 'TMOUT': '86400', 14:03:00 INFO - 'USER': 'cltbld', 14:03:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:00 INFO - '_': '/tools/buildbot/bin/python'} 14:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:00 INFO - Running setup.py (path:/tmp/pip-gTxF4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:01 INFO - Running setup.py (path:/tmp/pip-8noXI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:01 INFO - Running setup.py (path:/tmp/pip-8sLCgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:01 INFO - Running setup.py (path:/tmp/pip-ufbWoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:01 INFO - Running setup.py (path:/tmp/pip-lvVbOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:01 INFO - Running setup.py (path:/tmp/pip-Fm5xnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:01 INFO - Running setup.py (path:/tmp/pip-7YHCpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:01 INFO - Running setup.py (path:/tmp/pip-vxvGNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:01 INFO - Running setup.py (path:/tmp/pip-2xUhy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:01 INFO - Running setup.py (path:/tmp/pip-beN90y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:01 INFO - Running setup.py (path:/tmp/pip-vBqMPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:01 INFO - Running setup.py (path:/tmp/pip-AL5s7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:01 INFO - Running setup.py (path:/tmp/pip-nrRPFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:01 INFO - Running setup.py (path:/tmp/pip-rEeDSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:01 INFO - Running setup.py (path:/tmp/pip-O9ZURd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:02 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)) 14:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:02 INFO - Running setup.py (path:/tmp/pip-jokvte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:02 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)) 14:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:02 INFO - Running setup.py (path:/tmp/pip-N3tsrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:02 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)) 14:03:02 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)) 14:03:02 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)) 14:03:02 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)) 14:03:02 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)) 14:03:02 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)) 14:03:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:04 INFO - Downloading blessings-1.6.tar.gz 14:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:04 INFO - Installing collected packages: blessings 14:03:04 INFO - Running setup.py install for blessings 14:03:04 INFO - Successfully installed blessings 14:03:04 INFO - Cleaning up... 14:03:04 INFO - Return code: 0 14:03:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:03:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:04 INFO - Reading from file tmpfile_stdout 14:03:04 INFO - Current package versions: 14:03:04 INFO - argparse == 1.2.1 14:03:04 INFO - blessings == 1.6 14:03:04 INFO - blobuploader == 1.2.4 14:03:04 INFO - docopt == 0.6.1 14:03:04 INFO - functools32 == 3.2.3-2 14:03:04 INFO - jsonschema == 2.5.1 14:03:04 INFO - manifestparser == 1.1 14:03:04 INFO - mozInstall == 1.12 14:03:04 INFO - mozcrash == 0.17 14:03:04 INFO - mozdebug == 0.1 14:03:04 INFO - mozdevice == 0.48 14:03:04 INFO - mozfile == 1.2 14:03:04 INFO - mozhttpd == 0.7 14:03:04 INFO - mozinfo == 0.9 14:03:04 INFO - mozleak == 0.1 14:03:04 INFO - mozlog == 3.2 14:03:04 INFO - moznetwork == 0.27 14:03:04 INFO - mozprocess == 0.22 14:03:04 INFO - mozprofile == 0.28 14:03:04 INFO - mozrunner == 6.11 14:03:04 INFO - mozscreenshot == 0.1 14:03:04 INFO - mozsystemmonitor == 0.3 14:03:04 INFO - moztest == 0.7 14:03:04 INFO - mozversion == 1.4 14:03:04 INFO - psutil == 3.1.1 14:03:04 INFO - requests == 1.2.3 14:03:04 INFO - wsgiref == 0.1.2 14:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:04 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')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 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')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 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 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:03:04 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 14:03:04 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 14:03:04 INFO - Using env: {'DISPLAY': ':0', 14:03:04 INFO - 'HOME': '/home/cltbld', 14:03:04 INFO - 'LANG': 'en_US.UTF-8', 14:03:04 INFO - 'LANGUAGE': 'en_US:en', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MAIL': '/var/mail/cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SHLVL': '1', 14:03:04 INFO - 'TERM': 'linux', 14:03:04 INFO - 'TMOUT': '86400', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - '_': '/tools/buildbot/bin/python'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 INFO - Cleaning up... 14:03:04 INFO - Return code: 0 14:03:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:03:04 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')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 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')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 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 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:03:04 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 14:03:04 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 14:03:04 INFO - Using env: {'DISPLAY': ':0', 14:03:04 INFO - 'HOME': '/home/cltbld', 14:03:04 INFO - 'LANG': 'en_US.UTF-8', 14:03:04 INFO - 'LANGUAGE': 'en_US:en', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MAIL': '/var/mail/cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SHLVL': '1', 14:03:04 INFO - 'TERM': 'linux', 14:03:04 INFO - 'TMOUT': '86400', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - '_': '/tools/buildbot/bin/python'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:03:04 INFO - Cleaning up... 14:03:05 INFO - Return code: 0 14:03:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcca9737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c7190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', '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 14:03: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', 'flake8'] in /builds/slave/test/build 14:03: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 flake8 14:03:05 INFO - Using env: {'DISPLAY': ':0', 14:03:05 INFO - 'HOME': '/home/cltbld', 14:03:05 INFO - 'LANG': 'en_US.UTF-8', 14:03:05 INFO - 'LANGUAGE': 'en_US:en', 14:03:05 INFO - 'LOGNAME': 'cltbld', 14:03:05 INFO - 'MAIL': '/var/mail/cltbld', 14:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:05 INFO - 'MOZ_NO_REMOTE': '1', 14:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:05 INFO - 'NO_EM_RESTART': '1', 14:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:05 INFO - 'PWD': '/builds/slave/test', 14:03:05 INFO - 'SHELL': '/bin/bash', 14:03:05 INFO - 'SHLVL': '1', 14:03:05 INFO - 'TERM': 'linux', 14:03:05 INFO - 'TMOUT': '86400', 14:03:05 INFO - 'USER': 'cltbld', 14:03:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:05 INFO - '_': '/tools/buildbot/bin/python'} 14:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:05 INFO - Downloading/unpacking flake8 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:07 INFO - no previously-included directories found matching 'docs/_build' 14:03:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:07 INFO - Running setup.py install for pep8 14:03:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:08 INFO - no previously-included directories found matching 'docs/_build' 14:03:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:03:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:08 INFO - Cleaning up... 14:03:08 INFO - Return code: 0 14:03:08 INFO - Running post-action listener: _resource_record_post_action 14:03:08 INFO - Running post-action listener: _start_resource_monitoring 14:03:08 INFO - Starting resource monitoring. 14:03:08 INFO - ##### 14:03:08 INFO - ##### Finished create-virtualenv step (success) 14:03:08 INFO - ##### 14:03:08 INFO - ##### 14:03:08 INFO - ##### Running install step. 14:03:08 INFO - ##### 14:03:08 INFO - Running pre-action listener: _resource_record_pre_action 14:03:08 INFO - Running main action method: install 14:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:08 INFO - Reading from file tmpfile_stdout 14:03:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:03:08 INFO - Reading from file tmpfile_stdout 14:03:08 INFO - Output received: 14:03:08 INFO - Usage: mozinstall [options] installer 14:03:08 INFO - Options: 14:03:08 INFO - -h, --help show this help message and exit 14:03:08 INFO - -d DEST, --destination=DEST 14:03:08 INFO - Directory to install application into. [default: 14:03:08 INFO - "/builds/slave/test"] 14:03:08 INFO - --app=APP Application being installed. [default: firefox] 14:03:08 INFO - mkdir: /builds/slave/test/build/application 14:03:08 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'] 14:03:08 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 14:03:25 INFO - Reading from file tmpfile_stdout 14:03:25 INFO - Output received: 14:03:25 INFO - /builds/slave/test/build/application/firefox/firefox 14:03:25 INFO - Running post-action listener: _resource_record_post_action 14:03:25 INFO - ##### 14:03:25 INFO - ##### Finished install step (success) 14:03:25 INFO - ##### 14:03:25 INFO - ##### 14:03:25 INFO - ##### Running run-tests step. 14:03:25 INFO - ##### 14:03:25 INFO - Running pre-action listener: _resource_record_pre_action 14:03:25 INFO - Running main action method: run_tests 14:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:25 INFO - Python 2.7.3 14:03:25 INFO - Return code: 0 14:03:25 INFO - grabbing minidump binary from tooltool 14:03:25 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')]} 14:03:25 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 0x2559110>, '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 0x24c5230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:25 INFO - Return code: 0 14:03:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:03:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:03:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:03:26 INFO - Return code: 0 14:03:26 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:03:26 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:03:26 INFO - Using env: {'DISPLAY': ':0', 14:03:26 INFO - 'HOME': '/home/cltbld', 14:03:26 INFO - 'LANG': 'en_US.UTF-8', 14:03:26 INFO - 'LANGUAGE': 'en_US:en', 14:03:26 INFO - 'LOGNAME': 'cltbld', 14:03:26 INFO - 'MAIL': '/var/mail/cltbld', 14:03:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:26 INFO - 'MOZ_NO_REMOTE': '1', 14:03:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:26 INFO - 'NO_EM_RESTART': '1', 14:03:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:26 INFO - 'PWD': '/builds/slave/test', 14:03:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:26 INFO - 'SHELL': '/bin/bash', 14:03:26 INFO - 'SHLVL': '1', 14:03:26 INFO - 'TERM': 'linux', 14:03:26 INFO - 'TMOUT': '86400', 14:03:26 INFO - 'USER': 'cltbld', 14:03:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949', 14:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:26 INFO - '_': '/tools/buildbot/bin/python'} 14:03:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:03:26 INFO - mozversion application_buildid: 20160607113037 14:03:26 INFO - mozversion application_changeset: 3cf6f6e8022b9759ed2d914ad16f5a754de00366 14:03:26 INFO - mozversion application_display_name: Nightly 14:03:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:26 INFO - mozversion application_name: Firefox 14:03:26 INFO - mozversion application_remotingname: firefox 14:03:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:03:26 INFO - mozversion application_vendor: Mozilla 14:03:26 INFO - mozversion application_version: 50.0a1 14:03:26 INFO - mozversion platform_buildid: 20160607113037 14:03:26 INFO - mozversion platform_changeset: 3cf6f6e8022b9759ed2d914ad16f5a754de00366 14:03:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:03:26 INFO - mozversion platform_version: 50.0a1 14:03:26 INFO - using testdate: 1465333406 14:03:26 INFO - actual date: 1465333406 14:03:26 INFO - starting webserver on 'localhost:47253' 14:03:26 INFO - SUITE-START | Running 2 tests 14:03:26 INFO - TEST-START | dromaeo_css 14:03:26 INFO - operating with platform_type : linux_ 14:03:26 INFO - Initialising browser for dromaeo_css test... 14:03:26 INFO - TEST-INFO | started process 11732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZDx3N/profile http://localhost:47253/getInfo.html) 14:03:30 INFO - PROCESS | 11732 | __metrics Screen width/height:1600/1200 14:03:30 INFO - PROCESS | 11732 | colorDepth:24 14:03:30 INFO - PROCESS | 11732 | Browser inner width/height: 1024/697 14:03:30 INFO - PROCESS | 11732 | __metrics 14:03:31 ERROR - PROCESS | 11732 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:03:31 INFO - PROCESS | 11732 | console.error: PushService: 14:03:31 INFO - PROCESS | 11732 | stateChangeProcessEnqueue: Error transitioning state 14:03:31 INFO - PROCESS | 11732 | UnknownError 14:03:32 INFO - TEST-INFO | 11732: exit 0 14:03:32 INFO - Browser initialized. 14:03:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:32 INFO - TEST-INFO | started process 11814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZDx3N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:43 INFO - PROCESS | 11814 | RSS: Main: 156061696 14:03:43 INFO - PROCESS | 11814 | 14:04:35 INFO - PROCESS | 11814 | 1465333475239 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] 14:06:42 INFO - PROCESS | 11814 | Cycle 1(1): loaded http://localhost:47253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47253/tests/dromaeo/cssquery-ext.html) 14:06:43 INFO - PROCESS | 11814 | RSS: Main: 247865344 14:06:43 INFO - PROCESS | 11814 | 14:09:46 INFO - PROCESS | 11814 | Cycle 1(1): loaded http://localhost:47253/tests/dromaeo/cssquery-ext.html (next: http://localhost:47253/tests/dromaeo/cssquery-jquery.html) 14:09:47 INFO - PROCESS | 11814 | RSS: Main: 259219456 14:09:47 INFO - PROCESS | 11814 | 14:12:49 INFO - PROCESS | 11814 | Cycle 1(1): loaded http://localhost:47253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47253/tests/dromaeo/cssquery-mootools.html) 14:12:49 INFO - PROCESS | 11814 | RSS: Main: 257462272 14:12:49 INFO - PROCESS | 11814 | 14:15:51 INFO - PROCESS | 11814 | Cycle 1(1): loaded http://localhost:47253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47253/tests/dromaeo/cssquery-prototype.html) 14:15:52 INFO - PROCESS | 11814 | RSS: Main: 244994048 14:15:52 INFO - PROCESS | 11814 | 14:18:54 INFO - PROCESS | 11814 | Cycle 1(1): loaded http://localhost:47253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47253/tests/dromaeo/cssquery-yui.html) 14:18:55 INFO - PROCESS | 11814 | RSS: Main: 229347328 14:18:55 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | Cycle 1(1): loaded http://localhost:47253/tests/dromaeo/cssquery-yui.html (next: http://localhost:47253/tests/dromaeo/cssquery-dojo.html) 14:21:58 INFO - PROCESS | 11814 | RSS: Main: 330469376 14:21:58 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | __start_tp_report 14:21:58 INFO - PROCESS | 11814 | _x_x_mozilla_page_load 14:21:58 INFO - PROCESS | 11814 | _x_x_mozilla_page_load_details 14:21:58 INFO - PROCESS | 11814 | |i|pagename|runs| 14:21:58 INFO - PROCESS | 11814 | |0;dojo.html;3135.764817638677;3176.904692859214;3203.807771533708;3216.9195770105757;3239.1902024493875;5265.210218467232;5338.62629615927;5341.252224688546;5428.1586354115125;5441.727913604319;5363.8122665706705;5366.490183432577;5433.538149257308;5450.155225939976;5478.753456094475;4839.346688197093;4902.950970490285;4930.334404855353;4939.703617782927;5075.847724568251;4973.875653108683;5001.274815151819;5022.372203474566;5049.091163590552;5050.242463630467;4811.566958973692;4862.197737373347;4869.245266983623;4926.088673595361;4932.90134197314;4858.271259311096;4869.488703686133;4885.43817460993;4895.8776030599165;4995.350604421438;4887.560119589254;4916.754162291871;4917.336159618441;4929.728864912428;4962.851114466572;5173.120569503193;5304.416514183436;5360.383555891083;5384.057789886793;5388.946110538884;5778.191053252548;5877.970610146965;5889.911651325234;5893.0276504376725;5899.557533185029;5878.50032747217;5934.703264836741;5953.732082056318;5954.106883967396;5955.464008239236;5276.841694749163;5386.48828361305;5432.049391356536;5445.564354851642;5512.310961129859;6038.12447195163;6045.093236014633;6047.12316714074;6049.576529642971;6053.152558641706;5569.136783798518;5796.0436527972415;5798.5071268941765;5804.984127777622;5805.332386775491;5689.146628005749;5765.423457654201;5766.481016708516;5804.129380592861;5807.070868660994;5759.942400576025;5769.913451298234;5770.221020162225;5775;5776.826695199151;5559.19391688211;5740.856478588069;5746.597738158289;5791.362950075489;5791.391903850035;4452.376667266585;4461.57615026572;4468.4637843458995;4506.752128632891;4507.639388848885;3955.564887862333;3974.960250397517;3987.823592040355;3989.6409323161056;4022;5307.230451584499;5338;5355.062863998784;5478.753456094485;5495.0383682855345;5780.595358324961;5835.387284335168;5861.150133230658;5861.6189947653265;5904.084866845646;5467.917981230205;5471.425500322488;5473.507384335429;5474.343078830566;5483.150111732688;4713.622910167179;4866.270059491034;4887.828925987574;4915.631327650441;4967.875803104951;6051.122587224828;6058.818235452944;6063.454289114001;6066.363031881677;6101.420365065312;5861.238039055066;5873.735681894411;5874.647521148745;5875.294964604275;5879.088741245114;5762.654240745569;5901.822945311647;5960.672163031075;5972.5520585955355;6038.275406951194;5683.783324503364;5729.169270455844;5733.3406658234835;5738.196652468741;5743.282089738783;5804.6807425592;5815.302163740378;5818.156367326798;5818.214541037075;5821.883562328814;5495.725213739377;5624.550035997192;5665.858353541194;5682.602217844877;5711.5716321276905;5672.376038635664;5704.828855134353;5705.115707065412;5705.543556515386;5710.5146062585145;5375.139977603565;5590.664560126405;5597.272354593877;5605.299337582802;5611.803586874603;5653.689047102449;5680.886382272414;5711.543076553782;5797.507211887037;5799.971000145141;5567.66594004361;5575.163725441054;5575.470330318613;5601.971990140023;5620.915686264628 14:21:58 INFO - PROCESS | 11814 | |1;ext.html;619.74900165433;624.381861956663;636.9840753981151;646.221303329488;647.1586936981922;31121.68878311216;34497;34533.82733086337;37340.62659373406;39045.60954390455;45441.77279113608;46044.30933536;46092;46117.7694111529;46200.3069953951;8747.300215982723;8867.955660221689;8919.821603567925;8926.018138004814;8927.107289271085;8729.214370706635;8873.157050080232;8878.689245876396;8881.067487913773;8882.955585222066;8915.465072095663;8962.551872406386;8964;8967.730968070968;8967.820643587125;8883.289336853068;8916.777080572972;8929.241014513775;8931.196192342655;8954.86567701485;8786.384953053288;8858.335624828163;8873.645054197825;8875.423097498642;8886.244669203126;42245.78877105626;42625.786871065444;42718.57281427177;42720.57279427197;42760.78619606913;3487.3905507799304;3615.8011309378235;3645.125169959217;3820.465134881119;4063.2686116499017;30704.692953070407;30817;31065.37869242625;31141;32949.01152965415;4153.8961525961795;4254.893627659333;4263.4031235627035;4380.430544029287;4381.846635367779;343986;345015.2749236263;345056;345570;345774;57098.42901570931;57753.13370299449;58049;58185.12722309169;58228;61880;62129.37870621326;62265.377346226865;62383.37616623867;62449.37550624526;17459.738103928452;17689.823101768816;17720.379786707403;17730.20214090369;17734;13499.865001350057;13570.389332480063;13577.660558486117;13579.524716635067;13590.524331648345;15346.769798453031;16831.158442077845;16850.157492125345;16855.314468553293;16877.831221687873;5799.420057994167;5867.6772777497645;5874.441928016831;5877.265341832271;5888.705564721747;970.5632465390603;1021.8313978193663;1043.6034306963306;1051.5478344311866;1111.238801421013;31706;31919;32001.51997720036;32567.18582035468;32852.67147328544;1110.6612483192541;1127.8421021057059;1134.4838098665252;1209.1294268126935;1233.6991510832413;16945.83054169467;17030.57423564421;17179.656406872044;17186.82813171852;17391.217395217245;391928;545789;546712;547459;548499;59678.70160649169;59879;59926.70036649789;59968.400315997154;59970.70014649899;1272.9363531823371;1357.3349058961235;1400.2998500749625;1415.9751555275848;1459.7226526959844;29535.556966645087;30289.697103028688;30440;30477.906230249653;30763.077107686804;49281.50718492913;49899.25151122809;49929.75035124801;49947.50052499574;49959.50040499549;386754;394140;395771;396054;396495;23689.40776480602;25963.091291804696;26761.598576021766;27475.86262068677;27587.44825103527;46466.53533464622;47064.7646761764;47636.5236347646;47859.28211076906;48418.5158148414;38799.80600096982;39775.60224397719;39827.60172398355;39915.40126898157;40550.79724601358;39340.60659393369;39763.60236397599;39817.40273895952;39999.2000559958;40001.79999099986;36641;37707.811460943616;37741.4338784913;40594.39108413435;40675.59324406718;34198.829005855805;35994.28011439809;36324.875518053144;36767;36963.815180925;27940.57138324687;27989.440211195255;28266.20226396318;28312;28313.71686283193 14:21:58 INFO - PROCESS | 11814 | |2;jquery.html;367.70767240044177;375.59901567154515;384.49630983411714;391.6905644540813;402.762370201581;16932.746008809863;18383.356582519613;19192.808071919277;19275.614487710238;19310.90344548277;17746.556336091606;18021.36925207618;18276.543086422847;18326.266949322046;18549.53626159347;5284.973575132119;5377.892442151165;5485.067538518441;5577.749001294931;5582.665040097587;5413.323334583177;5454.881749241396;5455.8363249102595;5457.508824205821;5489.451054894498;5261.158214685651;5473.507384335409;5475.808346707866;5476.726163691819;5480.972595137038;5352.170413585881;5388.191771234307;5396.19057141428;5413.83758487246;5415.891682166354;4775.021120670254;4775.14047471455;4834.613230941516;4838.371011768448;4839.9032019359765;19204.327848525376;19245.422637320902;19377.224911003545;19451.805481945143;19969.30107446247;2213.7896899794496;2239.6304609739373;2274.8180145588312;2356.0340260493117;2644.2728249731285;13438.260895650736;13988.58034258974;14124.364403601863;14165.504207352693;14308.49760775114;1859.5537071102974;1866.150901339887;1871.9157637906326;1894.5926625775387;1947.123794292574;76298.23701762967;79355.6032219841;79764.60117699375;80227.5988620059;81272.59363703203;10140.543675534618;10186.643467478603;10351.689449316533;10373.585056597802;10500.369977801356;14170.71658566823;14315.28423578817;14324.068935519157;14324.212168330841;14363.138211707332;8049.678012879536;8207.589620518951;8234.835303293901;8332.833343333221;8404.20160084791;8140.959295203486;8211.876821847676;8252.958735206406;8402.915970840335;8452.78868028292;6319.33646967071;6324.524091764808;6369.299377068519;6470.38531339522;6572.112764776694;1777.9911100444415;1796.568823482381;1836.2287839107607;1891.1111777464569;1910.1881700277327;869.8869147010848;945.4610871803144;1035;1062.4953147254992;1098.7363032872213;16480.83519164817;17618.031008294667;17850.732239016426;18090;18381.81618183801;980.6910823090703;981.8527220916777;1002.0830939690247;1003.227514813604;1011.0900189829213;10141.695749127539;10263.7434064149;10385.234510133296;10513.9474302628;10565.683029509128;337274;450341;453854;455426;464473;54324.72837635787;67961;69028.6548567264;78596;79039.60480197563;939.9342046056847;1002.1331548210891;1016.7661437869332;1070.989290107089;1073.0771536478621;15469.922650386676;16082.678346432771;16725.498235052968;16823.24295406734;17319;35059.824700876336;41596.80039995001;42044.15911681688;42056;42391.15217695691;46356.30465542952;48897.266541001205;49016;54871.72564137314;55532.167017493965;8088.272055515032;8106.8783968241705;8308.667653294042;8339.749807505785;8487.575621218792;12612.495500180257;13063.673408164492;13072.673183170496;13126.474941002252;13179.934100329438;11152.035708782461;11191.104711622887;11281.71795705114;11293.943530282297;11560.075193984292;11372.43137843088;11374.94312528432;11525;11577.421128943352;11699.88300116988;11340.886591133984;11519.19365644397;11563.71090722705;11578.94210528942;11752.58865939688;8256.545889975869;8307.252347288773;8343;8421.789455263668;8671.956640217011;11450.599229026944;11581.82627260575;11587.246828956091;11601.361925094201;11605.825912611148 14:21:58 INFO - PROCESS | 11814 | |3;mootools.html;1358.476986360251;1468.1484738851468;1510.2222355486927;1706.7866516685415;1906.0755533566219;8823.514706691138;9177.77055573611;9221.492817895012;9459.858102128474;9464.242860571156;9162.86255706165;9340.299477539178;9352.111549402796;9357.391769534992;9358.812823743521;2044.9386518404472;2291.186628746796;2327.2320134355664;2356.5522550715395;2359.905603775847;2398.6761787158684;2402.8918698658604;2403.0267741564694;2408.2895545814026;2414.058517178293;2342;2353.729321128075;2365.7161140663143;2374.2165085521824;2375.3586531636447;1956.7064940259004;2230.732312122556;2290.874001929893;2297.310806757983;2302.1366987379733;2302.4013756423283;2322.210448447519;2336.217367181996;2336.941576460585;2345.7302410222874;9268.629254829799;9296.070392960717;9298.767530811716;9306.395084319498;9311.72064838056;5141.331626888518;5264.684118952875;5267.683938963674;5274.894502109974;5278.973605131988;3119.781615286931;3263.6573159818354;3289;3316.0217735768006;3327.1848397142853;1029.433811403725;1040.6929955663097;1043.9269251152423;1054.583439541377;1060.867391576053;13239.801402978963;13246.602601921957;13273.86726132736;13284.601461956157;13339.933300333534;4596.931046034312;4603.746793926299;4708.387909571802;4713.787879545429;4718.3158442025715;10924.344539327665;11025.062869656009;11064.834027489595;11065.50205240766;11066.114710823114;5347.25138480613;5360.758765855546;5387.461253874581;5387.919181212285;5391.595630327663;4359.585839345257;4765.499622539653;4899.608031357483;4914.385701787277;4946;3861.575226725058;3928.3518219493462;3981.482407287034;4042.130941847517;4132.40080188377;1243.104964425612;1252.6179515247936;1253.4359538207661;1266.7719810434025;1276.310792172235;1038.8753349598096;1053.1627356251797;1053.984190237147;1058.878229003659;1068.9251752377415;6348.936510634927;6352.269489008823;6458.22501299847;6506.967465162738;6532.967335163294;452.9637628989673;457.86492984569634;459.52209701910306;464.02323109853944;466.7946103714423;4140.875773726793;4224.324108142744;4296.054867929113;4297.183535128315;4307.181635489247;11354.659360219206;11683.824742628867;11856.05151587871;11856.70358241051;11875.940620296844;11455;11638.185327027197;11665.825012624817;11696.70758231051;11723.062155027748;8143.95928020368;8502.319814414832;8507.829843403097;8566;8653.091425400367;6043.697815109315;6242.843928901813;6281.623102613858;6284.465820405317;6319.093217119992;10560;10716.410597417216;10939.28894621847;10959;10980.450977451255;10997.285176463503;11024;11082.44587770592;11155.16336274799;11280.210385272952;8103.189681032086;8166.550839703873;8371.623276952674;8373.246407823324;8375.623096960773;8872.689455869013;8903.73288801337;8923.464592124234;8928.464292142493;9029.63881444735;7877.251661092187;8020.398470114881;8158.673653054048;8333.33333333344;8427.452215606212;7912.604369781603;8012.599370031592;8017.518948863087;8127.878081828895;8222.095569487232;7132.536385134949;7402.666879990521;7404.592747398729;7547.16981132064;7568.470207085451;5357.651752636066;5393.9730301348245;5419.160030195326;5510.586705997146;5562.527185189304;5498.532624726943;5556.361018482926;5613.578981576316;5614.522765564972;5644.068728659725 14:21:58 INFO - PROCESS | 11814 | |4;prototype.html;324.208930210287;331.5010908582583;338.1242581713362;341.09439438291344;341.60373966199217;5299;5378.542823859972;5378.973105134479;5426.348838139419;5427.891442171154;5063.8480845574595;5113.463086375923;5155.175171972485;5181.637285390024;5314.256004159421;3999.500187429714;4052.818537448104;4163.146554956242;4168.499780026401;4208.45290112285;4081.8367265309503;4147.709660323763;4164.479440069991;4180.101278225181;4187.68592355573;4112.485939257593;4166.604172603597;4167.312393455076;4183.414321994923;4190.55999120091;4120.690948178869;4139.461869956886;4165.521789305933;4168.2497150513045;4175.123224122938;3697.8552439585246;3699.963000370016;3700.888973330804;3709.2766910452474;3718.535183102112;4928.8767780805765;5078.13671675816;5088.109580823341;5093.567046801027;5156.664816786934;4730.124926888502;4746.596539294164;4749.857504274877;4764.190087685102;4765.761711914391;5502.972485137549;5517.710150287626;5517.862053448655;5520.503154716095;5527.2538207342295;3943.9014024649327;4041.2725709372303;4041.898952526181;4051.736637118578;4064.9593504065174;5653.830385088454;5658.811649553599;5715.599908006441;5749.540036797046;5759.625624334405;4086.693497987663;4090.284200264942;4102.774347410861;4106.281400754856;4106.979465102655;4016.357382818735;4174.91650166995;4201.68487363449;4213.157368526307;4216.262154123016;4742.359781429532;4776.035890211186;4785.210440277385;4785.832495862628;4799.832005879847;5396.703181325065;5554.861128471821;5563.749631266603;5566.548739781361;5567.526760225426;1335.4391155714623;1373.416298073315;1421.8507056758892;1430.1562078373809;1442.819647544057;921.9815603688023;949.534727983297;951.0442005784142;958.9041095890494;963.7230669363122;4704.435467743892;4751.762411879392;4766.523347665275;4806.7836947337455;4861.368022157168;4982.800687972441;5050.863555700012;5056.216286475602;5056.696598204119;5098.821541246039;4653.441587009581;4758.357621721093;4765.284497580868;4770.356001939763;4807.855764327076;2652.6286319915225;2736.2065001149444;2736.8642013564545;2743.6570428696414;2756.627855239517;5182.818601348935;5193.766280517386;5238;5239.816606418757;5248.687828042989;4807.375041244686;5083.779892825769;5125.205593133071;5139.820106296262;5146.614003949719;5201;5205.6616319939085;5235.424103348629;5256.369235691742;5268.631195816256;4918.532739389752;5023.8492845214705;5030.522100400456;5075.654951437798;5091.854332775096;4958.504149585013;4978.5270399312;5003.2745251938995;5023;5044.470330615232;5178.818741344035;5193.558547523503;5224.791008359623;5234.816781412632;5255.868603284795;3673.7612055216327;3738.6261373862394;3802.421994872097;3847.845646306041;3859.9228015440094;5030.2957585937265;5104.41299250591;5423.810166644149;5618.410066943075;5705.657660540381;5531.668099914018;5583.888322233452;5608.46719561641;5609.9158512621525;5610.831675049755;5523.364813046391;5524.198991146181;5569.554435645057;5583.050881350261;5616.248038461043;5271.815486457956;5508.173773933942;5519.675277933347;5553.305836770403;5555.194496798023;5638.182463542681;5651.180578816131;5654.971725141348;5674.290713660793;5690.886182276414;5235.397929238186;5545.639533430475;5588.888222235614;5591.273134492652;5611.410801865909 14:21:58 INFO - PROCESS | 11814 | |5;yui.html;733.7761982595306;743.5390058163939;772.6909236305477;793.1830214878676;805.7904944714375;16871.746923796138;17896.37362692303;17916.37292694756;17969.640607187866;17989.910050449762;16447.83552164478;16459.753103703424;16549.08980006102;16622.418215362464;16628.418005369815;818.153211426174;829.4318391901567;830.4975489828627;830.5099991005305;831.3515457942814;688.8415664397191;805.6495424490336;836.8451836410253;837.4598384042289;842.0568962761715;865.2645251536206;867.1371984875027;869.5912920927186;869.8129902071054;869.852125138728;702.8032150997728;855.9443636163692;861.9784505387385;862.3187681731424;862.6204470033197;620.9596376235576;635;635.4154178156108;639.2137670665107;639.5139693832674;15513.534593962198;15597.610059748484;15602.843971560253;15612.921935390365;15619.843801561952;13049.86950130496;13722.65693357664;13940.442382304796;13973;14024.859751402457;12948.48206071756;13004.804927926089;13062.804057939138;13372.264525451097;14001.649958751113;4419.491758447755;4432.734035957853;4457.48738895028;4625.676202665814;4672.3692301539195;72118.63940680315;72282.27717722808;72693;72996;73423;10850.186236032328;10956.28784129029;11099;11101.000909918146;11167.83248251277;19985.800141998683;20037.599248014958;20064.097115629833;20069.698954515694;20103.39689809308;7995.440319177718;8348.248657620843;8358.623861926228;8367;8513.318934485227;5052.494750524918;5055.115354812893;5186.092433824066;5220.634555581149;5226.398964119099;3304.8678052877617;3444.810535420526;3450.723942084627;3451.7066049386085;3452.482127680818;641.7593402474072;642.4378668664918;646.4731244036095;647.9449246813979;683.7201489956622;582.118091091996;683.9384455398938;687.7524091327118;715.559930642651;747.6747614787585;10319.432431216204;10364.948175259226;10375.84436233457;10503.684889453329;10543.42011189392;720.5964659790534;740.6000759589868;750.1763659668385;759.3393747439762;766.4098644044167;4834.651329978413;4850.902981940412;4969.850904472872;4971.90056198874;4981.227909674007;117058;119273;122627;128642;129503.35248323699;106989.46505267423;109509;110110;111108.4444577772;111541.44229278964;85139;86919.99920377492;87274;87568.5621571888;88505;9341.57962891658;9428.95285523568;9495.38280011797;9545.713628591153;9715.271354648288;54802.17796732973;55427;55915;57096.71451642715;58687;80011;84465.15534844573;86031.13968860231;86564.56717716371;87473.56263218643;12146.331951742739;12648.620541383772;12709.745805084032;12855.228686278853;12978.156419833058;14704.926475367554;14767.556973290819;14808;15209.391624334903;15514.612134696272;13409.463621455032;13412.12821166621;13901.721965560835;14003.43986240539;14419.78370324425;13598.184108953099;13738.86261137376;14171.716565668836;14278.571642850731;14644.487442939446;13716.314184290546;13726.261685501151;13920.651983700489;13952.302384880919;13992.16047037181;10474.947625261824;10621;10763.085137763377;10809.945950270197;11223.438828058728;10995.230333876552;11584.884151158718;11897.226680265756;12028.338441385808;12131.09016823724 14:21:58 INFO - PROCESS | 11814 | __end_tp_report 14:21:58 INFO - PROCESS | 11814 | __start_cc_report 14:21:58 INFO - PROCESS | 11814 | _x_x_mozilla_cycle_collect,815 14:21:58 INFO - PROCESS | 11814 | __end_cc_report 14:21:58 INFO - PROCESS | 11814 | __startTimestamp1465334518759__endTimestamp 14:21:58 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | ------- Summary: start ------- 14:21:58 INFO - PROCESS | 11814 | Number of tests: 6 14:21:58 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | [#0] dojo.html Cycles:165 Average:5391.16 Median:5590.66 stddev:614.18 (11.0%) stddev-sans-first:590.03 14:21:58 INFO - PROCESS | 11814 | Values: 3135.8 3176.9 3203.8 3216.9 3239.2 5265.2 5338.6 5341.3 5428.2 5441.7 5363.8 5366.5 5433.5 5450.2 5478.8 4839.3 4903.0 4930.3 4939.7 5075.8 4973.9 5001.3 5022.4 5049.1 5050.2 4811.6 4862.2 4869.2 4926.1 4932.9 4858.3 4869.5 4885.4 4895.9 4995.4 4887.6 4916.8 4917.3 4929.7 4962.9 5173.1 5304.4 5360.4 5384.1 5388.9 5778.2 5878.0 5889.9 5893.0 5899.6 5878.5 5934.7 5953.7 5954.1 5955.5 5276.8 5386.5 5432.0 5445.6 5512.3 6038.1 6045.1 6047.1 6049.6 6053.2 5569.1 5796.0 5798.5 5805.0 5805.3 5689.1 5765.4 5766.5 5804.1 5807.1 5759.9 5769.9 5770.2 5775.0 5776.8 5559.2 5740.9 5746.6 5791.4 5791.4 4452.4 4461.6 4468.5 4506.8 4507.6 3955.6 3975.0 3987.8 3989.6 4022.0 5307.2 5338.0 5355.1 5478.8 5495.0 5780.6 5835.4 5861.2 5861.6 5904.1 5467.9 5471.4 5473.5 5474.3 5483.2 4713.6 4866.3 4887.8 4915.6 4967.9 6051.1 6058.8 6063.5 6066.4 6101.4 5861.2 5873.7 5874.6 5875.3 5879.1 5762.7 5901.8 5960.7 5972.6 6038.3 5683.8 5729.2 5733.3 5738.2 5743.3 5804.7 5815.3 5818.2 5818.2 5821.9 5495.7 5624.6 5665.9 5682.6 5711.6 5672.4 5704.8 5705.1 5705.5 5710.5 5375.1 5590.7 5597.3 5605.3 5611.8 5653.7 5680.9 5711.5 5797.5 5800.0 5567.7 5575.2 5575.5 5602.0 5620.9 14:21:58 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | [#1] ext.html Cycles:180 Average:57950.94 Median:39796.50 stddev:112878.00 (283.6%) stddev-sans-first:113112.58 14:21:58 INFO - PROCESS | 11814 | Values: 619.7 624.4 637.0 646.2 647.2 31121.7 34497.0 34533.8 37340.6 39045.6 45441.8 46044.3 46092.0 46117.8 46200.3 8747.3 8868.0 8919.8 8926.0 8927.1 8729.2 8873.2 8878.7 8881.1 8883.0 8915.5 8962.6 8964.0 8967.7 8967.8 8883.3 8916.8 8929.2 8931.2 8954.9 8786.4 8858.3 8873.6 8875.4 8886.2 42245.8 42625.8 42718.6 42720.6 42760.8 3487.4 3615.8 3645.1 3820.5 4063.3 30704.7 30817.0 31065.4 31141.0 32949.0 4153.9 4254.9 4263.4 4380.4 4381.8 343986.0 345015.3 345056.0 345570.0 345774.0 57098.4 57753.1 58049.0 58185.1 58228.0 61880.0 62129.4 62265.4 62383.4 62449.4 17459.7 17689.8 17720.4 17730.2 17734.0 13499.9 13570.4 13577.7 13579.5 13590.5 15346.8 16831.2 16850.2 16855.3 16877.8 5799.4 5867.7 5874.4 5877.3 5888.7 970.6 1021.8 1043.6 1051.5 1111.2 31706.0 31919.0 32001.5 32567.2 32852.7 1110.7 1127.8 1134.5 1209.1 1233.7 16945.8 17030.6 17179.7 17186.8 17391.2 391928.0 545789.0 546712.0 547459.0 548499.0 59678.7 59879.0 59926.7 59968.4 59970.7 1272.9 1357.3 1400.3 1416.0 1459.7 29535.6 30289.7 30440.0 30477.9 30763.1 49281.5 49899.3 49929.8 49947.5 49959.5 386754.0 394140.0 395771.0 396054.0 396495.0 23689.4 25963.1 26761.6 27475.9 27587.4 46466.5 47064.8 47636.5 47859.3 48418.5 38799.8 39775.6 39827.6 39915.4 40550.8 39340.6 39763.6 39817.4 39999.2 40001.8 36641.0 37707.8 37741.4 40594.4 40675.6 34198.8 35994.3 36324.9 36767.0 36963.8 27940.6 27989.4 28266.2 28312.0 28313.7 14:21:58 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | [#2] jquery.html Cycles:180 Average:26305.70 Median:2226.71 stddev:71530.82 (3212.4%) stddev-sans-first:71704.97 14:21:58 INFO - PROCESS | 11814 | Values: 367.7 375.6 384.5 391.7 402.8 16932.7 18383.4 19192.8 19275.6 19310.9 17746.6 18021.4 18276.5 18326.3 18549.5 5285.0 5377.9 5485.1 5577.7 5582.7 5413.3 5454.9 5455.8 5457.5 5489.5 5261.2 5473.5 5475.8 5476.7 5481.0 5352.2 5388.2 5396.2 5413.8 5415.9 4775.0 4775.1 4834.6 4838.4 4839.9 19204.3 19245.4 19377.2 19451.8 19969.3 2213.8 2239.6 2274.8 2356.0 2644.3 13438.3 13988.6 14124.4 14165.5 14308.5 1859.6 1866.2 1871.9 1894.6 1947.1 76298.2 79355.6 79764.6 80227.6 81272.6 10140.5 10186.6 10351.7 10373.6 10500.4 14170.7 14315.3 14324.1 14324.2 14363.1 8049.7 8207.6 8234.8 8332.8 8404.2 8141.0 8211.9 8253.0 8402.9 8452.8 6319.3 6324.5 6369.3 6470.4 6572.1 1778.0 1796.6 1836.2 1891.1 1910.2 869.9 945.5 1035.0 1062.5 1098.7 16480.8 17618.0 17850.7 18090.0 18381.8 980.7 981.9 1002.1 1003.2 1011.1 10141.7 10263.7 10385.2 10513.9 10565.7 337274.0 450341.0 453854.0 455426.0 464473.0 54324.7 67961.0 69028.7 78596.0 79039.6 939.9 1002.1 1016.8 1071.0 1073.1 15469.9 16082.7 16725.5 16823.2 17319.0 35059.8 41596.8 42044.2 42056.0 42391.2 46356.3 48897.3 49016.0 54871.7 55532.2 8088.3 8106.9 8308.7 8339.7 8487.6 12612.5 13063.7 13072.7 13126.5 13179.9 11152.0 11191.1 11281.7 11293.9 11560.1 11372.4 11374.9 11525.0 11577.4 11699.9 11340.9 11519.2 11563.7 11578.9 11752.6 8256.5 8307.3 8343.0 8421.8 8672.0 11450.6 11581.8 11587.2 11601.4 11605.8 14:21:58 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | [#3] mootools.html Cycles:180 Average:6084.45 Median:2406.27 stddev:3601.98 (149.7%) stddev-sans-first:3594.57 14:21:58 INFO - PROCESS | 11814 | Values: 1358.5 1468.1 1510.2 1706.8 1906.1 8823.5 9177.8 9221.5 9459.9 9464.2 9162.9 9340.3 9352.1 9357.4 9358.8 2044.9 2291.2 2327.2 2356.6 2359.9 2398.7 2402.9 2403.0 2408.3 2414.1 2342.0 2353.7 2365.7 2374.2 2375.4 1956.7 2230.7 2290.9 2297.3 2302.1 2302.4 2322.2 2336.2 2336.9 2345.7 9268.6 9296.1 9298.8 9306.4 9311.7 5141.3 5264.7 5267.7 5274.9 5279.0 3119.8 3263.7 3289.0 3316.0 3327.2 1029.4 1040.7 1043.9 1054.6 1060.9 13239.8 13246.6 13273.9 13284.6 13339.9 4596.9 4603.7 4708.4 4713.8 4718.3 10924.3 11025.1 11064.8 11065.5 11066.1 5347.3 5360.8 5387.5 5387.9 5391.6 4359.6 4765.5 4899.6 4914.4 4946.0 3861.6 3928.4 3981.5 4042.1 4132.4 1243.1 1252.6 1253.4 1266.8 1276.3 1038.9 1053.2 1054.0 1058.9 1068.9 6348.9 6352.3 6458.2 6507.0 6533.0 453.0 457.9 459.5 464.0 466.8 4140.9 4224.3 4296.1 4297.2 4307.2 11354.7 11683.8 11856.1 11856.7 11875.9 11455.0 11638.2 11665.8 11696.7 11723.1 8144.0 8502.3 8507.8 8566.0 8653.1 6043.7 6242.8 6281.6 6284.5 6319.1 10560.0 10716.4 10939.3 10959.0 10980.5 10997.3 11024.0 11082.4 11155.2 11280.2 8103.2 8166.6 8371.6 8373.2 8375.6 8872.7 8903.7 8923.5 8928.5 9029.6 7877.3 8020.4 8158.7 8333.3 8427.5 7912.6 8012.6 8017.5 8127.9 8222.1 7132.5 7402.7 7404.6 7547.2 7568.5 5357.7 5394.0 5419.2 5510.6 5562.5 5498.5 5556.4 5613.6 5614.5 5644.1 14:21:58 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | [#4] prototype.html Cycles:180 Average:4505.79 Median:5037.50 stddev:1289.79 (25.6%) stddev-sans-first:1254.64 14:21:58 INFO - PROCESS | 11814 | Values: 324.2 331.5 338.1 341.1 341.6 5299.0 5378.5 5379.0 5426.3 5427.9 5063.8 5113.5 5155.2 5181.6 5314.3 3999.5 4052.8 4163.1 4168.5 4208.5 4081.8 4147.7 4164.5 4180.1 4187.7 4112.5 4166.6 4167.3 4183.4 4190.6 4120.7 4139.5 4165.5 4168.2 4175.1 3697.9 3700.0 3700.9 3709.3 3718.5 4928.9 5078.1 5088.1 5093.6 5156.7 4730.1 4746.6 4749.9 4764.2 4765.8 5503.0 5517.7 5517.9 5520.5 5527.3 3943.9 4041.3 4041.9 4051.7 4065.0 5653.8 5658.8 5715.6 5749.5 5759.6 4086.7 4090.3 4102.8 4106.3 4107.0 4016.4 4174.9 4201.7 4213.2 4216.3 4742.4 4776.0 4785.2 4785.8 4799.8 5396.7 5554.9 5563.7 5566.5 5567.5 1335.4 1373.4 1421.9 1430.2 1442.8 922.0 949.5 951.0 958.9 963.7 4704.4 4751.8 4766.5 4806.8 4861.4 4982.8 5050.9 5056.2 5056.7 5098.8 4653.4 4758.4 4765.3 4770.4 4807.9 2652.6 2736.2 2736.9 2743.7 2756.6 5182.8 5193.8 5238.0 5239.8 5248.7 4807.4 5083.8 5125.2 5139.8 5146.6 5201.0 5205.7 5235.4 5256.4 5268.6 4918.5 5023.8 5030.5 5075.7 5091.9 4958.5 4978.5 5003.3 5023.0 5044.5 5178.8 5193.6 5224.8 5234.8 5255.9 3673.8 3738.6 3802.4 3847.8 3859.9 5030.3 5104.4 5423.8 5618.4 5705.7 5531.7 5583.9 5608.5 5609.9 5610.8 5523.4 5524.2 5569.6 5583.1 5616.2 5271.8 5508.2 5519.7 5553.3 5555.2 5638.2 5651.2 5655.0 5674.3 5690.9 5235.4 5545.6 5588.9 5591.3 5611.4 14:21:58 INFO - PROCESS | 11814 | 14:21:58 INFO - PROCESS | 11814 | [#5] yui.html Cycles:180 Average:21870.55 Median:4426.11 stddev:32006.49 (723.1%) stddev-sans-first:32056.93 14:21:58 INFO - PROCESS | 11814 | Values: 733.8 743.5 772.7 793.2 805.8 16871.7 17896.4 17916.4 17969.6 17989.9 16447.8 16459.8 16549.1 16622.4 16628.4 818.2 829.4 830.5 830.5 831.4 688.8 805.6 836.8 837.5 842.1 865.3 867.1 869.6 869.8 869.9 702.8 855.9 862.0 862.3 862.6 621.0 635.0 635.4 639.2 639.5 15513.5 15597.6 15602.8 15612.9 15619.8 13049.9 13722.7 13940.4 13973.0 14024.9 12948.5 13004.8 13062.8 13372.3 14001.6 4419.5 4432.7 4457.5 4625.7 4672.4 72118.6 72282.3 72693.0 72996.0 73423.0 10850.2 10956.3 11099.0 11101.0 11167.8 19985.8 20037.6 20064.1 20069.7 20103.4 7995.4 8348.2 8358.6 8367.0 8513.3 5052.5 5055.1 5186.1 5220.6 5226.4 3304.9 3444.8 3450.7 3451.7 3452.5 641.8 642.4 646.5 647.9 683.7 582.1 683.9 687.8 715.6 747.7 10319.4 10364.9 10375.8 10503.7 10543.4 720.6 740.6 750.2 759.3 766.4 4834.7 4850.9 4969.9 4971.9 4981.2 117058.0 119273.0 122627.0 128642.0 129503.4 106989.5 109509.0 110110.0 111108.4 111541.4 85139.0 86920.0 87274.0 87568.6 88505.0 9341.6 9429.0 9495.4 9545.7 9715.3 54802.2 55427.0 55915.0 57096.7 58687.0 80011.0 84465.2 86031.1 86564.6 87473.6 12146.3 12648.6 12709.7 12855.2 12978.2 14704.9 14767.6 14808.0 15209.4 15514.6 13409.5 13412.1 13901.7 14003.4 14419.8 13598.2 13738.9 14171.7 14278.6 14644.5 13716.3 13726.3 13920.7 13952.3 13992.2 10474.9 10621.0 10763.1 10809.9 11223.4 10995.2 11584.9 11897.2 12028.3 12131.1 14:21:58 INFO - PROCESS | 11814 | -------- Summary: end -------- 14:21:58 INFO - PROCESS | 11814 | 14:21:59 INFO - TEST-INFO | 11814: exit 0 14:21:59 INFO - TEST-OK | dromaeo_css | took 1113060ms 14:21:59 INFO - TEST-START | kraken 14:21:59 INFO - operating with platform_type : linux_ 14:21:59 INFO - Initialising browser for kraken test... 14:21:59 INFO - TEST-INFO | started process 12003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv9Y11X/profile http://localhost:47253/getInfo.html) 14:22:03 INFO - PROCESS | 12003 | __metrics Screen width/height:1600/1200 14:22:03 INFO - PROCESS | 12003 | colorDepth:24 14:22:03 INFO - PROCESS | 12003 | Browser inner width/height: 1024/697 14:22:03 INFO - PROCESS | 12003 | __metrics 14:22:04 ERROR - PROCESS | 12003 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:22:04 INFO - PROCESS | 12003 | console.error: PushService: 14:22:04 INFO - PROCESS | 12003 | stateChangeProcessEnqueue: Error transitioning state 14:22:04 INFO - PROCESS | 12003 | UnknownError 14:22:05 INFO - TEST-INFO | 12003: exit 0 14:22:05 INFO - Browser initialized. 14:22:05 INFO - Running cycle 1/1 for kraken test... 14:22:05 INFO - TEST-INFO | started process 12084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv9Y11X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:16 INFO - PROCESS | 12084 | RSS: Main: 156155904 14:22:16 INFO - PROCESS | 12084 | 14:22:19 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47253/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:20 INFO - PROCESS | 12084 | RSS: Main: 214249472 14:22:20 INFO - PROCESS | 12084 | 14:22:22 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47253/tests/kraken/driver.html?testName=audio-dft) 14:22:23 INFO - PROCESS | 12084 | RSS: Main: 202637312 14:22:23 INFO - PROCESS | 12084 | 14:22:26 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47253/tests/kraken/driver.html?testName=audio-fft) 14:22:27 INFO - PROCESS | 12084 | RSS: Main: 268967936 14:22:27 INFO - PROCESS | 12084 | 14:22:29 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47253/tests/kraken/driver.html?testName=audio-oscillator) 14:22:29 INFO - PROCESS | 12084 | RSS: Main: 178851840 14:22:29 INFO - PROCESS | 12084 | 14:22:32 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:32 INFO - PROCESS | 12084 | RSS: Main: 182681600 14:22:32 INFO - PROCESS | 12084 | 14:22:35 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47253/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:36 INFO - PROCESS | 12084 | RSS: Main: 217477120 14:22:36 INFO - PROCESS | 12084 | 14:22:39 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47253/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:40 INFO - PROCESS | 12084 | RSS: Main: 220000256 14:22:40 INFO - PROCESS | 12084 | 14:22:43 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47253/tests/kraken/driver.html?testName=json-parse-financial) 14:22:43 INFO - PROCESS | 12084 | RSS: Main: 220860416 14:22:43 INFO - PROCESS | 12084 | 14:22:45 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:45 INFO - PROCESS | 12084 | RSS: Main: 206770176 14:22:45 INFO - PROCESS | 12084 | 14:22:47 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47253/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:48 INFO - PROCESS | 12084 | RSS: Main: 210718720 14:22:48 INFO - PROCESS | 12084 | 14:22:50 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:51 INFO - PROCESS | 12084 | RSS: Main: 217395200 14:22:51 INFO - PROCESS | 12084 | 14:22:53 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:54 INFO - PROCESS | 12084 | RSS: Main: 222302208 14:22:54 INFO - PROCESS | 12084 | 14:22:56 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:57 INFO - PROCESS | 12084 | RSS: Main: 222593024 14:22:57 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:47253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47253/tests/kraken/driver.html?testName=ai-astar) 14:22:59 INFO - PROCESS | 12084 | RSS: Main: 263557120 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | __start_tp_report 14:22:59 INFO - PROCESS | 12084 | _x_x_mozilla_page_load 14:22:59 INFO - PROCESS | 12084 | _x_x_mozilla_page_load_details 14:22:59 INFO - PROCESS | 12084 | |i|pagename|runs| 14:22:59 INFO - PROCESS | 12084 | |0;ai-astar;112;106;110;110;111;110;111;110;110;110 14:22:59 INFO - PROCESS | 12084 | |1;audio-beat-detection;163;126;128;181;127;127;152;125;157;125 14:22:59 INFO - PROCESS | 12084 | |2;audio-dft;161;161;161;162;161;161;161;161;162;162 14:22:59 INFO - PROCESS | 12084 | |3;audio-fft;75;75;76;126;76;76;73;74;100;75 14:22:59 INFO - PROCESS | 12084 | |4;audio-oscillator;85;86;113;84;84;86;124;84;84;136 14:22:59 INFO - PROCESS | 12084 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;117;117 14:22:59 INFO - PROCESS | 12084 | |6;imaging-darkroom;145;145;146;145;145;145;145;146;146;146 14:22:59 INFO - PROCESS | 12084 | |7;imaging-desaturate;95;95;94;94;95;95;94;95;95;94 14:22:59 INFO - PROCESS | 12084 | |8;json-parse-financial;54;56;54;55;54;55;54;54;55;54 14:22:59 INFO - PROCESS | 12084 | |9;json-stringify-tinderbox;60;61;61;61;61;62;60;61;61;62 14:22:59 INFO - PROCESS | 12084 | |10;stanford-crypto-aes;84;79;79;84;86;80;79;81;118;79 14:22:59 INFO - PROCESS | 12084 | |11;stanford-crypto-ccm;123;119;128;125;126;125;125;120;136;121 14:22:59 INFO - PROCESS | 12084 | |12;stanford-crypto-pbkdf2;160;160;162;159;159;157;159;161;158;161 14:22:59 INFO - PROCESS | 12084 | |13;stanford-crypto-sha256-iterative;62;64;64;67;63;63;64;62;63;65 14:22:59 INFO - PROCESS | 12084 | __end_tp_report 14:22:59 INFO - PROCESS | 12084 | __start_cc_report 14:22:59 INFO - PROCESS | 12084 | _x_x_mozilla_cycle_collect,1631 14:22:59 INFO - PROCESS | 12084 | __end_cc_report 14:22:59 INFO - PROCESS | 12084 | __startTimestamp1465334579405__endTimestamp 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | ------- Summary: start ------- 14:22:59 INFO - PROCESS | 12084 | Number of tests: 14 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.56 (1.4%) stddev-sans-first:1.48 14:22:59 INFO - PROCESS | 12084 | Values: 112.0 106.0 110.0 110.0 111.0 110.0 111.0 110.0 110.0 110.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:140.00 stddev:20.44 (14.6%) stddev-sans-first:20.08 14:22:59 INFO - PROCESS | 12084 | Values: 163.0 126.0 128.0 181.0 127.0 127.0 152.0 125.0 157.0 125.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:22:59 INFO - PROCESS | 12084 | Values: 161.0 161.0 161.0 162.0 161.0 161.0 161.0 161.0 162.0 162.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:17.18 (22.9%) stddev-sans-first:18.00 14:22:59 INFO - PROCESS | 12084 | Values: 75.0 75.0 76.0 126.0 76.0 76.0 73.0 74.0 100.0 75.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.00 stddev:19.91 (23.7%) stddev-sans-first:20.67 14:22:59 INFO - PROCESS | 12084 | Values: 85.0 86.0 113.0 84.0 84.0 86.0 124.0 84.0 84.0 136.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:22:59 INFO - PROCESS | 12084 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:22:59 INFO - PROCESS | 12084 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:22:59 INFO - PROCESS | 12084 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 14:22:59 INFO - PROCESS | 12084 | Values: 54.0 56.0 54.0 55.0 54.0 55.0 54.0 54.0 55.0 54.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 14:22:59 INFO - PROCESS | 12084 | Values: 60.0 61.0 61.0 61.0 61.0 62.0 60.0 61.0 61.0 62.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:80.50 stddev:11.91 (14.8%) stddev-sans-first:12.63 14:22:59 INFO - PROCESS | 12084 | Values: 84.0 79.0 79.0 84.0 86.0 80.0 79.0 81.0 118.0 79.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.00 stddev:4.85 (3.9%) stddev-sans-first:5.10 14:22:59 INFO - PROCESS | 12084 | Values: 123.0 119.0 128.0 125.0 126.0 125.0 125.0 120.0 136.0 121.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 14:22:59 INFO - PROCESS | 12084 | Values: 160.0 160.0 162.0 159.0 159.0 157.0 159.0 161.0 158.0 161.0 14:22:59 INFO - PROCESS | 12084 | 14:22:59 INFO - PROCESS | 12084 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.45 14:22:59 INFO - PROCESS | 12084 | Values: 62.0 64.0 64.0 67.0 63.0 63.0 64.0 62.0 63.0 65.0 14:22:59 INFO - PROCESS | 12084 | -------- Summary: end -------- 14:22:59 INFO - PROCESS | 12084 | 14:23:00 INFO - TEST-INFO | 12084: exit 0 14:23:00 INFO - TEST-OK | kraken | took 60900ms 14:23:00 INFO - SUITE-END | took 1173s 14:23:00 INFO - Completed test suite (00:19:34) 14:23:00 INFO - javascript benchmark 14:23:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.764817638677, 3176.904692859214, 3203.807771533708, 3216.9195770105757, 3239.1902024493875, 5265.210218467232, 5338.62629615927, 5341.252224688546, 5428.1586354115125, 5441.727913604319, 5363.8122665706705, 5366.490183432577, 5433.538149257308, 5450.155225939976, 5478.753456094475, 4839.346688197093, 4902.950970490285, 4930.334404855353, 4939.703617782927, 5075.847724568251, 4973.875653108683, 5001.274815151819, 5022.372203474566, 5049.091163590552, 5050.242463630467, 4811.566958973692, 4862.197737373347, 4869.245266983623, 4926.088673595361, 4932.90134197314, 4858.271259311096, 4869.488703686133, 4885.43817460993, 4895.8776030599165, 4995.350604421438, 4887.560119589254, 4916.754162291871, 4917.336159618441, 4929.728864912428, 4962.851114466572, 5173.120569503193, 5304.416514183436, 5360.383555891083, 5384.057789886793, 5388.946110538884, 5778.191053252548, 5877.970610146965, 5889.911651325234, 5893.0276504376725, 5899.557533185029, 5878.50032747217, 5934.703264836741, 5953.732082056318, 5954.106883967396, 5955.464008239236, 5276.841694749163, 5386.48828361305, 5432.049391356536, 5445.564354851642, 5512.310961129859, 6038.12447195163, 6045.093236014633, 6047.12316714074, 6049.576529642971, 6053.152558641706, 5569.136783798518, 5796.0436527972415, 5798.5071268941765, 5804.984127777622, 5805.332386775491, 5689.146628005749, 5765.423457654201, 5766.481016708516, 5804.129380592861, 5807.070868660994, 5759.942400576025, 5769.913451298234, 5770.221020162225, 5775.0, 5776.826695199151, 5559.19391688211, 5740.856478588069, 5746.597738158289, 5791.362950075489, 5791.391903850035, 4452.376667266585, 4461.57615026572, 4468.4637843458995, 4506.752128632891, 4507.639388848885, 3955.564887862333, 3974.960250397517, 3987.823592040355, 3989.6409323161056, 4022.0, 5307.230451584499, 5338.0, 5355.062863998784, 5478.753456094485, 5495.0383682855345, 5780.595358324961, 5835.387284335168, 5861.150133230658, 5861.6189947653265, 5904.084866845646, 5467.917981230205, 5471.425500322488, 5473.507384335429, 5474.343078830566, 5483.150111732688, 4713.622910167179, 4866.270059491034, 4887.828925987574, 4915.631327650441, 4967.875803104951, 6051.122587224828, 6058.818235452944, 6063.454289114001, 6066.363031881677, 6101.420365065312, 5861.238039055066, 5873.735681894411, 5874.647521148745, 5875.294964604275, 5879.088741245114, 5762.654240745569, 5901.822945311647, 5960.672163031075, 5972.5520585955355, 6038.275406951194, 5683.783324503364, 5729.169270455844, 5733.3406658234835, 5738.196652468741, 5743.282089738783, 5804.6807425592, 5815.302163740378, 5818.156367326798, 5818.214541037075, 5821.883562328814, 5495.725213739377, 5624.550035997192, 5665.858353541194, 5682.602217844877, 5711.5716321276905, 5672.376038635664, 5704.828855134353, 5705.115707065412, 5705.543556515386, 5710.5146062585145, 5375.139977603565, 5590.664560126405, 5597.272354593877, 5605.299337582802, 5611.803586874603, 5653.689047102449, 5680.886382272414, 5711.543076553782, 5797.507211887037, 5799.971000145141, 5567.66594004361, 5575.163725441054, 5575.470330318613, 5601.971990140023, 5620.915686264628], "value": 5350.24162471176, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.74900165433, 624.381861956663, 636.9840753981151, 646.221303329488, 647.1586936981922, 31121.68878311216, 34497.0, 34533.82733086337, 37340.62659373406, 39045.60954390455, 45441.77279113608, 46044.30933536, 46092.0, 46117.7694111529, 46200.3069953951, 8747.300215982723, 8867.955660221689, 8919.821603567925, 8926.018138004814, 8927.107289271085, 8729.214370706635, 8873.157050080232, 8878.689245876396, 8881.067487913773, 8882.955585222066, 8915.465072095663, 8962.551872406386, 8964.0, 8967.730968070968, 8967.820643587125, 8883.289336853068, 8916.777080572972, 8929.241014513775, 8931.196192342655, 8954.86567701485, 8786.384953053288, 8858.335624828163, 8873.645054197825, 8875.423097498642, 8886.244669203126, 42245.78877105626, 42625.786871065444, 42718.57281427177, 42720.57279427197, 42760.78619606913, 3487.3905507799304, 3615.8011309378235, 3645.125169959217, 3820.465134881119, 4063.2686116499017, 30704.692953070407, 30817.0, 31065.37869242625, 31141.0, 32949.01152965415, 4153.8961525961795, 4254.893627659333, 4263.4031235627035, 4380.430544029287, 4381.846635367779, 343986.0, 345015.2749236263, 345056.0, 345570.0, 345774.0, 57098.42901570931, 57753.13370299449, 58049.0, 58185.12722309169, 58228.0, 61880.0, 62129.37870621326, 62265.377346226865, 62383.37616623867, 62449.37550624526, 17459.738103928452, 17689.823101768816, 17720.379786707403, 17730.20214090369, 17734.0, 13499.865001350057, 13570.389332480063, 13577.660558486117, 13579.524716635067, 13590.524331648345, 15346.769798453031, 16831.158442077845, 16850.157492125345, 16855.314468553293, 16877.831221687873, 5799.420057994167, 5867.6772777497645, 5874.441928016831, 5877.265341832271, 5888.705564721747, 970.5632465390603, 1021.8313978193663, 1043.6034306963306, 1051.5478344311866, 1111.238801421013, 31706.0, 31919.0, 32001.51997720036, 32567.18582035468, 32852.67147328544, 1110.6612483192541, 1127.8421021057059, 1134.4838098665252, 1209.1294268126935, 1233.6991510832413, 16945.83054169467, 17030.57423564421, 17179.656406872044, 17186.82813171852, 17391.217395217245, 391928.0, 545789.0, 546712.0, 547459.0, 548499.0, 59678.70160649169, 59879.0, 59926.70036649789, 59968.400315997154, 59970.70014649899, 1272.9363531823371, 1357.3349058961235, 1400.2998500749625, 1415.9751555275848, 1459.7226526959844, 29535.556966645087, 30289.697103028688, 30440.0, 30477.906230249653, 30763.077107686804, 49281.50718492913, 49899.25151122809, 49929.75035124801, 49947.50052499574, 49959.50040499549, 386754.0, 394140.0, 395771.0, 396054.0, 396495.0, 23689.40776480602, 25963.091291804696, 26761.598576021766, 27475.86262068677, 27587.44825103527, 46466.53533464622, 47064.7646761764, 47636.5236347646, 47859.28211076906, 48418.5158148414, 38799.80600096982, 39775.60224397719, 39827.60172398355, 39915.40126898157, 40550.79724601358, 39340.60659393369, 39763.60236397599, 39817.40273895952, 39999.2000559958, 40001.79999099986, 36641.0, 37707.811460943616, 37741.4338784913, 40594.39108413435, 40675.59324406718, 34198.829005855805, 35994.28011439809, 36324.875518053144, 36767.0, 36963.815180925, 27940.57138324687, 27989.440211195255, 28266.20226396318, 28312.0, 28313.71686283193], "value": 19785.5876229898, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.70767240044177, 375.59901567154515, 384.49630983411714, 391.6905644540813, 402.762370201581, 16932.746008809863, 18383.356582519613, 19192.808071919277, 19275.614487710238, 19310.90344548277, 17746.556336091606, 18021.36925207618, 18276.543086422847, 18326.266949322046, 18549.53626159347, 5284.973575132119, 5377.892442151165, 5485.067538518441, 5577.749001294931, 5582.665040097587, 5413.323334583177, 5454.881749241396, 5455.8363249102595, 5457.508824205821, 5489.451054894498, 5261.158214685651, 5473.507384335409, 5475.808346707866, 5476.726163691819, 5480.972595137038, 5352.170413585881, 5388.191771234307, 5396.19057141428, 5413.83758487246, 5415.891682166354, 4775.021120670254, 4775.14047471455, 4834.613230941516, 4838.371011768448, 4839.9032019359765, 19204.327848525376, 19245.422637320902, 19377.224911003545, 19451.805481945143, 19969.30107446247, 2213.7896899794496, 2239.6304609739373, 2274.8180145588312, 2356.0340260493117, 2644.2728249731285, 13438.260895650736, 13988.58034258974, 14124.364403601863, 14165.504207352693, 14308.49760775114, 1859.5537071102974, 1866.150901339887, 1871.9157637906326, 1894.5926625775387, 1947.123794292574, 76298.23701762967, 79355.6032219841, 79764.60117699375, 80227.5988620059, 81272.59363703203, 10140.543675534618, 10186.643467478603, 10351.689449316533, 10373.585056597802, 10500.369977801356, 14170.71658566823, 14315.28423578817, 14324.068935519157, 14324.212168330841, 14363.138211707332, 8049.678012879536, 8207.589620518951, 8234.835303293901, 8332.833343333221, 8404.20160084791, 8140.959295203486, 8211.876821847676, 8252.958735206406, 8402.915970840335, 8452.78868028292, 6319.33646967071, 6324.524091764808, 6369.299377068519, 6470.38531339522, 6572.112764776694, 1777.9911100444415, 1796.568823482381, 1836.2287839107607, 1891.1111777464569, 1910.1881700277327, 869.8869147010848, 945.4610871803144, 1035.0, 1062.4953147254992, 1098.7363032872213, 16480.83519164817, 17618.031008294667, 17850.732239016426, 18090.0, 18381.81618183801, 980.6910823090703, 981.8527220916777, 1002.0830939690247, 1003.227514813604, 1011.0900189829213, 10141.695749127539, 10263.7434064149, 10385.234510133296, 10513.9474302628, 10565.683029509128, 337274.0, 450341.0, 453854.0, 455426.0, 464473.0, 54324.72837635787, 67961.0, 69028.6548567264, 78596.0, 79039.60480197563, 939.9342046056847, 1002.1331548210891, 1016.7661437869332, 1070.989290107089, 1073.0771536478621, 15469.922650386676, 16082.678346432771, 16725.498235052968, 16823.24295406734, 17319.0, 35059.824700876336, 41596.80039995001, 42044.15911681688, 42056.0, 42391.15217695691, 46356.30465542952, 48897.266541001205, 49016.0, 54871.72564137314, 55532.167017493965, 8088.272055515032, 8106.8783968241705, 8308.667653294042, 8339.749807505785, 8487.575621218792, 12612.495500180257, 13063.673408164492, 13072.673183170496, 13126.474941002252, 13179.934100329438, 11152.035708782461, 11191.104711622887, 11281.71795705114, 11293.943530282297, 11560.075193984292, 11372.43137843088, 11374.94312528432, 11525.0, 11577.421128943352, 11699.88300116988, 11340.886591133984, 11519.19365644397, 11563.71090722705, 11578.94210528942, 11752.58865939688, 8256.545889975869, 8307.252347288773, 8343.0, 8421.789455263668, 8671.956640217011, 11450.599229026944, 11581.82627260575, 11587.246828956091, 11601.361925094201, 11605.825912611148], "value": 8956.555151771898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.476986360251, 1468.1484738851468, 1510.2222355486927, 1706.7866516685415, 1906.0755533566219, 8823.514706691138, 9177.77055573611, 9221.492817895012, 9459.858102128474, 9464.242860571156, 9162.86255706165, 9340.299477539178, 9352.111549402796, 9357.391769534992, 9358.812823743521, 2044.9386518404472, 2291.186628746796, 2327.2320134355664, 2356.5522550715395, 2359.905603775847, 2398.6761787158684, 2402.8918698658604, 2403.0267741564694, 2408.2895545814026, 2414.058517178293, 2342.0, 2353.729321128075, 2365.7161140663143, 2374.2165085521824, 2375.3586531636447, 1956.7064940259004, 2230.732312122556, 2290.874001929893, 2297.310806757983, 2302.1366987379733, 2302.4013756423283, 2322.210448447519, 2336.217367181996, 2336.941576460585, 2345.7302410222874, 9268.629254829799, 9296.070392960717, 9298.767530811716, 9306.395084319498, 9311.72064838056, 5141.331626888518, 5264.684118952875, 5267.683938963674, 5274.894502109974, 5278.973605131988, 3119.781615286931, 3263.6573159818354, 3289.0, 3316.0217735768006, 3327.1848397142853, 1029.433811403725, 1040.6929955663097, 1043.9269251152423, 1054.583439541377, 1060.867391576053, 13239.801402978963, 13246.602601921957, 13273.86726132736, 13284.601461956157, 13339.933300333534, 4596.931046034312, 4603.746793926299, 4708.387909571802, 4713.787879545429, 4718.3158442025715, 10924.344539327665, 11025.062869656009, 11064.834027489595, 11065.50205240766, 11066.114710823114, 5347.25138480613, 5360.758765855546, 5387.461253874581, 5387.919181212285, 5391.595630327663, 4359.585839345257, 4765.499622539653, 4899.608031357483, 4914.385701787277, 4946.0, 3861.575226725058, 3928.3518219493462, 3981.482407287034, 4042.130941847517, 4132.40080188377, 1243.104964425612, 1252.6179515247936, 1253.4359538207661, 1266.7719810434025, 1276.310792172235, 1038.8753349598096, 1053.1627356251797, 1053.984190237147, 1058.878229003659, 1068.9251752377415, 6348.936510634927, 6352.269489008823, 6458.22501299847, 6506.967465162738, 6532.967335163294, 452.9637628989673, 457.86492984569634, 459.52209701910306, 464.02323109853944, 466.7946103714423, 4140.875773726793, 4224.324108142744, 4296.054867929113, 4297.183535128315, 4307.181635489247, 11354.659360219206, 11683.824742628867, 11856.05151587871, 11856.70358241051, 11875.940620296844, 11455.0, 11638.185327027197, 11665.825012624817, 11696.70758231051, 11723.062155027748, 8143.95928020368, 8502.319814414832, 8507.829843403097, 8566.0, 8653.091425400367, 6043.697815109315, 6242.843928901813, 6281.623102613858, 6284.465820405317, 6319.093217119992, 10560.0, 10716.410597417216, 10939.28894621847, 10959.0, 10980.450977451255, 10997.285176463503, 11024.0, 11082.44587770592, 11155.16336274799, 11280.210385272952, 8103.189681032086, 8166.550839703873, 8371.623276952674, 8373.246407823324, 8375.623096960773, 8872.689455869013, 8903.73288801337, 8923.464592124234, 8928.464292142493, 9029.63881444735, 7877.251661092187, 8020.398470114881, 8158.673653054048, 8333.33333333344, 8427.452215606212, 7912.604369781603, 8012.599370031592, 8017.518948863087, 8127.878081828895, 8222.095569487232, 7132.536385134949, 7402.666879990521, 7404.592747398729, 7547.16981132064, 7568.470207085451, 5357.651752636066, 5393.9730301348245, 5419.160030195326, 5510.586705997146, 5562.527185189304, 5498.532624726943, 5556.361018482926, 5613.578981576316, 5614.522765564972, 5644.068728659725], "value": 4710.37330139001, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.208930210287, 331.5010908582583, 338.1242581713362, 341.09439438291344, 341.60373966199217, 5299.0, 5378.542823859972, 5378.973105134479, 5426.348838139419, 5427.891442171154, 5063.8480845574595, 5113.463086375923, 5155.175171972485, 5181.637285390024, 5314.256004159421, 3999.500187429714, 4052.818537448104, 4163.146554956242, 4168.499780026401, 4208.45290112285, 4081.8367265309503, 4147.709660323763, 4164.479440069991, 4180.101278225181, 4187.68592355573, 4112.485939257593, 4166.604172603597, 4167.312393455076, 4183.414321994923, 4190.55999120091, 4120.690948178869, 4139.461869956886, 4165.521789305933, 4168.2497150513045, 4175.123224122938, 3697.8552439585246, 3699.963000370016, 3700.888973330804, 3709.2766910452474, 3718.535183102112, 4928.8767780805765, 5078.13671675816, 5088.109580823341, 5093.567046801027, 5156.664816786934, 4730.124926888502, 4746.596539294164, 4749.857504274877, 4764.190087685102, 4765.761711914391, 5502.972485137549, 5517.710150287626, 5517.862053448655, 5520.503154716095, 5527.2538207342295, 3943.9014024649327, 4041.2725709372303, 4041.898952526181, 4051.736637118578, 4064.9593504065174, 5653.830385088454, 5658.811649553599, 5715.599908006441, 5749.540036797046, 5759.625624334405, 4086.693497987663, 4090.284200264942, 4102.774347410861, 4106.281400754856, 4106.979465102655, 4016.357382818735, 4174.91650166995, 4201.68487363449, 4213.157368526307, 4216.262154123016, 4742.359781429532, 4776.035890211186, 4785.210440277385, 4785.832495862628, 4799.832005879847, 5396.703181325065, 5554.861128471821, 5563.749631266603, 5566.548739781361, 5567.526760225426, 1335.4391155714623, 1373.416298073315, 1421.8507056758892, 1430.1562078373809, 1442.819647544057, 921.9815603688023, 949.534727983297, 951.0442005784142, 958.9041095890494, 963.7230669363122, 4704.435467743892, 4751.762411879392, 4766.523347665275, 4806.7836947337455, 4861.368022157168, 4982.800687972441, 5050.863555700012, 5056.216286475602, 5056.696598204119, 5098.821541246039, 4653.441587009581, 4758.357621721093, 4765.284497580868, 4770.356001939763, 4807.855764327076, 2652.6286319915225, 2736.2065001149444, 2736.8642013564545, 2743.6570428696414, 2756.627855239517, 5182.818601348935, 5193.766280517386, 5238.0, 5239.816606418757, 5248.687828042989, 4807.375041244686, 5083.779892825769, 5125.205593133071, 5139.820106296262, 5146.614003949719, 5201.0, 5205.6616319939085, 5235.424103348629, 5256.369235691742, 5268.631195816256, 4918.532739389752, 5023.8492845214705, 5030.522100400456, 5075.654951437798, 5091.854332775096, 4958.504149585013, 4978.5270399312, 5003.2745251938995, 5023.0, 5044.470330615232, 5178.818741344035, 5193.558547523503, 5224.791008359623, 5234.816781412632, 5255.868603284795, 3673.7612055216327, 3738.6261373862394, 3802.421994872097, 3847.845646306041, 3859.9228015440094, 5030.2957585937265, 5104.41299250591, 5423.810166644149, 5618.410066943075, 5705.657660540381, 5531.668099914018, 5583.888322233452, 5608.46719561641, 5609.9158512621525, 5610.831675049755, 5523.364813046391, 5524.198991146181, 5569.554435645057, 5583.050881350261, 5616.248038461043, 5271.815486457956, 5508.173773933942, 5519.675277933347, 5553.305836770403, 5555.194496798023, 5638.182463542681, 5651.180578816131, 5654.971725141348, 5674.290713660793, 5690.886182276414, 5235.397929238186, 5545.639533430475, 5588.888222235614, 5591.273134492652, 5611.410801865909], "value": 4100.309366451772, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.7761982595306, 743.5390058163939, 772.6909236305477, 793.1830214878676, 805.7904944714375, 16871.746923796138, 17896.37362692303, 17916.37292694756, 17969.640607187866, 17989.910050449762, 16447.83552164478, 16459.753103703424, 16549.08980006102, 16622.418215362464, 16628.418005369815, 818.153211426174, 829.4318391901567, 830.4975489828627, 830.5099991005305, 831.3515457942814, 688.8415664397191, 805.6495424490336, 836.8451836410253, 837.4598384042289, 842.0568962761715, 865.2645251536206, 867.1371984875027, 869.5912920927186, 869.8129902071054, 869.852125138728, 702.8032150997728, 855.9443636163692, 861.9784505387385, 862.3187681731424, 862.6204470033197, 620.9596376235576, 635.0, 635.4154178156108, 639.2137670665107, 639.5139693832674, 15513.534593962198, 15597.610059748484, 15602.843971560253, 15612.921935390365, 15619.843801561952, 13049.86950130496, 13722.65693357664, 13940.442382304796, 13973.0, 14024.859751402457, 12948.48206071756, 13004.804927926089, 13062.804057939138, 13372.264525451097, 14001.649958751113, 4419.491758447755, 4432.734035957853, 4457.48738895028, 4625.676202665814, 4672.3692301539195, 72118.63940680315, 72282.27717722808, 72693.0, 72996.0, 73423.0, 10850.186236032328, 10956.28784129029, 11099.0, 11101.000909918146, 11167.83248251277, 19985.800141998683, 20037.599248014958, 20064.097115629833, 20069.698954515694, 20103.39689809308, 7995.440319177718, 8348.248657620843, 8358.623861926228, 8367.0, 8513.318934485227, 5052.494750524918, 5055.115354812893, 5186.092433824066, 5220.634555581149, 5226.398964119099, 3304.8678052877617, 3444.810535420526, 3450.723942084627, 3451.7066049386085, 3452.482127680818, 641.7593402474072, 642.4378668664918, 646.4731244036095, 647.9449246813979, 683.7201489956622, 582.118091091996, 683.9384455398938, 687.7524091327118, 715.559930642651, 747.6747614787585, 10319.432431216204, 10364.948175259226, 10375.84436233457, 10503.684889453329, 10543.42011189392, 720.5964659790534, 740.6000759589868, 750.1763659668385, 759.3393747439762, 766.4098644044167, 4834.651329978413, 4850.902981940412, 4969.850904472872, 4971.90056198874, 4981.227909674007, 117058.0, 119273.0, 122627.0, 128642.0, 129503.35248323699, 106989.46505267423, 109509.0, 110110.0, 111108.4444577772, 111541.44229278964, 85139.0, 86919.99920377492, 87274.0, 87568.5621571888, 88505.0, 9341.57962891658, 9428.95285523568, 9495.38280011797, 9545.713628591153, 9715.271354648288, 54802.17796732973, 55427.0, 55915.0, 57096.71451642715, 58687.0, 80011.0, 84465.15534844573, 86031.13968860231, 86564.56717716371, 87473.56263218643, 12146.331951742739, 12648.620541383772, 12709.745805084032, 12855.228686278853, 12978.156419833058, 14704.926475367554, 14767.556973290819, 14808.0, 15209.391624334903, 15514.612134696272, 13409.463621455032, 13412.12821166621, 13901.721965560835, 14003.43986240539, 14419.78370324425, 13598.184108953099, 13738.86261137376, 14171.716565668836, 14278.571642850731, 14644.487442939446, 13716.314184290546, 13726.261685501151, 13920.651983700489, 13952.302384880919, 13992.16047037181, 10474.947625261824, 10621.0, 10763.085137763377, 10809.945950270197, 11223.438828058728, 10995.230333876552, 11584.884151158718, 11897.226680265756, 12028.338441385808, 12131.09016823724], "value": 7790.3787732102155, "unit": "score"}], "name": "dromaeo_css", "value": 7228.638018913081, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 128.0, 181.0, 127.0, 127.0, 152.0, 125.0, 157.0, 125.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 126.0, 76.0, 76.0, 73.0, 74.0, 100.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 113.0, 84.0, 84.0, 86.0, 124.0, 84.0, 84.0, 136.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 60.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 79.0, 84.0, 86.0, 80.0, 79.0, 81.0, 118.0, 79.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 119.0, 128.0, 125.0, 126.0, 125.0, 125.0, 120.0, 136.0, 121.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 159.0, 159.0, 157.0, 159.0, 161.0, 158.0, 161.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 67.0, 63.0, 63.0, 64.0, 62.0, 63.0, 65.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1496.9, "alertThreshold": 2.0}]} 14:23:00 INFO - Return code: 0 14:23:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:23:00 ERROR - # TBPL SUCCESS # 14:23:00 INFO - Running post-action listener: _resource_record_post_action 14:23:00 INFO - ##### 14:23:00 INFO - ##### Finished run-tests step (success) 14:23:00 INFO - ##### 14:23:00 INFO - Running post-run listener: _resource_record_post_run 14:23:00 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 367919104; Read time: 160; Write time: 248808 14:23:00 INFO - TinderboxPrint: CPU usage
13.2% 14:23:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 160 14:23:00 INFO - TinderboxPrint: I/O write bytes / time
367,919,104 / 248,808 14:23:00 INFO - TinderboxPrint: CPU idle
8,253.2 (86.8%) 14:23:00 INFO - TinderboxPrint: CPU user
1,215.5 (12.8%) 14:23:00 INFO - TinderboxPrint: Swap in / out
0 / 0 14:23:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 73244672; Read time: 0; Write time: 34328 14:23:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294674432; Read time: 160; Write time: 214480 14:23:01 INFO - Running post-run listener: _upload_blobber_files 14:23:01 INFO - Blob upload gear active. 14:23:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:23:01 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 14:23:01 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'] 14:23:01 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 14:23:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:23:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:23:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:02 INFO - (blobuploader) - INFO - Done attempting. 14:23:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:23:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:23:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:03 INFO - (blobuploader) - INFO - Done attempting. 14:23:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:23:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:23:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:17 INFO - (blobuploader) - INFO - Done attempting. 14:23:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:17 INFO - Return code: 0 14:23:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:23:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bba1a1a1625619179a1fd19acc001fc3ef08a09fd36e2e6bc4f1388f51563489231bba1a2a04540783be7247a9c2318904cd7345ea3e88b91f9d8ec8fe1d557a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bfd31a0060748ea930b291311d80ed1f4ee4363804391ab264eabd3e1a14b1d96aede3e7d541a6ac88795c27ffe583b89dfded82f83b9bd40bbf5181d0faf51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a8fc93e46f3619aad9236c26e7bf31071a4afecda1dc0262dfba8663c728d7e4580a5b485fdc14990ae0e0f32d6ba0df5f5d8a144639e19db0ecb00d9105914"} 14:23:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:23:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:23:17 INFO - Contents: 14:23:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bba1a1a1625619179a1fd19acc001fc3ef08a09fd36e2e6bc4f1388f51563489231bba1a2a04540783be7247a9c2318904cd7345ea3e88b91f9d8ec8fe1d557a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bfd31a0060748ea930b291311d80ed1f4ee4363804391ab264eabd3e1a14b1d96aede3e7d541a6ac88795c27ffe583b89dfded82f83b9bd40bbf5181d0faf51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a8fc93e46f3619aad9236c26e7bf31071a4afecda1dc0262dfba8663c728d7e4580a5b485fdc14990ae0e0f32d6ba0df5f5d8a144639e19db0ecb00d9105914"} 14:23:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:23:17 INFO - Copying logs to upload dir... 14:23:17 INFO - mkdir: /builds/slave/test/build/upload/logs 14:23:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.225487 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-07 14:23:16.700165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 14:23:16.704027) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bba1a1a1625619179a1fd19acc001fc3ef08a09fd36e2e6bc4f1388f51563489231bba1a2a04540783be7247a9c2318904cd7345ea3e88b91f9d8ec8fe1d557a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bfd31a0060748ea930b291311d80ed1f4ee4363804391ab264eabd3e1a14b1d96aede3e7d541a6ac88795c27ffe583b89dfded82f83b9bd40bbf5181d0faf51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a8fc93e46f3619aad9236c26e7bf31071a4afecda1dc0262dfba8663c728d7e4580a5b485fdc14990ae0e0f32d6ba0df5f5d8a144639e19db0ecb00d9105914"} build_url:https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bba1a1a1625619179a1fd19acc001fc3ef08a09fd36e2e6bc4f1388f51563489231bba1a2a04540783be7247a9c2318904cd7345ea3e88b91f9d8ec8fe1d557a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bfd31a0060748ea930b291311d80ed1f4ee4363804391ab264eabd3e1a14b1d96aede3e7d541a6ac88795c27ffe583b89dfded82f83b9bd40bbf5181d0faf51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a8fc93e46f3619aad9236c26e7bf31071a4afecda1dc0262dfba8663c728d7e4580a5b485fdc14990ae0e0f32d6ba0df5f5d8a144639e19db0ecb00d9105914"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 14:23:16.730561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:23:16.730953) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465331844.230477-227257949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:23:16.815181) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 14:23:16.815556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 14:23:16.815894) ========= ========= Total master_lag: 0.17 =========