builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1465200855.77 results: success (0) buildid: 20160605222917 builduid: 249ac4edb00748ec80a4e9677a872098 revision: 824355c9efe2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:15.772380) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:15.772807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:15.773092) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:15.797239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:15.797519) ========= 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=db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 01:14:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-06 01:14:16 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109248 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:15.932304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:15.932606) ========= 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=db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017173 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:15.981910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 01:14:15.982217) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 824355c9efe2 --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 824355c9efe2 --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=db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 01:14:16,323 Setting DEBUG logging. 2016-06-06 01:14:16,323 attempt 1/10 2016-06-06 01:14:16,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/824355c9efe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 01:14:16,889 unpacking tar archive at: fx-team-824355c9efe2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.989223 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 01:14:16.987818) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:16.988120) ========= script_repo_revision: 824355c9efe2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:16.988540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:16.988801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 01:14:17.000496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-06 01:14:17.000767) ========= /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=db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:14:17 INFO - MultiFileLogger online at 20160606 01:14:17 in /builds/slave/test 01:14:17 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 01:14:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:14:17 INFO - {'append_to_log': False, 01:14:17 INFO - 'base_work_dir': '/builds/slave/test', 01:14:17 INFO - 'blob_upload_branch': 'Fx-Team', 01:14:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:14:17 INFO - 'branch': 'Fx-Team', 01:14:17 INFO - 'buildbot_json_path': 'buildprops.json', 01:14:17 INFO - 'config_files': ('talos/linux_config.py',), 01:14:17 INFO - 'default_actions': ('clobber', 01:14:17 INFO - 'read-buildbot-config', 01:14:17 INFO - 'download-and-extract', 01:14:17 INFO - 'populate-webroot', 01:14:17 INFO - 'create-virtualenv', 01:14:17 INFO - 'install', 01:14:17 INFO - 'run-tests'), 01:14:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:14:17 INFO - 'download_minidump_stackwalk': True, 01:14:17 INFO - 'download_symbols': 'ondemand', 01:14:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:14:17 INFO - 'tooltool.py': '/tools/tooltool.py', 01:14:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:14:17 INFO - '/tools/misc-python/virtualenv.py')}, 01:14:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:14:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:14:17 INFO - 'installer_path': 'installer.exe', 01:14:17 INFO - 'log_level': 'info', 01:14:17 INFO - 'log_name': 'talos', 01:14:17 INFO - 'log_to_console': True, 01:14:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:14:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:14:17 INFO - 'opt_config_files': (), 01:14:17 INFO - 'pip_index': False, 01:14:17 INFO - 'sps_profile': False, 01:14:17 INFO - 'sps_profile_interval': 0, 01:14:17 INFO - 'suite': 'dromaeojs', 01:14:17 INFO - 'system_bits': '32', 01:14:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:14:17 INFO - 'title': 'talos-linux64-ix-031', 01:14:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:14:17 INFO - 'use_talos_json': True, 01:14:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:14:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:14:17 INFO - 'work_dir': 'build'} 01:14:17 INFO - ##### 01:14:17 INFO - ##### Running clobber step. 01:14:17 INFO - ##### 01:14:17 INFO - Running pre-action listener: _resource_record_pre_action 01:14:17 INFO - Running main action method: clobber 01:14:17 INFO - rmtree: /builds/slave/test/build 01:14:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:14:18 INFO - Running post-action listener: _resource_record_post_action 01:14:18 INFO - ##### 01:14:18 INFO - ##### Finished clobber step (success) 01:14:18 INFO - ##### 01:14:18 INFO - ##### 01:14:18 INFO - ##### Running read-buildbot-config step. 01:14:18 INFO - ##### 01:14:18 INFO - Running pre-action listener: _resource_record_pre_action 01:14:18 INFO - Running main action method: read_buildbot_config 01:14:18 INFO - Using buildbot properties: 01:14:18 INFO - { 01:14:18 INFO - "project": "", 01:14:18 INFO - "product": "firefox", 01:14:18 INFO - "script_repo_revision": "production", 01:14:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:14:18 INFO - "repository": "", 01:14:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:14:18 INFO - "buildid": "20160605222917", 01:14:18 INFO - "pgo_build": "True", 01:14:18 INFO - "basedir": "/builds/slave/test", 01:14:18 INFO - "buildnumber": 771, 01:14:18 INFO - "slavename": "talos-linux64-ix-031", 01:14:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:14:18 INFO - "platform": "ubuntu64_hw", 01:14:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:14:18 INFO - "branch": "fx-team", 01:14:18 INFO - "repo_path": "integration/fx-team", 01:14:18 INFO - "revision": "824355c9efe2", 01:14:18 INFO - "stage_platform": "linux64-pgo", 01:14:18 INFO - "builduid": "249ac4edb00748ec80a4e9677a872098", 01:14:18 INFO - "slavebuilddir": "test" 01:14:18 INFO - } 01:14:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:14:18 INFO - Running post-action listener: _resource_record_post_action 01:14:18 INFO - ##### 01:14:18 INFO - ##### Finished read-buildbot-config step (success) 01:14:18 INFO - ##### 01:14:18 INFO - ##### 01:14:18 INFO - ##### Running download-and-extract step. 01:14:18 INFO - ##### 01:14:18 INFO - Running pre-action listener: _resource_record_pre_action 01:14:18 INFO - Running main action method: download_and_extract 01:14:18 INFO - mkdir: /builds/slave/test/build/tests 01:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:18 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:14:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:14:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:14:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:14:19 INFO - Downloaded 1361 bytes. 01:14:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:14:19 INFO - Using the following test package requirements: 01:14:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:14:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:14:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:19 INFO - u'jsshell-linux-x86_64.zip'], 01:14:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:14:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:14:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:14:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:14:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:14:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:14:19 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')]} 01:14:19 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:14:20 INFO - Downloaded 24441139 bytes. 01:14:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:14:22 INFO - Return code: 0 01:14:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:22 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:14:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:14:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:14:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:14:26 INFO - Downloaded 24441139 bytes. 01:14:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:14:27 INFO - Return code: 0 01:14: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')]} 01:14:28 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:14:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:14:29 INFO - Downloaded 10833369 bytes. 01:14:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:14:29 INFO - Return code: 0 01:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:29 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:14:34 INFO - Downloaded 59156993 bytes. 01:14:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:14:34 INFO - mkdir: /builds/slave/test/properties 01:14:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:14:34 INFO - Writing to file /builds/slave/test/properties/build_url 01:14:34 INFO - Contents: 01:14:34 INFO - build_url:https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:14:35 INFO - Running post-action listener: _resource_record_post_action 01:14:35 INFO - Running post-action listener: set_extra_try_arguments 01:14:35 INFO - ##### 01:14:35 INFO - ##### Finished download-and-extract step (success) 01:14:35 INFO - ##### 01:14:35 INFO - ##### 01:14:35 INFO - ##### Running populate-webroot step. 01:14:35 INFO - ##### 01:14:35 INFO - Running pre-action listener: _resource_record_pre_action 01:14:35 INFO - Running main action method: populate_webroot 01:14:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:14:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:14:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:14:35 INFO - '--tppagecycles', 01:14:35 INFO - '7'], 01:14:35 INFO - 'tests': ['tsvgm']}}, 01:14:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:14:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:14:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:14:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:14:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:35 INFO - 'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:35 INFO - 'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['damp', 'tps']}, 01:14:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:35 INFO - 'tests': ['damp', 'tps']}, 01:14:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['dromaeo_dom']}, 01:14:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:14:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['a11yr', 01:14:35 INFO - 'ts_paint', 01:14:35 INFO - 'tpaint', 01:14:35 INFO - 'sessionrestore', 01:14:35 INFO - 'sessionrestore_no_auto_restore', 01:14:35 INFO - 'tabpaint']}, 01:14:35 INFO - 'other-e10s': {'tests': ['a11yr', 01:14:35 INFO - 'ts_paint', 01:14:35 INFO - 'tpaint', 01:14:35 INFO - 'sessionrestore', 01:14:35 INFO - 'sessionrestore_no_auto_restore', 01:14:35 INFO - 'tabpaint']}, 01:14:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:14:35 INFO - 'ts_paint', 01:14:35 INFO - 'tpaint', 01:14:35 INFO - 'sessionrestore', 01:14:35 INFO - 'sessionrestore_no_auto_restore', 01:14:35 INFO - 'tabpaint']}, 01:14:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:14:35 INFO - 'ts_paint', 01:14:35 INFO - 'tpaint', 01:14:35 INFO - 'sessionrestore', 01:14:35 INFO - 'sessionrestore_no_auto_restore', 01:14:35 INFO - 'tabpaint']}, 01:14:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['a11yr', 01:14:35 INFO - 'ts_paint', 01:14:35 INFO - 'tpaint', 01:14:35 INFO - 'sessionrestore', 01:14:35 INFO - 'sessionrestore_no_auto_restore', 01:14:35 INFO - 'tabpaint']}, 01:14:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['a11yr', 01:14:35 INFO - 'ts_paint', 01:14:35 INFO - 'tpaint', 01:14:35 INFO - 'sessionrestore', 01:14:35 INFO - 'sessionrestore_no_auto_restore', 01:14:35 INFO - 'tabpaint']}, 01:14:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['tsvgx', 01:14:35 INFO - 'tsvgr_opacity', 01:14:35 INFO - 'tart', 01:14:35 INFO - 'tscrollx', 01:14:35 INFO - 'cart']}, 01:14:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:14:35 INFO - 'tsvgr_opacity', 01:14:35 INFO - 'tart', 01:14:35 INFO - 'tscrollx', 01:14:35 INFO - 'cart']}, 01:14:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:35 INFO - 'talos_options': ['--disable-e10s'], 01:14:35 INFO - 'tests': ['tp5o']}, 01:14:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:35 INFO - 'tests': ['tp5o']}, 01:14:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:35 INFO - 'talos_options': ['--disable-e10s', 01:14:35 INFO - '--xperf_path', 01:14:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:35 INFO - 'tests': ['tp5n']}, 01:14:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:35 INFO - 'talos_options': ['--xperf_path', 01:14:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:35 INFO - 'tests': ['tp5n']}}, 01:14:35 INFO - 'talos.zip': {'path': '', 01:14:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:14:35 INFO - Running post-action listener: _resource_record_post_action 01:14:35 INFO - ##### 01:14:35 INFO - ##### Finished populate-webroot step (success) 01:14:35 INFO - ##### 01:14:35 INFO - ##### 01:14:35 INFO - ##### Running create-virtualenv step. 01:14:35 INFO - ##### 01:14:35 INFO - Running pre-action listener: _resource_record_pre_action 01:14:35 INFO - Running main action method: create_virtualenv 01:14:35 INFO - Creating virtualenv /builds/slave/test/build/venv 01:14:35 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 01:14:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:14:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:14:35 INFO - Using real prefix '/usr' 01:14:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:14:36 INFO - Installing distribute.............................................................................................................................................................................................done. 01:14:38 INFO - Installing pip.................done. 01:14:38 INFO - Return code: 0 01:14:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:38 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 01:14:38 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 01:14:38 INFO - Using env: {'DISPLAY': ':0', 01:14:38 INFO - 'HOME': '/home/cltbld', 01:14:38 INFO - 'LANG': 'en_US.UTF-8', 01:14:38 INFO - 'LANGUAGE': 'en_US:en', 01:14:38 INFO - 'LOGNAME': 'cltbld', 01:14:38 INFO - 'MAIL': '/var/mail/cltbld', 01:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:38 INFO - 'MOZ_NO_REMOTE': '1', 01:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:38 INFO - 'NO_EM_RESTART': '1', 01:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:38 INFO - 'PWD': '/builds/slave/test', 01:14:38 INFO - 'SHELL': '/bin/bash', 01:14:38 INFO - 'SHLVL': '1', 01:14:38 INFO - 'TERM': 'linux', 01:14:38 INFO - 'TMOUT': '86400', 01:14:38 INFO - 'USER': 'cltbld', 01:14:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:38 INFO - '_': '/tools/buildbot/bin/python'} 01:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:38 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 01:14:38 INFO - Cleaning up... 01:14:38 INFO - Return code: 0 01:14:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:38 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 01:14:38 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 01:14:38 INFO - Using env: {'DISPLAY': ':0', 01:14:38 INFO - 'HOME': '/home/cltbld', 01:14:38 INFO - 'LANG': 'en_US.UTF-8', 01:14:38 INFO - 'LANGUAGE': 'en_US:en', 01:14:38 INFO - 'LOGNAME': 'cltbld', 01:14:38 INFO - 'MAIL': '/var/mail/cltbld', 01:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:38 INFO - 'MOZ_NO_REMOTE': '1', 01:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:38 INFO - 'NO_EM_RESTART': '1', 01:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:38 INFO - 'PWD': '/builds/slave/test', 01:14:38 INFO - 'SHELL': '/bin/bash', 01:14:38 INFO - 'SHLVL': '1', 01:14:38 INFO - 'TERM': 'linux', 01:14:38 INFO - 'TMOUT': '86400', 01:14:38 INFO - 'USER': 'cltbld', 01:14:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:38 INFO - '_': '/tools/buildbot/bin/python'} 01:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:38 INFO - Downloading/unpacking psutil>=3.1.1 01:14:38 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 01:14:38 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 01:14:38 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 01:14:38 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 01:14:38 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 01:14:38 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 01:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:14:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:40 INFO - Installing collected packages: psutil 01:14:40 INFO - Running setup.py install for psutil 01:14:40 INFO - building 'psutil._psutil_linux' extension 01:14:40 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 01:14:41 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 01:14:41 INFO - building 'psutil._psutil_posix' extension 01:14:41 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 01:14:41 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 01:14:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:41 INFO - Successfully installed psutil 01:14:41 INFO - Cleaning up... 01:14:41 INFO - Return code: 0 01:14:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:14:41 INFO - Using env: {'DISPLAY': ':0', 01:14:41 INFO - 'HOME': '/home/cltbld', 01:14:41 INFO - 'LANG': 'en_US.UTF-8', 01:14:41 INFO - 'LANGUAGE': 'en_US:en', 01:14:41 INFO - 'LOGNAME': 'cltbld', 01:14:41 INFO - 'MAIL': '/var/mail/cltbld', 01:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:41 INFO - 'MOZ_NO_REMOTE': '1', 01:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:41 INFO - 'NO_EM_RESTART': '1', 01:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:41 INFO - 'PWD': '/builds/slave/test', 01:14:41 INFO - 'SHELL': '/bin/bash', 01:14:41 INFO - 'SHLVL': '1', 01:14:41 INFO - 'TERM': 'linux', 01:14:41 INFO - 'TMOUT': '86400', 01:14:41 INFO - 'USER': 'cltbld', 01:14:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:41 INFO - '_': '/tools/buildbot/bin/python'} 01:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:14:43 INFO - Installing collected packages: mozsystemmonitor 01:14:43 INFO - Running setup.py install for mozsystemmonitor 01:14:43 INFO - Successfully installed mozsystemmonitor 01:14:43 INFO - Cleaning up... 01:14:43 INFO - Return code: 0 01:14:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:14:43 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')]} 01:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:43 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')]} 01:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:43 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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:43 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 01:14:43 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 01:14:43 INFO - Using env: {'DISPLAY': ':0', 01:14:43 INFO - 'HOME': '/home/cltbld', 01:14:43 INFO - 'LANG': 'en_US.UTF-8', 01:14:43 INFO - 'LANGUAGE': 'en_US:en', 01:14:43 INFO - 'LOGNAME': 'cltbld', 01:14:43 INFO - 'MAIL': '/var/mail/cltbld', 01:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:43 INFO - 'MOZ_NO_REMOTE': '1', 01:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:43 INFO - 'NO_EM_RESTART': '1', 01:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:43 INFO - 'PWD': '/builds/slave/test', 01:14:43 INFO - 'SHELL': '/bin/bash', 01:14:43 INFO - 'SHLVL': '1', 01:14:43 INFO - 'TERM': 'linux', 01:14:43 INFO - 'TMOUT': '86400', 01:14:43 INFO - 'USER': 'cltbld', 01:14:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:43 INFO - '_': '/tools/buildbot/bin/python'} 01:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:43 INFO - Downloading/unpacking jsonschema==2.5.1 01:14:43 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 01:14:43 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 01:14:43 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 01:14:43 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 01:14:43 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 01:14:43 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 01:14:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:14:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:45 INFO - Downloading functools32-3.2.3-2.tar.gz 01:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:14:45 INFO - warning: no files found matching '*.txt' 01:14:45 INFO - no previously-included directories found matching 'build' 01:14:46 INFO - no previously-included directories found matching 'dist' 01:14:46 INFO - no previously-included directories found matching '.git*' 01:14:46 INFO - Installing collected packages: jsonschema, functools32 01:14:46 INFO - Running setup.py install for functools32 01:14:46 INFO - warning: no files found matching '*.txt' 01:14:46 INFO - no previously-included directories found matching 'build' 01:14:46 INFO - no previously-included directories found matching 'dist' 01:14:46 INFO - no previously-included directories found matching '.git*' 01:14:46 INFO - Successfully installed jsonschema functools32 01:14:46 INFO - Cleaning up... 01:14:46 INFO - Return code: 0 01:14:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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', '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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:14: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 blobuploader==1.2.4 01:14:46 INFO - Using env: {'DISPLAY': ':0', 01:14:46 INFO - 'HOME': '/home/cltbld', 01:14:46 INFO - 'LANG': 'en_US.UTF-8', 01:14:46 INFO - 'LANGUAGE': 'en_US:en', 01:14:46 INFO - 'LOGNAME': 'cltbld', 01:14:46 INFO - 'MAIL': '/var/mail/cltbld', 01:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:46 INFO - 'MOZ_NO_REMOTE': '1', 01:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:46 INFO - 'NO_EM_RESTART': '1', 01:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:46 INFO - 'PWD': '/builds/slave/test', 01:14:46 INFO - 'SHELL': '/bin/bash', 01:14:46 INFO - 'SHLVL': '1', 01:14:46 INFO - 'TERM': 'linux', 01:14:46 INFO - 'TMOUT': '86400', 01:14:46 INFO - 'USER': 'cltbld', 01:14:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:46 INFO - '_': '/tools/buildbot/bin/python'} 01:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:46 INFO - Downloading/unpacking blobuploader==1.2.4 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:48 INFO - Downloading blobuploader-1.2.4.tar.gz 01:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:14:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:14:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:48 INFO - Downloading docopt-0.6.1.tar.gz 01:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:14:49 INFO - Installing collected packages: blobuploader, requests, docopt 01:14:49 INFO - Running setup.py install for blobuploader 01:14:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:14:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:14:49 INFO - Running setup.py install for requests 01:14:49 INFO - Running setup.py install for docopt 01:14:49 INFO - Successfully installed blobuploader requests docopt 01:14:49 INFO - Cleaning up... 01:14:49 INFO - Return code: 0 01:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:49 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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:49 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 01:14:49 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 01:14:49 INFO - Using env: {'DISPLAY': ':0', 01:14:49 INFO - 'HOME': '/home/cltbld', 01:14:49 INFO - 'LANG': 'en_US.UTF-8', 01:14:49 INFO - 'LANGUAGE': 'en_US:en', 01:14:49 INFO - 'LOGNAME': 'cltbld', 01:14:49 INFO - 'MAIL': '/var/mail/cltbld', 01:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:49 INFO - 'MOZ_NO_REMOTE': '1', 01:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:49 INFO - 'NO_EM_RESTART': '1', 01:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:49 INFO - 'PWD': '/builds/slave/test', 01:14:49 INFO - 'SHELL': '/bin/bash', 01:14:49 INFO - 'SHLVL': '1', 01:14:49 INFO - 'TERM': 'linux', 01:14:49 INFO - 'TMOUT': '86400', 01:14:49 INFO - 'USER': 'cltbld', 01:14:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:49 INFO - '_': '/tools/buildbot/bin/python'} 01:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:49 INFO - Running setup.py (path:/tmp/pip-DKeVqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:49 INFO - Running setup.py (path:/tmp/pip-p2Dkpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:49 INFO - Running setup.py (path:/tmp/pip-LAueY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:50 INFO - Running setup.py (path:/tmp/pip-R7Rjeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:50 INFO - Running setup.py (path:/tmp/pip-7n3Oya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:50 INFO - Running setup.py (path:/tmp/pip-6r86xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:50 INFO - Running setup.py (path:/tmp/pip-DjEH2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:50 INFO - Running setup.py (path:/tmp/pip-FzuovQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:50 INFO - Running setup.py (path:/tmp/pip-UOSixS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:50 INFO - Running setup.py (path:/tmp/pip-LUKigU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:50 INFO - Running setup.py (path:/tmp/pip-yVnC6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:50 INFO - Running setup.py (path:/tmp/pip-g30LcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:50 INFO - Running setup.py (path:/tmp/pip-uuA4Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:50 INFO - Running setup.py (path:/tmp/pip-uX21Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:50 INFO - Running setup.py (path:/tmp/pip-XqGc0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:50 INFO - Running setup.py (path:/tmp/pip-hi31Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:51 INFO - Running setup.py (path:/tmp/pip-pbAkoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:14:51 INFO - Running setup.py install for manifestparser 01:14:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Running setup.py install for mozcrash 01:14:51 INFO - Running setup.py install for mozdebug 01:14:51 INFO - Running setup.py install for mozdevice 01:14:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Running setup.py install for mozfile 01:14:51 INFO - Running setup.py install for mozhttpd 01:14:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Running setup.py install for mozinfo 01:14:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Running setup.py install for mozInstall 01:14:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:14:51 INFO - Running setup.py install for mozleak 01:14:51 INFO - Running setup.py install for mozlog 01:14:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:14:52 INFO - Running setup.py install for moznetwork 01:14:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:14:52 INFO - Running setup.py install for mozprocess 01:14:52 INFO - Running setup.py install for mozprofile 01:14:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:14:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:14:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:14:52 INFO - Running setup.py install for mozrunner 01:14:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:14:52 INFO - Running setup.py install for mozscreenshot 01:14:52 INFO - Running setup.py install for moztest 01:14:52 INFO - Running setup.py install for mozversion 01:14:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:14:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:14:52 INFO - Cleaning up... 01:14:52 INFO - Return code: 0 01:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:52 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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:52 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 01:14:52 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 01:14:52 INFO - Using env: {'DISPLAY': ':0', 01:14:52 INFO - 'HOME': '/home/cltbld', 01:14:52 INFO - 'LANG': 'en_US.UTF-8', 01:14:52 INFO - 'LANGUAGE': 'en_US:en', 01:14:52 INFO - 'LOGNAME': 'cltbld', 01:14:52 INFO - 'MAIL': '/var/mail/cltbld', 01:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:52 INFO - 'MOZ_NO_REMOTE': '1', 01:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:52 INFO - 'NO_EM_RESTART': '1', 01:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:52 INFO - 'PWD': '/builds/slave/test', 01:14:52 INFO - 'SHELL': '/bin/bash', 01:14:52 INFO - 'SHLVL': '1', 01:14:52 INFO - 'TERM': 'linux', 01:14:52 INFO - 'TMOUT': '86400', 01:14:52 INFO - 'USER': 'cltbld', 01:14:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:52 INFO - '_': '/tools/buildbot/bin/python'} 01:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:53 INFO - Running setup.py (path:/tmp/pip-wuasNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:53 INFO - Running setup.py (path:/tmp/pip-DV5rQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:53 INFO - Running setup.py (path:/tmp/pip-OO2KfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:53 INFO - Running setup.py (path:/tmp/pip-FFoXru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:53 INFO - Running setup.py (path:/tmp/pip-tpDTq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:53 INFO - Running setup.py (path:/tmp/pip-dC5Wti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:53 INFO - Running setup.py (path:/tmp/pip-QayQ2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:53 INFO - Running setup.py (path:/tmp/pip-zs2kJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:53 INFO - Running setup.py (path:/tmp/pip-vF87TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:53 INFO - Running setup.py (path:/tmp/pip-sU88WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:53 INFO - Running setup.py (path:/tmp/pip-NOGhk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:53 INFO - Running setup.py (path:/tmp/pip-HgIfRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:53 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)) 01:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:53 INFO - Running setup.py (path:/tmp/pip-9l_HwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:54 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)) 01:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:54 INFO - Running setup.py (path:/tmp/pip-SVMjTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:54 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)) 01:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:54 INFO - Running setup.py (path:/tmp/pip-h8DLp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:54 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)) 01:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:54 INFO - Running setup.py (path:/tmp/pip-ssAY3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:54 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)) 01:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:54 INFO - Running setup.py (path:/tmp/pip-liaC6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:54 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)) 01:14:54 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)) 01:14:54 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)) 01:14:54 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)) 01:14:54 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)) 01:14:54 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)) 01:14:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:56 INFO - Downloading blessings-1.6.tar.gz 01:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:14:56 INFO - Installing collected packages: blessings 01:14:56 INFO - Running setup.py install for blessings 01:14:56 INFO - Successfully installed blessings 01:14:56 INFO - Cleaning up... 01:14:56 INFO - Return code: 0 01:14:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:57 INFO - Reading from file tmpfile_stdout 01:14:57 INFO - Current package versions: 01:14:57 INFO - argparse == 1.2.1 01:14:57 INFO - blessings == 1.6 01:14:57 INFO - blobuploader == 1.2.4 01:14:57 INFO - docopt == 0.6.1 01:14:57 INFO - functools32 == 3.2.3-2 01:14:57 INFO - jsonschema == 2.5.1 01:14:57 INFO - manifestparser == 1.1 01:14:57 INFO - mozInstall == 1.12 01:14:57 INFO - mozcrash == 0.17 01:14:57 INFO - mozdebug == 0.1 01:14:57 INFO - mozdevice == 0.48 01:14:57 INFO - mozfile == 1.2 01:14:57 INFO - mozhttpd == 0.7 01:14:57 INFO - mozinfo == 0.9 01:14:57 INFO - mozleak == 0.1 01:14:57 INFO - mozlog == 3.2 01:14:57 INFO - moznetwork == 0.27 01:14:57 INFO - mozprocess == 0.22 01:14:57 INFO - mozprofile == 0.28 01:14:57 INFO - mozrunner == 6.11 01:14:57 INFO - mozscreenshot == 0.1 01:14:57 INFO - mozsystemmonitor == 0.3 01:14:57 INFO - moztest == 0.7 01:14:57 INFO - mozversion == 1.4 01:14:57 INFO - psutil == 3.1.1 01:14:57 INFO - requests == 1.2.3 01:14:57 INFO - wsgiref == 0.1.2 01:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:57 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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:57 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 01:14:57 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 01:14:57 INFO - Using env: {'DISPLAY': ':0', 01:14:57 INFO - 'HOME': '/home/cltbld', 01:14:57 INFO - 'LANG': 'en_US.UTF-8', 01:14:57 INFO - 'LANGUAGE': 'en_US:en', 01:14:57 INFO - 'LOGNAME': 'cltbld', 01:14:57 INFO - 'MAIL': '/var/mail/cltbld', 01:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:57 INFO - 'MOZ_NO_REMOTE': '1', 01:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:57 INFO - 'NO_EM_RESTART': '1', 01:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:57 INFO - 'PWD': '/builds/slave/test', 01:14:57 INFO - 'SHELL': '/bin/bash', 01:14:57 INFO - 'SHLVL': '1', 01:14:57 INFO - 'TERM': 'linux', 01:14:57 INFO - 'TMOUT': '86400', 01:14:57 INFO - 'USER': 'cltbld', 01:14:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:57 INFO - '_': '/tools/buildbot/bin/python'} 01:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 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)) 01:14:57 INFO - Cleaning up... 01:14:57 INFO - Return code: 0 01:14:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:57 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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:57 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 01:14:57 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 01:14:57 INFO - Using env: {'DISPLAY': ':0', 01:14:57 INFO - 'HOME': '/home/cltbld', 01:14:57 INFO - 'LANG': 'en_US.UTF-8', 01:14:57 INFO - 'LANGUAGE': 'en_US:en', 01:14:57 INFO - 'LOGNAME': 'cltbld', 01:14:57 INFO - 'MAIL': '/var/mail/cltbld', 01:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:57 INFO - 'MOZ_NO_REMOTE': '1', 01:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:57 INFO - 'NO_EM_RESTART': '1', 01:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:57 INFO - 'PWD': '/builds/slave/test', 01:14:57 INFO - 'SHELL': '/bin/bash', 01:14:57 INFO - 'SHLVL': '1', 01:14:57 INFO - 'TERM': 'linux', 01:14:57 INFO - 'TMOUT': '86400', 01:14:57 INFO - 'USER': 'cltbld', 01:14:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:57 INFO - '_': '/tools/buildbot/bin/python'} 01:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:14:57 INFO - Cleaning up... 01:14:57 INFO - Return code: 0 01:14:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:57 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 0x7f84e98c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d43350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, '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': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', '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 01:14:57 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 01:14:57 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 01:14:57 INFO - Using env: {'DISPLAY': ':0', 01:14:57 INFO - 'HOME': '/home/cltbld', 01:14:57 INFO - 'LANG': 'en_US.UTF-8', 01:14:57 INFO - 'LANGUAGE': 'en_US:en', 01:14:57 INFO - 'LOGNAME': 'cltbld', 01:14:57 INFO - 'MAIL': '/var/mail/cltbld', 01:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:57 INFO - 'MOZ_NO_REMOTE': '1', 01:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:57 INFO - 'NO_EM_RESTART': '1', 01:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:57 INFO - 'PWD': '/builds/slave/test', 01:14:57 INFO - 'SHELL': '/bin/bash', 01:14:57 INFO - 'SHLVL': '1', 01:14:57 INFO - 'TERM': 'linux', 01:14:57 INFO - 'TMOUT': '86400', 01:14:57 INFO - 'USER': 'cltbld', 01:14:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:57 INFO - '_': '/tools/buildbot/bin/python'} 01:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:57 INFO - Downloading/unpacking flake8 01:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:14:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:14:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:15:00 INFO - no previously-included directories found matching 'docs/_build' 01:15:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:15:00 INFO - Running setup.py install for pep8 01:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:15:00 INFO - no previously-included directories found matching 'docs/_build' 01:15:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:15:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:15:00 INFO - Cleaning up... 01:15:00 INFO - Return code: 0 01:15:00 INFO - Running post-action listener: _resource_record_post_action 01:15:00 INFO - Running post-action listener: _start_resource_monitoring 01:15:00 INFO - Starting resource monitoring. 01:15:00 INFO - ##### 01:15:00 INFO - ##### Finished create-virtualenv step (success) 01:15:00 INFO - ##### 01:15:00 INFO - ##### 01:15:00 INFO - ##### Running install step. 01:15:00 INFO - ##### 01:15:00 INFO - Running pre-action listener: _resource_record_pre_action 01:15:00 INFO - Running main action method: install 01:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:15:00 INFO - Reading from file tmpfile_stdout 01:15:00 INFO - Detecting whether we're running mozinstall >=1.0... 01:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:15:00 INFO - Reading from file tmpfile_stdout 01:15:00 INFO - Output received: 01:15:00 INFO - Usage: mozinstall [options] installer 01:15:00 INFO - Options: 01:15:00 INFO - -h, --help show this help message and exit 01:15:00 INFO - -d DEST, --destination=DEST 01:15:00 INFO - Directory to install application into. [default: 01:15:00 INFO - "/builds/slave/test"] 01:15:00 INFO - --app=APP Application being installed. [default: firefox] 01:15:00 INFO - mkdir: /builds/slave/test/build/application 01:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:15:17 INFO - Reading from file tmpfile_stdout 01:15:17 INFO - Output received: 01:15:17 INFO - /builds/slave/test/build/application/firefox/firefox 01:15:17 INFO - Running post-action listener: _resource_record_post_action 01:15:17 INFO - ##### 01:15:17 INFO - ##### Finished install step (success) 01:15:17 INFO - ##### 01:15:17 INFO - ##### 01:15:17 INFO - ##### Running run-tests step. 01:15:17 INFO - ##### 01:15:17 INFO - Running pre-action listener: _resource_record_pre_action 01:15:17 INFO - Running main action method: run_tests 01:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:15:17 INFO - Python 2.7.3 01:15:17 INFO - Return code: 0 01:15:17 INFO - grabbing minidump binary from tooltool 01:15:17 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')]} 01:15:17 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 0x1dd21c0>, '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 0x1dd30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:15:17 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 01:15:17 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 01:15:17 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 01:15:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:15:17 INFO - Return code: 0 01:15:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:15:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:15:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:15:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:15:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:15:18 INFO - Return code: 0 01:15:18 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/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 01:15:18 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/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 01:15:18 INFO - Using env: {'DISPLAY': ':0', 01:15:18 INFO - 'HOME': '/home/cltbld', 01:15:18 INFO - 'LANG': 'en_US.UTF-8', 01:15:18 INFO - 'LANGUAGE': 'en_US:en', 01:15:18 INFO - 'LOGNAME': 'cltbld', 01:15:18 INFO - 'MAIL': '/var/mail/cltbld', 01:15:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:15:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:18 INFO - 'MOZ_NO_REMOTE': '1', 01:15:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:18 INFO - 'NO_EM_RESTART': '1', 01:15:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:18 INFO - 'PWD': '/builds/slave/test', 01:15:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:15:18 INFO - 'SHELL': '/bin/bash', 01:15:18 INFO - 'SHLVL': '1', 01:15:18 INFO - 'TERM': 'linux', 01:15:18 INFO - 'TMOUT': '86400', 01:15:18 INFO - 'USER': 'cltbld', 01:15:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241', 01:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:18 INFO - '_': '/tools/buildbot/bin/python'} 01:15:18 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/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 01:15:18 INFO - mozversion application_buildid: 20160605222917 01:15:18 INFO - mozversion application_changeset: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 01:15:18 INFO - mozversion application_display_name: Nightly 01:15:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:15:18 INFO - mozversion application_name: Firefox 01:15:18 INFO - mozversion application_remotingname: firefox 01:15:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:15:18 INFO - mozversion application_vendor: Mozilla 01:15:18 INFO - mozversion application_version: 49.0a1 01:15:18 INFO - mozversion platform_buildid: 20160605222917 01:15:18 INFO - mozversion platform_changeset: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 01:15:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:15:18 INFO - mozversion platform_version: 49.0a1 01:15:18 INFO - using testdate: 1465200918 01:15:18 INFO - actual date: 1465200918 01:15:18 INFO - starting webserver on 'localhost:46189' 01:15:18 INFO - SUITE-START | Running 2 tests 01:15:18 INFO - TEST-START | dromaeo_css 01:15:18 INFO - operating with platform_type : linux_ 01:15:18 INFO - Initialising browser for dromaeo_css test... 01:15:18 INFO - TEST-INFO | started process 806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpenbat0/profile http://localhost:46189/getInfo.html) 01:15:22 INFO - PROCESS | 806 | __metrics Screen width/height:1600/1200 01:15:22 INFO - PROCESS | 806 | colorDepth:24 01:15:22 INFO - PROCESS | 806 | Browser inner width/height: 1024/697 01:15:22 INFO - PROCESS | 806 | __metrics 01:15:24 ERROR - PROCESS | 806 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:15:24 INFO - TEST-INFO | 806: exit 0 01:15:24 INFO - Browser initialized. 01:15:24 INFO - Running cycle 1/1 for dromaeo_css test... 01:15:24 INFO - TEST-INFO | started process 897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpenbat0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:15:36 INFO - PROCESS | 897 | RSS: Main: 156401664 01:15:36 INFO - PROCESS | 897 | 01:16:27 INFO - PROCESS | 897 | 1465200987809 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] 01:18:35 INFO - PROCESS | 897 | Cycle 1(1): loaded http://localhost:46189/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46189/tests/dromaeo/cssquery-ext.html) 01:18:36 INFO - PROCESS | 897 | RSS: Main: 253612032 01:18:36 INFO - PROCESS | 897 | 01:21:39 INFO - PROCESS | 897 | Cycle 1(1): loaded http://localhost:46189/tests/dromaeo/cssquery-ext.html (next: http://localhost:46189/tests/dromaeo/cssquery-jquery.html) 01:21:39 INFO - PROCESS | 897 | RSS: Main: 239333376 01:21:39 INFO - PROCESS | 897 | 01:24:42 INFO - PROCESS | 897 | Cycle 1(1): loaded http://localhost:46189/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46189/tests/dromaeo/cssquery-mootools.html) 01:24:42 INFO - PROCESS | 897 | RSS: Main: 235466752 01:24:42 INFO - PROCESS | 897 | 01:27:44 INFO - PROCESS | 897 | Cycle 1(1): loaded http://localhost:46189/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46189/tests/dromaeo/cssquery-prototype.html) 01:27:45 INFO - PROCESS | 897 | RSS: Main: 236728320 01:27:45 INFO - PROCESS | 897 | 01:30:47 INFO - PROCESS | 897 | Cycle 1(1): loaded http://localhost:46189/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46189/tests/dromaeo/cssquery-yui.html) 01:30:48 INFO - PROCESS | 897 | RSS: Main: 227725312 01:30:48 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | Cycle 1(1): loaded http://localhost:46189/tests/dromaeo/cssquery-yui.html (next: http://localhost:46189/tests/dromaeo/cssquery-dojo.html) 01:33:51 INFO - PROCESS | 897 | RSS: Main: 288014336 01:33:51 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | __start_tp_report 01:33:51 INFO - PROCESS | 897 | _x_x_mozilla_page_load 01:33:51 INFO - PROCESS | 897 | _x_x_mozilla_page_load_details 01:33:51 INFO - PROCESS | 897 | |i|pagename|runs| 01:33:51 INFO - PROCESS | 897 | |0;dojo.html;3097.8296193709352;3104.1463597510688;3120.1887509247604;3145.732612727918;3152.38528486945;5261.289725887004;5321;5364.704941228231;5425.348958125026;5432.972835135819;5380.650257733245;5387.0303345397815;5420.7018613976215;5425.593080518967;5518.034343989796;4845.297431872376;4921.434035085975;4937.2840938063955;4945.77744001519;5086.643934924557;4989.176785830334;5025.271335656327;5048.066107770056;5059.569936555397;5071.442141364465;4751.192297309449;4770.165221086313;4779.952200478003;4828.444728856191;4862.781174847105;4856.975715121437;4972.726500042496;4974.079795237856;4976.154053810861;5015.3229314042865;4919.2867034279825;4947.554720075211;4968.850934471971;4970.900581988376;5019.071471777696;5199.14214154664;5265.815696450644;5350.866228344284;5421.674699518002;5469.878674871642;5897;5908.0842469416875;5917.674527900964;5918.467337939606;5920.851978700523;5497.972510137463;5903.291605007384;5941.435563621449;5947.910781338283;5948.791792287249;5296.629235953485;5340.706261155635;5344.652597581145;5411.134218525017;5411.215373770781;5890.440408161217;5895.292564892155;5895.410458954156;5897.705114744245;5897.882042359214;5505.807296744595;5637.436256374412;5653.660780353192;5654.15187721845;5659.801906933238;5762.337331206965;5824.534037277008;5882.3529411764675;5884.440978107073;5885.176075349455;5756.827295181151;5769.826905192851;5783;5790;5808.680522571299;5604.467575580314;5751.769929202868;5804.970975145182;5805.82582522525;5813.244278243886;4431.40176076232;4434.667399945017;4444.377787109807;4474.552544745565;4483.327500874895;3954.8418063277722;3974.3243648579232;3979.0649197439157;4002.699797515198;4007.7996100194873;5299.788008479694;5406.459354064562;5407.026735187704;5468.91796623051;5583.609147359727;5787.768489260382;5799.18811366409;5807.216025836543;5814.941850581525;5855.063189889597;5488.1493368527945;5496.697681627549;5499.340079190442;5501.477359650827;5502.669839809624;4872;4940.6788558743565;4970.130227210224;4976.178930476431;4985.476524964826;5946.613470124428;5947.524198064145;5951.3751056139345;5954.196183515257;5954.345022047658;5782.277215348082;5788.942110578841;5791.102379131242;5793.304803423616;5793.913091303718;5799.884002319845;5840.299164100165;5882.23530940975;5898.882022359443;5944.851378715393;5614.21401003868;5657.15142728594;5659.066254068197;5660.575456840671;5662.348829884451;5594.076977298863;5759.827205183851;5772.076467765138;5775.162601422854;5777.62445441045;5560.471755183251;5611.298587676541;5623.803166889139;5655.208270842003;5659.773609055592;5559.388467268516;5585.050541407889;5598.1602759586385;5599.888002239851;5603.3836278008575;5411.70235637028;5530.695811730394;5537.9169312459535;5538.750756215899;5542.418046105262;5696.886062278814;5807.709614519342;5815.389384114607;5816.418358164319;5823.796167134299;5601.767933851399;5607.747651355618;5632.5212356950115;5636.070048442125;5638.21065050885 01:33:51 INFO - PROCESS | 897 | |1;ext.html;590.7135039505839;611.8959776837937;614.2874265851613;632.987340253195;634.2325785799186;32899.17752056197;36181.27637447253;36213.91358259253;42920.14159716804;44146;45247.54752452474;45821.31268030974;45835.54164458363;45911.31133033007;45952;8721;8907.153820387086;8909.77725556863;8911.15344042315;8922.509261990588;8793.736187914341;8914.286857051453;8922.063183365719;8925.196732294093;8930.508822014786;8876.955615221947;8946.329025323126;8953;8958.776030599221;8965.50689712069;8870.112988701143;8913.331500137516;8914.331425143107;8915.153060459279;8919.687810926587;8820.33847461443;8895.199432051082;8900.287976961827;8902.465852048834;8907.910920890772;42153.57846421527;42298;42371.36442953358;42508;42781;3497.790132592027;3625.655562721537;3707.4994875691705;3837.827297771607;4038.959610403888;32883.82569868039;32917.50623740646;32942.50586241209;33258.50112248318;34630.480542791876;4297.892552686177;4308.246056940055;4376.912461750779;4427.822887084512;4455.933161002587;331684;332204;332925;333208.99999999756;333729;59411.70294148502;59477.70261148667;59727.70136149378;59750.70124649349;59756.10365844516;62640.37359626436;62751.6862415685;63047.36952630507;63126.36873631205;63194.684026579576;15317.23413829304;15552.533423997298;15715.21423928799;15722.13528255934;16035.759463608056;12671.113022088366;12682.619521414372;12734.872651273554;12812.42344094518;12814.743705125846;19847.503812404804;20059;20090.497737556678;20100.894450805055;20185.394438166877;7227.674754636054;7267.709291628382;7451.919471676577;7477.775666730006;7525.924740752523;983.5524836199512;1120.523777394604;1140.122105978392;1164.8776878427811;1219.2136072233359;32861.83569082139;32879.3424131516;32979.50530741993;33422.323544410094;33569;1112.6606385052637;1138.908887289015;1141.828725691153;1168.6435637130587;1177.935213563245;16953;17477.912610436866;17609;17648.08475226624;17788.46634600964;495035;846990;856366;857789;859755;58550.7072464635;58889.70555147197;59050.704746475996;59091.40908590859;59131;1275.789494733377;1361.7412691588765;1379.344811214685;1379.7861331493634;1402.4179965314484;28649.570256446586;33699.15752106217;33719.831400842835;33745.3250934975;34095.14762130867;48566.51433485761;48778.75610621924;49085.509144908094;49297.75351123365;49411.258831118284;416569;420681;420881;422131;422408;24928.37679058038;27394.5890811642;28574.285642859093;28628.713712862605;28895.42209155763;46973;47207.527924720314;47300.7634961823;48089.5191048085;48325.27512087251;39746;40441;40758.38862417125;40877.1824563513;41326.586734133474;40173.39739903962;40468.595314046484;40527.79736101301;40550.59449405468;40797.79601101975;40333.798331008154;40880.59119408887;41112;41208.1758364837;41426.585734143475;33348;35882;36749.63250367462;37160;37215.25569488541;27589.58615620727;27810;28077;28231.294217644725;28244.576331355456 01:33:51 INFO - PROCESS | 897 | |2;jquery.html;394.26076107298815;396.56774116213325;399.32115403813526;402.54713447371705;415.5615825304305;14260.286985650702;17293.91353043236;18183.818161818377;19735.1119199636;19791.901040494795;14781.113133211988;17409.129543522835;17581.29674813006;18332.450026499195;19373.225070997145;5426.240326354314;5588.552915766749;5611.018071837432;5632.7746890124345;5637.126245431965;4157;5497.065498865202;5573.247611572447;5995.700214989233;6293.49652027839;6275.748970041216;6294.43350098491;6311.0217916223055;6353.856305864942;6355.173827402431;6072.696365181768;6224.719887605069;6243.2508099027955;6308.3060863305;6314.084457753623;5067.315912351823;5517.503424691797;5532.114861622162;5538.280023596906;5549.861253468655;13914.817240534567;14965.551033469013;18361.449156525327;18635.161417736097;18661.62676746471;2156.4608847788054;2283.406314358262;2323.94190145246;2413.9396515087087;2839.0489186122672;9720.222382209406;10064.29549931505;10310.381377117397;10383.376997380181;13454.798178027337;1771.9645607087787;1892.110707967267;1902.9238830446905;1910.6751852185023;1973.200853654258;83181.58409207976;84485;84578.15421845826;84912.99999999939;85591.57204214002;10820.13438924884;10898.673039808818;10966.725831854268;10969.616063437741;11115.555377784798;14849.183294918883;14978.17620030887;14992.175430351435;14993.550193493995;15037.323320450607;7713.382929365637;7939.126696063428;7952.3638108951145;8019.639116239783;8047.114817370085;6386.329435409308;7421.962890185622;7486.962565187139;7585.127710313384;7658.157602663814;4517.977410112994;4664.626829853603;4818.349522814446;4840.443349014838;4900.803967841318;1962.4014675523817;1982.5899452940919;1982.6332128556264;1984.176566724793;1984.3388947392039;902.9458232506071;974.1768205866032;983.7983213441228;1073.431081526792;1137.1357768096307;18023.639527209383;18680.719789203173;18956.52608684766;19233.98043205443;19301.80698193028;1029.4080903480528;1049.396596956753;1056.0653821368144;1074.3929679730927;1084.3764835219781;10242.385456872611;10636.627718029986;10689.412082335391;10692.144628429707;10739.677809665722;457225;468113;468514;473063;479725;91116.54441727749;93707.53146234225;94381.52809236047;94542.52728736312;95020.52489737645;974.2595627323285;984.0995489127369;1060.6764936694383;1066.9626563070256;1083.274206281793;16715.414960476326;16742.832571674127;16917.323307068073;16939.32242710278;17316.567085822957;40542;40894.591054089076;41640.33438662419;41973.370399443425;43217;56181;56892.71553642205;58333.708331458074;58770;59219;8500.659973600987;8596.613152408032;8689.522076285864;8690.26132778721;11508.251963622337;13352.000956632406;13382.197068175941;13451.260180689764;13841.37713802861;14314.642133946734;8576.785580360542;12396.690082748004;12467.87532124667;12582.433790479266;12860.614181574567;8450.492970421794;8808.911910881065;8963.372563920462;8999.55002249898;9047.547622618711;8662.740117796477;8898.154675305836;9082.772930676785;9117.498537580497;9276.211522020703;12316.13787034899;12770;12773.552925647558;12877.162984405984;12903.677408064874;11512;11541.480633371351;11682.182247242952;11713.648590542298;11770.52917883275 01:33:51 INFO - PROCESS | 897 | |3;mootools.html;1273.2106094221583;1456.2500312339148;1509.6603264265539;1610.4846449136273;1801.2884910460361;8119.959400202998;8423.284020858227;8497.787555311113;8714.477131372121;8742.781430464242;8520.360972927025;8635.438696484724;8694.826103477943;8709.695160669378;8715.694950676727;1933.2267093162707;2252.1441852096223;2284.9657255141187;2285.7828506291958;2346.5541547105995;2398.688170537828;2406.867622280774;2407.7471865454136;2409.0002648900772;2410.7348191698898;2279.338991692407;2295.827812914038;2329.114936324203;2335.2877372401413;2339.9532009359805;1963.1165975311096;2226.7439244486927;2266.626006708891;2287.931362059141;2292.85096468729;2285.908563657468;2299.4366380236784;2300.6318988961684;2302.7466978632337;2304.7234331880113;8692.348073894484;8716.346274029473;8716.956415217946;8739.694110706158;8742.344324175712;5041.092603331399;5156.278121063054;5156.639035267533;5160.045391602565;5162.5095615916425;3079.5688603595513;3161.8893338733033;3218.806871587712;3237.1259759864706;3309.7352211822995;1094.8029354716148;1096.4627332606965;1106.6016234155697;1117.4133579870634;1169.2399940038958;12121.818172727417;12192.57325993586;12196.573119940847;12198.207116537396;12201.755964880653;4610.124076425468;4643.421236779511;4717.599004084623;4722.858314250578;4812.951870481251;10197.592096316064;10208.795824083476;10225.642102526524;10231;10238.436885971343;5260.473952604709;5265.657732247469;5265.947340526623;5273.525382715574;5275.155975044051;4127.360259159835;4683.7423941682855;4812.783424745895;4827.396575428072;4861.7326047067045;4019.992894443532;4027.154297597537;4081.8163182656854;4122.670186385082;4133.42132101506;1303.778357679197;1310.60026691858;1331.2744554217975;1332.0808642037157;1333.9399727012308;960.9093678674755;991.5191132300828;1012.5696578954063;1019.2508506247901;1025.5180065369264;5721.828345149652;5874;5875.294964604275;5973.104034394789;6120.816375508742;457.8485109948482;469.4812232483057;474.7222874618318;475.32741171243;482.54881685624053;4000.179963107556;4125.66994640428;4202.747835129902;4203.138356636943;4237.237297286518;10611.25721199524;11036;11060.22578419519;11075.889241107647;11101.333919964827;10263.332883362558;10703.999999999844;10926.672199834018;10958.726031849268;10968;8015.358771298283;8116.715914942949;8139.877901831359;8164.183581641788;8188.68980963043;5812.273465816773;6003.279606447254;6043.214382130295;6045.425684559959;6218.657973811484;9528.428294302365;9903.405795652285;9957.452340121074;10008.499575021075;10101.49492525356;10175.033371829664;10352.327098738559;10364.429956352473;10429.478526073513;10454;6935.133108361455;7051.858962820612;7581;7787.10448298453;7953.403494737802;8524.829503410021;8545.188207120314;8622.78443038929;8625.180607842245;8648.394612377073;7412.888806668012;7644.617769111411;7695.884561731466;7735.265149810759;7763.456558040883;7479.738209162653;7557.470977031775;7584.886226706714;7657.770266892002;7762.146163922077;6975.093237879043;7005.789826305219;7016.614086225102;7058.858822823618;7081.539699919695;4798.880027999328;4934.062528119646;4985.875353116201;5011.072951503837;5041.773120209526;4980.178270585313;4984.551390374883;5047.924281135713;5076.162433198629;5152.871178220575 01:33:51 INFO - PROCESS | 897 | |4;prototype.html;326.64558953535413;334.6803802368738;334.98157601331934;345.27492266240915;346.34886413542534;5322.866928326794;5353;5356.437574054722;5369.677819330843;5471;5298.867528311795;5345;5389.407165211824;5392.2181283713835;5392.649477783942;3650.7261955353324;3978.9801050994706;4034.9596504035026;4035.59644035597;4039.2325458163;4111.48606424197;4135.359019352005;4147.315692910666;4147.7926103694845;4152.397902304164;4112.9588704112875;4126.958730412703;4128.545859955418;4133.276676581601;4147.834086636531;3919.333713268737;4019.397090436458;4026.4296924199584;4053.169100334454;4101.425800387948;3506.3337965786673;3682.429223470366;3686.594474607818;3688.5204923359793;3690.280395322913;5042.1428357179;5064.82273120439;5075.365579302587;5083.517065878736;5123.308353372285;4459.502678500018;4705.011947491031;4709.764511774431;4774.901772592289;4779.235322348442;5389.757460914268;5410.8637186190945;5465.125579907196;5475.425080366584;5508.328460696559;3968.3253846846105;3968.3650615901315;3972.2651309507546;3978.3543943277973;3984.900377490557;5481.75332110056;5694.088945768699;5773.191753154561;5774.614092617783;5833.941660583382;4018.517777866616;4035.7376770509823;4039.838406463767;4057.3711074783455;4076.7961601919787;4117;4119.196756632428;4121.237571049365;4150.107726838744;4161.854335098257;4534.79593418297;4696.201645720235;4700.623950084054;4742.549457801572;4753.120672675566;5531.6957567333375;5549.805756798492;5556.416576259516;5558.638688485235;5560.916586251209;1402.9719405612034;1412.1244828206577;1424.5227848670604;1426.9001169918006;1434.5911415246605;886.8448021596324;915.5925613102239;916.9455126604325;917.6329468212634;932.5616960028775;4767.189577771787;4801.7118972861745;4821.373221481185;4834.661573689878;4847.95152048475;5016.949830501649;5051.444341122474;5066.265391518209;5072.923906141411;5089.396839995389;4588.472325682523;4676.976615116902;4830.975845120752;4836.830710925171;4878.048780487842;2665.506881226979;2680.477306925131;2687.3819021625136;2712.6337944377256;2714.1179116787125;5180.922286165711;5192.324997750344;5199.908019315911;5203.739813009334;5236.554892834076;4945.826896058621;4981.61700514323;5132.358455193101;5140.228965655182;5190.532852043334;5192.9740351298005;5202.3468031303555;5223.268742376071;5246.816361427332;5263.315768950089;5048.293238946624;5049.6465247432325;5060.620453466078;5068.26510156018;5087.745612719275;5046.34397528319;5119.206522988943;5236.947630523799;5747.706765977621;5780.624259423124;5887.5289976802605;5894;5903.96680580888;5944.73248703818;5994.700264986646;4081.551049377428;4110.856120035784;4131;4132.615573782817;4153.6677065835265;5694.658320500783;5698.427934133262;5711.714414279352;5743.592819759018;5743.798967036134;5593.720313984366;5607.43925607436;5615.18579805934;5615.803446879339;5623.156526521055;5270.893112446276;5547.833564993057;5558.277423934863;5596.1605759136455;5604.915926261027;5485.451454854483;5510.421405752499;5519.530839878656;5528.170774383874;5564.443555644403;5575.135853942646;5611.270534830446;5640.971795140998;5675.971620141873;5710.314762228559;5294.761735721979;5581.944180558143;5585.96112418956;5592.636478628876;5598.496135347838 01:33:51 INFO - PROCESS | 897 | |5;yui.html;709.2729951799408;743.2456057102042;756.53851150798;785.4894318692849;798.7364169823959;15196.088234705925;15244.161571113584;15279.541613751577;15684;16916.915415422936;16180.433684821033;16926.915365423185;16963.406280780175;16973.32106715733;16985.06582137982;689.6448329110513;809.6923169195697;813.8535063688533;824.5671022713063;827.1976183102381;822.3421262989584;828.4366630691158;828.6395417993162;828.6478246745139;830.4436027861317;853.5433543054467;859.1794835931702;859.2352806002663;859.2438653984485;859.5788063848701;705.0552259971637;830.7590798668379;847.2882778466118;853.1255463150289;853.3002937591177;617.6263360666821;622.551762730833;623.9313675495691;624.1418050181001;624.434886427779;15417.306221220071;15501.457448989231;15502;15508.5347439577;15513.224338783128;14086.225257610828;14158.57524274263;14279.500217492441;14334.713305733827;14374.281285935765;13587.456501739918;13592.11651242666;13592.524261650893;13730.725385492335;13854;4430.800613972379;4458.375827384169;4486.842960496399;4520.3219517072375;4542;71682;72468;73334.63332683302;73890.26109738888;73981.63009184973;11220.943895280634;11225.341483284508;11284.210105292716;11358.318500889973;11497.597584084517;20491.282805102048;20589.279375221795;20659.793402066087;20687.17251309961;20689.68965465519;8556.828863422821;8606.65573377058;8634.913650863537;8650.43772154808;8912.153345432174;4638.095571363552;4765.0946320199055;4767.332573439652;4794.376731025014;4997.125503036954;3382.222088919513;3471.8090505022465;3487.04106370745;3490.3019396120876;3491.965080349215;605.1799811255773;610.3804638292137;611.721666641677;620.4230066038627;629.6820105846518;690.3027941778839;697.8743826111247;731.2650785960076;736.2931585677702;746.8506298740274;9954.25343099256;10187.439690817077;10258.640947566948;10287.537060832281;10371.429571373495;597.0536699331608;624.1499542520797;649.8951781970575;670.8893032649655;724.277709335132;4682.879309745027;4863.562279394871;4904.681195722266;4910.8526744197015;4919.606431485473;105172.47413762883;112143.4392828047;112374;115182.42408787903;115786;93221.06778932124;95776.52111739536;95825;95928.52035739776;96564.51717741367;86001.56999214964;86668.56665716632;86672.56663716641;86945.1305486937;87612.12387876167;8823.955880220557;8866.955665221632;9051.14014168653;9160.770980725536;9206.689430002902;38113;45927;50677.49322506728;51732.48267517277;54062.72968635132;69518.65240673764;71186.28813712003;72043.63978180075;72316;74119.62940185264;12857.228566286052;12978.935105324414;13106;13459.259740714355;14006.439742410597;14888.553343399715;15082.849171508144;15170.089794612359;15229.619259518158;15263.923680381527;14091.506797262047;14644.853551464776;14708.705825883208;14709.043912145677;14830.555083347517;14257.358418870968;14350.354234059283;14810.555683329518;15014.549563513112;15023.173725445205;13917.095388799695;14117.928453615456;14315.57053288403;14362.353694083582;14824.62938426548;10782.946085269523;10878.690082562976;11000.394978275952;11307.830382544103;11320.547178112784;10731.610040630967;10855.240133190917;11128.38793866345;11470.197086203885;11627.53489860396 01:33:51 INFO - PROCESS | 897 | __end_tp_report 01:33:51 INFO - PROCESS | 897 | __start_cc_report 01:33:51 INFO - PROCESS | 897 | _x_x_mozilla_cycle_collect,849 01:33:51 INFO - PROCESS | 897 | __end_cc_report 01:33:51 INFO - PROCESS | 897 | __startTimestamp1465202031560__endTimestamp 01:33:51 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | ------- Summary: start ------- 01:33:51 INFO - PROCESS | 897 | Number of tests: 6 01:33:51 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | [#0] dojo.html Cycles:165 Average:5371.37 Median:5560.47 stddev:605.23 (10.9%) stddev-sans-first:580.21 01:33:51 INFO - PROCESS | 897 | Values: 3097.8 3104.1 3120.2 3145.7 3152.4 5261.3 5321.0 5364.7 5425.3 5433.0 5380.7 5387.0 5420.7 5425.6 5518.0 4845.3 4921.4 4937.3 4945.8 5086.6 4989.2 5025.3 5048.1 5059.6 5071.4 4751.2 4770.2 4780.0 4828.4 4862.8 4857.0 4972.7 4974.1 4976.2 5015.3 4919.3 4947.6 4968.9 4970.9 5019.1 5199.1 5265.8 5350.9 5421.7 5469.9 5897.0 5908.1 5917.7 5918.5 5920.9 5498.0 5903.3 5941.4 5947.9 5948.8 5296.6 5340.7 5344.7 5411.1 5411.2 5890.4 5895.3 5895.4 5897.7 5897.9 5505.8 5637.4 5653.7 5654.2 5659.8 5762.3 5824.5 5882.4 5884.4 5885.2 5756.8 5769.8 5783.0 5790.0 5808.7 5604.5 5751.8 5805.0 5805.8 5813.2 4431.4 4434.7 4444.4 4474.6 4483.3 3954.8 3974.3 3979.1 4002.7 4007.8 5299.8 5406.5 5407.0 5468.9 5583.6 5787.8 5799.2 5807.2 5814.9 5855.1 5488.1 5496.7 5499.3 5501.5 5502.7 4872.0 4940.7 4970.1 4976.2 4985.5 5946.6 5947.5 5951.4 5954.2 5954.3 5782.3 5788.9 5791.1 5793.3 5793.9 5799.9 5840.3 5882.2 5898.9 5944.9 5614.2 5657.2 5659.1 5660.6 5662.3 5594.1 5759.8 5772.1 5775.2 5777.6 5560.5 5611.3 5623.8 5655.2 5659.8 5559.4 5585.1 5598.2 5599.9 5603.4 5411.7 5530.7 5537.9 5538.8 5542.4 5696.9 5807.7 5815.4 5816.4 5823.8 5601.8 5607.7 5632.5 5636.1 5638.2 01:33:51 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | [#1] ext.html Cycles:180 Average:66238.63 Median:41376.59 stddev:149258.58 (360.7%) stddev-sans-first:149595.91 01:33:51 INFO - PROCESS | 897 | Values: 590.7 611.9 614.3 633.0 634.2 32899.2 36181.3 36213.9 42920.1 44146.0 45247.5 45821.3 45835.5 45911.3 45952.0 8721.0 8907.2 8909.8 8911.2 8922.5 8793.7 8914.3 8922.1 8925.2 8930.5 8877.0 8946.3 8953.0 8958.8 8965.5 8870.1 8913.3 8914.3 8915.2 8919.7 8820.3 8895.2 8900.3 8902.5 8907.9 42153.6 42298.0 42371.4 42508.0 42781.0 3497.8 3625.7 3707.5 3837.8 4039.0 32883.8 32917.5 32942.5 33258.5 34630.5 4297.9 4308.2 4376.9 4427.8 4455.9 331684.0 332204.0 332925.0 333209.0 333729.0 59411.7 59477.7 59727.7 59750.7 59756.1 62640.4 62751.7 63047.4 63126.4 63194.7 15317.2 15552.5 15715.2 15722.1 16035.8 12671.1 12682.6 12734.9 12812.4 12814.7 19847.5 20059.0 20090.5 20100.9 20185.4 7227.7 7267.7 7451.9 7477.8 7525.9 983.6 1120.5 1140.1 1164.9 1219.2 32861.8 32879.3 32979.5 33422.3 33569.0 1112.7 1138.9 1141.8 1168.6 1177.9 16953.0 17477.9 17609.0 17648.1 17788.5 495035.0 846990.0 856366.0 857789.0 859755.0 58550.7 58889.7 59050.7 59091.4 59131.0 1275.8 1361.7 1379.3 1379.8 1402.4 28649.6 33699.2 33719.8 33745.3 34095.1 48566.5 48778.8 49085.5 49297.8 49411.3 416569.0 420681.0 420881.0 422131.0 422408.0 24928.4 27394.6 28574.3 28628.7 28895.4 46973.0 47207.5 47300.8 48089.5 48325.3 39746.0 40441.0 40758.4 40877.2 41326.6 40173.4 40468.6 40527.8 40550.6 40797.8 40333.8 40880.6 41112.0 41208.2 41426.6 33348.0 35882.0 36749.6 37160.0 37215.3 27589.6 27810.0 28077.0 28231.3 28244.6 01:33:51 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | [#2] jquery.html Cycles:180 Average:28283.85 Median:397.94 stddev:77655.47 (19514.1%) stddev-sans-first:77845.08 01:33:51 INFO - PROCESS | 897 | Values: 394.3 396.6 399.3 402.5 415.6 14260.3 17293.9 18183.8 19735.1 19791.9 14781.1 17409.1 17581.3 18332.5 19373.2 5426.2 5588.6 5611.0 5632.8 5637.1 4157.0 5497.1 5573.2 5995.7 6293.5 6275.7 6294.4 6311.0 6353.9 6355.2 6072.7 6224.7 6243.3 6308.3 6314.1 5067.3 5517.5 5532.1 5538.3 5549.9 13914.8 14965.6 18361.4 18635.2 18661.6 2156.5 2283.4 2323.9 2413.9 2839.0 9720.2 10064.3 10310.4 10383.4 13454.8 1772.0 1892.1 1902.9 1910.7 1973.2 83181.6 84485.0 84578.2 84913.0 85591.6 10820.1 10898.7 10966.7 10969.6 11115.6 14849.2 14978.2 14992.2 14993.6 15037.3 7713.4 7939.1 7952.4 8019.6 8047.1 6386.3 7422.0 7487.0 7585.1 7658.2 4518.0 4664.6 4818.3 4840.4 4900.8 1962.4 1982.6 1982.6 1984.2 1984.3 902.9 974.2 983.8 1073.4 1137.1 18023.6 18680.7 18956.5 19234.0 19301.8 1029.4 1049.4 1056.1 1074.4 1084.4 10242.4 10636.6 10689.4 10692.1 10739.7 457225.0 468113.0 468514.0 473063.0 479725.0 91116.5 93707.5 94381.5 94542.5 95020.5 974.3 984.1 1060.7 1067.0 1083.3 16715.4 16742.8 16917.3 16939.3 17316.6 40542.0 40894.6 41640.3 41973.4 43217.0 56181.0 56892.7 58333.7 58770.0 59219.0 8500.7 8596.6 8689.5 8690.3 11508.3 13352.0 13382.2 13451.3 13841.4 14314.6 8576.8 12396.7 12467.9 12582.4 12860.6 8450.5 8808.9 8963.4 8999.6 9047.5 8662.7 8898.2 9082.8 9117.5 9276.2 12316.1 12770.0 12773.6 12877.2 12903.7 11512.0 11541.5 11682.2 11713.6 11770.5 01:33:51 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | [#3] mootools.html Cycles:180 Average:5743.71 Median:2593.54 stddev:3292.86 (127.0%) stddev-sans-first:3284.95 01:33:51 INFO - PROCESS | 897 | Values: 1273.2 1456.3 1509.7 1610.5 1801.3 8120.0 8423.3 8497.8 8714.5 8742.8 8520.4 8635.4 8694.8 8709.7 8715.7 1933.2 2252.1 2285.0 2285.8 2346.6 2398.7 2406.9 2407.7 2409.0 2410.7 2279.3 2295.8 2329.1 2335.3 2340.0 1963.1 2226.7 2266.6 2287.9 2292.9 2285.9 2299.4 2300.6 2302.7 2304.7 8692.3 8716.3 8717.0 8739.7 8742.3 5041.1 5156.3 5156.6 5160.0 5162.5 3079.6 3161.9 3218.8 3237.1 3309.7 1094.8 1096.5 1106.6 1117.4 1169.2 12121.8 12192.6 12196.6 12198.2 12201.8 4610.1 4643.4 4717.6 4722.9 4813.0 10197.6 10208.8 10225.6 10231.0 10238.4 5260.5 5265.7 5265.9 5273.5 5275.2 4127.4 4683.7 4812.8 4827.4 4861.7 4020.0 4027.2 4081.8 4122.7 4133.4 1303.8 1310.6 1331.3 1332.1 1333.9 960.9 991.5 1012.6 1019.3 1025.5 5721.8 5874.0 5875.3 5973.1 6120.8 457.8 469.5 474.7 475.3 482.5 4000.2 4125.7 4202.7 4203.1 4237.2 10611.3 11036.0 11060.2 11075.9 11101.3 10263.3 10704.0 10926.7 10958.7 10968.0 8015.4 8116.7 8139.9 8164.2 8188.7 5812.3 6003.3 6043.2 6045.4 6218.7 9528.4 9903.4 9957.5 10008.5 10101.5 10175.0 10352.3 10364.4 10429.5 10454.0 6935.1 7051.9 7581.0 7787.1 7953.4 8524.8 8545.2 8622.8 8625.2 8648.4 7412.9 7644.6 7695.9 7735.3 7763.5 7479.7 7557.5 7584.9 7657.8 7762.1 6975.1 7005.8 7016.6 7058.9 7081.5 4798.9 4934.1 4985.9 5011.1 5041.8 4980.2 4984.6 5047.9 5076.2 5152.9 01:33:51 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | [#4] prototype.html Cycles:180 Average:4541.34 Median:5067.27 stddev:1325.62 (26.2%) stddev-sans-first:1291.05 01:33:51 INFO - PROCESS | 897 | Values: 326.6 334.7 335.0 345.3 346.3 5322.9 5353.0 5356.4 5369.7 5471.0 5298.9 5345.0 5389.4 5392.2 5392.6 3650.7 3979.0 4035.0 4035.6 4039.2 4111.5 4135.4 4147.3 4147.8 4152.4 4113.0 4127.0 4128.5 4133.3 4147.8 3919.3 4019.4 4026.4 4053.2 4101.4 3506.3 3682.4 3686.6 3688.5 3690.3 5042.1 5064.8 5075.4 5083.5 5123.3 4459.5 4705.0 4709.8 4774.9 4779.2 5389.8 5410.9 5465.1 5475.4 5508.3 3968.3 3968.4 3972.3 3978.4 3984.9 5481.8 5694.1 5773.2 5774.6 5833.9 4018.5 4035.7 4039.8 4057.4 4076.8 4117.0 4119.2 4121.2 4150.1 4161.9 4534.8 4696.2 4700.6 4742.5 4753.1 5531.7 5549.8 5556.4 5558.6 5560.9 1403.0 1412.1 1424.5 1426.9 1434.6 886.8 915.6 916.9 917.6 932.6 4767.2 4801.7 4821.4 4834.7 4848.0 5016.9 5051.4 5066.3 5072.9 5089.4 4588.5 4677.0 4831.0 4836.8 4878.0 2665.5 2680.5 2687.4 2712.6 2714.1 5180.9 5192.3 5199.9 5203.7 5236.6 4945.8 4981.6 5132.4 5140.2 5190.5 5193.0 5202.3 5223.3 5246.8 5263.3 5048.3 5049.6 5060.6 5068.3 5087.7 5046.3 5119.2 5236.9 5747.7 5780.6 5887.5 5894.0 5904.0 5944.7 5994.7 4081.6 4110.9 4131.0 4132.6 4153.7 5694.7 5698.4 5711.7 5743.6 5743.8 5593.7 5607.4 5615.2 5615.8 5623.2 5270.9 5547.8 5558.3 5596.2 5604.9 5485.5 5510.4 5519.5 5528.2 5564.4 5575.1 5611.3 5641.0 5676.0 5710.3 5294.8 5581.9 5586.0 5592.6 5598.5 01:33:51 INFO - PROCESS | 897 | 01:33:51 INFO - PROCESS | 897 | [#5] yui.html Cycles:180 Average:20600.05 Median:25282.55 stddev:29019.18 (114.8%) stddev-sans-first:29062.16 01:33:51 INFO - PROCESS | 897 | Values: 709.3 743.2 756.5 785.5 798.7 15196.1 15244.2 15279.5 15684.0 16916.9 16180.4 16926.9 16963.4 16973.3 16985.1 689.6 809.7 813.9 824.6 827.2 822.3 828.4 828.6 828.6 830.4 853.5 859.2 859.2 859.2 859.6 705.1 830.8 847.3 853.1 853.3 617.6 622.6 623.9 624.1 624.4 15417.3 15501.5 15502.0 15508.5 15513.2 14086.2 14158.6 14279.5 14334.7 14374.3 13587.5 13592.1 13592.5 13730.7 13854.0 4430.8 4458.4 4486.8 4520.3 4542.0 71682.0 72468.0 73334.6 73890.3 73981.6 11220.9 11225.3 11284.2 11358.3 11497.6 20491.3 20589.3 20659.8 20687.2 20689.7 8556.8 8606.7 8634.9 8650.4 8912.2 4638.1 4765.1 4767.3 4794.4 4997.1 3382.2 3471.8 3487.0 3490.3 3492.0 605.2 610.4 611.7 620.4 629.7 690.3 697.9 731.3 736.3 746.9 9954.3 10187.4 10258.6 10287.5 10371.4 597.1 624.1 649.9 670.9 724.3 4682.9 4863.6 4904.7 4910.9 4919.6 105172.5 112143.4 112374.0 115182.4 115786.0 93221.1 95776.5 95825.0 95928.5 96564.5 86001.6 86668.6 86672.6 86945.1 87612.1 8824.0 8867.0 9051.1 9160.8 9206.7 38113.0 45927.0 50677.5 51732.5 54062.7 69518.7 71186.3 72043.6 72316.0 74119.6 12857.2 12978.9 13106.0 13459.3 14006.4 14888.6 15082.8 15170.1 15229.6 15263.9 14091.5 14644.9 14708.7 14709.0 14830.6 14257.4 14350.4 14810.6 15014.5 15023.2 13917.1 14117.9 14315.6 14362.4 14824.6 10782.9 10878.7 11000.4 11307.8 11320.5 10731.6 10855.2 11128.4 11470.2 11627.5 01:33:51 INFO - PROCESS | 897 | -------- Summary: end -------- 01:33:51 INFO - PROCESS | 897 | 01:33:52 INFO - TEST-INFO | 897: exit 0 01:33:52 INFO - TEST-OK | dromaeo_css | took 1113416ms 01:33:52 INFO - TEST-START | kraken 01:33:52 INFO - operating with platform_type : linux_ 01:33:52 INFO - Initialising browser for kraken test... 01:33:52 INFO - TEST-INFO | started process 1084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKyB7x3/profile http://localhost:46189/getInfo.html) 01:33:56 INFO - PROCESS | 1084 | __metrics Screen width/height:1600/1200 01:33:56 INFO - PROCESS | 1084 | colorDepth:24 01:33:56 INFO - PROCESS | 1084 | Browser inner width/height: 1024/697 01:33:56 INFO - PROCESS | 1084 | __metrics 01:33:57 ERROR - PROCESS | 1084 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:33:58 INFO - TEST-INFO | 1084: exit 0 01:33:58 INFO - Browser initialized. 01:33:58 INFO - Running cycle 1/1 for kraken test... 01:33:58 INFO - TEST-INFO | started process 1224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKyB7x3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:09 INFO - PROCESS | 1224 | RSS: Main: 156028928 01:34:09 INFO - PROCESS | 1224 | 01:34:12 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46189/tests/kraken/driver.html?testName=audio-beat-detection) 01:34:13 INFO - PROCESS | 1224 | RSS: Main: 214196224 01:34:13 INFO - PROCESS | 1224 | 01:34:15 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46189/tests/kraken/driver.html?testName=audio-dft) 01:34:16 INFO - PROCESS | 1224 | RSS: Main: 198348800 01:34:16 INFO - PROCESS | 1224 | 01:34:19 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46189/tests/kraken/driver.html?testName=audio-fft) 01:34:20 INFO - PROCESS | 1224 | RSS: Main: 268595200 01:34:20 INFO - PROCESS | 1224 | 01:34:22 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46189/tests/kraken/driver.html?testName=audio-oscillator) 01:34:22 INFO - PROCESS | 1224 | RSS: Main: 179433472 01:34:22 INFO - PROCESS | 1224 | 01:34:25 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46189/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:34:25 INFO - PROCESS | 1224 | RSS: Main: 184590336 01:34:25 INFO - PROCESS | 1224 | 01:34:28 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46189/tests/kraken/driver.html?testName=imaging-darkroom) 01:34:29 INFO - PROCESS | 1224 | RSS: Main: 218173440 01:34:29 INFO - PROCESS | 1224 | 01:34:32 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46189/tests/kraken/driver.html?testName=imaging-desaturate) 01:34:33 INFO - PROCESS | 1224 | RSS: Main: 221433856 01:34:33 INFO - PROCESS | 1224 | 01:34:36 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46189/tests/kraken/driver.html?testName=json-parse-financial) 01:34:36 INFO - PROCESS | 1224 | RSS: Main: 220524544 01:34:36 INFO - PROCESS | 1224 | 01:34:38 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46189/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:34:38 INFO - PROCESS | 1224 | RSS: Main: 206520320 01:34:38 INFO - PROCESS | 1224 | 01:34:40 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46189/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:34:41 INFO - PROCESS | 1224 | RSS: Main: 210214912 01:34:41 INFO - PROCESS | 1224 | 01:34:43 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46189/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:34:43 INFO - PROCESS | 1224 | RSS: Main: 216358912 01:34:43 INFO - PROCESS | 1224 | 01:34:46 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:34:47 INFO - PROCESS | 1224 | RSS: Main: 224559104 01:34:47 INFO - PROCESS | 1224 | 01:34:49 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:34:50 INFO - PROCESS | 1224 | RSS: Main: 223436800 01:34:50 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | Cycle 1(1): loaded http://localhost:46189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46189/tests/kraken/driver.html?testName=ai-astar) 01:34:52 INFO - PROCESS | 1224 | RSS: Main: 265420800 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | __start_tp_report 01:34:52 INFO - PROCESS | 1224 | _x_x_mozilla_page_load 01:34:52 INFO - PROCESS | 1224 | _x_x_mozilla_page_load_details 01:34:52 INFO - PROCESS | 1224 | |i|pagename|runs| 01:34:52 INFO - PROCESS | 1224 | |0;ai-astar;111;104;111;109;109;109;110;111;110;109 01:34:52 INFO - PROCESS | 1224 | |1;audio-beat-detection;150;124;126;186;131;132;153;127;176;126 01:34:52 INFO - PROCESS | 1224 | |2;audio-dft;160;160;161;159;161;162;160;160;160;161 01:34:52 INFO - PROCESS | 1224 | |3;audio-fft;75;74;75;105;74;76;76;74;99;74 01:34:52 INFO - PROCESS | 1224 | |4;audio-oscillator;86;85;110;85;85;85;121;85;84;120 01:34:52 INFO - PROCESS | 1224 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;116;117 01:34:52 INFO - PROCESS | 1224 | |6;imaging-darkroom;145;145;145;145;145;145;146;146;146;145 01:34:52 INFO - PROCESS | 1224 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;94 01:34:52 INFO - PROCESS | 1224 | |8;json-parse-financial;53;52;55;53;53;53;55;52;53;53 01:34:52 INFO - PROCESS | 1224 | |9;json-stringify-tinderbox;63;65;63;63;63;62;62;62;63;62 01:34:52 INFO - PROCESS | 1224 | |10;stanford-crypto-aes;85;82;79;80;80;80;81;82;109;81 01:34:52 INFO - PROCESS | 1224 | |11;stanford-crypto-ccm;135;123;129;120;127;128;122;122;154;124 01:34:52 INFO - PROCESS | 1224 | |12;stanford-crypto-pbkdf2;163;158;164;160;160;159;166;159;163;159 01:34:52 INFO - PROCESS | 1224 | |13;stanford-crypto-sha256-iterative;67;65;64;63;62;64;64;62;63;61 01:34:52 INFO - PROCESS | 1224 | __end_tp_report 01:34:52 INFO - PROCESS | 1224 | __start_cc_report 01:34:52 INFO - PROCESS | 1224 | _x_x_mozilla_cycle_collect,1632 01:34:52 INFO - PROCESS | 1224 | __end_cc_report 01:34:52 INFO - PROCESS | 1224 | __startTimestamp1465202092279__endTimestamp 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | ------- Summary: start ------- 01:34:52 INFO - PROCESS | 1224 | Number of tests: 14 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.06 (1.9%) stddev-sans-first:2.09 01:34:52 INFO - PROCESS | 1224 | Values: 111.0 104.0 111.0 109.0 109.0 109.0 110.0 111.0 110.0 109.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:141.00 stddev:22.48 (15.9%) stddev-sans-first:23.70 01:34:52 INFO - PROCESS | 1224 | Values: 150.0 124.0 126.0 186.0 131.0 132.0 153.0 127.0 176.0 126.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 01:34:52 INFO - PROCESS | 1224 | Values: 160.0 160.0 161.0 159.0 161.0 162.0 160.0 160.0 160.0 161.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:11.60 (15.5%) stddev-sans-first:12.15 01:34:52 INFO - PROCESS | 1224 | Values: 75.0 74.0 75.0 105.0 74.0 76.0 76.0 74.0 99.0 74.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:85.00 stddev:15.73 (18.5%) stddev-sans-first:16.37 01:34:52 INFO - PROCESS | 1224 | Values: 86.0 85.0 110.0 85.0 85.0 85.0 121.0 85.0 84.0 120.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:34:52 INFO - PROCESS | 1224 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 01:34:52 INFO - PROCESS | 1224 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 01:34:52 INFO - PROCESS | 1224 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 01:34:52 INFO - PROCESS | 1224 | Values: 53.0 52.0 55.0 53.0 53.0 53.0 55.0 52.0 53.0 53.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 01:34:52 INFO - PROCESS | 1224 | Values: 63.0 65.0 63.0 63.0 63.0 62.0 62.0 62.0 63.0 62.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.00 stddev:8.97 (11.1%) stddev-sans-first:9.51 01:34:52 INFO - PROCESS | 1224 | Values: 85.0 82.0 79.0 80.0 80.0 80.0 81.0 82.0 109.0 81.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:127.50 stddev:10.01 (7.9%) stddev-sans-first:10.33 01:34:52 INFO - PROCESS | 1224 | Values: 135.0 123.0 129.0 120.0 127.0 128.0 122.0 122.0 154.0 124.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.69 (1.7%) stddev-sans-first:2.76 01:34:52 INFO - PROCESS | 1224 | Values: 163.0 158.0 164.0 160.0 160.0 159.0 166.0 159.0 163.0 159.0 01:34:52 INFO - PROCESS | 1224 | 01:34:52 INFO - PROCESS | 1224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.72 (2.7%) stddev-sans-first:1.27 01:34:52 INFO - PROCESS | 1224 | Values: 67.0 65.0 64.0 63.0 62.0 64.0 64.0 62.0 63.0 61.0 01:34:52 INFO - PROCESS | 1224 | -------- Summary: end -------- 01:34:52 INFO - PROCESS | 1224 | 01:34:53 INFO - TEST-INFO | 1224: exit 0 01:34:53 INFO - TEST-OK | kraken | took 60921ms 01:34:53 INFO - SUITE-END | took 1174s 01:34:53 INFO - Completed test suite (00:19:34) 01:34:53 INFO - javascript benchmark 01:34:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.8296193709352, 3104.1463597510688, 3120.1887509247604, 3145.732612727918, 3152.38528486945, 5261.289725887004, 5321.0, 5364.704941228231, 5425.348958125026, 5432.972835135819, 5380.650257733245, 5387.0303345397815, 5420.7018613976215, 5425.593080518967, 5518.034343989796, 4845.297431872376, 4921.434035085975, 4937.2840938063955, 4945.77744001519, 5086.643934924557, 4989.176785830334, 5025.271335656327, 5048.066107770056, 5059.569936555397, 5071.442141364465, 4751.192297309449, 4770.165221086313, 4779.952200478003, 4828.444728856191, 4862.781174847105, 4856.975715121437, 4972.726500042496, 4974.079795237856, 4976.154053810861, 5015.3229314042865, 4919.2867034279825, 4947.554720075211, 4968.850934471971, 4970.900581988376, 5019.071471777696, 5199.14214154664, 5265.815696450644, 5350.866228344284, 5421.674699518002, 5469.878674871642, 5897.0, 5908.0842469416875, 5917.674527900964, 5918.467337939606, 5920.851978700523, 5497.972510137463, 5903.291605007384, 5941.435563621449, 5947.910781338283, 5948.791792287249, 5296.629235953485, 5340.706261155635, 5344.652597581145, 5411.134218525017, 5411.215373770781, 5890.440408161217, 5895.292564892155, 5895.410458954156, 5897.705114744245, 5897.882042359214, 5505.807296744595, 5637.436256374412, 5653.660780353192, 5654.15187721845, 5659.801906933238, 5762.337331206965, 5824.534037277008, 5882.3529411764675, 5884.440978107073, 5885.176075349455, 5756.827295181151, 5769.826905192851, 5783.0, 5790.0, 5808.680522571299, 5604.467575580314, 5751.769929202868, 5804.970975145182, 5805.82582522525, 5813.244278243886, 4431.40176076232, 4434.667399945017, 4444.377787109807, 4474.552544745565, 4483.327500874895, 3954.8418063277722, 3974.3243648579232, 3979.0649197439157, 4002.699797515198, 4007.7996100194873, 5299.788008479694, 5406.459354064562, 5407.026735187704, 5468.91796623051, 5583.609147359727, 5787.768489260382, 5799.18811366409, 5807.216025836543, 5814.941850581525, 5855.063189889597, 5488.1493368527945, 5496.697681627549, 5499.340079190442, 5501.477359650827, 5502.669839809624, 4872.0, 4940.6788558743565, 4970.130227210224, 4976.178930476431, 4985.476524964826, 5946.613470124428, 5947.524198064145, 5951.3751056139345, 5954.196183515257, 5954.345022047658, 5782.277215348082, 5788.942110578841, 5791.102379131242, 5793.304803423616, 5793.913091303718, 5799.884002319845, 5840.299164100165, 5882.23530940975, 5898.882022359443, 5944.851378715393, 5614.21401003868, 5657.15142728594, 5659.066254068197, 5660.575456840671, 5662.348829884451, 5594.076977298863, 5759.827205183851, 5772.076467765138, 5775.162601422854, 5777.62445441045, 5560.471755183251, 5611.298587676541, 5623.803166889139, 5655.208270842003, 5659.773609055592, 5559.388467268516, 5585.050541407889, 5598.1602759586385, 5599.888002239851, 5603.3836278008575, 5411.70235637028, 5530.695811730394, 5537.9169312459535, 5538.750756215899, 5542.418046105262, 5696.886062278814, 5807.709614519342, 5815.389384114607, 5816.418358164319, 5823.796167134299, 5601.767933851399, 5607.747651355618, 5632.5212356950115, 5636.070048442125, 5638.21065050885], "value": 5330.827011998117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7135039505839, 611.8959776837937, 614.2874265851613, 632.987340253195, 634.2325785799186, 32899.17752056197, 36181.27637447253, 36213.91358259253, 42920.14159716804, 44146.0, 45247.54752452474, 45821.31268030974, 45835.54164458363, 45911.31133033007, 45952.0, 8721.0, 8907.153820387086, 8909.77725556863, 8911.15344042315, 8922.509261990588, 8793.736187914341, 8914.286857051453, 8922.063183365719, 8925.196732294093, 8930.508822014786, 8876.955615221947, 8946.329025323126, 8953.0, 8958.776030599221, 8965.50689712069, 8870.112988701143, 8913.331500137516, 8914.331425143107, 8915.153060459279, 8919.687810926587, 8820.33847461443, 8895.199432051082, 8900.287976961827, 8902.465852048834, 8907.910920890772, 42153.57846421527, 42298.0, 42371.36442953358, 42508.0, 42781.0, 3497.790132592027, 3625.655562721537, 3707.4994875691705, 3837.827297771607, 4038.959610403888, 32883.82569868039, 32917.50623740646, 32942.50586241209, 33258.50112248318, 34630.480542791876, 4297.892552686177, 4308.246056940055, 4376.912461750779, 4427.822887084512, 4455.933161002587, 331684.0, 332204.0, 332925.0, 333208.99999999756, 333729.0, 59411.70294148502, 59477.70261148667, 59727.70136149378, 59750.70124649349, 59756.10365844516, 62640.37359626436, 62751.6862415685, 63047.36952630507, 63126.36873631205, 63194.684026579576, 15317.23413829304, 15552.533423997298, 15715.21423928799, 15722.13528255934, 16035.759463608056, 12671.113022088366, 12682.619521414372, 12734.872651273554, 12812.42344094518, 12814.743705125846, 19847.503812404804, 20059.0, 20090.497737556678, 20100.894450805055, 20185.394438166877, 7227.674754636054, 7267.709291628382, 7451.919471676577, 7477.775666730006, 7525.924740752523, 983.5524836199512, 1120.523777394604, 1140.122105978392, 1164.8776878427811, 1219.2136072233359, 32861.83569082139, 32879.3424131516, 32979.50530741993, 33422.323544410094, 33569.0, 1112.6606385052637, 1138.908887289015, 1141.828725691153, 1168.6435637130587, 1177.935213563245, 16953.0, 17477.912610436866, 17609.0, 17648.08475226624, 17788.46634600964, 495035.0, 846990.0, 856366.0, 857789.0, 859755.0, 58550.7072464635, 58889.70555147197, 59050.704746475996, 59091.40908590859, 59131.0, 1275.789494733377, 1361.7412691588765, 1379.344811214685, 1379.7861331493634, 1402.4179965314484, 28649.570256446586, 33699.15752106217, 33719.831400842835, 33745.3250934975, 34095.14762130867, 48566.51433485761, 48778.75610621924, 49085.509144908094, 49297.75351123365, 49411.258831118284, 416569.0, 420681.0, 420881.0, 422131.0, 422408.0, 24928.37679058038, 27394.5890811642, 28574.285642859093, 28628.713712862605, 28895.42209155763, 46973.0, 47207.527924720314, 47300.7634961823, 48089.5191048085, 48325.27512087251, 39746.0, 40441.0, 40758.38862417125, 40877.1824563513, 41326.586734133474, 40173.39739903962, 40468.595314046484, 40527.79736101301, 40550.59449405468, 40797.79601101975, 40333.798331008154, 40880.59119408887, 41112.0, 41208.1758364837, 41426.585734143475, 33348.0, 35882.0, 36749.63250367462, 37160.0, 37215.25569488541, 27589.58615620727, 27810.0, 28077.0, 28231.294217644725, 28244.576331355456], "value": 20432.88329238337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.26076107298815, 396.56774116213325, 399.32115403813526, 402.54713447371705, 415.5615825304305, 14260.286985650702, 17293.91353043236, 18183.818161818377, 19735.1119199636, 19791.901040494795, 14781.113133211988, 17409.129543522835, 17581.29674813006, 18332.450026499195, 19373.225070997145, 5426.240326354314, 5588.552915766749, 5611.018071837432, 5632.7746890124345, 5637.126245431965, 4157.0, 5497.065498865202, 5573.247611572447, 5995.700214989233, 6293.49652027839, 6275.748970041216, 6294.43350098491, 6311.0217916223055, 6353.856305864942, 6355.173827402431, 6072.696365181768, 6224.719887605069, 6243.2508099027955, 6308.3060863305, 6314.084457753623, 5067.315912351823, 5517.503424691797, 5532.114861622162, 5538.280023596906, 5549.861253468655, 13914.817240534567, 14965.551033469013, 18361.449156525327, 18635.161417736097, 18661.62676746471, 2156.4608847788054, 2283.406314358262, 2323.94190145246, 2413.9396515087087, 2839.0489186122672, 9720.222382209406, 10064.29549931505, 10310.381377117397, 10383.376997380181, 13454.798178027337, 1771.9645607087787, 1892.110707967267, 1902.9238830446905, 1910.6751852185023, 1973.200853654258, 83181.58409207976, 84485.0, 84578.15421845826, 84912.99999999939, 85591.57204214002, 10820.13438924884, 10898.673039808818, 10966.725831854268, 10969.616063437741, 11115.555377784798, 14849.183294918883, 14978.17620030887, 14992.175430351435, 14993.550193493995, 15037.323320450607, 7713.382929365637, 7939.126696063428, 7952.3638108951145, 8019.639116239783, 8047.114817370085, 6386.329435409308, 7421.962890185622, 7486.962565187139, 7585.127710313384, 7658.157602663814, 4517.977410112994, 4664.626829853603, 4818.349522814446, 4840.443349014838, 4900.803967841318, 1962.4014675523817, 1982.5899452940919, 1982.6332128556264, 1984.176566724793, 1984.3388947392039, 902.9458232506071, 974.1768205866032, 983.7983213441228, 1073.431081526792, 1137.1357768096307, 18023.639527209383, 18680.719789203173, 18956.52608684766, 19233.98043205443, 19301.80698193028, 1029.4080903480528, 1049.396596956753, 1056.0653821368144, 1074.3929679730927, 1084.3764835219781, 10242.385456872611, 10636.627718029986, 10689.412082335391, 10692.144628429707, 10739.677809665722, 457225.0, 468113.0, 468514.0, 473063.0, 479725.0, 91116.54441727749, 93707.53146234225, 94381.52809236047, 94542.52728736312, 95020.52489737645, 974.2595627323285, 984.0995489127369, 1060.6764936694383, 1066.9626563070256, 1083.274206281793, 16715.414960476326, 16742.832571674127, 16917.323307068073, 16939.32242710278, 17316.567085822957, 40542.0, 40894.591054089076, 41640.33438662419, 41973.370399443425, 43217.0, 56181.0, 56892.71553642205, 58333.708331458074, 58770.0, 59219.0, 8500.659973600987, 8596.613152408032, 8689.522076285864, 8690.26132778721, 11508.251963622337, 13352.000956632406, 13382.197068175941, 13451.260180689764, 13841.37713802861, 14314.642133946734, 8576.785580360542, 12396.690082748004, 12467.87532124667, 12582.433790479266, 12860.614181574567, 8450.492970421794, 8808.911910881065, 8963.372563920462, 8999.55002249898, 9047.547622618711, 8662.740117796477, 8898.154675305836, 9082.772930676785, 9117.498537580497, 9276.211522020703, 12316.13787034899, 12770.0, 12773.552925647558, 12877.162984405984, 12903.677408064874, 11512.0, 11541.480633371351, 11682.182247242952, 11713.648590542298, 11770.52917883275], "value": 9119.267171896605, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.2106094221583, 1456.2500312339148, 1509.6603264265539, 1610.4846449136273, 1801.2884910460361, 8119.959400202998, 8423.284020858227, 8497.787555311113, 8714.477131372121, 8742.781430464242, 8520.360972927025, 8635.438696484724, 8694.826103477943, 8709.695160669378, 8715.694950676727, 1933.2267093162707, 2252.1441852096223, 2284.9657255141187, 2285.7828506291958, 2346.5541547105995, 2398.688170537828, 2406.867622280774, 2407.7471865454136, 2409.0002648900772, 2410.7348191698898, 2279.338991692407, 2295.827812914038, 2329.114936324203, 2335.2877372401413, 2339.9532009359805, 1963.1165975311096, 2226.7439244486927, 2266.626006708891, 2287.931362059141, 2292.85096468729, 2285.908563657468, 2299.4366380236784, 2300.6318988961684, 2302.7466978632337, 2304.7234331880113, 8692.348073894484, 8716.346274029473, 8716.956415217946, 8739.694110706158, 8742.344324175712, 5041.092603331399, 5156.278121063054, 5156.639035267533, 5160.045391602565, 5162.5095615916425, 3079.5688603595513, 3161.8893338733033, 3218.806871587712, 3237.1259759864706, 3309.7352211822995, 1094.8029354716148, 1096.4627332606965, 1106.6016234155697, 1117.4133579870634, 1169.2399940038958, 12121.818172727417, 12192.57325993586, 12196.573119940847, 12198.207116537396, 12201.755964880653, 4610.124076425468, 4643.421236779511, 4717.599004084623, 4722.858314250578, 4812.951870481251, 10197.592096316064, 10208.795824083476, 10225.642102526524, 10231.0, 10238.436885971343, 5260.473952604709, 5265.657732247469, 5265.947340526623, 5273.525382715574, 5275.155975044051, 4127.360259159835, 4683.7423941682855, 4812.783424745895, 4827.396575428072, 4861.7326047067045, 4019.992894443532, 4027.154297597537, 4081.8163182656854, 4122.670186385082, 4133.42132101506, 1303.778357679197, 1310.60026691858, 1331.2744554217975, 1332.0808642037157, 1333.9399727012308, 960.9093678674755, 991.5191132300828, 1012.5696578954063, 1019.2508506247901, 1025.5180065369264, 5721.828345149652, 5874.0, 5875.294964604275, 5973.104034394789, 6120.816375508742, 457.8485109948482, 469.4812232483057, 474.7222874618318, 475.32741171243, 482.54881685624053, 4000.179963107556, 4125.66994640428, 4202.747835129902, 4203.138356636943, 4237.237297286518, 10611.25721199524, 11036.0, 11060.22578419519, 11075.889241107647, 11101.333919964827, 10263.332883362558, 10703.999999999844, 10926.672199834018, 10958.726031849268, 10968.0, 8015.358771298283, 8116.715914942949, 8139.877901831359, 8164.183581641788, 8188.68980963043, 5812.273465816773, 6003.279606447254, 6043.214382130295, 6045.425684559959, 6218.657973811484, 9528.428294302365, 9903.405795652285, 9957.452340121074, 10008.499575021075, 10101.49492525356, 10175.033371829664, 10352.327098738559, 10364.429956352473, 10429.478526073513, 10454.0, 6935.133108361455, 7051.858962820612, 7581.0, 7787.10448298453, 7953.403494737802, 8524.829503410021, 8545.188207120314, 8622.78443038929, 8625.180607842245, 8648.394612377073, 7412.888806668012, 7644.617769111411, 7695.884561731466, 7735.265149810759, 7763.456558040883, 7479.738209162653, 7557.470977031775, 7584.886226706714, 7657.770266892002, 7762.146163922077, 6975.093237879043, 7005.789826305219, 7016.614086225102, 7058.858822823618, 7081.539699919695, 4798.880027999328, 4934.062528119646, 4985.875353116201, 5011.072951503837, 5041.773120209526, 4980.178270585313, 4984.551390374883, 5047.924281135713, 5076.162433198629, 5152.871178220575], "value": 4524.289176280735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.64558953535413, 334.6803802368738, 334.98157601331934, 345.27492266240915, 346.34886413542534, 5322.866928326794, 5353.0, 5356.437574054722, 5369.677819330843, 5471.0, 5298.867528311795, 5345.0, 5389.407165211824, 5392.2181283713835, 5392.649477783942, 3650.7261955353324, 3978.9801050994706, 4034.9596504035026, 4035.59644035597, 4039.2325458163, 4111.48606424197, 4135.359019352005, 4147.315692910666, 4147.7926103694845, 4152.397902304164, 4112.9588704112875, 4126.958730412703, 4128.545859955418, 4133.276676581601, 4147.834086636531, 3919.333713268737, 4019.397090436458, 4026.4296924199584, 4053.169100334454, 4101.425800387948, 3506.3337965786673, 3682.429223470366, 3686.594474607818, 3688.5204923359793, 3690.280395322913, 5042.1428357179, 5064.82273120439, 5075.365579302587, 5083.517065878736, 5123.308353372285, 4459.502678500018, 4705.011947491031, 4709.764511774431, 4774.901772592289, 4779.235322348442, 5389.757460914268, 5410.8637186190945, 5465.125579907196, 5475.425080366584, 5508.328460696559, 3968.3253846846105, 3968.3650615901315, 3972.2651309507546, 3978.3543943277973, 3984.900377490557, 5481.75332110056, 5694.088945768699, 5773.191753154561, 5774.614092617783, 5833.941660583382, 4018.517777866616, 4035.7376770509823, 4039.838406463767, 4057.3711074783455, 4076.7961601919787, 4117.0, 4119.196756632428, 4121.237571049365, 4150.107726838744, 4161.854335098257, 4534.79593418297, 4696.201645720235, 4700.623950084054, 4742.549457801572, 4753.120672675566, 5531.6957567333375, 5549.805756798492, 5556.416576259516, 5558.638688485235, 5560.916586251209, 1402.9719405612034, 1412.1244828206577, 1424.5227848670604, 1426.9001169918006, 1434.5911415246605, 886.8448021596324, 915.5925613102239, 916.9455126604325, 917.6329468212634, 932.5616960028775, 4767.189577771787, 4801.7118972861745, 4821.373221481185, 4834.661573689878, 4847.95152048475, 5016.949830501649, 5051.444341122474, 5066.265391518209, 5072.923906141411, 5089.396839995389, 4588.472325682523, 4676.976615116902, 4830.975845120752, 4836.830710925171, 4878.048780487842, 2665.506881226979, 2680.477306925131, 2687.3819021625136, 2712.6337944377256, 2714.1179116787125, 5180.922286165711, 5192.324997750344, 5199.908019315911, 5203.739813009334, 5236.554892834076, 4945.826896058621, 4981.61700514323, 5132.358455193101, 5140.228965655182, 5190.532852043334, 5192.9740351298005, 5202.3468031303555, 5223.268742376071, 5246.816361427332, 5263.315768950089, 5048.293238946624, 5049.6465247432325, 5060.620453466078, 5068.26510156018, 5087.745612719275, 5046.34397528319, 5119.206522988943, 5236.947630523799, 5747.706765977621, 5780.624259423124, 5887.5289976802605, 5894.0, 5903.96680580888, 5944.73248703818, 5994.700264986646, 4081.551049377428, 4110.856120035784, 4131.0, 4132.615573782817, 4153.6677065835265, 5694.658320500783, 5698.427934133262, 5711.714414279352, 5743.592819759018, 5743.798967036134, 5593.720313984366, 5607.43925607436, 5615.18579805934, 5615.803446879339, 5623.156526521055, 5270.893112446276, 5547.833564993057, 5558.277423934863, 5596.1605759136455, 5604.915926261027, 5485.451454854483, 5510.421405752499, 5519.530839878656, 5528.170774383874, 5564.443555644403, 5575.135853942646, 5611.270534830446, 5640.971795140998, 5675.971620141873, 5710.314762228559, 5294.761735721979, 5581.944180558143, 5585.96112418956, 5592.636478628876, 5598.496135347838], "value": 4123.272693890148, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2729951799408, 743.2456057102042, 756.53851150798, 785.4894318692849, 798.7364169823959, 15196.088234705925, 15244.161571113584, 15279.541613751577, 15684.0, 16916.915415422936, 16180.433684821033, 16926.915365423185, 16963.406280780175, 16973.32106715733, 16985.06582137982, 689.6448329110513, 809.6923169195697, 813.8535063688533, 824.5671022713063, 827.1976183102381, 822.3421262989584, 828.4366630691158, 828.6395417993162, 828.6478246745139, 830.4436027861317, 853.5433543054467, 859.1794835931702, 859.2352806002663, 859.2438653984485, 859.5788063848701, 705.0552259971637, 830.7590798668379, 847.2882778466118, 853.1255463150289, 853.3002937591177, 617.6263360666821, 622.551762730833, 623.9313675495691, 624.1418050181001, 624.434886427779, 15417.306221220071, 15501.457448989231, 15502.0, 15508.5347439577, 15513.224338783128, 14086.225257610828, 14158.57524274263, 14279.500217492441, 14334.713305733827, 14374.281285935765, 13587.456501739918, 13592.11651242666, 13592.524261650893, 13730.725385492335, 13854.0, 4430.800613972379, 4458.375827384169, 4486.842960496399, 4520.3219517072375, 4542.0, 71682.0, 72468.0, 73334.63332683302, 73890.26109738888, 73981.63009184973, 11220.943895280634, 11225.341483284508, 11284.210105292716, 11358.318500889973, 11497.597584084517, 20491.282805102048, 20589.279375221795, 20659.793402066087, 20687.17251309961, 20689.68965465519, 8556.828863422821, 8606.65573377058, 8634.913650863537, 8650.43772154808, 8912.153345432174, 4638.095571363552, 4765.0946320199055, 4767.332573439652, 4794.376731025014, 4997.125503036954, 3382.222088919513, 3471.8090505022465, 3487.04106370745, 3490.3019396120876, 3491.965080349215, 605.1799811255773, 610.3804638292137, 611.721666641677, 620.4230066038627, 629.6820105846518, 690.3027941778839, 697.8743826111247, 731.2650785960076, 736.2931585677702, 746.8506298740274, 9954.25343099256, 10187.439690817077, 10258.640947566948, 10287.537060832281, 10371.429571373495, 597.0536699331608, 624.1499542520797, 649.8951781970575, 670.8893032649655, 724.277709335132, 4682.879309745027, 4863.562279394871, 4904.681195722266, 4910.8526744197015, 4919.606431485473, 105172.47413762883, 112143.4392828047, 112374.0, 115182.42408787903, 115786.0, 93221.06778932124, 95776.52111739536, 95825.0, 95928.52035739776, 96564.51717741367, 86001.56999214964, 86668.56665716632, 86672.56663716641, 86945.1305486937, 87612.12387876167, 8823.955880220557, 8866.955665221632, 9051.14014168653, 9160.770980725536, 9206.689430002902, 38113.0, 45927.0, 50677.49322506728, 51732.48267517277, 54062.72968635132, 69518.65240673764, 71186.28813712003, 72043.63978180075, 72316.0, 74119.62940185264, 12857.228566286052, 12978.935105324414, 13106.0, 13459.259740714355, 14006.439742410597, 14888.553343399715, 15082.849171508144, 15170.089794612359, 15229.619259518158, 15263.923680381527, 14091.506797262047, 14644.853551464776, 14708.705825883208, 14709.043912145677, 14830.555083347517, 14257.358418870968, 14350.354234059283, 14810.555683329518, 15014.549563513112, 15023.173725445205, 13917.095388799695, 14117.928453615456, 14315.57053288403, 14362.353694083582, 14824.62938426548, 10782.946085269523, 10878.690082562976, 11000.394978275952, 11307.830382544103, 11320.547178112784, 10731.610040630967, 10855.240133190917, 11128.38793866345, 11470.197086203885, 11627.53489860396], "value": 7636.661481308556, "unit": "score"}], "name": "dromaeo_css", "value": 7218.904269572389, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 109.0, 109.0, 109.0, 110.0, 111.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 126.0, 186.0, 131.0, 132.0, 153.0, 127.0, 176.0, 126.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 161.0, 162.0, 160.0, 160.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 105.0, 74.0, 76.0, 76.0, 74.0, 99.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 110.0, 85.0, 85.0, 85.0, 121.0, 85.0, 84.0, 120.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 55.0, 53.0, 53.0, 53.0, 55.0, 52.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 79.0, 80.0, 80.0, 80.0, 81.0, 82.0, 109.0, 81.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 129.0, 120.0, 127.0, 128.0, 122.0, 122.0, 154.0, 124.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 164.0, 160.0, 160.0, 159.0, 166.0, 159.0, 163.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 63.0, 62.0, 64.0, 64.0, 62.0, 63.0, 61.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1497.2, "alertThreshold": 2.0}]} 01:34:53 INFO - Return code: 0 01:34:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:34:53 ERROR - # TBPL SUCCESS # 01:34:53 INFO - Running post-action listener: _resource_record_post_action 01:34:53 INFO - ##### 01:34:53 INFO - ##### Finished run-tests step (success) 01:34:53 INFO - ##### 01:34:53 INFO - Running post-run listener: _resource_record_post_run 01:34:53 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 542674944; Read time: 180; Write time: 619732 01:34:53 INFO - TinderboxPrint: CPU usage
13.2% 01:34:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 01:34:53 INFO - TinderboxPrint: I/O write bytes / time
542,674,944 / 619,732 01:34:53 INFO - TinderboxPrint: CPU idle
8,254.7 (86.8%) 01:34:53 INFO - TinderboxPrint: CPU user
1,212.4 (12.7%) 01:34:53 INFO - TinderboxPrint: Swap in / out
0 / 0 01:34:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 181100544; Read time: 0; Write time: 321844 01:34:53 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293994496; Read time: 180; Write time: 255292 01:34:54 INFO - Running post-run listener: _upload_blobber_files 01:34:54 INFO - Blob upload gear active. 01:34:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:34:54 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 01:34:54 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'] 01:34:54 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 01:34:54 INFO - (blobuploader) - INFO - Open directory for files ... 01:34:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:34:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:58 INFO - (blobuploader) - INFO - Done attempting. 01:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:59 INFO - (blobuploader) - INFO - Done attempting. 01:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:00 INFO - (blobuploader) - INFO - Done attempting. 01:35:00 INFO - (blobuploader) - INFO - Iteration through files over. 01:35:00 INFO - Return code: 0 01:35:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:35:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:35:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9669d2920d14c7c6be16e54e0c483114970afd3c7e350f66232dd2bac3156c226b7f6a5ce334c8410b12c9d1a762ac90ad80ef670b94d4ef803db9496a49b5ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c52740de303fd1b1c0c489e0faf3f32167df7933591e3025fed38cf69704ed916325f795bfcef96cec332d3d11e719dd4f31d38ca163796c6baffc04c86dabcd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68de8fe9aa82bf7191df780adb3e4b44ddaa87a414cb9dfa97738d3316e98b0ace184ef7abeaee4fe5e6f25e1eeaec71bc2fc20c6b2a310796b37548b9d3ebc0"} 01:35:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:35:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:35:00 INFO - Contents: 01:35:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9669d2920d14c7c6be16e54e0c483114970afd3c7e350f66232dd2bac3156c226b7f6a5ce334c8410b12c9d1a762ac90ad80ef670b94d4ef803db9496a49b5ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c52740de303fd1b1c0c489e0faf3f32167df7933591e3025fed38cf69704ed916325f795bfcef96cec332d3d11e719dd4f31d38ca163796c6baffc04c86dabcd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68de8fe9aa82bf7191df780adb3e4b44ddaa87a414cb9dfa97738d3316e98b0ace184ef7abeaee4fe5e6f25e1eeaec71bc2fc20c6b2a310796b37548b9d3ebc0"} 01:35:00 INFO - Running post-run listener: copy_logs_to_upload_dir 01:35:00 INFO - Copying logs to upload dir... 01:35:00 INFO - mkdir: /builds/slave/test/build/upload/logs 01:35:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.888851 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-06 01:34:59.910544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 01:34:59.913831) ========= 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=db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241 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/9669d2920d14c7c6be16e54e0c483114970afd3c7e350f66232dd2bac3156c226b7f6a5ce334c8410b12c9d1a762ac90ad80ef670b94d4ef803db9496a49b5ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c52740de303fd1b1c0c489e0faf3f32167df7933591e3025fed38cf69704ed916325f795bfcef96cec332d3d11e719dd4f31d38ca163796c6baffc04c86dabcd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68de8fe9aa82bf7191df780adb3e4b44ddaa87a414cb9dfa97738d3316e98b0ace184ef7abeaee4fe5e6f25e1eeaec71bc2fc20c6b2a310796b37548b9d3ebc0"} build_url:https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011502 build_url: 'https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9669d2920d14c7c6be16e54e0c483114970afd3c7e350f66232dd2bac3156c226b7f6a5ce334c8410b12c9d1a762ac90ad80ef670b94d4ef803db9496a49b5ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c52740de303fd1b1c0c489e0faf3f32167df7933591e3025fed38cf69704ed916325f795bfcef96cec332d3d11e719dd4f31d38ca163796c6baffc04c86dabcd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68de8fe9aa82bf7191df780adb3e4b44ddaa87a414cb9dfa97738d3316e98b0ace184ef7abeaee4fe5e6f25e1eeaec71bc2fc20c6b2a310796b37548b9d3ebc0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 01:34:59.938252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:34:59.938553) ========= 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=db0483c52d987ecb441a263b000001ad-1465199880.937820-1139682241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:35:00.024057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 01:35:00.024398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 01:35:00.024712) ========= ========= Total master_lag: 0.19 =========