builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1465053872.96 results: success (0) buildid: 20160604053002 builduid: 6ac011f5931c45d6bddb84c72300e629 revision: a58743e540f5894ce8d802784bbd16737f5ae2c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:32.955369) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:32.955821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:32.956104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.009570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.009849) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 08:24:34-- 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% 25.7M=0s 2016-06-04 08:24:34 (25.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.151377) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.151684) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.201160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-04 08:24:33.201509) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a58743e540f5894ce8d802784bbd16737f5ae2c3 --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 a58743e540f5894ce8d802784bbd16737f5ae2c3 --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=5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 08:24:34,494 truncating revision to first 12 chars 2016-06-04 08:24:34,494 Setting DEBUG logging. 2016-06-04 08:24:34,494 attempt 1/10 2016-06-04 08:24:34,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a58743e540f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 08:24:35,814 unpacking tar archive at: fx-team-a58743e540f5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.660110 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-04 08:24:34.875237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:34.875583) ========= script_repo_revision: a58743e540f5894ce8d802784bbd16737f5ae2c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:34.876037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:34.876352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:34.885411) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-04 08:24:34.885854) ========= /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=5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:24:36 INFO - MultiFileLogger online at 20160604 08:24:36 in /builds/slave/test 08:24:36 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 08:24:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:36 INFO - {'append_to_log': False, 08:24:36 INFO - 'base_work_dir': '/builds/slave/test', 08:24:36 INFO - 'blob_upload_branch': 'Fx-Team', 08:24:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:36 INFO - 'branch': 'Fx-Team', 08:24:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:36 INFO - 'config_files': ('talos/linux_config.py',), 08:24:36 INFO - 'default_actions': ('clobber', 08:24:36 INFO - 'read-buildbot-config', 08:24:36 INFO - 'download-and-extract', 08:24:36 INFO - 'populate-webroot', 08:24:36 INFO - 'create-virtualenv', 08:24:36 INFO - 'install', 08:24:36 INFO - 'run-tests'), 08:24:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:36 INFO - 'download_minidump_stackwalk': True, 08:24:36 INFO - 'download_symbols': 'ondemand', 08:24:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:36 INFO - 'installer_path': 'installer.exe', 08:24:36 INFO - 'log_level': 'info', 08:24:36 INFO - 'log_name': 'talos', 08:24:36 INFO - 'log_to_console': True, 08:24:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:24:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:24:36 INFO - 'opt_config_files': (), 08:24:36 INFO - 'pip_index': False, 08:24:36 INFO - 'sps_profile': False, 08:24:36 INFO - 'sps_profile_interval': 0, 08:24:36 INFO - 'suite': 'dromaeojs', 08:24:36 INFO - 'system_bits': '32', 08:24:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:36 INFO - 'title': 'talos-linux64-ix-039', 08:24:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:36 INFO - 'use_talos_json': True, 08:24:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:36 INFO - 'work_dir': 'build'} 08:24:36 INFO - ##### 08:24:36 INFO - ##### Running clobber step. 08:24:36 INFO - ##### 08:24:36 INFO - Running pre-action listener: _resource_record_pre_action 08:24:36 INFO - Running main action method: clobber 08:24:36 INFO - rmtree: /builds/slave/test/build 08:24:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:37 INFO - Running post-action listener: _resource_record_post_action 08:24:37 INFO - ##### 08:24:37 INFO - ##### Finished clobber step (success) 08:24:37 INFO - ##### 08:24:37 INFO - ##### 08:24:37 INFO - ##### Running read-buildbot-config step. 08:24:37 INFO - ##### 08:24:37 INFO - Running pre-action listener: _resource_record_pre_action 08:24:37 INFO - Running main action method: read_buildbot_config 08:24:37 INFO - Using buildbot properties: 08:24:37 INFO - { 08:24:37 INFO - "project": "", 08:24:37 INFO - "product": "firefox", 08:24:37 INFO - "script_repo_revision": "production", 08:24:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:24:37 INFO - "repository": "", 08:24:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:24:37 INFO - "buildid": "20160604053002", 08:24:37 INFO - "pgo_build": "True", 08:24:37 INFO - "basedir": "/builds/slave/test", 08:24:37 INFO - "buildnumber": 766, 08:24:37 INFO - "slavename": "talos-linux64-ix-039", 08:24:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:24:37 INFO - "platform": "ubuntu64_hw", 08:24:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:24:37 INFO - "branch": "fx-team", 08:24:37 INFO - "repo_path": "integration/fx-team", 08:24:37 INFO - "revision": "a58743e540f5894ce8d802784bbd16737f5ae2c3", 08:24:37 INFO - "stage_platform": "linux64-pgo", 08:24:37 INFO - "builduid": "6ac011f5931c45d6bddb84c72300e629", 08:24:37 INFO - "slavebuilddir": "test" 08:24:37 INFO - } 08:24:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:24:37 INFO - Running post-action listener: _resource_record_post_action 08:24:37 INFO - ##### 08:24:37 INFO - ##### Finished read-buildbot-config step (success) 08:24:37 INFO - ##### 08:24:37 INFO - ##### 08:24:37 INFO - ##### Running download-and-extract step. 08:24:37 INFO - ##### 08:24:37 INFO - Running pre-action listener: _resource_record_pre_action 08:24:37 INFO - Running main action method: download_and_extract 08:24:37 INFO - mkdir: /builds/slave/test/build/tests 08:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:37 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:24:43 INFO - Downloaded 1361 bytes. 08:24:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:43 INFO - Using the following test package requirements: 08:24:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:24:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:24:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'jsshell-linux-x86_64.zip'], 08:24:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:24:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:24:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:24:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:24:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:24:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:24: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')]} 08:24:43 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:24:49 INFO - Downloaded 24440907 bytes. 08:24:49 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'] 08:24:49 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 08:24:50 INFO - Return code: 0 08:24:50 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 08:24:50 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')]} 08:24:50 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:24:57 INFO - Downloaded 24440907 bytes. 08:24:57 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'] 08:24:57 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 08:24:59 INFO - Return code: 0 08:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:59 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:24:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:25:00 INFO - Downloaded 10833369 bytes. 08:25:00 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'] 08:25:00 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 08:25:00 INFO - Return code: 0 08:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:00 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:25:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:25:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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 08:25:01 INFO - Downloaded 59144481 bytes. 08:25:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:01 INFO - mkdir: /builds/slave/test/properties 08:25:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:25:01 INFO - Writing to file /builds/slave/test/properties/build_url 08:25:01 INFO - Contents: 08:25:01 INFO - build_url:https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:02 INFO - Running post-action listener: _resource_record_post_action 08:25:02 INFO - Running post-action listener: set_extra_try_arguments 08:25:02 INFO - ##### 08:25:02 INFO - ##### Finished download-and-extract step (success) 08:25:02 INFO - ##### 08:25:02 INFO - ##### 08:25:02 INFO - ##### Running populate-webroot step. 08:25:02 INFO - ##### 08:25:02 INFO - Running pre-action listener: _resource_record_pre_action 08:25:02 INFO - Running main action method: populate_webroot 08:25:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:25:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:25:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:25:02 INFO - '--tppagecycles', 08:25:02 INFO - '7'], 08:25:02 INFO - 'tests': ['tsvgm']}}, 08:25:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:25:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:25:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:25:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:25:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:02 INFO - 'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:02 INFO - 'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['damp', 'tps']}, 08:25:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:02 INFO - 'tests': ['damp', 'tps']}, 08:25:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['dromaeo_dom']}, 08:25:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:25:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['a11yr', 08:25:02 INFO - 'ts_paint', 08:25:02 INFO - 'tpaint', 08:25:02 INFO - 'sessionrestore', 08:25:02 INFO - 'sessionrestore_no_auto_restore', 08:25:02 INFO - 'tabpaint']}, 08:25:02 INFO - 'other-e10s': {'tests': ['a11yr', 08:25:02 INFO - 'ts_paint', 08:25:02 INFO - 'tpaint', 08:25:02 INFO - 'sessionrestore', 08:25:02 INFO - 'sessionrestore_no_auto_restore', 08:25:02 INFO - 'tabpaint']}, 08:25:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:25:02 INFO - 'ts_paint', 08:25:02 INFO - 'tpaint', 08:25:02 INFO - 'sessionrestore', 08:25:02 INFO - 'sessionrestore_no_auto_restore', 08:25:02 INFO - 'tabpaint']}, 08:25:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:25:02 INFO - 'ts_paint', 08:25:02 INFO - 'tpaint', 08:25:02 INFO - 'sessionrestore', 08:25:02 INFO - 'sessionrestore_no_auto_restore', 08:25:02 INFO - 'tabpaint']}, 08:25:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['a11yr', 08:25:02 INFO - 'ts_paint', 08:25:02 INFO - 'tpaint', 08:25:02 INFO - 'sessionrestore', 08:25:02 INFO - 'sessionrestore_no_auto_restore', 08:25:02 INFO - 'tabpaint']}, 08:25:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['a11yr', 08:25:02 INFO - 'ts_paint', 08:25:02 INFO - 'tpaint', 08:25:02 INFO - 'sessionrestore', 08:25:02 INFO - 'sessionrestore_no_auto_restore', 08:25:02 INFO - 'tabpaint']}, 08:25:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['tsvgx', 08:25:02 INFO - 'tsvgr_opacity', 08:25:02 INFO - 'tart', 08:25:02 INFO - 'tscrollx', 08:25:02 INFO - 'cart']}, 08:25:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:25:02 INFO - 'tsvgr_opacity', 08:25:02 INFO - 'tart', 08:25:02 INFO - 'tscrollx', 08:25:02 INFO - 'cart']}, 08:25:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:02 INFO - 'talos_options': ['--disable-e10s'], 08:25:02 INFO - 'tests': ['tp5o']}, 08:25:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:02 INFO - 'tests': ['tp5o']}, 08:25:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:02 INFO - 'talos_options': ['--disable-e10s', 08:25:02 INFO - '--xperf_path', 08:25:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:02 INFO - 'tests': ['tp5n']}, 08:25:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:02 INFO - 'talos_options': ['--xperf_path', 08:25:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:02 INFO - 'tests': ['tp5n']}}, 08:25:02 INFO - 'talos.zip': {'path': '', 08:25:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:25:02 INFO - Running post-action listener: _resource_record_post_action 08:25:02 INFO - ##### 08:25:02 INFO - ##### Finished populate-webroot step (success) 08:25:02 INFO - ##### 08:25:02 INFO - ##### 08:25:02 INFO - ##### Running create-virtualenv step. 08:25:02 INFO - ##### 08:25:02 INFO - Running pre-action listener: _resource_record_pre_action 08:25:02 INFO - Running main action method: create_virtualenv 08:25:02 INFO - Creating virtualenv /builds/slave/test/build/venv 08:25:02 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 08:25:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:25:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:25:02 INFO - Using real prefix '/usr' 08:25:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:25:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:25:05 INFO - Installing pip.................done. 08:25:05 INFO - Return code: 0 08:25:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:25:05 INFO - Using env: {'DISPLAY': ':0', 08:25:05 INFO - 'HOME': '/home/cltbld', 08:25:05 INFO - 'LANG': 'en_US.UTF-8', 08:25:05 INFO - 'LANGUAGE': 'en_US:en', 08:25:05 INFO - 'LOGNAME': 'cltbld', 08:25:05 INFO - 'MAIL': '/var/mail/cltbld', 08:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:05 INFO - 'MOZ_NO_REMOTE': '1', 08:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:05 INFO - 'NO_EM_RESTART': '1', 08:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:05 INFO - 'PWD': '/builds/slave/test', 08:25:05 INFO - 'SHELL': '/bin/bash', 08:25:05 INFO - 'SHLVL': '1', 08:25:05 INFO - 'TERM': 'linux', 08:25:05 INFO - 'TMOUT': '86400', 08:25:05 INFO - 'USER': 'cltbld', 08:25:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:05 INFO - '_': '/tools/buildbot/bin/python'} 08:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:05 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 08:25:05 INFO - Cleaning up... 08:25:05 INFO - Return code: 0 08:25:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:25:05 INFO - Using env: {'DISPLAY': ':0', 08:25:05 INFO - 'HOME': '/home/cltbld', 08:25:05 INFO - 'LANG': 'en_US.UTF-8', 08:25:05 INFO - 'LANGUAGE': 'en_US:en', 08:25:05 INFO - 'LOGNAME': 'cltbld', 08:25:05 INFO - 'MAIL': '/var/mail/cltbld', 08:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:05 INFO - 'MOZ_NO_REMOTE': '1', 08:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:05 INFO - 'NO_EM_RESTART': '1', 08:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:05 INFO - 'PWD': '/builds/slave/test', 08:25:05 INFO - 'SHELL': '/bin/bash', 08:25:05 INFO - 'SHLVL': '1', 08:25:05 INFO - 'TERM': 'linux', 08:25:05 INFO - 'TMOUT': '86400', 08:25:05 INFO - 'USER': 'cltbld', 08:25:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:05 INFO - '_': '/tools/buildbot/bin/python'} 08:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:05 INFO - Downloading/unpacking psutil>=3.1.1 08:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:25:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:07 INFO - Installing collected packages: psutil 08:25:07 INFO - Running setup.py install for psutil 08:25:07 INFO - building 'psutil._psutil_linux' extension 08:25:07 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 08:25:07 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 08:25:07 INFO - building 'psutil._psutil_posix' extension 08:25:07 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 08:25:08 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 08:25:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:08 INFO - Successfully installed psutil 08:25:08 INFO - Cleaning up... 08:25:08 INFO - Return code: 0 08:25:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:08 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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:08 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 08:25:08 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 08:25:08 INFO - Using env: {'DISPLAY': ':0', 08:25:08 INFO - 'HOME': '/home/cltbld', 08:25:08 INFO - 'LANG': 'en_US.UTF-8', 08:25:08 INFO - 'LANGUAGE': 'en_US:en', 08:25:08 INFO - 'LOGNAME': 'cltbld', 08:25:08 INFO - 'MAIL': '/var/mail/cltbld', 08:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:08 INFO - 'MOZ_NO_REMOTE': '1', 08:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:08 INFO - 'NO_EM_RESTART': '1', 08:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:08 INFO - 'PWD': '/builds/slave/test', 08:25:08 INFO - 'SHELL': '/bin/bash', 08:25:08 INFO - 'SHLVL': '1', 08:25:08 INFO - 'TERM': 'linux', 08:25:08 INFO - 'TMOUT': '86400', 08:25:08 INFO - 'USER': 'cltbld', 08:25:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:08 INFO - '_': '/tools/buildbot/bin/python'} 08:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:25:08 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 08:25:08 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 08:25:08 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 08:25:08 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 08:25:08 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 08:25:08 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 08:25:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:25:10 INFO - Installing collected packages: mozsystemmonitor 08:25:10 INFO - Running setup.py install for mozsystemmonitor 08:25:10 INFO - Successfully installed mozsystemmonitor 08:25:10 INFO - Cleaning up... 08:25:10 INFO - Return code: 0 08:25:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:25:10 INFO - Using env: {'DISPLAY': ':0', 08:25:10 INFO - 'HOME': '/home/cltbld', 08:25:10 INFO - 'LANG': 'en_US.UTF-8', 08:25:10 INFO - 'LANGUAGE': 'en_US:en', 08:25:10 INFO - 'LOGNAME': 'cltbld', 08:25:10 INFO - 'MAIL': '/var/mail/cltbld', 08:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:10 INFO - 'MOZ_NO_REMOTE': '1', 08:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:10 INFO - 'NO_EM_RESTART': '1', 08:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:10 INFO - 'PWD': '/builds/slave/test', 08:25:10 INFO - 'SHELL': '/bin/bash', 08:25:10 INFO - 'SHLVL': '1', 08:25:10 INFO - 'TERM': 'linux', 08:25:10 INFO - 'TMOUT': '86400', 08:25:10 INFO - 'USER': 'cltbld', 08:25:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:10 INFO - '_': '/tools/buildbot/bin/python'} 08:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:10 INFO - Downloading/unpacking jsonschema==2.5.1 08:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:12 INFO - warning: no files found matching '*.txt' 08:25:12 INFO - no previously-included directories found matching 'build' 08:25:12 INFO - no previously-included directories found matching 'dist' 08:25:12 INFO - no previously-included directories found matching '.git*' 08:25:12 INFO - Installing collected packages: jsonschema, functools32 08:25:12 INFO - Running setup.py install for functools32 08:25:12 INFO - warning: no files found matching '*.txt' 08:25:12 INFO - no previously-included directories found matching 'build' 08:25:12 INFO - no previously-included directories found matching 'dist' 08:25:12 INFO - no previously-included directories found matching '.git*' 08:25:13 INFO - Successfully installed jsonschema functools32 08:25:13 INFO - Cleaning up... 08:25:13 INFO - Return code: 0 08:25:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:13 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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:13 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 08:25:13 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 08:25:13 INFO - Using env: {'DISPLAY': ':0', 08:25:13 INFO - 'HOME': '/home/cltbld', 08:25:13 INFO - 'LANG': 'en_US.UTF-8', 08:25:13 INFO - 'LANGUAGE': 'en_US:en', 08:25:13 INFO - 'LOGNAME': 'cltbld', 08:25:13 INFO - 'MAIL': '/var/mail/cltbld', 08:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:13 INFO - 'MOZ_NO_REMOTE': '1', 08:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:13 INFO - 'NO_EM_RESTART': '1', 08:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:13 INFO - 'PWD': '/builds/slave/test', 08:25:13 INFO - 'SHELL': '/bin/bash', 08:25:13 INFO - 'SHLVL': '1', 08:25:13 INFO - 'TERM': 'linux', 08:25:13 INFO - 'TMOUT': '86400', 08:25:13 INFO - 'USER': 'cltbld', 08:25:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:13 INFO - '_': '/tools/buildbot/bin/python'} 08:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:25:13 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 08:25:13 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 08:25:13 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 08:25:13 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 08:25:13 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 08:25:13 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 08:25:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:16 INFO - Downloading docopt-0.6.1.tar.gz 08:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:16 INFO - Running setup.py install for blobuploader 08:25:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:16 INFO - Running setup.py install for requests 08:25:16 INFO - Running setup.py install for docopt 08:25:16 INFO - Successfully installed blobuploader requests docopt 08:25:16 INFO - Cleaning up... 08:25:16 INFO - Return code: 0 08:25:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:16 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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:16 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 08:25:16 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 08:25:16 INFO - Using env: {'DISPLAY': ':0', 08:25:16 INFO - 'HOME': '/home/cltbld', 08:25:16 INFO - 'LANG': 'en_US.UTF-8', 08:25:16 INFO - 'LANGUAGE': 'en_US:en', 08:25:16 INFO - 'LOGNAME': 'cltbld', 08:25:16 INFO - 'MAIL': '/var/mail/cltbld', 08:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:16 INFO - 'MOZ_NO_REMOTE': '1', 08:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:16 INFO - 'NO_EM_RESTART': '1', 08:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:16 INFO - 'PWD': '/builds/slave/test', 08:25:16 INFO - 'SHELL': '/bin/bash', 08:25:16 INFO - 'SHLVL': '1', 08:25:16 INFO - 'TERM': 'linux', 08:25:16 INFO - 'TMOUT': '86400', 08:25:16 INFO - 'USER': 'cltbld', 08:25:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:16 INFO - '_': '/tools/buildbot/bin/python'} 08:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:16 INFO - Running setup.py (path:/tmp/pip-ZUs4Rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:17 INFO - Running setup.py (path:/tmp/pip-5a3nkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:17 INFO - Running setup.py (path:/tmp/pip-m1G4au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:17 INFO - Running setup.py (path:/tmp/pip-BemZBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:17 INFO - Running setup.py (path:/tmp/pip-yOj3C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:17 INFO - Running setup.py (path:/tmp/pip-z7myWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:17 INFO - Running setup.py (path:/tmp/pip-XHeeuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:17 INFO - Running setup.py (path:/tmp/pip-QP0b17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:17 INFO - Running setup.py (path:/tmp/pip-lF47Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:17 INFO - Running setup.py (path:/tmp/pip-dYEGTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:17 INFO - Running setup.py (path:/tmp/pip-IIXawQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:17 INFO - Running setup.py (path:/tmp/pip-SWQtjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:17 INFO - Running setup.py (path:/tmp/pip-VpbjcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:17 INFO - Running setup.py (path:/tmp/pip-O9YubR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:17 INFO - Running setup.py (path:/tmp/pip-lny7fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:18 INFO - Running setup.py (path:/tmp/pip-cAho0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:18 INFO - Running setup.py (path:/tmp/pip-p2RPOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:25:18 INFO - Running setup.py install for manifestparser 08:25:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Running setup.py install for mozcrash 08:25:18 INFO - Running setup.py install for mozdebug 08:25:18 INFO - Running setup.py install for mozdevice 08:25:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Running setup.py install for mozfile 08:25:18 INFO - Running setup.py install for mozhttpd 08:25:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Running setup.py install for mozinfo 08:25:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Running setup.py install for mozInstall 08:25:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:25:18 INFO - Running setup.py install for mozleak 08:25:19 INFO - Running setup.py install for mozlog 08:25:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:25:19 INFO - Running setup.py install for moznetwork 08:25:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:25:19 INFO - Running setup.py install for mozprocess 08:25:19 INFO - Running setup.py install for mozprofile 08:25:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:19 INFO - Running setup.py install for mozrunner 08:25:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:19 INFO - Running setup.py install for mozscreenshot 08:25:19 INFO - Running setup.py install for moztest 08:25:19 INFO - Running setup.py install for mozversion 08:25:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:19 INFO - Cleaning up... 08:25:19 INFO - Return code: 0 08:25:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:19 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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:19 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 08:25:19 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 08:25:19 INFO - Using env: {'DISPLAY': ':0', 08:25:19 INFO - 'HOME': '/home/cltbld', 08:25:19 INFO - 'LANG': 'en_US.UTF-8', 08:25:19 INFO - 'LANGUAGE': 'en_US:en', 08:25:19 INFO - 'LOGNAME': 'cltbld', 08:25:19 INFO - 'MAIL': '/var/mail/cltbld', 08:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:19 INFO - 'MOZ_NO_REMOTE': '1', 08:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:19 INFO - 'NO_EM_RESTART': '1', 08:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:19 INFO - 'PWD': '/builds/slave/test', 08:25:19 INFO - 'SHELL': '/bin/bash', 08:25:19 INFO - 'SHLVL': '1', 08:25:19 INFO - 'TERM': 'linux', 08:25:19 INFO - 'TMOUT': '86400', 08:25:19 INFO - 'USER': 'cltbld', 08:25:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:19 INFO - '_': '/tools/buildbot/bin/python'} 08:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:20 INFO - Running setup.py (path:/tmp/pip-ljg8Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:20 INFO - Running setup.py (path:/tmp/pip-bNE65F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:20 INFO - Running setup.py (path:/tmp/pip-sVtk_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:20 INFO - Running setup.py (path:/tmp/pip-8liH63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:20 INFO - Running setup.py (path:/tmp/pip-ZZFmw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:20 INFO - Running setup.py (path:/tmp/pip-s0RBnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:20 INFO - Running setup.py (path:/tmp/pip-GbbGrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:20 INFO - Running setup.py (path:/tmp/pip-_MmiTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:20 INFO - Running setup.py (path:/tmp/pip-pLQfZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:20 INFO - Running setup.py (path:/tmp/pip-g87PwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:20 INFO - Running setup.py (path:/tmp/pip-SBYixE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:20 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)) 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:20 INFO - Running setup.py (path:/tmp/pip-mCqlJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:21 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)) 08:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:21 INFO - Running setup.py (path:/tmp/pip-wj1Xhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:21 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)) 08:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:21 INFO - Running setup.py (path:/tmp/pip-QunfFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:21 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)) 08:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:21 INFO - Running setup.py (path:/tmp/pip-DFNvRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:21 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)) 08:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:21 INFO - Running setup.py (path:/tmp/pip-ttVnkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:21 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)) 08:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:21 INFO - Running setup.py (path:/tmp/pip-aFLDXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:21 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)) 08:25:21 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)) 08:25:21 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)) 08:25:21 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)) 08:25:21 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)) 08:25:21 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)) 08:25:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:23 INFO - Downloading blessings-1.6.tar.gz 08:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:25:23 INFO - Installing collected packages: blessings 08:25:23 INFO - Running setup.py install for blessings 08:25:23 INFO - Successfully installed blessings 08:25:23 INFO - Cleaning up... 08:25:23 INFO - Return code: 0 08:25:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:25:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:23 INFO - Reading from file tmpfile_stdout 08:25:23 INFO - Current package versions: 08:25:23 INFO - argparse == 1.2.1 08:25:23 INFO - blessings == 1.6 08:25:23 INFO - blobuploader == 1.2.4 08:25:23 INFO - docopt == 0.6.1 08:25:23 INFO - functools32 == 3.2.3-2 08:25:23 INFO - jsonschema == 2.5.1 08:25:23 INFO - manifestparser == 1.1 08:25:23 INFO - mozInstall == 1.12 08:25:23 INFO - mozcrash == 0.17 08:25:23 INFO - mozdebug == 0.1 08:25:23 INFO - mozdevice == 0.48 08:25:23 INFO - mozfile == 1.2 08:25:23 INFO - mozhttpd == 0.7 08:25:23 INFO - mozinfo == 0.9 08:25:23 INFO - mozleak == 0.1 08:25:23 INFO - mozlog == 3.2 08:25:23 INFO - moznetwork == 0.27 08:25:23 INFO - mozprocess == 0.22 08:25:23 INFO - mozprofile == 0.28 08:25:23 INFO - mozrunner == 6.11 08:25:23 INFO - mozscreenshot == 0.1 08:25:23 INFO - mozsystemmonitor == 0.3 08:25:23 INFO - moztest == 0.7 08:25:23 INFO - mozversion == 1.4 08:25:23 INFO - psutil == 3.1.1 08:25:23 INFO - requests == 1.2.3 08:25:23 INFO - wsgiref == 0.1.2 08:25:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:23 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')]} 08:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:23 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')]} 08:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:23 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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:23 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 08:25:23 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 08:25:23 INFO - Using env: {'DISPLAY': ':0', 08:25:23 INFO - 'HOME': '/home/cltbld', 08:25:23 INFO - 'LANG': 'en_US.UTF-8', 08:25:23 INFO - 'LANGUAGE': 'en_US:en', 08:25:23 INFO - 'LOGNAME': 'cltbld', 08:25:23 INFO - 'MAIL': '/var/mail/cltbld', 08:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:23 INFO - 'MOZ_NO_REMOTE': '1', 08:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:23 INFO - 'NO_EM_RESTART': '1', 08:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:23 INFO - 'PWD': '/builds/slave/test', 08:25:23 INFO - 'SHELL': '/bin/bash', 08:25:23 INFO - 'SHLVL': '1', 08:25:23 INFO - 'TERM': 'linux', 08:25:23 INFO - 'TMOUT': '86400', 08:25:23 INFO - 'USER': 'cltbld', 08:25:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:23 INFO - '_': '/tools/buildbot/bin/python'} 08:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 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)) 08:25:23 INFO - Cleaning up... 08:25:23 INFO - Return code: 0 08:25:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:25:23 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')]} 08:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:23 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')]} 08:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:23 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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:23 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 08:25:23 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 08:25:23 INFO - Using env: {'DISPLAY': ':0', 08:25:23 INFO - 'HOME': '/home/cltbld', 08:25:23 INFO - 'LANG': 'en_US.UTF-8', 08:25:23 INFO - 'LANGUAGE': 'en_US:en', 08:25:23 INFO - 'LOGNAME': 'cltbld', 08:25:23 INFO - 'MAIL': '/var/mail/cltbld', 08:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:23 INFO - 'MOZ_NO_REMOTE': '1', 08:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:23 INFO - 'NO_EM_RESTART': '1', 08:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:23 INFO - 'PWD': '/builds/slave/test', 08:25:23 INFO - 'SHELL': '/bin/bash', 08:25:23 INFO - 'SHLVL': '1', 08:25:23 INFO - 'TERM': 'linux', 08:25:23 INFO - 'TMOUT': '86400', 08:25:23 INFO - 'USER': 'cltbld', 08:25:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:23 INFO - '_': '/tools/buildbot/bin/python'} 08:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:25:24 INFO - Cleaning up... 08:25:24 INFO - Return code: 0 08:25:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:25:24 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')]} 08:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:24 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')]} 08:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:24 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 0x7fdaba7abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1808350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, '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': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', '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 08:25:24 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 08:25:24 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 08:25:24 INFO - Using env: {'DISPLAY': ':0', 08:25:24 INFO - 'HOME': '/home/cltbld', 08:25:24 INFO - 'LANG': 'en_US.UTF-8', 08:25:24 INFO - 'LANGUAGE': 'en_US:en', 08:25:24 INFO - 'LOGNAME': 'cltbld', 08:25:24 INFO - 'MAIL': '/var/mail/cltbld', 08:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:24 INFO - 'MOZ_NO_REMOTE': '1', 08:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:24 INFO - 'NO_EM_RESTART': '1', 08:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:24 INFO - 'PWD': '/builds/slave/test', 08:25:24 INFO - 'SHELL': '/bin/bash', 08:25:24 INFO - 'SHLVL': '1', 08:25:24 INFO - 'TERM': 'linux', 08:25:24 INFO - 'TMOUT': '86400', 08:25:24 INFO - 'USER': 'cltbld', 08:25:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:24 INFO - '_': '/tools/buildbot/bin/python'} 08:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:24 INFO - Downloading/unpacking flake8 08:25:24 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 08:25:24 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 08:25:24 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 08:25:24 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 08:25:24 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 08:25:24 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 08:25:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:25:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:25:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 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 08:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:25:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:25:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:25:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:25:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:25:26 INFO - no previously-included directories found matching 'docs/_build' 08:25:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:25:27 INFO - Running setup.py install for pep8 08:25:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:25:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:25:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:25:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:25:27 INFO - no previously-included directories found matching 'docs/_build' 08:25:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:25:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:25:27 INFO - Cleaning up... 08:25:27 INFO - Return code: 0 08:25:27 INFO - Running post-action listener: _resource_record_post_action 08:25:27 INFO - Running post-action listener: _start_resource_monitoring 08:25:27 INFO - Starting resource monitoring. 08:25:27 INFO - ##### 08:25:27 INFO - ##### Finished create-virtualenv step (success) 08:25:27 INFO - ##### 08:25:27 INFO - ##### 08:25:27 INFO - ##### Running install step. 08:25:27 INFO - ##### 08:25:27 INFO - Running pre-action listener: _resource_record_pre_action 08:25:27 INFO - Running main action method: install 08:25:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:27 INFO - Reading from file tmpfile_stdout 08:25:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:25:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:25:27 INFO - Reading from file tmpfile_stdout 08:25:27 INFO - Output received: 08:25:27 INFO - Usage: mozinstall [options] installer 08:25:27 INFO - Options: 08:25:27 INFO - -h, --help show this help message and exit 08:25:27 INFO - -d DEST, --destination=DEST 08:25:27 INFO - Directory to install application into. [default: 08:25:27 INFO - "/builds/slave/test"] 08:25:27 INFO - --app=APP Application being installed. [default: firefox] 08:25:27 INFO - mkdir: /builds/slave/test/build/application 08:25:27 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'] 08:25:27 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 08:25:44 INFO - Reading from file tmpfile_stdout 08:25:44 INFO - Output received: 08:25:44 INFO - /builds/slave/test/build/application/firefox/firefox 08:25:44 INFO - Running post-action listener: _resource_record_post_action 08:25:44 INFO - ##### 08:25:44 INFO - ##### Finished install step (success) 08:25:44 INFO - ##### 08:25:44 INFO - ##### 08:25:44 INFO - ##### Running run-tests step. 08:25:44 INFO - ##### 08:25:44 INFO - Running pre-action listener: _resource_record_pre_action 08:25:44 INFO - Running main action method: run_tests 08:25:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:44 INFO - Python 2.7.3 08:25:44 INFO - Return code: 0 08:25:44 INFO - grabbing minidump binary from tooltool 08:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:44 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 0x18971c0>, '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 0x18980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1898550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25:44 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 08:25:44 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 08:25:44 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 08:25:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:44 INFO - Return code: 0 08:25:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:25:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:25:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:25:45 INFO - Return code: 0 08:25:45 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/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 08:25:45 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/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 08:25:45 INFO - Using env: {'DISPLAY': ':0', 08:25:45 INFO - 'HOME': '/home/cltbld', 08:25:45 INFO - 'LANG': 'en_US.UTF-8', 08:25:45 INFO - 'LANGUAGE': 'en_US:en', 08:25:45 INFO - 'LOGNAME': 'cltbld', 08:25:45 INFO - 'MAIL': '/var/mail/cltbld', 08:25:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:45 INFO - 'MOZ_NO_REMOTE': '1', 08:25:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:45 INFO - 'NO_EM_RESTART': '1', 08:25:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:45 INFO - 'PWD': '/builds/slave/test', 08:25:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:45 INFO - 'SHELL': '/bin/bash', 08:25:45 INFO - 'SHLVL': '1', 08:25:45 INFO - 'TERM': 'linux', 08:25:45 INFO - 'TMOUT': '86400', 08:25:45 INFO - 'USER': 'cltbld', 08:25:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252', 08:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:45 INFO - '_': '/tools/buildbot/bin/python'} 08:25:45 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/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 08:25:45 INFO - mozversion application_buildid: 20160604053002 08:25:45 INFO - mozversion application_changeset: a58743e540f5894ce8d802784bbd16737f5ae2c3 08:25:45 INFO - mozversion application_display_name: Nightly 08:25:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:45 INFO - mozversion application_name: Firefox 08:25:45 INFO - mozversion application_remotingname: firefox 08:25:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:25:45 INFO - mozversion application_vendor: Mozilla 08:25:45 INFO - mozversion application_version: 49.0a1 08:25:45 INFO - mozversion platform_buildid: 20160604053002 08:25:45 INFO - mozversion platform_changeset: a58743e540f5894ce8d802784bbd16737f5ae2c3 08:25:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:25:45 INFO - mozversion platform_version: 49.0a1 08:25:45 INFO - using testdate: 1465053945 08:25:45 INFO - actual date: 1465053945 08:25:45 INFO - starting webserver on 'localhost:50328' 08:25:45 INFO - SUITE-START | Running 2 tests 08:25:45 INFO - TEST-START | dromaeo_css 08:25:45 INFO - operating with platform_type : linux_ 08:25:45 INFO - Initialising browser for dromaeo_css test... 08:25:45 INFO - TEST-INFO | started process 11856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW7LmTl/profile http://localhost:50328/getInfo.html) 08:25:49 INFO - PROCESS | 11856 | __metrics Screen width/height:1600/1200 08:25:49 INFO - PROCESS | 11856 | colorDepth:24 08:25:49 INFO - PROCESS | 11856 | Browser inner width/height: 1024/697 08:25:49 INFO - PROCESS | 11856 | __metrics 08:25:50 ERROR - PROCESS | 11856 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:25:51 INFO - TEST-INFO | 11856: exit 0 08:25:51 INFO - Browser initialized. 08:25:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:52 INFO - TEST-INFO | started process 11939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW7LmTl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:03 INFO - PROCESS | 11939 | RSS: Main: 156798976 08:26:03 INFO - PROCESS | 11939 | 08:26:54 INFO - PROCESS | 11939 | 1465054014927 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] 08:29:02 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:50328/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50328/tests/dromaeo/cssquery-ext.html) 08:29:03 INFO - PROCESS | 11939 | RSS: Main: 259346432 08:29:03 INFO - PROCESS | 11939 | 08:32:06 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:50328/tests/dromaeo/cssquery-ext.html (next: http://localhost:50328/tests/dromaeo/cssquery-jquery.html) 08:32:06 INFO - PROCESS | 11939 | RSS: Main: 239505408 08:32:06 INFO - PROCESS | 11939 | 08:35:08 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:50328/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50328/tests/dromaeo/cssquery-mootools.html) 08:35:09 INFO - PROCESS | 11939 | RSS: Main: 242417664 08:35:09 INFO - PROCESS | 11939 | 08:38:11 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:50328/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50328/tests/dromaeo/cssquery-prototype.html) 08:38:11 INFO - PROCESS | 11939 | RSS: Main: 245313536 08:38:11 INFO - PROCESS | 11939 | 08:41:14 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:50328/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50328/tests/dromaeo/cssquery-yui.html) 08:41:15 INFO - PROCESS | 11939 | RSS: Main: 218247168 08:41:15 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:50328/tests/dromaeo/cssquery-yui.html (next: http://localhost:50328/tests/dromaeo/cssquery-dojo.html) 08:44:17 INFO - PROCESS | 11939 | RSS: Main: 272097280 08:44:17 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | __start_tp_report 08:44:17 INFO - PROCESS | 11939 | _x_x_mozilla_page_load 08:44:17 INFO - PROCESS | 11939 | _x_x_mozilla_page_load_details 08:44:17 INFO - PROCESS | 11939 | |i|pagename|runs| 08:44:17 INFO - PROCESS | 11939 | |0;dojo.html;3092.8453577321134;3102.5811515445407;3121.3445176512932;3146.323540438805;3162.1304141361124;5340;5386.407495175533;5410.323709536308;5441.727913604319;5444.673319600822;5393.973030134854;5416.268803711498;5474.206240095194;5516.200150978106;5528.861778455531;4921.237208232721;4961.652684312099;4974.179260422026;5003.674761140533;5081.364829396325;5004.149294619905;5017.774200161001;5059.721715305675;5067.569256613192;5078.59371250301;4802.9039419211595;4923.359963204778;4935.210366341368;4942.555170034678;4991.625628077891;4924.162892308316;4958.578520825734;5022.17134172861;5024.648274620778;5070.2141168119;4877.6341774367065;4984.0281145176705;4988.5260900214425;5006.4492905780335;5018.64869459138;5352.759125839347;5440.6735595863975;5443.183522471661;5511.145772405283;5513.7794488220825;5930.97034514829;5940.138679891435;5962.522998160137;5969.552283578705;5978.2228310319815;5758.481736643722;5785.2189954356045;5970.791022314198;6013.579049466539;6022.337542870281;5449.04641687707;5468.398476167618;5516.338039435253;5519.061759500894;5522.199281104257;6053.636781793107;6060.969695151496;6064.272287325549;6068.180795592539;6069.726862291208;5623.803166889139;5705.486506214461;5756.94243057564;5805.82582522525;5821.039528477839;5879.823605291848;5904.970475147683;5919.082542205965;5919.437653422918;5923.644581325134;5852.092925596539;5864.824055278348;5874.060150375919;5878.882422351529;5887.705614719247;5736.598438109292;5764.221830052973;5791.102379131242;5837.09525023622;5898.941010589925;4440.666949978765;4440.822367105279;4441.156180325728;4444.799984000728;4481.126180394792;3941.1526521797377;3956;3963.742356746802;3978.2839088963688;3995.400689896481;5374.731263436891;5432.511074003359;5436.728163591804;5480.068388373986;5504.366997795225;5906.379830117861;5908.261467316585;5938.2280303560265;5945.286565612154;6001.63990160583;5541.307336582927;5547.223388725582;5547.362053363915;5547.5007249346945;5558.805441809598;4889.364382630235;4996.150654388763;5078.314427552233;5085.847424577269;5107.157319042316;6140.754369825247;6142.416470435302;6151.138840562325;6153.630782152995;6156.630602163885;5784.913226301693;5945.643261404416;5955.970220148872;5956.285245770535;5957.987142185925;6030.336662966983;6086.939130608637;6092.603980741238;6141.048137538689;6151.96924015377;5799.246098007401;5841.707914604168;5845.561582881216;5848.356680765028;5849.53203743708;5568;5816.651000939957;5952.76188952437;5960.4635582797755;5966.701664916824;5733.340665823317;5777.04678728022;5777.306723193244;5782.959067367914;5852.092925596539;5734.05388110957;5768.1347797828985;5768.990426675231;5771.769129234784;5787.623804452697;5448.645838020516;5553.250311208097;5620.606557540933;5647.88704225905;5651.6043876928225;5821.738021788945;5866.149408335853;5867.061270196748;5867.501262392744;5868.853278668067;5619.634723742944;5656.236408084856;5662.886742265214;5695.658260504218;5708.429157084258 08:44:17 INFO - PROCESS | 11939 | |1;ext.html;580.8838232353528;621.2172662445319;626.8370223741831;641.2081079866363;646.0051520658186;33003.83498082512;36337.636623633756;36396.636033639654;36410.27179456413;43346.34980475296;44381.778091109496;44857.7757111214;44876.77561612196;44894;44923;8731.86902196466;8918.598663060146;8922.01857795642;8922.553872306391;8928.330375221853;8816.250618697419;8982.640694372218;8985.37102402832;8987.910120898772;8995;9016.909830901672;9066.773330666752;9071.773205669844;9073.319501037415;9085.454872707625;8933;8963.596638151299;8989.05614910438;8991.325650576167;8992;8762.824743505158;8852.645894164225;8859.379843410963;8864.0692727264;8868.423552469134;42435.363469547985;42610.78694606507;42640.57359426397;43105.784471077444;43141;3527.8236088195486;3677.485152078711;4248.34150706641;4282.186384586918;4340.131973605292;32722.181945451317;32979.186144762025;33143.6685633143;33325.50011749825;33648.83175584131;4045.3325201341745;4047.494063242095;4056;4063.634272915422;4076.735012224196;345334.9999999975;347860;348177;349407;350251;58618;59749.80500389968;59855.401445984986;59954;59956.100658490155;35986.28027439437;36736.448953265724;36751.81624091916;38397.232055358734;62323.688381558706;17321.4803555891;17394.739078913826;17458.388956386465;17481.56296092608;17499.12504374776;12860.742785144244;12920.289384083777;12927.095103342675;12929.612111636477;12933;19972.60054798925;20144.294949676692;20245.493862653257;20253.797462025486;20321.59356812885;7500.58746768922;7542.396608271325;7561.7731468056045;7582.128055273603;7583.734569290048;954.7899462118323;997.5211898288862;1088.6679562733284;1111.222144498854;1149.5918948773065;31825.363492730015;32851.50722739161;33223.83388083044;33266;33594.496082558784;1162.2213117211488;1167.3831743035787;1194.2834299420451;1195.121585634558;1268.5369840008516;16769.161541922855;17403.91298043527;17488.5627859302;17535.473935781945;17798.733019004725;542195;588371;597009;597848;838602;61350.38649613536;61876;62240;62265;62393.68803156046;1281.6859869332072;1380.7859781734048;1402.3198748606917;1410.612081677547;1432.0691550492263;32382;34310.65689343175;34437.827810860785;34584;34609.826950865085;51594.22608660948;51662.483375165764;52317.73841130922;52358;52515;426536;428724;428909;429524;429923;25291.114810981526;28780.712192877803;29247;29899.402011959202;29982.850085749433;48204;48211.6967133622;48281;48438;48984.26523602077;40377;40726.38910416287;41244.38133427941;41564.58435415607;41883.696396697254;40307.59692403038;40834.38748418835;41132.1773564533;41708.1658366837;41917.79041104775;40829.38755918723;41501.58498414977;42005.78997105117;42033.15933681248;42245.788771055944;35530;36524;37004.81497592603;37015.81492092522;37783;28372.716272837006;28690.282742931595;28731.5690264642;28837.711622883504;28879.7112028877 08:44:17 INFO - PROCESS | 11939 | |2;jquery.html;398.43422340276805;403.4513062235361;411.0648275173979;412.2723393210985;425.6956276262472;17685.29258829647;18256.452306430794;19277.325293614726;19278.90360548197;19292.61414771704;17846;18136;18342.81657183428;19233.519162020955;19260.807391926075;5292.655977361478;5591.524720398771;5605.5515558755205;5665.291838520196;5805.680687562203;5584.078627026536;5585.190147428621;5586.832395028136;5622.381538030813;6249.062640603923;6343.968280158593;6367.267764207106;6392.968035159841;6396.2324521057535;6398.616083035009;5321.175217841241;5578.470045345685;5628.26832511775;6351.301356850743;6351.809445716636;5299.814506492293;5453.100238460649;5552.944470555283;5561.082421400504;5589.580781441367;13609.863901361057;13974.091684040606;14097.78853317201;14225.359858806378;14237.501687440994;2233.2630232023557;2287.97712022881;2314.5370925814905;2360.067773229565;2360.197532838843;10287.845682314772;10357.844632330522;13429.798553021712;13981.930090349584;14410.855891441057;1895.4313705888178;1960.44127423685;1993.6909778984282;2014.617222727677;2030.198071761646;57783.422165778225;61375.69312153411;70920.2907970924;78379;81191.59404203;10832.512536935857;10960.12319014477;11226.494807733508;11240.325580465198;11280;13821.930890345484;14430.350634221486;15439.30523126462;15653;15671.608209794618;8233.300169485541;8334.583270836434;8408;8507.787305317417;8518.361122915807;7998.84002319962;8120.512769233865;8160.143184965612;8289.129641387688;8305;4719.433667959866;4863.975680121647;4880.097182021337;4907.803687852446;4931.2849636803185;1904.980950190508;1944.1542928825722;2019.2831544801677;2034.4201902458024;2053.3531937439657;921.5484412637759;1017.867677201959;1079.6221322537206;1093.4423444043596;1112.8942750438696;18513.44459666212;18558.72161917572;18832.90583547101;19226;19821.30625428103;986.1371300112402;1025.7845852370936;1028.3315844701003;1033.01347213411;1053.3153450257394;10672.30630009047;11017;11067.225294229487;11086.445677716081;11125.276857004268;227801.860990694;229625;230224;471621;476635;89326;92750.53624731833;93287.73834878158;100979.45592448357;103128;1012.3925644613321;1051.984220236697;1069.561479793281;1071.1805468816362;1071.3732466507024;13212.537561185312;16402.67194656124;16692.58268543296;17100.315987360365;17683.911580442014;40214;41343.105982582136;41692;42134.15731685288;42288.365674514294;53248.73375633097;55240.44759552353;55245;55270.44729552653;55561.444385557246;8657.264132548804;8672.609732562176;8773.649054037767;8947.552622368985;9028.322875784212;8231.46495477792;10980.890191097988;12086.972607328476;13432.731345373233;13469;11483.712907177387;11746.353950532803;11814.291142531476;11932.940335298268;12199.573014944433;6099.841030204425;10938.398388088732;11668;11708.531658733555;11734.530618775494;11568.768624627292;12113.212641178296;12201.938990304992;12407.379631018232;12488.56290029881;8620.267277281502;8629.784255393666;8729.694460693845;8820.427726770668;9004.684836030707;8690.695825646326;11017.614383496539;11656.18406711522;11780.410979450822;11826.546632484693 08:44:17 INFO - PROCESS | 11939 | |3;mootools.html;1401.9018668693195;1498.4530646314095;1539.3842463014796;1686.131642204265;1839.9908000460005;7497.625118744061;8627.741167764969;8949.776255593597;8976.506292153937;9202.539873006357;8861.689840855572;9032.8645070324;9037.231835293991;9054;9072.09279072094;2340.297910626818;2360.280114565057;2364.6334818103137;2364.869932153731;2365.38499990003;2336.380859072347;2365.9881700591473;2369.312899259213;2369.857808531485;2374.3351861478814;2364.609839376501;2365.4914193448403;2380.1074597026113;2411.2284069097896;2411.252511721363;2309.6997390339234;2311.3412677386864;2341.1571834139695;2341.590221711194;2360.704911886014;2241.3442106883567;2278.863268203913;2308.2613563659634;2313.3753886450563;2317.1079134533325;7841.647125879349;8074.152214017561;9059.50172740499;9137.588808503633;9137.81724365509;4803.879903002418;4931.284963680247;5099.33708617881;5276.34045744282;5277.445868183862;3327.8169700666454;3358.261182539837;3410.744194185446;3431.742619303562;3522.489239060322;1151.205668089016;1158.0966845860241;1159.3044173495919;1179.7463545337707;1197.8921897029222;12483.438245278985;12629.74740505194;12639.620811375673;12658.177218480769;12663.556775512812;4686.109639168547;4736.8578942631775;4844.249141383091;4861.222204447272;4868.148074087091;10664.466776661136;10692.946535267274;10694.679159625224;10702.25084244111;10706.946465267623;5418.133098704188;5419.810306639249;5420.728963551806;5421.454885357654;5422.783088676409;4881.731504767201;4894.583960363338;4955.677880937727;5042.84871453857;5045.2432135180015;3763.6989040876665;3840.078381188495;3844.38489841624;3870.8645197417954;3897.902552436155;1252.5616034388074;1276.5978716704208;1281.7116148866617;1287.6072797796762;1290.451558087809;836.5315423362814;974.3569244298728;1023.744063984004;1028.0857501144542;1042.2339580408393;6247.406496382836;6294.276158241769;6296.5592408531875;6405.679716014274;6452.774152904626;452.5067676232856;467.67029244382627;981.7741919358588;1059.1632610237825;1086.750047489082;4336.869893903125;4359.738415695005;4370;4392.846250381222;4407.977960110243;9585.376950498196;10535.789284214272;11154.163437742201;11167;11467.369294688706;11001.834972475419;11317.49071291794;11356.829647555292;11413.771724565462;11453;8259.38054645904;8497.532635704973;8562.957185214034;8576.699815506427;8577.742667719978;6337;6358.968205158944;6476.514261430318;6491.837704057436;6543.312952140147;10209.591616335263;10456;10467.581296748045;10568.524416401127;10604.098651614699;10529.631462898762;10561.89438105609;10596.099331556905;10767.246292759744;10774.784504310026;7084.822879428056;7090.7518236863525;7146.857062858609;7153.785386438415;7195.100612423447;8009;8262.091169971178;8300.584970751559;8318;8318.500889946623;7415.332620064004;7420.072490938633;7449.366803821519;7451.552906825608;7590.20302868213;7513.023306970059;7537.849243015218;7541.2458754124145;7558.811029724081;7626.161122276656;6792.66036698173;6857.485688573277;6858.4856135791015;6873.450123990169;6875.5530890491955;4990.426100998432;5070.847874563769;5113.846584602468;5172.818951336685;5239.842804715865;5288.65623734456;5353.304070470814;5363.19552067193;5404.78380864761;5407.351117865881 08:44:17 INFO - PROCESS | 11939 | |4;prototype.html;330.2088282866096;334.7338865601846;340.84321212242367;341.78125999360395;343.51049754100416;5285.26006359109;5381.0852155133625;5404.621676482648;5405.486478784519;5467.261919640848;5265.736713164336;5290.312259406282;5306.283651707018;5308.256844041837;5310.6017048721305;3985.581513941038;4195.790210489478;4202.306619407809;4215.747055176699;4269.573042695737;4034.334334834749;4175.853845115422;4182.414461975326;4185.514142479422;4198.6641068714425;4114.218298523286;4119.670426365884;4136.689748268876;4138.979305103485;4154.875353739378;4046.9190616187807;4139.668826493873;4172.415861779354;4186.832526698929;4193.412922190896;3648.6898613617873;3667.468217108531;3723.2739615774663;3725.254949010182;3737.2712321097397;5062.696238225718;5125.256837758504;5129.9227162295965;5143.485651434864;5143.588512918957;4620.168369693454;4742.1227072991605;4779.163646361872;4790.209615413488;4793.616510679138;5493.642913210669;5516.586256030814;5525.11598144299;5542.644376140124;5572.247746554204;4077.6330130288416;4086.366613174963;4089.8159582818844;4093;4110.794460276974;5541.6977010402525;5765.828794163235;5810.605454690886;5824.359320474744;5841.182234487175;4154.626083652486;4187.309093999517;4192.538820729717;4206.242876282237;4222.150048717103;4235.53409124996;4251.278232315917;4262.914741705211;4265.722728022669;4274.7435153890865;4642.582167604932;4821.349117869043;4821.975890120527;4823.27650852368;4837.56461918422;5592.860178495489;5593.552515798727;5593.552515798727;5600.943990560124;5625.887482250414;1454.8836093112525;1474.6018574984694;1475.7417451945867;1479.3416929466284;1479.7114562660179;926.8795056642729;957.6504575829772;963.9710808675751;966.9371490853072;978.3836183204678;4823.300621409946;5141.537261646395;5288.36539615241;5401.405845357008;5453.936482385976;5752.626079304831;5763;5772.181762744722;5773.509251713567;5800.767969281266;5131.230315452712;5388.91916621251;5399.865003374868;5469.863253418617;5470.261514695545;3027.349119939224;3042.4675681755602;3048.810963724149;3063.509838425886;3068.769842261839;5810.82567522975;5869.618474799125;5951.940480595139;5972.193753843176;5997.250343707036;5719.256496655408;5819.912701309484;5827.621204621686;5842.795502157489;5893.233879595625;5832.708364581754;5917.733701983421;5935.52515798735;5947.286325640951;5961;5449.34607847045;5729.427057294237;5751.884962300815;5791;5810.099434587646;5714.857128571819;5726.570507211893;5730.395489263013;5742.684152371659;5755.539556835527;5919.792807251725;5924.170616113662;5966.134910438049;5981.371955944737;6048.975512243878;3959;4091.1613119309873;4102.323116685713;4134.441850350164;4155.41824144626;5701.401352858056;5742.765305459347;5748.712564371848;5778.884422311614;5793.304803423616;5611.410801865745;5612.158176273591;5650.434956504317;5672.347680016851;5715.342735585295;5488.286522752017;5569.443055694398;5583.330000399978;5583.497485226349;5620.185073164286;5460.781568737365;5471.644343117685;5476.479734425223;5477.589180811376;5492.231087647812;5399.78400863961;5455.790404886027;5657.575681823797;5668.829935101953;5671.858203544779;5511.173324001272;5538.224648549287;5582.906410096214;5597.580181486486;5627.662340259434 08:44:17 INFO - PROCESS | 11939 | |5;yui.html;791.7387262203473;806.5080301016379;829.0631586307471;832.5417389877211;841.1000229754166;13347.466101355947;13909.860901390983;13949.302534873254;13983.650408739773;14183.361748721307;13951.720965580682;14141.434342626308;14156.929215353935;14220.431182752678;14223.502177423792;645.7384759172543;772.5750837039634;782.4444644302552;794.8847417124542;795.0538858758089;784.8861915022318;792.4888446951712;794.4319811334894;794.5232860283842;794.9205079492034;832.6045128563914;833.754042557444;834.7245409015011;835.2148979958819;835.9958200209021;691.8339598496375;820.110180454205;832.9625166867505;846.3652260804397;846.5386364431338;593.1873333533044;598.8023952095798;599.1372423709887;599.8170557979814;604.8457643300974;15048.097114173184;15093.47172848956;15103.169325687082;15115.697686046327;15117.470888518848;14428.350724217435;14749.852501474956;15092.924535377362;15763.684726305524;16008.439704610399;11540.769184616345;11719.765604687858;11729.296242225493;11783.764324713458;11971.700707482296;3895.2599006188734;3971.7815520146382;4013.97993010036;4015.0966032642714;4077.612626800449;72643.27356726471;75668.62165689192;75834;77503.22496775017;78071.60964195199;11840.70398240051;11921.940390297994;11972.880271197351;12016.09879259059;12051.638450846489;22811.657825132635;22824.31527054191;22916.541669166523;22926.19758308451;22958.540829183323;7859.371250299962;8054.073781515201;8090.595470226465;8143.389245806469;8202.343812494986;4495.213337665896;4688.531146885284;4778.689385189951;4917.754112294371;4991.401031876198;3547.5742910850863;3666.578343490533;3689.815509224528;3690.7231957603285;3695.297893400299;637.0985056145595;641.6086187425667;643.4048505132733;661.3716968879584;662.5991275278484;744.3747252308087;749.6102026946066;768.036114676078;770.7302444144617;776.3129630277133;10428.113610343054;10738.409387483764;10826.945865270623;10872.456377181268;10973.122150227962;621.7637297826797;653.4217217762315;743.5092838726523;747.5103807006419;756.7229828572008;4777.737224452689;5100.515451032146;5111.87220319495;5178.559822415062;5218.556422704112;93079;104973;107618;110122;110269;89461;92355.53822230846;94420;94465;95156;83302.16697833066;84097;84172.15827841766;84395.99999999878;84937.15062849416;9676.75808104803;9738.640169141634;9865.309428339948;9889.406635601887;9907.851382229128;44329.55670443254;45297.77351113223;47068.7646561765;47607.76196118997;50492.24261636005;49042;49567;51663.48336516587;55724.442755573546;61484.385156147866;11315.20793544444;11394.25937314072;11639.825402618799;12757.744845103232;13817.516386926409;14625.92687036558;14687.853121469076;14878.553643390716;15012.47456339023;15834.524964251092;13602.523911663044;14270.215138167501;14431.278436078364;14778.926105369404;14922.850771492145;13210.339483025618;13226.867731322563;13352.332383380597;13360.93319533396;14012.859871401155;13687.178769273478;13747.773388132242;13965.231912244924;14412.126423564869;14650.267486625413;11248.662540123809;11497.152921038727;11559.595414160463;11711.1802173847;12172.75654486923;11476.368799716096;11592.6522204334;11690.240134391237;11733.76532469363;12109.91197244697 08:44:17 INFO - PROCESS | 11939 | __end_tp_report 08:44:17 INFO - PROCESS | 11939 | __start_cc_report 08:44:17 INFO - PROCESS | 11939 | _x_x_mozilla_cycle_collect,871 08:44:17 INFO - PROCESS | 11939 | __end_cc_report 08:44:17 INFO - PROCESS | 11939 | __startTimestamp1465055057941__endTimestamp 08:44:17 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | ------- Summary: start ------- 08:44:17 INFO - PROCESS | 11939 | Number of tests: 6 08:44:17 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | [#0] dojo.html Cycles:165 Average:5455.55 Median:5651.60 stddev:642.70 (11.4%) stddev-sans-first:617.37 08:44:17 INFO - PROCESS | 11939 | Values: 3092.8 3102.6 3121.3 3146.3 3162.1 5340.0 5386.4 5410.3 5441.7 5444.7 5394.0 5416.3 5474.2 5516.2 5528.9 4921.2 4961.7 4974.2 5003.7 5081.4 5004.1 5017.8 5059.7 5067.6 5078.6 4802.9 4923.4 4935.2 4942.6 4991.6 4924.2 4958.6 5022.2 5024.6 5070.2 4877.6 4984.0 4988.5 5006.4 5018.6 5352.8 5440.7 5443.2 5511.1 5513.8 5931.0 5940.1 5962.5 5969.6 5978.2 5758.5 5785.2 5970.8 6013.6 6022.3 5449.0 5468.4 5516.3 5519.1 5522.2 6053.6 6061.0 6064.3 6068.2 6069.7 5623.8 5705.5 5756.9 5805.8 5821.0 5879.8 5905.0 5919.1 5919.4 5923.6 5852.1 5864.8 5874.1 5878.9 5887.7 5736.6 5764.2 5791.1 5837.1 5898.9 4440.7 4440.8 4441.2 4444.8 4481.1 3941.2 3956.0 3963.7 3978.3 3995.4 5374.7 5432.5 5436.7 5480.1 5504.4 5906.4 5908.3 5938.2 5945.3 6001.6 5541.3 5547.2 5547.4 5547.5 5558.8 4889.4 4996.2 5078.3 5085.8 5107.2 6140.8 6142.4 6151.1 6153.6 6156.6 5784.9 5945.6 5956.0 5956.3 5958.0 6030.3 6086.9 6092.6 6141.0 6152.0 5799.2 5841.7 5845.6 5848.4 5849.5 5568.0 5816.7 5952.8 5960.5 5966.7 5733.3 5777.0 5777.3 5783.0 5852.1 5734.1 5768.1 5769.0 5771.8 5787.6 5448.6 5553.3 5620.6 5647.9 5651.6 5821.7 5866.1 5867.1 5867.5 5868.9 5619.6 5656.2 5662.9 5695.7 5708.4 08:44:17 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | [#1] ext.html Cycles:180 Average:62486.28 Median:41533.08 stddev:130389.72 (313.9%) stddev-sans-first:130672.66 08:44:17 INFO - PROCESS | 11939 | Values: 580.9 621.2 626.8 641.2 646.0 33003.8 36337.6 36396.6 36410.3 43346.3 44381.8 44857.8 44876.8 44894.0 44923.0 8731.9 8918.6 8922.0 8922.6 8928.3 8816.3 8982.6 8985.4 8987.9 8995.0 9016.9 9066.8 9071.8 9073.3 9085.5 8933.0 8963.6 8989.1 8991.3 8992.0 8762.8 8852.6 8859.4 8864.1 8868.4 42435.4 42610.8 42640.6 43105.8 43141.0 3527.8 3677.5 4248.3 4282.2 4340.1 32722.2 32979.2 33143.7 33325.5 33648.8 4045.3 4047.5 4056.0 4063.6 4076.7 345335.0 347860.0 348177.0 349407.0 350251.0 58618.0 59749.8 59855.4 59954.0 59956.1 35986.3 36736.4 36751.8 38397.2 62323.7 17321.5 17394.7 17458.4 17481.6 17499.1 12860.7 12920.3 12927.1 12929.6 12933.0 19972.6 20144.3 20245.5 20253.8 20321.6 7500.6 7542.4 7561.8 7582.1 7583.7 954.8 997.5 1088.7 1111.2 1149.6 31825.4 32851.5 33223.8 33266.0 33594.5 1162.2 1167.4 1194.3 1195.1 1268.5 16769.2 17403.9 17488.6 17535.5 17798.7 542195.0 588371.0 597009.0 597848.0 838602.0 61350.4 61876.0 62240.0 62265.0 62393.7 1281.7 1380.8 1402.3 1410.6 1432.1 32382.0 34310.7 34437.8 34584.0 34609.8 51594.2 51662.5 52317.7 52358.0 52515.0 426536.0 428724.0 428909.0 429524.0 429923.0 25291.1 28780.7 29247.0 29899.4 29982.9 48204.0 48211.7 48281.0 48438.0 48984.3 40377.0 40726.4 41244.4 41564.6 41883.7 40307.6 40834.4 41132.2 41708.2 41917.8 40829.4 41501.6 42005.8 42033.2 42245.8 35530.0 36524.0 37004.8 37015.8 37783.0 28372.7 28690.3 28731.6 28837.7 28879.7 08:44:17 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | [#2] jquery.html Cycles:180 Average:23903.66 Median:2043.89 stddev:58646.34 (2869.4%) stddev-sans-first:58784.31 08:44:17 INFO - PROCESS | 11939 | Values: 398.4 403.5 411.1 412.3 425.7 17685.3 18256.5 19277.3 19278.9 19292.6 17846.0 18136.0 18342.8 19233.5 19260.8 5292.7 5591.5 5605.6 5665.3 5805.7 5584.1 5585.2 5586.8 5622.4 6249.1 6344.0 6367.3 6393.0 6396.2 6398.6 5321.2 5578.5 5628.3 6351.3 6351.8 5299.8 5453.1 5552.9 5561.1 5589.6 13609.9 13974.1 14097.8 14225.4 14237.5 2233.3 2288.0 2314.5 2360.1 2360.2 10287.8 10357.8 13429.8 13981.9 14410.9 1895.4 1960.4 1993.7 2014.6 2030.2 57783.4 61375.7 70920.3 78379.0 81191.6 10832.5 10960.1 11226.5 11240.3 11280.0 13821.9 14430.4 15439.3 15653.0 15671.6 8233.3 8334.6 8408.0 8507.8 8518.4 7998.8 8120.5 8160.1 8289.1 8305.0 4719.4 4864.0 4880.1 4907.8 4931.3 1905.0 1944.2 2019.3 2034.4 2053.4 921.5 1017.9 1079.6 1093.4 1112.9 18513.4 18558.7 18832.9 19226.0 19821.3 986.1 1025.8 1028.3 1033.0 1053.3 10672.3 11017.0 11067.2 11086.4 11125.3 227801.9 229625.0 230224.0 471621.0 476635.0 89326.0 92750.5 93287.7 100979.5 103128.0 1012.4 1052.0 1069.6 1071.2 1071.4 13212.5 16402.7 16692.6 17100.3 17683.9 40214.0 41343.1 41692.0 42134.2 42288.4 53248.7 55240.4 55245.0 55270.4 55561.4 8657.3 8672.6 8773.6 8947.6 9028.3 8231.5 10980.9 12087.0 13432.7 13469.0 11483.7 11746.4 11814.3 11932.9 12199.6 6099.8 10938.4 11668.0 11708.5 11734.5 11568.8 12113.2 12201.9 12407.4 12488.6 8620.3 8629.8 8729.7 8820.4 9004.7 8690.7 11017.6 11656.2 11780.4 11826.5 08:44:17 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | [#3] mootools.html Cycles:180 Average:5868.75 Median:2576.89 stddev:3355.95 (130.2%) stddev-sans-first:3348.57 08:44:17 INFO - PROCESS | 11939 | Values: 1401.9 1498.5 1539.4 1686.1 1840.0 7497.6 8627.7 8949.8 8976.5 9202.5 8861.7 9032.9 9037.2 9054.0 9072.1 2340.3 2360.3 2364.6 2364.9 2365.4 2336.4 2366.0 2369.3 2369.9 2374.3 2364.6 2365.5 2380.1 2411.2 2411.3 2309.7 2311.3 2341.2 2341.6 2360.7 2241.3 2278.9 2308.3 2313.4 2317.1 7841.6 8074.2 9059.5 9137.6 9137.8 4803.9 4931.3 5099.3 5276.3 5277.4 3327.8 3358.3 3410.7 3431.7 3522.5 1151.2 1158.1 1159.3 1179.7 1197.9 12483.4 12629.7 12639.6 12658.2 12663.6 4686.1 4736.9 4844.2 4861.2 4868.1 10664.5 10692.9 10694.7 10702.3 10706.9 5418.1 5419.8 5420.7 5421.5 5422.8 4881.7 4894.6 4955.7 5042.8 5045.2 3763.7 3840.1 3844.4 3870.9 3897.9 1252.6 1276.6 1281.7 1287.6 1290.5 836.5 974.4 1023.7 1028.1 1042.2 6247.4 6294.3 6296.6 6405.7 6452.8 452.5 467.7 981.8 1059.2 1086.8 4336.9 4359.7 4370.0 4392.8 4408.0 9585.4 10535.8 11154.2 11167.0 11467.4 11001.8 11317.5 11356.8 11413.8 11453.0 8259.4 8497.5 8563.0 8576.7 8577.7 6337.0 6359.0 6476.5 6491.8 6543.3 10209.6 10456.0 10467.6 10568.5 10604.1 10529.6 10561.9 10596.1 10767.2 10774.8 7084.8 7090.8 7146.9 7153.8 7195.1 8009.0 8262.1 8300.6 8318.0 8318.5 7415.3 7420.1 7449.4 7451.6 7590.2 7513.0 7537.8 7541.2 7558.8 7626.2 6792.7 6857.5 6858.5 6873.5 6875.6 4990.4 5070.8 5113.8 5172.8 5239.8 5288.7 5353.3 5363.2 5404.8 5407.4 08:44:17 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | [#4] prototype.html Cycles:180 Average:4722.67 Median:5405.05 stddev:1378.45 (25.5%) stddev-sans-first:1342.31 08:44:17 INFO - PROCESS | 11939 | Values: 330.2 334.7 340.8 341.8 343.5 5285.3 5381.1 5404.6 5405.5 5467.3 5265.7 5290.3 5306.3 5308.3 5310.6 3985.6 4195.8 4202.3 4215.7 4269.6 4034.3 4175.9 4182.4 4185.5 4198.7 4114.2 4119.7 4136.7 4139.0 4154.9 4046.9 4139.7 4172.4 4186.8 4193.4 3648.7 3667.5 3723.3 3725.3 3737.3 5062.7 5125.3 5129.9 5143.5 5143.6 4620.2 4742.1 4779.2 4790.2 4793.6 5493.6 5516.6 5525.1 5542.6 5572.2 4077.6 4086.4 4089.8 4093.0 4110.8 5541.7 5765.8 5810.6 5824.4 5841.2 4154.6 4187.3 4192.5 4206.2 4222.2 4235.5 4251.3 4262.9 4265.7 4274.7 4642.6 4821.3 4822.0 4823.3 4837.6 5592.9 5593.6 5593.6 5600.9 5625.9 1454.9 1474.6 1475.7 1479.3 1479.7 926.9 957.7 964.0 966.9 978.4 4823.3 5141.5 5288.4 5401.4 5453.9 5752.6 5763.0 5772.2 5773.5 5800.8 5131.2 5388.9 5399.9 5469.9 5470.3 3027.3 3042.5 3048.8 3063.5 3068.8 5810.8 5869.6 5951.9 5972.2 5997.3 5719.3 5819.9 5827.6 5842.8 5893.2 5832.7 5917.7 5935.5 5947.3 5961.0 5449.3 5729.4 5751.9 5791.0 5810.1 5714.9 5726.6 5730.4 5742.7 5755.5 5919.8 5924.2 5966.1 5981.4 6049.0 3959.0 4091.2 4102.3 4134.4 4155.4 5701.4 5742.8 5748.7 5778.9 5793.3 5611.4 5612.2 5650.4 5672.3 5715.3 5488.3 5569.4 5583.3 5583.5 5620.2 5460.8 5471.6 5476.5 5477.6 5492.2 5399.8 5455.8 5657.6 5668.8 5671.9 5511.2 5538.2 5582.9 5597.6 5627.7 08:44:17 INFO - PROCESS | 11939 | 08:44:17 INFO - PROCESS | 11939 | [#5] yui.html Cycles:180 Average:19701.17 Median:24896.49 stddev:27475.50 (110.4%) stddev-sans-first:27515.89 08:44:17 INFO - PROCESS | 11939 | Values: 791.7 806.5 829.1 832.5 841.1 13347.5 13909.9 13949.3 13983.7 14183.4 13951.7 14141.4 14156.9 14220.4 14223.5 645.7 772.6 782.4 794.9 795.1 784.9 792.5 794.4 794.5 794.9 832.6 833.8 834.7 835.2 836.0 691.8 820.1 833.0 846.4 846.5 593.2 598.8 599.1 599.8 604.8 15048.1 15093.5 15103.2 15115.7 15117.5 14428.4 14749.9 15092.9 15763.7 16008.4 11540.8 11719.8 11729.3 11783.8 11971.7 3895.3 3971.8 4014.0 4015.1 4077.6 72643.3 75668.6 75834.0 77503.2 78071.6 11840.7 11921.9 11972.9 12016.1 12051.6 22811.7 22824.3 22916.5 22926.2 22958.5 7859.4 8054.1 8090.6 8143.4 8202.3 4495.2 4688.5 4778.7 4917.8 4991.4 3547.6 3666.6 3689.8 3690.7 3695.3 637.1 641.6 643.4 661.4 662.6 744.4 749.6 768.0 770.7 776.3 10428.1 10738.4 10826.9 10872.5 10973.1 621.8 653.4 743.5 747.5 756.7 4777.7 5100.5 5111.9 5178.6 5218.6 93079.0 104973.0 107618.0 110122.0 110269.0 89461.0 92355.5 94420.0 94465.0 95156.0 83302.2 84097.0 84172.2 84396.0 84937.2 9676.8 9738.6 9865.3 9889.4 9907.9 44329.6 45297.8 47068.8 47607.8 50492.2 49042.0 49567.0 51663.5 55724.4 61484.4 11315.2 11394.3 11639.8 12757.7 13817.5 14625.9 14687.9 14878.6 15012.5 15834.5 13602.5 14270.2 14431.3 14778.9 14922.9 13210.3 13226.9 13352.3 13360.9 14012.9 13687.2 13747.8 13965.2 14412.1 14650.3 11248.7 11497.2 11559.6 11711.2 12172.8 11476.4 11592.7 11690.2 11733.8 12109.9 08:44:17 INFO - PROCESS | 11939 | -------- Summary: end -------- 08:44:17 INFO - PROCESS | 11939 | 08:44:18 INFO - TEST-INFO | 11939: exit 0 08:44:18 INFO - TEST-OK | dromaeo_css | took 1113109ms 08:44:18 INFO - TEST-START | kraken 08:44:18 INFO - operating with platform_type : linux_ 08:44:18 INFO - Initialising browser for kraken test... 08:44:18 INFO - TEST-INFO | started process 12130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_nPFYa/profile http://localhost:50328/getInfo.html) 08:44:22 INFO - PROCESS | 12130 | __metrics Screen width/height:1600/1200 08:44:22 INFO - PROCESS | 12130 | colorDepth:24 08:44:22 INFO - PROCESS | 12130 | Browser inner width/height: 1024/697 08:44:22 INFO - PROCESS | 12130 | __metrics 08:44:23 ERROR - PROCESS | 12130 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:44:24 INFO - TEST-INFO | 12130: exit 0 08:44:24 INFO - Browser initialized. 08:44:24 INFO - Running cycle 1/1 for kraken test... 08:44:24 INFO - TEST-INFO | started process 12212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_nPFYa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:36 INFO - PROCESS | 12212 | RSS: Main: 155942912 08:44:36 INFO - PROCESS | 12212 | 08:44:38 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50328/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:39 INFO - PROCESS | 12212 | RSS: Main: 214016000 08:44:39 INFO - PROCESS | 12212 | 08:44:42 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50328/tests/kraken/driver.html?testName=audio-dft) 08:44:42 INFO - PROCESS | 12212 | RSS: Main: 201031680 08:44:42 INFO - PROCESS | 12212 | 08:44:46 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50328/tests/kraken/driver.html?testName=audio-fft) 08:44:46 INFO - PROCESS | 12212 | RSS: Main: 268361728 08:44:46 INFO - PROCESS | 12212 | 08:44:48 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50328/tests/kraken/driver.html?testName=audio-oscillator) 08:44:49 INFO - PROCESS | 12212 | RSS: Main: 178974720 08:44:49 INFO - PROCESS | 12212 | 08:44:51 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50328/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:52 INFO - PROCESS | 12212 | RSS: Main: 183312384 08:44:52 INFO - PROCESS | 12212 | 08:44:55 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50328/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:55 INFO - PROCESS | 12212 | RSS: Main: 219488256 08:44:55 INFO - PROCESS | 12212 | 08:44:59 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50328/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:59 INFO - PROCESS | 12212 | RSS: Main: 220553216 08:44:59 INFO - PROCESS | 12212 | 08:45:02 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50328/tests/kraken/driver.html?testName=json-parse-financial) 08:45:03 INFO - PROCESS | 12212 | RSS: Main: 220073984 08:45:03 INFO - PROCESS | 12212 | 08:45:04 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50328/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:45:05 INFO - PROCESS | 12212 | RSS: Main: 206811136 08:45:05 INFO - PROCESS | 12212 | 08:45:07 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50328/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:45:07 INFO - PROCESS | 12212 | RSS: Main: 211128320 08:45:07 INFO - PROCESS | 12212 | 08:45:09 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50328/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:45:10 INFO - PROCESS | 12212 | RSS: Main: 215830528 08:45:10 INFO - PROCESS | 12212 | 08:45:12 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:45:13 INFO - PROCESS | 12212 | RSS: Main: 222560256 08:45:13 INFO - PROCESS | 12212 | 08:45:16 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:16 INFO - PROCESS | 12212 | RSS: Main: 218894336 08:45:16 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | Cycle 1(1): loaded http://localhost:50328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50328/tests/kraken/driver.html?testName=ai-astar) 08:45:18 INFO - PROCESS | 12212 | RSS: Main: 261369856 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | __start_tp_report 08:45:18 INFO - PROCESS | 12212 | _x_x_mozilla_page_load 08:45:18 INFO - PROCESS | 12212 | _x_x_mozilla_page_load_details 08:45:18 INFO - PROCESS | 12212 | |i|pagename|runs| 08:45:18 INFO - PROCESS | 12212 | |0;ai-astar;110;105;111;112;110;112;110;110;110;111 08:45:18 INFO - PROCESS | 12212 | |1;audio-beat-detection;161;128;126;188;131;126;160;124;161;124 08:45:18 INFO - PROCESS | 12212 | |2;audio-dft;162;161;160;160;162;160;161;163;161;161 08:45:18 INFO - PROCESS | 12212 | |3;audio-fft;74;74;75;126;74;78;75;74;98;76 08:45:18 INFO - PROCESS | 12212 | |4;audio-oscillator;87;85;109;85;84;86;125;86;85;130 08:45:18 INFO - PROCESS | 12212 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;117;116;118 08:45:18 INFO - PROCESS | 12212 | |6;imaging-darkroom;145;147;146;147;146;145;145;147;145;145 08:45:18 INFO - PROCESS | 12212 | |7;imaging-desaturate;95;95;94;94;94;97;95;94;95;95 08:45:18 INFO - PROCESS | 12212 | |8;json-parse-financial;53;53;53;53;54;53;53;52;53;52 08:45:18 INFO - PROCESS | 12212 | |9;json-stringify-tinderbox;63;62;62;62;62;61;61;62;61;61 08:45:18 INFO - PROCESS | 12212 | |10;stanford-crypto-aes;84;78;78;79;86;83;80;80;117;82 08:45:18 INFO - PROCESS | 12212 | |11;stanford-crypto-ccm;122;127;121;123;129;128;129;125;135;122 08:45:18 INFO - PROCESS | 12212 | |12;stanford-crypto-pbkdf2;162;160;164;161;161;167;165;166;168;168 08:45:18 INFO - PROCESS | 12212 | |13;stanford-crypto-sha256-iterative;64;68;64;62;65;63;67;63;64;65 08:45:18 INFO - PROCESS | 12212 | __end_tp_report 08:45:18 INFO - PROCESS | 12212 | __start_cc_report 08:45:18 INFO - PROCESS | 12212 | _x_x_mozilla_cycle_collect,1633 08:45:18 INFO - PROCESS | 12212 | __end_cc_report 08:45:18 INFO - PROCESS | 12212 | __startTimestamp1465055118841__endTimestamp 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | ------- Summary: start ------- 08:45:18 INFO - PROCESS | 12212 | Number of tests: 14 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:1.97 (1.8%) stddev-sans-first:2.09 08:45:18 INFO - PROCESS | 12212 | Values: 110.0 105.0 111.0 112.0 110.0 112.0 110.0 110.0 110.0 111.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:145.50 stddev:22.68 (15.6%) stddev-sans-first:23.09 08:45:18 INFO - PROCESS | 12212 | Values: 161.0 128.0 126.0 188.0 131.0 126.0 160.0 124.0 161.0 124.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 08:45:18 INFO - PROCESS | 12212 | Values: 162.0 161.0 160.0 160.0 162.0 160.0 161.0 163.0 161.0 161.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.98 (22.6%) stddev-sans-first:17.74 08:45:18 INFO - PROCESS | 12212 | Values: 74.0 74.0 75.0 126.0 74.0 78.0 75.0 74.0 98.0 76.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.12 (21.3%) stddev-sans-first:18.91 08:45:18 INFO - PROCESS | 12212 | Values: 87.0 85.0 109.0 85.0 84.0 86.0 125.0 86.0 85.0 130.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 08:45:18 INFO - PROCESS | 12212 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 08:45:18 INFO - PROCESS | 12212 | Values: 145.0 147.0 146.0 147.0 146.0 145.0 145.0 147.0 145.0 145.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 08:45:18 INFO - PROCESS | 12212 | Values: 95.0 95.0 94.0 94.0 94.0 97.0 95.0 94.0 95.0 95.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 08:45:18 INFO - PROCESS | 12212 | Values: 53.0 53.0 53.0 53.0 54.0 53.0 53.0 52.0 53.0 52.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 08:45:18 INFO - PROCESS | 12212 | Values: 63.0 62.0 62.0 62.0 62.0 61.0 61.0 62.0 61.0 61.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.00 stddev:11.65 (14.4%) stddev-sans-first:12.36 08:45:18 INFO - PROCESS | 12212 | Values: 84.0 78.0 78.0 79.0 86.0 83.0 80.0 80.0 117.0 82.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.50 stddev:4.36 (3.4%) stddev-sans-first:4.36 08:45:18 INFO - PROCESS | 12212 | Values: 122.0 127.0 121.0 123.0 129.0 128.0 129.0 125.0 135.0 122.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:165.50 stddev:3.05 (1.8%) stddev-sans-first:3.13 08:45:18 INFO - PROCESS | 12212 | Values: 162.0 160.0 164.0 161.0 161.0 167.0 165.0 166.0 168.0 168.0 08:45:18 INFO - PROCESS | 12212 | 08:45:18 INFO - PROCESS | 12212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.84 (2.9%) stddev-sans-first:1.94 08:45:18 INFO - PROCESS | 12212 | Values: 64.0 68.0 64.0 62.0 65.0 63.0 67.0 63.0 64.0 65.0 08:45:18 INFO - PROCESS | 12212 | -------- Summary: end -------- 08:45:18 INFO - PROCESS | 12212 | 08:45:19 INFO - TEST-INFO | 12212: exit 0 08:45:19 INFO - TEST-OK | kraken | took 61174ms 08:45:19 INFO - SUITE-END | took 1174s 08:45:20 INFO - Completed test suite (00:19:34) 08:45:20 INFO - javascript benchmark 08:45:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.8453577321134, 3102.5811515445407, 3121.3445176512932, 3146.323540438805, 3162.1304141361124, 5340.0, 5386.407495175533, 5410.323709536308, 5441.727913604319, 5444.673319600822, 5393.973030134854, 5416.268803711498, 5474.206240095194, 5516.200150978106, 5528.861778455531, 4921.237208232721, 4961.652684312099, 4974.179260422026, 5003.674761140533, 5081.364829396325, 5004.149294619905, 5017.774200161001, 5059.721715305675, 5067.569256613192, 5078.59371250301, 4802.9039419211595, 4923.359963204778, 4935.210366341368, 4942.555170034678, 4991.625628077891, 4924.162892308316, 4958.578520825734, 5022.17134172861, 5024.648274620778, 5070.2141168119, 4877.6341774367065, 4984.0281145176705, 4988.5260900214425, 5006.4492905780335, 5018.64869459138, 5352.759125839347, 5440.6735595863975, 5443.183522471661, 5511.145772405283, 5513.7794488220825, 5930.97034514829, 5940.138679891435, 5962.522998160137, 5969.552283578705, 5978.2228310319815, 5758.481736643722, 5785.2189954356045, 5970.791022314198, 6013.579049466539, 6022.337542870281, 5449.04641687707, 5468.398476167618, 5516.338039435253, 5519.061759500894, 5522.199281104257, 6053.636781793107, 6060.969695151496, 6064.272287325549, 6068.180795592539, 6069.726862291208, 5623.803166889139, 5705.486506214461, 5756.94243057564, 5805.82582522525, 5821.039528477839, 5879.823605291848, 5904.970475147683, 5919.082542205965, 5919.437653422918, 5923.644581325134, 5852.092925596539, 5864.824055278348, 5874.060150375919, 5878.882422351529, 5887.705614719247, 5736.598438109292, 5764.221830052973, 5791.102379131242, 5837.09525023622, 5898.941010589925, 4440.666949978765, 4440.822367105279, 4441.156180325728, 4444.799984000728, 4481.126180394792, 3941.1526521797377, 3956.0, 3963.742356746802, 3978.2839088963688, 3995.400689896481, 5374.731263436891, 5432.511074003359, 5436.728163591804, 5480.068388373986, 5504.366997795225, 5906.379830117861, 5908.261467316585, 5938.2280303560265, 5945.286565612154, 6001.63990160583, 5541.307336582927, 5547.223388725582, 5547.362053363915, 5547.5007249346945, 5558.805441809598, 4889.364382630235, 4996.150654388763, 5078.314427552233, 5085.847424577269, 5107.157319042316, 6140.754369825247, 6142.416470435302, 6151.138840562325, 6153.630782152995, 6156.630602163885, 5784.913226301693, 5945.643261404416, 5955.970220148872, 5956.285245770535, 5957.987142185925, 6030.336662966983, 6086.939130608637, 6092.603980741238, 6141.048137538689, 6151.96924015377, 5799.246098007401, 5841.707914604168, 5845.561582881216, 5848.356680765028, 5849.53203743708, 5568.0, 5816.651000939957, 5952.76188952437, 5960.4635582797755, 5966.701664916824, 5733.340665823317, 5777.04678728022, 5777.306723193244, 5782.959067367914, 5852.092925596539, 5734.05388110957, 5768.1347797828985, 5768.990426675231, 5771.769129234784, 5787.623804452697, 5448.645838020516, 5553.250311208097, 5620.606557540933, 5647.88704225905, 5651.6043876928225, 5821.738021788945, 5866.149408335853, 5867.061270196748, 5867.501262392744, 5868.853278668067, 5619.634723742944, 5656.236408084856, 5662.886742265214, 5695.658260504218, 5708.429157084258], "value": 5410.495149024251, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8838232353528, 621.2172662445319, 626.8370223741831, 641.2081079866363, 646.0051520658186, 33003.83498082512, 36337.636623633756, 36396.636033639654, 36410.27179456413, 43346.34980475296, 44381.778091109496, 44857.7757111214, 44876.77561612196, 44894.0, 44923.0, 8731.86902196466, 8918.598663060146, 8922.01857795642, 8922.553872306391, 8928.330375221853, 8816.250618697419, 8982.640694372218, 8985.37102402832, 8987.910120898772, 8995.0, 9016.909830901672, 9066.773330666752, 9071.773205669844, 9073.319501037415, 9085.454872707625, 8933.0, 8963.596638151299, 8989.05614910438, 8991.325650576167, 8992.0, 8762.824743505158, 8852.645894164225, 8859.379843410963, 8864.0692727264, 8868.423552469134, 42435.363469547985, 42610.78694606507, 42640.57359426397, 43105.784471077444, 43141.0, 3527.8236088195486, 3677.485152078711, 4248.34150706641, 4282.186384586918, 4340.131973605292, 32722.181945451317, 32979.186144762025, 33143.6685633143, 33325.50011749825, 33648.83175584131, 4045.3325201341745, 4047.494063242095, 4056.0, 4063.634272915422, 4076.735012224196, 345334.9999999975, 347860.0, 348177.0, 349407.0, 350251.0, 58618.0, 59749.80500389968, 59855.401445984986, 59954.0, 59956.100658490155, 35986.28027439437, 36736.448953265724, 36751.81624091916, 38397.232055358734, 62323.688381558706, 17321.4803555891, 17394.739078913826, 17458.388956386465, 17481.56296092608, 17499.12504374776, 12860.742785144244, 12920.289384083777, 12927.095103342675, 12929.612111636477, 12933.0, 19972.60054798925, 20144.294949676692, 20245.493862653257, 20253.797462025486, 20321.59356812885, 7500.58746768922, 7542.396608271325, 7561.7731468056045, 7582.128055273603, 7583.734569290048, 954.7899462118323, 997.5211898288862, 1088.6679562733284, 1111.222144498854, 1149.5918948773065, 31825.363492730015, 32851.50722739161, 33223.83388083044, 33266.0, 33594.496082558784, 1162.2213117211488, 1167.3831743035787, 1194.2834299420451, 1195.121585634558, 1268.5369840008516, 16769.161541922855, 17403.91298043527, 17488.5627859302, 17535.473935781945, 17798.733019004725, 542195.0, 588371.0, 597009.0, 597848.0, 838602.0, 61350.38649613536, 61876.0, 62240.0, 62265.0, 62393.68803156046, 1281.6859869332072, 1380.7859781734048, 1402.3198748606917, 1410.612081677547, 1432.0691550492263, 32382.0, 34310.65689343175, 34437.827810860785, 34584.0, 34609.826950865085, 51594.22608660948, 51662.483375165764, 52317.73841130922, 52358.0, 52515.0, 426536.0, 428724.0, 428909.0, 429524.0, 429923.0, 25291.114810981526, 28780.712192877803, 29247.0, 29899.402011959202, 29982.850085749433, 48204.0, 48211.6967133622, 48281.0, 48438.0, 48984.26523602077, 40377.0, 40726.38910416287, 41244.38133427941, 41564.58435415607, 41883.696396697254, 40307.59692403038, 40834.38748418835, 41132.1773564533, 41708.1658366837, 41917.79041104775, 40829.38755918723, 41501.58498414977, 42005.78997105117, 42033.15933681248, 42245.788771055944, 35530.0, 36524.0, 37004.81497592603, 37015.81492092522, 37783.0, 28372.716272837006, 28690.282742931595, 28731.5690264642, 28837.711622883504, 28879.7112028877], "value": 20348.93689178851, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.43422340276805, 403.4513062235361, 411.0648275173979, 412.2723393210985, 425.6956276262472, 17685.29258829647, 18256.452306430794, 19277.325293614726, 19278.90360548197, 19292.61414771704, 17846.0, 18136.0, 18342.81657183428, 19233.519162020955, 19260.807391926075, 5292.655977361478, 5591.524720398771, 5605.5515558755205, 5665.291838520196, 5805.680687562203, 5584.078627026536, 5585.190147428621, 5586.832395028136, 5622.381538030813, 6249.062640603923, 6343.968280158593, 6367.267764207106, 6392.968035159841, 6396.2324521057535, 6398.616083035009, 5321.175217841241, 5578.470045345685, 5628.26832511775, 6351.301356850743, 6351.809445716636, 5299.814506492293, 5453.100238460649, 5552.944470555283, 5561.082421400504, 5589.580781441367, 13609.863901361057, 13974.091684040606, 14097.78853317201, 14225.359858806378, 14237.501687440994, 2233.2630232023557, 2287.97712022881, 2314.5370925814905, 2360.067773229565, 2360.197532838843, 10287.845682314772, 10357.844632330522, 13429.798553021712, 13981.930090349584, 14410.855891441057, 1895.4313705888178, 1960.44127423685, 1993.6909778984282, 2014.617222727677, 2030.198071761646, 57783.422165778225, 61375.69312153411, 70920.2907970924, 78379.0, 81191.59404203, 10832.512536935857, 10960.12319014477, 11226.494807733508, 11240.325580465198, 11280.0, 13821.930890345484, 14430.350634221486, 15439.30523126462, 15653.0, 15671.608209794618, 8233.300169485541, 8334.583270836434, 8408.0, 8507.787305317417, 8518.361122915807, 7998.84002319962, 8120.512769233865, 8160.143184965612, 8289.129641387688, 8305.0, 4719.433667959866, 4863.975680121647, 4880.097182021337, 4907.803687852446, 4931.2849636803185, 1904.980950190508, 1944.1542928825722, 2019.2831544801677, 2034.4201902458024, 2053.3531937439657, 921.5484412637759, 1017.867677201959, 1079.6221322537206, 1093.4423444043596, 1112.8942750438696, 18513.44459666212, 18558.72161917572, 18832.90583547101, 19226.0, 19821.30625428103, 986.1371300112402, 1025.7845852370936, 1028.3315844701003, 1033.01347213411, 1053.3153450257394, 10672.30630009047, 11017.0, 11067.225294229487, 11086.445677716081, 11125.276857004268, 227801.860990694, 229625.0, 230224.0, 471621.0, 476635.0, 89326.0, 92750.53624731833, 93287.73834878158, 100979.45592448357, 103128.0, 1012.3925644613321, 1051.984220236697, 1069.561479793281, 1071.1805468816362, 1071.3732466507024, 13212.537561185312, 16402.67194656124, 16692.58268543296, 17100.315987360365, 17683.911580442014, 40214.0, 41343.105982582136, 41692.0, 42134.15731685288, 42288.365674514294, 53248.73375633097, 55240.44759552353, 55245.0, 55270.44729552653, 55561.444385557246, 8657.264132548804, 8672.609732562176, 8773.649054037767, 8947.552622368985, 9028.322875784212, 8231.46495477792, 10980.890191097988, 12086.972607328476, 13432.731345373233, 13469.0, 11483.712907177387, 11746.353950532803, 11814.291142531476, 11932.940335298268, 12199.573014944433, 6099.841030204425, 10938.398388088732, 11668.0, 11708.531658733555, 11734.530618775494, 11568.768624627292, 12113.212641178296, 12201.938990304992, 12407.379631018232, 12488.56290029881, 8620.267277281502, 8629.784255393666, 8729.694460693845, 8820.427726770668, 9004.684836030707, 8690.695825646326, 11017.614383496539, 11656.18406711522, 11780.410979450822, 11826.546632484693], "value": 9013.348049854823, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.9018668693195, 1498.4530646314095, 1539.3842463014796, 1686.131642204265, 1839.9908000460005, 7497.625118744061, 8627.741167764969, 8949.776255593597, 8976.506292153937, 9202.539873006357, 8861.689840855572, 9032.8645070324, 9037.231835293991, 9054.0, 9072.09279072094, 2340.297910626818, 2360.280114565057, 2364.6334818103137, 2364.869932153731, 2365.38499990003, 2336.380859072347, 2365.9881700591473, 2369.312899259213, 2369.857808531485, 2374.3351861478814, 2364.609839376501, 2365.4914193448403, 2380.1074597026113, 2411.2284069097896, 2411.252511721363, 2309.6997390339234, 2311.3412677386864, 2341.1571834139695, 2341.590221711194, 2360.704911886014, 2241.3442106883567, 2278.863268203913, 2308.2613563659634, 2313.3753886450563, 2317.1079134533325, 7841.647125879349, 8074.152214017561, 9059.50172740499, 9137.588808503633, 9137.81724365509, 4803.879903002418, 4931.284963680247, 5099.33708617881, 5276.34045744282, 5277.445868183862, 3327.8169700666454, 3358.261182539837, 3410.744194185446, 3431.742619303562, 3522.489239060322, 1151.205668089016, 1158.0966845860241, 1159.3044173495919, 1179.7463545337707, 1197.8921897029222, 12483.438245278985, 12629.74740505194, 12639.620811375673, 12658.177218480769, 12663.556775512812, 4686.109639168547, 4736.8578942631775, 4844.249141383091, 4861.222204447272, 4868.148074087091, 10664.466776661136, 10692.946535267274, 10694.679159625224, 10702.25084244111, 10706.946465267623, 5418.133098704188, 5419.810306639249, 5420.728963551806, 5421.454885357654, 5422.783088676409, 4881.731504767201, 4894.583960363338, 4955.677880937727, 5042.84871453857, 5045.2432135180015, 3763.6989040876665, 3840.078381188495, 3844.38489841624, 3870.8645197417954, 3897.902552436155, 1252.5616034388074, 1276.5978716704208, 1281.7116148866617, 1287.6072797796762, 1290.451558087809, 836.5315423362814, 974.3569244298728, 1023.744063984004, 1028.0857501144542, 1042.2339580408393, 6247.406496382836, 6294.276158241769, 6296.5592408531875, 6405.679716014274, 6452.774152904626, 452.5067676232856, 467.67029244382627, 981.7741919358588, 1059.1632610237825, 1086.750047489082, 4336.869893903125, 4359.738415695005, 4370.0, 4392.846250381222, 4407.977960110243, 9585.376950498196, 10535.789284214272, 11154.163437742201, 11167.0, 11467.369294688706, 11001.834972475419, 11317.49071291794, 11356.829647555292, 11413.771724565462, 11453.0, 8259.38054645904, 8497.532635704973, 8562.957185214034, 8576.699815506427, 8577.742667719978, 6337.0, 6358.968205158944, 6476.514261430318, 6491.837704057436, 6543.312952140147, 10209.591616335263, 10456.0, 10467.581296748045, 10568.524416401127, 10604.098651614699, 10529.631462898762, 10561.89438105609, 10596.099331556905, 10767.246292759744, 10774.784504310026, 7084.822879428056, 7090.7518236863525, 7146.857062858609, 7153.785386438415, 7195.100612423447, 8009.0, 8262.091169971178, 8300.584970751559, 8318.0, 8318.500889946623, 7415.332620064004, 7420.072490938633, 7449.366803821519, 7451.552906825608, 7590.20302868213, 7513.023306970059, 7537.849243015218, 7541.2458754124145, 7558.811029724081, 7626.161122276656, 6792.66036698173, 6857.485688573277, 6858.4856135791015, 6873.450123990169, 6875.5530890491955, 4990.426100998432, 5070.847874563769, 5113.846584602468, 5172.818951336685, 5239.842804715865, 5288.65623734456, 5353.304070470814, 5363.19552067193, 5404.78380864761, 5407.351117865881], "value": 4680.880460275512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.2088282866096, 334.7338865601846, 340.84321212242367, 341.78125999360395, 343.51049754100416, 5285.26006359109, 5381.0852155133625, 5404.621676482648, 5405.486478784519, 5467.261919640848, 5265.736713164336, 5290.312259406282, 5306.283651707018, 5308.256844041837, 5310.6017048721305, 3985.581513941038, 4195.790210489478, 4202.306619407809, 4215.747055176699, 4269.573042695737, 4034.334334834749, 4175.853845115422, 4182.414461975326, 4185.514142479422, 4198.6641068714425, 4114.218298523286, 4119.670426365884, 4136.689748268876, 4138.979305103485, 4154.875353739378, 4046.9190616187807, 4139.668826493873, 4172.415861779354, 4186.832526698929, 4193.412922190896, 3648.6898613617873, 3667.468217108531, 3723.2739615774663, 3725.254949010182, 3737.2712321097397, 5062.696238225718, 5125.256837758504, 5129.9227162295965, 5143.485651434864, 5143.588512918957, 4620.168369693454, 4742.1227072991605, 4779.163646361872, 4790.209615413488, 4793.616510679138, 5493.642913210669, 5516.586256030814, 5525.11598144299, 5542.644376140124, 5572.247746554204, 4077.6330130288416, 4086.366613174963, 4089.8159582818844, 4093.0, 4110.794460276974, 5541.6977010402525, 5765.828794163235, 5810.605454690886, 5824.359320474744, 5841.182234487175, 4154.626083652486, 4187.309093999517, 4192.538820729717, 4206.242876282237, 4222.150048717103, 4235.53409124996, 4251.278232315917, 4262.914741705211, 4265.722728022669, 4274.7435153890865, 4642.582167604932, 4821.349117869043, 4821.975890120527, 4823.27650852368, 4837.56461918422, 5592.860178495489, 5593.552515798727, 5593.552515798727, 5600.943990560124, 5625.887482250414, 1454.8836093112525, 1474.6018574984694, 1475.7417451945867, 1479.3416929466284, 1479.7114562660179, 926.8795056642729, 957.6504575829772, 963.9710808675751, 966.9371490853072, 978.3836183204678, 4823.300621409946, 5141.537261646395, 5288.36539615241, 5401.405845357008, 5453.936482385976, 5752.626079304831, 5763.0, 5772.181762744722, 5773.509251713567, 5800.767969281266, 5131.230315452712, 5388.91916621251, 5399.865003374868, 5469.863253418617, 5470.261514695545, 3027.349119939224, 3042.4675681755602, 3048.810963724149, 3063.509838425886, 3068.769842261839, 5810.82567522975, 5869.618474799125, 5951.940480595139, 5972.193753843176, 5997.250343707036, 5719.256496655408, 5819.912701309484, 5827.621204621686, 5842.795502157489, 5893.233879595625, 5832.708364581754, 5917.733701983421, 5935.52515798735, 5947.286325640951, 5961.0, 5449.34607847045, 5729.427057294237, 5751.884962300815, 5791.0, 5810.099434587646, 5714.857128571819, 5726.570507211893, 5730.395489263013, 5742.684152371659, 5755.539556835527, 5919.792807251725, 5924.170616113662, 5966.134910438049, 5981.371955944737, 6048.975512243878, 3959.0, 4091.1613119309873, 4102.323116685713, 4134.441850350164, 4155.41824144626, 5701.401352858056, 5742.765305459347, 5748.712564371848, 5778.884422311614, 5793.304803423616, 5611.410801865745, 5612.158176273591, 5650.434956504317, 5672.347680016851, 5715.342735585295, 5488.286522752017, 5569.443055694398, 5583.330000399978, 5583.497485226349, 5620.185073164286, 5460.781568737365, 5471.644343117685, 5476.479734425223, 5477.589180811376, 5492.231087647812, 5399.78400863961, 5455.790404886027, 5657.575681823797, 5668.829935101953, 5671.858203544779, 5511.173324001272, 5538.224648549287, 5582.906410096214, 5597.580181486486, 5627.662340259434], "value": 4285.360706651728, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.7387262203473, 806.5080301016379, 829.0631586307471, 832.5417389877211, 841.1000229754166, 13347.466101355947, 13909.860901390983, 13949.302534873254, 13983.650408739773, 14183.361748721307, 13951.720965580682, 14141.434342626308, 14156.929215353935, 14220.431182752678, 14223.502177423792, 645.7384759172543, 772.5750837039634, 782.4444644302552, 794.8847417124542, 795.0538858758089, 784.8861915022318, 792.4888446951712, 794.4319811334894, 794.5232860283842, 794.9205079492034, 832.6045128563914, 833.754042557444, 834.7245409015011, 835.2148979958819, 835.9958200209021, 691.8339598496375, 820.110180454205, 832.9625166867505, 846.3652260804397, 846.5386364431338, 593.1873333533044, 598.8023952095798, 599.1372423709887, 599.8170557979814, 604.8457643300974, 15048.097114173184, 15093.47172848956, 15103.169325687082, 15115.697686046327, 15117.470888518848, 14428.350724217435, 14749.852501474956, 15092.924535377362, 15763.684726305524, 16008.439704610399, 11540.769184616345, 11719.765604687858, 11729.296242225493, 11783.764324713458, 11971.700707482296, 3895.2599006188734, 3971.7815520146382, 4013.97993010036, 4015.0966032642714, 4077.612626800449, 72643.27356726471, 75668.62165689192, 75834.0, 77503.22496775017, 78071.60964195199, 11840.70398240051, 11921.940390297994, 11972.880271197351, 12016.09879259059, 12051.638450846489, 22811.657825132635, 22824.31527054191, 22916.541669166523, 22926.19758308451, 22958.540829183323, 7859.371250299962, 8054.073781515201, 8090.595470226465, 8143.389245806469, 8202.343812494986, 4495.213337665896, 4688.531146885284, 4778.689385189951, 4917.754112294371, 4991.401031876198, 3547.5742910850863, 3666.578343490533, 3689.815509224528, 3690.7231957603285, 3695.297893400299, 637.0985056145595, 641.6086187425667, 643.4048505132733, 661.3716968879584, 662.5991275278484, 744.3747252308087, 749.6102026946066, 768.036114676078, 770.7302444144617, 776.3129630277133, 10428.113610343054, 10738.409387483764, 10826.945865270623, 10872.456377181268, 10973.122150227962, 621.7637297826797, 653.4217217762315, 743.5092838726523, 747.5103807006419, 756.7229828572008, 4777.737224452689, 5100.515451032146, 5111.87220319495, 5178.559822415062, 5218.556422704112, 93079.0, 104973.0, 107618.0, 110122.0, 110269.0, 89461.0, 92355.53822230846, 94420.0, 94465.0, 95156.0, 83302.16697833066, 84097.0, 84172.15827841766, 84395.99999999878, 84937.15062849416, 9676.75808104803, 9738.640169141634, 9865.309428339948, 9889.406635601887, 9907.851382229128, 44329.55670443254, 45297.77351113223, 47068.7646561765, 47607.76196118997, 50492.24261636005, 49042.0, 49567.0, 51663.48336516587, 55724.442755573546, 61484.385156147866, 11315.20793544444, 11394.25937314072, 11639.825402618799, 12757.744845103232, 13817.516386926409, 14625.92687036558, 14687.853121469076, 14878.553643390716, 15012.47456339023, 15834.524964251092, 13602.523911663044, 14270.215138167501, 14431.278436078364, 14778.926105369404, 14922.850771492145, 13210.339483025618, 13226.867731322563, 13352.332383380597, 13360.93319533396, 14012.859871401155, 13687.178769273478, 13747.773388132242, 13965.231912244924, 14412.126423564869, 14650.267486625413, 11248.662540123809, 11497.152921038727, 11559.595414160463, 11711.1802173847, 12172.75654486923, 11476.368799716096, 11592.6522204334, 11690.240134391237, 11733.76532469363, 12109.91197244697], "value": 7506.522745397533, "unit": "score"}], "name": "dromaeo_css", "value": 7284.679444359629, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 112.0, 110.0, 112.0, 110.0, 110.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 126.0, 188.0, 131.0, 126.0, 160.0, 124.0, 161.0, 124.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 162.0, 160.0, 161.0, 163.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 126.0, 74.0, 78.0, 75.0, 74.0, 98.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 109.0, 85.0, 84.0, 86.0, 125.0, 86.0, 85.0, 130.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 147.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 97.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 52.0, 53.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 78.0, 79.0, 86.0, 83.0, 80.0, 80.0, 117.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 127.0, 121.0, 123.0, 129.0, 128.0, 129.0, 125.0, 135.0, 122.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 164.0, 161.0, 161.0, 167.0, 165.0, 166.0, 168.0, 168.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 64.0, 62.0, 65.0, 63.0, 67.0, 63.0, 64.0, 65.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1504.3999999999999, "alertThreshold": 2.0}]} 08:45:20 INFO - Return code: 0 08:45:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:45:20 ERROR - # TBPL SUCCESS # 08:45:20 INFO - Running post-action listener: _resource_record_post_action 08:45:20 INFO - ##### 08:45:20 INFO - ##### Finished run-tests step (success) 08:45:20 INFO - ##### 08:45:20 INFO - Running post-run listener: _resource_record_post_run 08:45:20 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 541601792; Read time: 588; Write time: 629804 08:45:20 INFO - TinderboxPrint: CPU usage
13.1% 08:45:20 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 588 08:45:20 INFO - TinderboxPrint: I/O write bytes / time
541,601,792 / 629,804 08:45:20 INFO - TinderboxPrint: CPU idle
8,265.4 (86.9%) 08:45:20 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 08:45:20 INFO - TinderboxPrint: Swap in / out
0 / 0 08:45:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248078336; Read time: 356; Write time: 325552 08:45:20 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293523456; Read time: 232; Write time: 304252 08:45:20 INFO - Running post-run listener: _upload_blobber_files 08:45:20 INFO - Blob upload gear active. 08:45:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:45:20 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 08:45:20 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'] 08:45:20 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 08:45:21 INFO - (blobuploader) - INFO - Open directory for files ... 08:45:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:45:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:45:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:24 INFO - (blobuploader) - INFO - Done attempting. 08:45:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:45:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:45:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:25 INFO - (blobuploader) - INFO - Done attempting. 08:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:45:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:26 INFO - (blobuploader) - INFO - Done attempting. 08:45:26 INFO - (blobuploader) - INFO - Iteration through files over. 08:45:26 INFO - Return code: 0 08:45:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:45:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:45:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85f6a5ffda852bb36538754a941fae7e9099a0cbefc0be62eed0564f707a566e6ec20fc43831f31ab8c32e9879ee89f1fe99878e07a324119450af9b4d7ec1ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0819bf51ab4373dbfb7f2fb8cd40e919de94fd01cc881b304276bbb77b3e179fc8ea0f509e8a1f92eedf0ab12e9db79ddf2c14d369eaa66d0183d1a8327fb375", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/418b0642b96c868a64bbdeb2a837904fd6357e117a35695cbc51e494efb896fd55766958793c0f7dbf296da4a5af10676256628dbeb1d13135d10e78f30227eb"} 08:45:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:45:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:45:26 INFO - Contents: 08:45:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85f6a5ffda852bb36538754a941fae7e9099a0cbefc0be62eed0564f707a566e6ec20fc43831f31ab8c32e9879ee89f1fe99878e07a324119450af9b4d7ec1ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0819bf51ab4373dbfb7f2fb8cd40e919de94fd01cc881b304276bbb77b3e179fc8ea0f509e8a1f92eedf0ab12e9db79ddf2c14d369eaa66d0183d1a8327fb375", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/418b0642b96c868a64bbdeb2a837904fd6357e117a35695cbc51e494efb896fd55766958793c0f7dbf296da4a5af10676256628dbeb1d13135d10e78f30227eb"} 08:45:26 INFO - Running post-run listener: copy_logs_to_upload_dir 08:45:26 INFO - Copying logs to upload dir... 08:45:26 INFO - mkdir: /builds/slave/test/build/upload/logs 08:45:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.297266 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-04 08:45:25.203804) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 08:45:25.207315) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252 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/85f6a5ffda852bb36538754a941fae7e9099a0cbefc0be62eed0564f707a566e6ec20fc43831f31ab8c32e9879ee89f1fe99878e07a324119450af9b4d7ec1ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0819bf51ab4373dbfb7f2fb8cd40e919de94fd01cc881b304276bbb77b3e179fc8ea0f509e8a1f92eedf0ab12e9db79ddf2c14d369eaa66d0183d1a8327fb375", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/418b0642b96c868a64bbdeb2a837904fd6357e117a35695cbc51e494efb896fd55766958793c0f7dbf296da4a5af10676256628dbeb1d13135d10e78f30227eb"} build_url:https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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/85f6a5ffda852bb36538754a941fae7e9099a0cbefc0be62eed0564f707a566e6ec20fc43831f31ab8c32e9879ee89f1fe99878e07a324119450af9b4d7ec1ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0819bf51ab4373dbfb7f2fb8cd40e919de94fd01cc881b304276bbb77b3e179fc8ea0f509e8a1f92eedf0ab12e9db79ddf2c14d369eaa66d0183d1a8327fb375", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/418b0642b96c868a64bbdeb2a837904fd6357e117a35695cbc51e494efb896fd55766958793c0f7dbf296da4a5af10676256628dbeb1d13135d10e78f30227eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 08:45:25.232814) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:45:25.233165) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465051831.910640-1240672252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:45:25.316664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 08:45:25.316994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 08:45:25.317297) ========= ========= Total master_lag: 0.18 =========