builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1467640282.39 results: success (0) buildid: 20160704041625 builduid: 125aad23bfe9403998211f5bbff942a5 revision: a2db4c13a2b9ac395db681b7f16e5abb528f0663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.392629) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.393088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.393390) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.441660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.442050) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 06:51:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-07-04 06:51:22 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164529 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.649418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.649742) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.125631 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.787432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:22.787823) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a2db4c13a2b9ac395db681b7f16e5abb528f0663 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a2db4c13a2b9ac395db681b7f16e5abb528f0663 --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=516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 06:51:22,893 truncating revision to first 12 chars 2016-07-04 06:51:22,894 Setting DEBUG logging. 2016-07-04 06:51:22,894 attempt 1/10 2016-07-04 06:51:22,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a2db4c13a2b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 06:51:23,206 unpacking tar archive at: mozilla-aurora-a2db4c13a2b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695618 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:23.498141) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:23.498574) ========= script_repo_revision: a2db4c13a2b9ac395db681b7f16e5abb528f0663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:23.499074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:23.499418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 06:51:23.510370) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-04 06:51:23.510754) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:51:23 INFO - MultiFileLogger online at 20160704 06:51:23 in /builds/slave/test 06:51:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:51:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:51:23 INFO - {'append_to_log': False, 06:51:23 INFO - 'base_work_dir': '/builds/slave/test', 06:51:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:51:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:51:23 INFO - 'branch': 'Mozilla-Aurora', 06:51:23 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:23 INFO - 'config_files': ('talos/linux_config.py',), 06:51:23 INFO - 'default_actions': ('clobber', 06:51:23 INFO - 'read-buildbot-config', 06:51:23 INFO - 'download-and-extract', 06:51:23 INFO - 'populate-webroot', 06:51:23 INFO - 'create-virtualenv', 06:51:23 INFO - 'install', 06:51:23 INFO - 'run-tests'), 06:51:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:23 INFO - 'download_minidump_stackwalk': True, 06:51:23 INFO - 'download_symbols': 'ondemand', 06:51:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:23 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:23 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:23 INFO - 'installer_path': 'installer.exe', 06:51:23 INFO - 'log_level': 'info', 06:51:23 INFO - 'log_name': 'talos', 06:51:23 INFO - 'log_to_console': True, 06:51:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:51:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:51:23 INFO - 'opt_config_files': (), 06:51:23 INFO - 'pip_index': False, 06:51:23 INFO - 'sps_profile': False, 06:51:23 INFO - 'sps_profile_interval': 0, 06:51:23 INFO - 'suite': 'dromaeojs', 06:51:23 INFO - 'system_bits': '32', 06:51:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:23 INFO - 'title': 'talos-linux64-ix-061', 06:51:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:23 INFO - 'use_talos_json': True, 06:51:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:51:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:23 INFO - 'work_dir': 'build'} 06:51:23 INFO - ##### 06:51:23 INFO - ##### Running clobber step. 06:51:23 INFO - ##### 06:51:23 INFO - Running pre-action listener: _resource_record_pre_action 06:51:23 INFO - Running main action method: clobber 06:51:23 INFO - rmtree: /builds/slave/test/build 06:51:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:51:25 INFO - Running post-action listener: _resource_record_post_action 06:51:25 INFO - ##### 06:51:25 INFO - ##### Finished clobber step (success) 06:51:25 INFO - ##### 06:51:25 INFO - ##### 06:51:25 INFO - ##### Running read-buildbot-config step. 06:51:25 INFO - ##### 06:51:25 INFO - Running pre-action listener: _resource_record_pre_action 06:51:25 INFO - Running main action method: read_buildbot_config 06:51:25 INFO - Using buildbot properties: 06:51:25 INFO - { 06:51:25 INFO - "project": "", 06:51:25 INFO - "product": "firefox", 06:51:25 INFO - "script_repo_revision": "production", 06:51:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:51:25 INFO - "repository": "", 06:51:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:51:25 INFO - "buildid": "20160704041625", 06:51:25 INFO - "pgo_build": "True", 06:51:25 INFO - "basedir": "/builds/slave/test", 06:51:25 INFO - "buildnumber": 403, 06:51:25 INFO - "slavename": "talos-linux64-ix-061", 06:51:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:51:25 INFO - "platform": "ubuntu64_hw", 06:51:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:51:25 INFO - "branch": "mozilla-aurora", 06:51:25 INFO - "repo_path": "releases/mozilla-aurora", 06:51:25 INFO - "revision": "a2db4c13a2b9ac395db681b7f16e5abb528f0663", 06:51:25 INFO - "stage_platform": "linux64-pgo", 06:51:25 INFO - "builduid": "125aad23bfe9403998211f5bbff942a5", 06:51:25 INFO - "slavebuilddir": "test" 06:51:25 INFO - } 06:51:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:51:25 INFO - Running post-action listener: _resource_record_post_action 06:51:25 INFO - ##### 06:51:25 INFO - ##### Finished read-buildbot-config step (success) 06:51:25 INFO - ##### 06:51:25 INFO - ##### 06:51:25 INFO - ##### Running download-and-extract step. 06:51:25 INFO - ##### 06:51:25 INFO - Running pre-action listener: _resource_record_pre_action 06:51:25 INFO - Running main action method: download_and_extract 06:51:25 INFO - mkdir: /builds/slave/test/build/tests 06:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:25 INFO - https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:51:27 INFO - Downloaded 1361 bytes. 06:51:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:51:27 INFO - Using the following test package requirements: 06:51:27 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:51:27 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:51:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:51:27 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:51:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:51:27 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:51:27 INFO - u'jsshell-linux-x86_64.zip'], 06:51:27 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:51:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:51:27 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:51:27 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:51:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:51:27 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:51:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:51:27 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:51:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:51:27 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:51:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:51:27 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:27 INFO - https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:51:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:51:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:51:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:33 INFO - Downloaded 24526479 bytes. 06:51:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:51:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:51:35 INFO - Return code: 0 06:51:35 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:35 INFO - https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:51:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:51:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:37 INFO - Downloaded 24526479 bytes. 06:51:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:51:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:51:39 INFO - Return code: 0 06:51:39 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')]} 06:51:39 INFO - https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:51:40 INFO - Downloaded 10833369 bytes. 06:51:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:51:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:51:40 INFO - Return code: 0 06:51:40 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')]} 06:51:40 INFO - https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:51:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:51:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:51:42 INFO - Downloaded 63618843 bytes. 06:51:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:51:42 INFO - mkdir: /builds/slave/test/properties 06:51:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:51:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:51:42 INFO - Contents: 06:51:42 INFO - build_url:https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:51:42 INFO - Running post-action listener: _resource_record_post_action 06:51:42 INFO - Running post-action listener: set_extra_try_arguments 06:51:42 INFO - ##### 06:51:42 INFO - ##### Finished download-and-extract step (success) 06:51:42 INFO - ##### 06:51:42 INFO - ##### 06:51:42 INFO - ##### Running populate-webroot step. 06:51:42 INFO - ##### 06:51:42 INFO - Running pre-action listener: _resource_record_pre_action 06:51:42 INFO - Running main action method: populate_webroot 06:51:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:42 INFO - '--tppagecycles', 06:51:42 INFO - '7'], 06:51:42 INFO - 'tests': ['tsvgm']}}, 06:51:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:51:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:51:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:51:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:42 INFO - 'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:42 INFO - 'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['damp', 'tps']}, 06:51:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:42 INFO - 'tests': ['damp', 'tps']}, 06:51:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['dromaeo_dom']}, 06:51:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['a11yr', 06:51:42 INFO - 'ts_paint', 06:51:42 INFO - 'tpaint', 06:51:42 INFO - 'sessionrestore', 06:51:42 INFO - 'sessionrestore_no_auto_restore', 06:51:42 INFO - 'tabpaint']}, 06:51:42 INFO - 'other-e10s': {'tests': ['a11yr', 06:51:42 INFO - 'ts_paint', 06:51:42 INFO - 'tpaint', 06:51:42 INFO - 'sessionrestore', 06:51:42 INFO - 'sessionrestore_no_auto_restore', 06:51:42 INFO - 'tabpaint']}, 06:51:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:51:42 INFO - 'ts_paint', 06:51:42 INFO - 'tpaint', 06:51:42 INFO - 'sessionrestore', 06:51:42 INFO - 'sessionrestore_no_auto_restore', 06:51:42 INFO - 'tabpaint']}, 06:51:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:51:42 INFO - 'ts_paint', 06:51:42 INFO - 'tpaint', 06:51:42 INFO - 'sessionrestore', 06:51:42 INFO - 'sessionrestore_no_auto_restore', 06:51:42 INFO - 'tabpaint']}, 06:51:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['a11yr', 06:51:42 INFO - 'ts_paint', 06:51:42 INFO - 'tpaint', 06:51:42 INFO - 'sessionrestore', 06:51:42 INFO - 'sessionrestore_no_auto_restore', 06:51:42 INFO - 'tabpaint']}, 06:51:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['a11yr', 06:51:42 INFO - 'ts_paint', 06:51:42 INFO - 'tpaint', 06:51:42 INFO - 'sessionrestore', 06:51:42 INFO - 'sessionrestore_no_auto_restore', 06:51:42 INFO - 'tabpaint']}, 06:51:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['tsvgx', 06:51:42 INFO - 'tsvgr_opacity', 06:51:42 INFO - 'tart', 06:51:42 INFO - 'tscrollx', 06:51:42 INFO - 'cart']}, 06:51:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:51:42 INFO - 'tsvgr_opacity', 06:51:42 INFO - 'tart', 06:51:42 INFO - 'tscrollx', 06:51:42 INFO - 'cart']}, 06:51:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:42 INFO - 'talos_options': ['--disable-e10s'], 06:51:42 INFO - 'tests': ['tp5o']}, 06:51:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:42 INFO - 'tests': ['tp5o']}, 06:51:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:42 INFO - 'talos_options': ['--disable-e10s', 06:51:42 INFO - '--xperf_path', 06:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:42 INFO - 'tests': ['tp5n']}, 06:51:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:42 INFO - 'talos_options': ['--xperf_path', 06:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:42 INFO - 'tests': ['tp5n']}}, 06:51:42 INFO - 'talos.zip': {'path': '', 06:51:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:42 INFO - Running post-action listener: _resource_record_post_action 06:51:42 INFO - ##### 06:51:42 INFO - ##### Finished populate-webroot step (success) 06:51:42 INFO - ##### 06:51:42 INFO - ##### 06:51:42 INFO - ##### Running create-virtualenv step. 06:51:42 INFO - ##### 06:51:42 INFO - Running pre-action listener: _resource_record_pre_action 06:51:42 INFO - Running main action method: create_virtualenv 06:51:42 INFO - Creating virtualenv /builds/slave/test/build/venv 06:51:42 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 06:51:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:51:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:42 INFO - Using real prefix '/usr' 06:51:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:51:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:45 INFO - Installing pip.................done. 06:51:45 INFO - Return code: 0 06:51:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:51:45 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')]} 06:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:45 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')]} 06:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:45 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 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:51:45 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 06:51:45 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 06:51:45 INFO - Using env: {'DISPLAY': ':0', 06:51:45 INFO - 'HOME': '/home/cltbld', 06:51:45 INFO - 'LANG': 'en_US.UTF-8', 06:51:45 INFO - 'LANGUAGE': 'en_US:en', 06:51:45 INFO - 'LOGNAME': 'cltbld', 06:51:45 INFO - 'MAIL': '/var/mail/cltbld', 06:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:45 INFO - 'MOZ_NO_REMOTE': '1', 06:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:45 INFO - 'NO_EM_RESTART': '1', 06:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:45 INFO - 'PWD': '/builds/slave/test', 06:51:45 INFO - 'SHELL': '/bin/bash', 06:51:45 INFO - 'SHLVL': '1', 06:51:45 INFO - 'TERM': 'linux', 06:51:45 INFO - 'TMOUT': '86400', 06:51:45 INFO - 'USER': 'cltbld', 06:51:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:45 INFO - '_': '/tools/buildbot/bin/python'} 06:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:51:46 INFO - Cleaning up... 06:51:46 INFO - Return code: 0 06:51:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:51:46 INFO - Using env: {'DISPLAY': ':0', 06:51:46 INFO - 'HOME': '/home/cltbld', 06:51:46 INFO - 'LANG': 'en_US.UTF-8', 06:51:46 INFO - 'LANGUAGE': 'en_US:en', 06:51:46 INFO - 'LOGNAME': 'cltbld', 06:51:46 INFO - 'MAIL': '/var/mail/cltbld', 06:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:46 INFO - 'MOZ_NO_REMOTE': '1', 06:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:46 INFO - 'NO_EM_RESTART': '1', 06:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:46 INFO - 'PWD': '/builds/slave/test', 06:51:46 INFO - 'SHELL': '/bin/bash', 06:51:46 INFO - 'SHLVL': '1', 06:51:46 INFO - 'TERM': 'linux', 06:51:46 INFO - 'TMOUT': '86400', 06:51:46 INFO - 'USER': 'cltbld', 06:51:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:46 INFO - '_': '/tools/buildbot/bin/python'} 06:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:46 INFO - Downloading/unpacking psutil>=3.1.1 06:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:48 INFO - Installing collected packages: psutil 06:51:48 INFO - Running setup.py install for psutil 06:51:48 INFO - building 'psutil._psutil_linux' extension 06:51:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:51:49 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 06:51:49 INFO - building 'psutil._psutil_posix' extension 06:51:49 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 06:51:49 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 06:51:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:49 INFO - Successfully installed psutil 06:51:49 INFO - Cleaning up... 06:51:49 INFO - Return code: 0 06:51:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:51:49 INFO - Using env: {'DISPLAY': ':0', 06:51:49 INFO - 'HOME': '/home/cltbld', 06:51:49 INFO - 'LANG': 'en_US.UTF-8', 06:51:49 INFO - 'LANGUAGE': 'en_US:en', 06:51:49 INFO - 'LOGNAME': 'cltbld', 06:51:49 INFO - 'MAIL': '/var/mail/cltbld', 06:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:49 INFO - 'MOZ_NO_REMOTE': '1', 06:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:49 INFO - 'NO_EM_RESTART': '1', 06:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:49 INFO - 'PWD': '/builds/slave/test', 06:51:49 INFO - 'SHELL': '/bin/bash', 06:51:49 INFO - 'SHLVL': '1', 06:51:49 INFO - 'TERM': 'linux', 06:51:49 INFO - 'TMOUT': '86400', 06:51:49 INFO - 'USER': 'cltbld', 06:51:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:49 INFO - '_': '/tools/buildbot/bin/python'} 06:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:51:50 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 06:51:50 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 06:51:50 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 06:51:50 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 06:51:50 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 06:51:50 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 06:51:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:51:52 INFO - Installing collected packages: mozsystemmonitor 06:51:52 INFO - Running setup.py install for mozsystemmonitor 06:51:52 INFO - Successfully installed mozsystemmonitor 06:51:52 INFO - Cleaning up... 06:51:52 INFO - Return code: 0 06:51:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:52 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 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:51:52 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 06:51:52 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 06:51:52 INFO - Using env: {'DISPLAY': ':0', 06:51:52 INFO - 'HOME': '/home/cltbld', 06:51:52 INFO - 'LANG': 'en_US.UTF-8', 06:51:52 INFO - 'LANGUAGE': 'en_US:en', 06:51:52 INFO - 'LOGNAME': 'cltbld', 06:51:52 INFO - 'MAIL': '/var/mail/cltbld', 06:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:52 INFO - 'MOZ_NO_REMOTE': '1', 06:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:52 INFO - 'NO_EM_RESTART': '1', 06:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:52 INFO - 'PWD': '/builds/slave/test', 06:51:52 INFO - 'SHELL': '/bin/bash', 06:51:52 INFO - 'SHLVL': '1', 06:51:52 INFO - 'TERM': 'linux', 06:51:52 INFO - 'TMOUT': '86400', 06:51:52 INFO - 'USER': 'cltbld', 06:51:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:52 INFO - '_': '/tools/buildbot/bin/python'} 06:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:52 INFO - Downloading/unpacking jsonschema==2.5.1 06:51:52 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 06:51:52 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 06:51:52 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 06:51:52 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 06:51:52 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 06:51:52 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 06:51:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:54 INFO - warning: no files found matching '*.txt' 06:51:54 INFO - no previously-included directories found matching 'build' 06:51:54 INFO - no previously-included directories found matching 'dist' 06:51:54 INFO - no previously-included directories found matching '.git*' 06:51:54 INFO - Installing collected packages: jsonschema, functools32 06:51:54 INFO - Running setup.py install for functools32 06:51:54 INFO - warning: no files found matching '*.txt' 06:51:54 INFO - no previously-included directories found matching 'build' 06:51:54 INFO - no previously-included directories found matching 'dist' 06:51:54 INFO - no previously-included directories found matching '.git*' 06:51:54 INFO - Successfully installed jsonschema functools32 06:51:54 INFO - Cleaning up... 06:51:54 INFO - Return code: 0 06:51:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:51:54 INFO - Using env: {'DISPLAY': ':0', 06:51:54 INFO - 'HOME': '/home/cltbld', 06:51:54 INFO - 'LANG': 'en_US.UTF-8', 06:51:54 INFO - 'LANGUAGE': 'en_US:en', 06:51:54 INFO - 'LOGNAME': 'cltbld', 06:51:54 INFO - 'MAIL': '/var/mail/cltbld', 06:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:54 INFO - 'MOZ_NO_REMOTE': '1', 06:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:54 INFO - 'NO_EM_RESTART': '1', 06:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:54 INFO - 'PWD': '/builds/slave/test', 06:51:54 INFO - 'SHELL': '/bin/bash', 06:51:54 INFO - 'SHLVL': '1', 06:51:54 INFO - 'TERM': 'linux', 06:51:54 INFO - 'TMOUT': '86400', 06:51:54 INFO - 'USER': 'cltbld', 06:51:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:54 INFO - '_': '/tools/buildbot/bin/python'} 06:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:55 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 06:51:55 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 06:51:55 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 06:51:55 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 06:51:55 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 06:51:55 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 06:51:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - Downloading docopt-0.6.1.tar.gz 06:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:57 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:57 INFO - Running setup.py install for blobuploader 06:51:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:58 INFO - Running setup.py install for requests 06:51:58 INFO - Running setup.py install for docopt 06:51:58 INFO - Successfully installed blobuploader requests docopt 06:51:58 INFO - Cleaning up... 06:51:58 INFO - Return code: 0 06:51:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:58 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')]} 06:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:58 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')]} 06:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:58 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 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:51:58 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 06:51:58 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 06:51:58 INFO - Using env: {'DISPLAY': ':0', 06:51:58 INFO - 'HOME': '/home/cltbld', 06:51:58 INFO - 'LANG': 'en_US.UTF-8', 06:51:58 INFO - 'LANGUAGE': 'en_US:en', 06:51:58 INFO - 'LOGNAME': 'cltbld', 06:51:58 INFO - 'MAIL': '/var/mail/cltbld', 06:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:58 INFO - 'MOZ_NO_REMOTE': '1', 06:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:58 INFO - 'NO_EM_RESTART': '1', 06:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:58 INFO - 'PWD': '/builds/slave/test', 06:51:58 INFO - 'SHELL': '/bin/bash', 06:51:58 INFO - 'SHLVL': '1', 06:51:58 INFO - 'TERM': 'linux', 06:51:58 INFO - 'TMOUT': '86400', 06:51:58 INFO - 'USER': 'cltbld', 06:51:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:58 INFO - '_': '/tools/buildbot/bin/python'} 06:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:58 INFO - Running setup.py (path:/tmp/pip-AAOfdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:58 INFO - Running setup.py (path:/tmp/pip-5VbXzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:58 INFO - Running setup.py (path:/tmp/pip-gw7O_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:58 INFO - Running setup.py (path:/tmp/pip-tdqzXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:59 INFO - Running setup.py (path:/tmp/pip-78JqbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:59 INFO - Running setup.py (path:/tmp/pip-P9CCYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:59 INFO - Running setup.py (path:/tmp/pip-Pmb3GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:59 INFO - Running setup.py (path:/tmp/pip-hwDNkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:59 INFO - Running setup.py (path:/tmp/pip-12N33I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:59 INFO - Running setup.py (path:/tmp/pip-InFAax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:59 INFO - Running setup.py (path:/tmp/pip-x4PVy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:59 INFO - Running setup.py (path:/tmp/pip-auUkhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:59 INFO - Running setup.py (path:/tmp/pip-n1HRfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:59 INFO - Running setup.py (path:/tmp/pip-aebMUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:59 INFO - Running setup.py (path:/tmp/pip-PD9thc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:59 INFO - Running setup.py (path:/tmp/pip-QLrNp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:59 INFO - Running setup.py (path:/tmp/pip-2IJsEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:59 INFO - Running setup.py install for manifestparser 06:52:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Running setup.py install for mozcrash 06:52:00 INFO - Running setup.py install for mozdebug 06:52:00 INFO - Running setup.py install for mozdevice 06:52:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Running setup.py install for mozfile 06:52:00 INFO - Running setup.py install for mozhttpd 06:52:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Running setup.py install for mozinfo 06:52:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Running setup.py install for mozInstall 06:52:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:52:00 INFO - Running setup.py install for mozleak 06:52:00 INFO - Running setup.py install for mozlog 06:52:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:52:01 INFO - Running setup.py install for moznetwork 06:52:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:52:01 INFO - Running setup.py install for mozprocess 06:52:01 INFO - Running setup.py install for mozprofile 06:52:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:52:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:52:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:52:01 INFO - Running setup.py install for mozrunner 06:52:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:52:01 INFO - Running setup.py install for mozscreenshot 06:52:01 INFO - Running setup.py install for moztest 06:52:01 INFO - Running setup.py install for mozversion 06:52:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:52:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:01 INFO - Cleaning up... 06:52:01 INFO - Return code: 0 06:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:01 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')]} 06:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:01 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')]} 06:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:01 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 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:52:01 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 06:52:01 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 06:52:01 INFO - Using env: {'DISPLAY': ':0', 06:52:01 INFO - 'HOME': '/home/cltbld', 06:52:01 INFO - 'LANG': 'en_US.UTF-8', 06:52:01 INFO - 'LANGUAGE': 'en_US:en', 06:52:01 INFO - 'LOGNAME': 'cltbld', 06:52:01 INFO - 'MAIL': '/var/mail/cltbld', 06:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:01 INFO - 'MOZ_NO_REMOTE': '1', 06:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:01 INFO - 'NO_EM_RESTART': '1', 06:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:01 INFO - 'PWD': '/builds/slave/test', 06:52:01 INFO - 'SHELL': '/bin/bash', 06:52:01 INFO - 'SHLVL': '1', 06:52:01 INFO - 'TERM': 'linux', 06:52:01 INFO - 'TMOUT': '86400', 06:52:01 INFO - 'USER': 'cltbld', 06:52:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:01 INFO - '_': '/tools/buildbot/bin/python'} 06:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:01 INFO - Running setup.py (path:/tmp/pip-maiCe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:52:02 INFO - Running setup.py (path:/tmp/pip-3DDUrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:02 INFO - Running setup.py (path:/tmp/pip-1OPcVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:02 INFO - Running setup.py (path:/tmp/pip-WAr7ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:02 INFO - Running setup.py (path:/tmp/pip-BLlYrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:52:02 INFO - Running setup.py (path:/tmp/pip-FDVgp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:02 INFO - Running setup.py (path:/tmp/pip-slT6lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:02 INFO - Running setup.py (path:/tmp/pip-ReATSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:02 INFO - Running setup.py (path:/tmp/pip-AnzRy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:02 INFO - Running setup.py (path:/tmp/pip-MCbaDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:02 INFO - Running setup.py (path:/tmp/pip-lesgNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:52:02 INFO - Running setup.py (path:/tmp/pip-82NRj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:02 INFO - Running setup.py (path:/tmp/pip-3dtRgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:02 INFO - Running setup.py (path:/tmp/pip-oBxZaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:03 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)) 06:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:03 INFO - Running setup.py (path:/tmp/pip-mJumEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:03 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)) 06:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:03 INFO - Running setup.py (path:/tmp/pip-Jw5TVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:03 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)) 06:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:03 INFO - Running setup.py (path:/tmp/pip-H1tNrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:03 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)) 06:52:03 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)) 06:52:03 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)) 06:52:03 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)) 06:52:03 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)) 06:52:03 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)) 06:52:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:03 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 06:52:03 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 06:52:03 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 06:52:03 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 06:52:03 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 06:52:03 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 06:52:05 INFO - Downloading blessings-1.6.tar.gz 06:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:05 INFO - Installing collected packages: blessings 06:52:05 INFO - Running setup.py install for blessings 06:52:05 INFO - Successfully installed blessings 06:52:05 INFO - Cleaning up... 06:52:05 INFO - Return code: 0 06:52:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:52:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:06 INFO - Reading from file tmpfile_stdout 06:52:06 INFO - Current package versions: 06:52:06 INFO - argparse == 1.2.1 06:52:06 INFO - blessings == 1.6 06:52:06 INFO - blobuploader == 1.2.4 06:52:06 INFO - docopt == 0.6.1 06:52:06 INFO - functools32 == 3.2.3-2 06:52:06 INFO - jsonschema == 2.5.1 06:52:06 INFO - manifestparser == 1.1 06:52:06 INFO - mozInstall == 1.12 06:52:06 INFO - mozcrash == 0.17 06:52:06 INFO - mozdebug == 0.1 06:52:06 INFO - mozdevice == 0.48 06:52:06 INFO - mozfile == 1.2 06:52:06 INFO - mozhttpd == 0.7 06:52:06 INFO - mozinfo == 0.9 06:52:06 INFO - mozleak == 0.1 06:52:06 INFO - mozlog == 3.2 06:52:06 INFO - moznetwork == 0.27 06:52:06 INFO - mozprocess == 0.22 06:52:06 INFO - mozprofile == 0.28 06:52:06 INFO - mozrunner == 6.11 06:52:06 INFO - mozscreenshot == 0.1 06:52:06 INFO - mozsystemmonitor == 0.3 06:52:06 INFO - moztest == 0.7 06:52:06 INFO - mozversion == 1.4 06:52:06 INFO - psutil == 3.1.1 06:52:06 INFO - requests == 1.2.3 06:52:06 INFO - wsgiref == 0.1.2 06:52:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:06 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')]} 06:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:06 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')]} 06:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:06 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 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:52:06 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 06:52:06 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 06:52:06 INFO - Using env: {'DISPLAY': ':0', 06:52:06 INFO - 'HOME': '/home/cltbld', 06:52:06 INFO - 'LANG': 'en_US.UTF-8', 06:52:06 INFO - 'LANGUAGE': 'en_US:en', 06:52:06 INFO - 'LOGNAME': 'cltbld', 06:52:06 INFO - 'MAIL': '/var/mail/cltbld', 06:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:06 INFO - 'MOZ_NO_REMOTE': '1', 06:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:06 INFO - 'NO_EM_RESTART': '1', 06:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:06 INFO - 'PWD': '/builds/slave/test', 06:52:06 INFO - 'SHELL': '/bin/bash', 06:52:06 INFO - 'SHLVL': '1', 06:52:06 INFO - 'TERM': 'linux', 06:52:06 INFO - 'TMOUT': '86400', 06:52:06 INFO - 'USER': 'cltbld', 06:52:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:06 INFO - '_': '/tools/buildbot/bin/python'} 06:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 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)) 06:52:06 INFO - Cleaning up... 06:52:06 INFO - Return code: 0 06:52:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:52:06 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')]} 06:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:06 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')]} 06:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:06 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 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:52:06 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 06:52:06 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 06:52:06 INFO - Using env: {'DISPLAY': ':0', 06:52:06 INFO - 'HOME': '/home/cltbld', 06:52:06 INFO - 'LANG': 'en_US.UTF-8', 06:52:06 INFO - 'LANGUAGE': 'en_US:en', 06:52:06 INFO - 'LOGNAME': 'cltbld', 06:52:06 INFO - 'MAIL': '/var/mail/cltbld', 06:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:06 INFO - 'MOZ_NO_REMOTE': '1', 06:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:06 INFO - 'NO_EM_RESTART': '1', 06:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:06 INFO - 'PWD': '/builds/slave/test', 06:52:06 INFO - 'SHELL': '/bin/bash', 06:52:06 INFO - 'SHLVL': '1', 06:52:06 INFO - 'TERM': 'linux', 06:52:06 INFO - 'TMOUT': '86400', 06:52:06 INFO - 'USER': 'cltbld', 06:52:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:06 INFO - '_': '/tools/buildbot/bin/python'} 06:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:52:06 INFO - Cleaning up... 06:52:06 INFO - Return code: 0 06:52:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:52:06 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')]} 06:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:06 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')]} 06:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:06 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 0x7f62a46f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2488350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', '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 06:52:06 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 06:52:06 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 06:52:06 INFO - Using env: {'DISPLAY': ':0', 06:52:06 INFO - 'HOME': '/home/cltbld', 06:52:06 INFO - 'LANG': 'en_US.UTF-8', 06:52:06 INFO - 'LANGUAGE': 'en_US:en', 06:52:06 INFO - 'LOGNAME': 'cltbld', 06:52:06 INFO - 'MAIL': '/var/mail/cltbld', 06:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:06 INFO - 'MOZ_NO_REMOTE': '1', 06:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:06 INFO - 'NO_EM_RESTART': '1', 06:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:06 INFO - 'PWD': '/builds/slave/test', 06:52:06 INFO - 'SHELL': '/bin/bash', 06:52:06 INFO - 'SHLVL': '1', 06:52:06 INFO - 'TERM': 'linux', 06:52:06 INFO - 'TMOUT': '86400', 06:52:06 INFO - 'USER': 'cltbld', 06:52:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:06 INFO - '_': '/tools/buildbot/bin/python'} 06:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:06 INFO - Downloading/unpacking flake8 06:52:06 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 06:52:06 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 06:52:06 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 06:52:06 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 06:52:06 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 06:52:06 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 06:52:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:52:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:52:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:52:09 INFO - no previously-included directories found matching 'docs/_build' 06:52:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:52:09 INFO - Running setup.py install for pep8 06:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:52:09 INFO - no previously-included directories found matching 'docs/_build' 06:52:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:52:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:52:09 INFO - Cleaning up... 06:52:09 INFO - Return code: 0 06:52:09 INFO - Running post-action listener: _resource_record_post_action 06:52:09 INFO - Running post-action listener: _start_resource_monitoring 06:52:09 INFO - Starting resource monitoring. 06:52:09 INFO - ##### 06:52:09 INFO - ##### Finished create-virtualenv step (success) 06:52:09 INFO - ##### 06:52:09 INFO - ##### 06:52:09 INFO - ##### Running install step. 06:52:09 INFO - ##### 06:52:09 INFO - Running pre-action listener: _resource_record_pre_action 06:52:09 INFO - Running main action method: install 06:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:09 INFO - Reading from file tmpfile_stdout 06:52:09 INFO - Detecting whether we're running mozinstall >=1.0... 06:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:52:09 INFO - Reading from file tmpfile_stdout 06:52:09 INFO - Output received: 06:52:09 INFO - Usage: mozinstall [options] installer 06:52:09 INFO - Options: 06:52:09 INFO - -h, --help show this help message and exit 06:52:09 INFO - -d DEST, --destination=DEST 06:52:09 INFO - Directory to install application into. [default: 06:52:09 INFO - "/builds/slave/test"] 06:52:09 INFO - --app=APP Application being installed. [default: firefox] 06:52:09 INFO - mkdir: /builds/slave/test/build/application 06:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:52:25 INFO - Reading from file tmpfile_stdout 06:52:25 INFO - Output received: 06:52:25 INFO - /builds/slave/test/build/application/firefox/firefox 06:52:25 INFO - Running post-action listener: _resource_record_post_action 06:52:25 INFO - ##### 06:52:25 INFO - ##### Finished install step (success) 06:52:25 INFO - ##### 06:52:25 INFO - ##### 06:52:25 INFO - ##### Running run-tests step. 06:52:25 INFO - ##### 06:52:25 INFO - Running pre-action listener: _resource_record_pre_action 06:52:25 INFO - Running main action method: run_tests 06:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:52:25 INFO - Python 2.7.3 06:52:25 INFO - Return code: 0 06:52:25 INFO - grabbing minidump binary from tooltool 06:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25171c0>, '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 0x25180c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2518550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:52:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:52:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:52:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:52:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:25 INFO - Return code: 0 06:52:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:52:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:52:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:52:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:52:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:52:26 INFO - Return code: 0 06:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 06:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 06:52:26 INFO - Using env: {'DISPLAY': ':0', 06:52:26 INFO - 'HOME': '/home/cltbld', 06:52:26 INFO - 'LANG': 'en_US.UTF-8', 06:52:26 INFO - 'LANGUAGE': 'en_US:en', 06:52:26 INFO - 'LOGNAME': 'cltbld', 06:52:26 INFO - 'MAIL': '/var/mail/cltbld', 06:52:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:52:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:26 INFO - 'MOZ_NO_REMOTE': '1', 06:52:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:26 INFO - 'NO_EM_RESTART': '1', 06:52:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:26 INFO - 'PWD': '/builds/slave/test', 06:52:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:52:26 INFO - 'SHELL': '/bin/bash', 06:52:26 INFO - 'SHLVL': '1', 06:52:26 INFO - 'TERM': 'linux', 06:52:26 INFO - 'TMOUT': '86400', 06:52:26 INFO - 'USER': 'cltbld', 06:52:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637', 06:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:26 INFO - '_': '/tools/buildbot/bin/python'} 06:52:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 06:52:27 INFO - mozversion application_buildid: 20160704041625 06:52:27 INFO - mozversion application_changeset: a2db4c13a2b9ac395db681b7f16e5abb528f0663 06:52:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:52:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:27 INFO - mozversion application_name: Firefox 06:52:27 INFO - mozversion application_remotingname: firefox-dev 06:52:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:52:27 INFO - mozversion application_vendor: Mozilla 06:52:27 INFO - mozversion application_version: 49.0a2 06:52:27 INFO - mozversion platform_buildid: 20160704041625 06:52:27 INFO - mozversion platform_changeset: a2db4c13a2b9ac395db681b7f16e5abb528f0663 06:52:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:52:27 INFO - mozversion platform_version: 49.0a2 06:52:27 INFO - using testdate: 1467640347 06:52:27 INFO - actual date: 1467640347 06:52:27 INFO - starting webserver on 'localhost:40430' 06:52:27 INFO - SUITE-START | Running 2 tests 06:52:27 INFO - TEST-START | dromaeo_css 06:52:27 INFO - operating with platform_type : linux_ 06:52:27 INFO - Initialising browser for dromaeo_css test... 06:52:27 INFO - TEST-INFO | started process 3370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlPAT9/profile http://localhost:40430/getInfo.html) 06:52:32 INFO - PROCESS | 3370 | __metrics Screen width/height:1600/1200 06:52:32 INFO - PROCESS | 3370 | colorDepth:24 06:52:32 INFO - PROCESS | 3370 | Browser inner width/height: 1024/697 06:52:32 INFO - PROCESS | 3370 | __metrics 06:52:33 ERROR - PROCESS | 3370 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:52:34 INFO - TEST-INFO | 3370: exit 0 06:52:34 INFO - Browser initialized. 06:52:34 INFO - Running cycle 1/1 for dromaeo_css test... 06:52:34 INFO - TEST-INFO | started process 3461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlPAT9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:46 INFO - PROCESS | 3461 | RSS: Main: 144949248 06:52:46 INFO - PROCESS | 3461 | 06:53:37 INFO - PROCESS | 3461 | 1467640417479 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] 06:55:45 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:40430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40430/tests/dromaeo/cssquery-ext.html) 06:55:46 INFO - PROCESS | 3461 | RSS: Main: 257732608 06:55:46 INFO - PROCESS | 3461 | 06:58:49 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:40430/tests/dromaeo/cssquery-ext.html (next: http://localhost:40430/tests/dromaeo/cssquery-jquery.html) 06:58:49 INFO - PROCESS | 3461 | RSS: Main: 229638144 06:58:49 INFO - PROCESS | 3461 | 07:01:51 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:40430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40430/tests/dromaeo/cssquery-mootools.html) 07:01:52 INFO - PROCESS | 3461 | RSS: Main: 235905024 07:01:52 INFO - PROCESS | 3461 | 07:04:54 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:40430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40430/tests/dromaeo/cssquery-prototype.html) 07:04:54 INFO - PROCESS | 3461 | RSS: Main: 220905472 07:04:54 INFO - PROCESS | 3461 | 07:07:57 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:40430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40430/tests/dromaeo/cssquery-yui.html) 07:07:57 INFO - PROCESS | 3461 | RSS: Main: 215420928 07:07:57 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:40430/tests/dromaeo/cssquery-yui.html (next: http://localhost:40430/tests/dromaeo/cssquery-dojo.html) 07:11:00 INFO - PROCESS | 3461 | RSS: Main: 261079040 07:11:00 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | __start_tp_report 07:11:00 INFO - PROCESS | 3461 | _x_x_mozilla_page_load 07:11:00 INFO - PROCESS | 3461 | _x_x_mozilla_page_load_details 07:11:00 INFO - PROCESS | 3461 | |i|pagename|runs| 07:11:00 INFO - PROCESS | 3461 | |0;dojo.html;3441.8279086045695;3462.948055779164;3471.5834099908016;3494.2662040971395;3510.0347404463787;5681.659100453976;5692.089265717481;5748.71256437178;5751.194832723422;5792.189093526904;5656.858578535539;5681.403452637475;5702.258706368177;5704.600677952545;5716.942830571693;5085.135526960416;5108.386993560778;5136.794528218867;5141.485851414866;5153.665011774241;5222.973885130588;5263.86840328991;5265.710385928773;5268.762905669235;5274.498922602346;5155.329807125068;5204.9219261711105;5229.3201883755055;5238.79044838206;5253;5290.232916227164;5300.416954135042;5302.549283310923;5309.362876454811;5337.653052551591;5045.318881950963;5076.517730815566;5124.333836601255;5215.869603259911;5220.530152286275;5548.86127846803;5561.026820306471;5563.944360556383;5598.916016259759;5605.523530499912;6140.969295153495;6154.138420621117;6156.230471191101;6157.230346206724;6159.19930409044;6153.353897840707;6163.845903852395;6191.288001879797;6210.378962103799;6240.188775459206;5816;5832.387599302055;5861.17943487912;5862.237909071793;5869.882602347929;6075.830753971228;6304.590201636879;6313.77901773445;6316.084167795644;6316.747330106836;6021.488173505301;6031.577789554777;6077.787277445356;6122.938770612237;6133.6505968686815;6141.758258235801;6164.845878853064;6165.198524191826;6181.938180618226;6196.845078872974;5969.313528944227;6008.3390827009;6032.607880487754;6033.336333003366;6077.878442431127;5898.528117750656;6056.939430605637;6062.302835174011;6066.726997285133;6101.542384321194;4605.98668292975;4615.284630882219;4619.3071039343695;4620.953790462119;4628.791704373311;4115.464989551339;4136.358864376027;4142.212979533879;4153.252414565347;4182.53992060873;5907.409259074144;5929.525637948954;5929.555283353766;5931.466168044896;5942.465178133989;6216.844578885564;6261.5616906816995;6265.279492858289;6266.060090986297;6282.2147231596055;5716.771329146871;5800.50695690871;5834.299884013861;5856.209411729362;5897.498712609477;5073.416557095908;5074.847754567369;5098.796048158107;5102.540771330598;5141.820036298712;6402.167718196604;6421.935780642228;6424.196975378171;6428.967855160694;6430.131932189188;6090.208272924491;6109.11417844419;6114.206128133634;6118.345080237391;6179.62922224668;6341.746330146742;6371.522135839923;6381.489480841615;6384;6384.265809431975;5921.911171332347;6054.9091763624465;6059.363766804422;6059.545534084873;6067.211262535842;6063.484603808725;6095.51235901118;6131.48134319063;6133.754649813957;6159.969200153971;5969.04495280753;6020.488258497901;6032.788852390146;6036.305824830025;6055.878882422415;5890.087036509348;5929.288485381781;5989.131575921554;5997.730102145327;6001.4298641628975;5800.651960882361;5826.563007774519;5860.413958604106;5863.120531920075;5887.558433117448;6017.849553761191;6045.6070355426755;6051.213342265477;6056.152138700498;6057.363976782374;5709.7145142741865;5806.477417032487;5827.388124246893;5874.647521148574;5882 07:11:00 INFO - PROCESS | 3461 | |1;ext.html;593.3947373678848;642.2613993907008;642.8007317731503;651.7230177174699;661.0315887225214;32988.5051724224;37910.24179516408;38543.61456385435;38667.80666096669;42015.369769453486;47942;48228.51771482284;48439;48464;48510.51489485104;8126.146754590742;9016.459012459258;9222.907770922306;10738.892611073907;10999.560017599286;10844.566217351297;10911.83632245517;10945.343279403261;10951.83572246417;10962.177836662282;11072.114230861513;11110.277831940939;11119.27724697892;11124.165687573424;11131.387773672444;8430.873536896952;10940.56237750493;11166.050885674727;11181.496832642551;11212.04697600705;10654.147668186526;10680.839787403194;10710.41092739899;11031.889681103246;11040.061594764455;45787.31319030217;46230;46448;46999.53000469986;47021.76489117567;3603.369410353204;4022.8591999279884;4336.739795612273;4357.2592659248;4380.386745855582;35663.64336356629;36171.276574468626;36429;36467.817660911795;36511.4523282151;4576.153411618861;4592.977035114836;4617.630589552828;4705.623550115983;4729.408823897013;384523;385267;385299;386734.0663296694;391260;34137.65862341395;34682.65317346845;70414;71167;71245;41369.37945930753;41386.37920431196;41404;41622;41622.79188604037;14729.55811325662;16906.915465422593;17020.234089466005;17025.744613830804;17027;13732.382042808098;14084.15495070299;14112.647183820281;14492.420303187966;14530.636734081521;9087.545622718837;9134.771630709285;9185.77035574116;9247.72256832296;9318.207952324128;3558.1994051338243;3570.9642903571153;3614.981925090358;3628.346897558412;3716.888493345204;1145.1411441418936;1207.3178654060428;1210.5762982955896;1227.380173012623;1248.494359784289;33173;33346.833265834;33444.33111337759;33623;34071.48892766561;1259.1123258103016;1271.7075072733323;1292.8836404723431;1296.8703129686955;1303.0552849184267;17552.297908083532;17782.822171778374;17923.641527169384;18019.369322073664;18054.458366249033;438087;441206;442756;443801;443912;59855.401445984986;60344.69827650922;60424.697876510334;60513;60785.696071519356;1353.810466534686;1491.4779827060659;1504.7968524249304;1527.7784721215362;1547.7678348247853;33864;34623.82688086543;35046.82476587601;35134.12164695801;35624.821875890455;53199.20201197063;53242.46757532375;53671;53890;53947;430968;433814;433967;434261;434678;25374.619380708937;30182;30707.07878763641;30879.845600771852;32289.838550807097;42250.15499689928;42293;42973.785131074146;43149.352759709254;43591;42380.36429453622;43314.56685433105;43770;43973.34039989467;44942;36207.45688814722;36385.45421818622;36388.27223455463;37256.44115338218;37293.25413491769;42979.570204298805;43461;43577.56422435735;44189.348639081756;44210.83107457164;37643.62356376401;39123.80438097791;39161.020974474726;39197.60802392053;39797;28974.130776076752;29240.415191696473;29299;29458.558121627764;29459.85270073636 07:11:00 INFO - PROCESS | 3461 | |2;jquery.html;418.47690387016223;421.5426262505182;422.74001489084213;425.6254496043479;431.7517427479198;18692.813071869277;19465;20392.184312627494;20668.379948601527;20787.688184677205;14979.77530337043;19511.21955121797;19617.01914904256;19893.602127957467;20634.277800276992;5671.347795003576;5887.617304875191;5965.522758179335;5967.552433567478;5971.5819892607315;5819.010768169422;5909.852253693649;5920.378360272152;5923.111533270001;5936.168936348915;4338.197433474817;5849.9707501462435;5853.414658534134;5871.236739223917;6238.282597501277;6530.967345163268;6586.538942274043;6642.900356494656;6662.20053593567;6671.999999999975;5675.318961724578;5956.702164891782;5956.910646340309;5971.820845374646;5973.223480947492;20355;20581.07385167671;23358.299251022498;23769.762302376927;23896.402589935216;2545.350935511433;2660.3349162709324;2678.1563807400607;2752.8898844046216;3127.796693214934;14580.562583122522;15215.923920380437;15392.923035384863;15453.304601292968;16096;2037.7758446570865;2056.8663036902553;2070.8861012644297;2165.1447678167037;2217.6895234667;78707.60646196733;80882.59558702228;81349;81614.59192704057;81621;10800.891991080145;11188.328700278009;11208.495617697223;11302.37836918961;11305.773884522428;15625.531234062997;15734.606634834221;15737.68524629501;15747.921260393625;15776.526704198892;8698.304135669132;8746.475211487332;8905.332100092519;9003.909960900439;9209.723708288762;8525;8542.40203185771;8552.914470855336;8597.570121494025;8672.69645562415;6951.165860096719;7047.295270472911;7068.893966590505;7122.394596459256;7146.14246290438;1989.7910719374547;2034.2879992002681;2040.367925376248;2060.6908963655274;2072.4922394013565;1032.8244198486275;1090.432974853072;1106.9225154239125;1132.0886686217673;1171.8769529199483;19715.11281992285;20077.59844803125;20674.58650826975;20783.376498705064;20903.95480226013;1093.3599600599102;1113.0372228022702;1155.6706338693432;1205.879412058787;1228.0789407944042;9552.856707149398;11567.132465064986;11941.462634181482;11950.521979120738;11974.64076077719;404312;406089;408037;554580;559584;66415;100696;103899.480502597;107682.46158769312;108957;1084.1326938449208;1091.5251865438559;1107.4352080438873;1124.2130508643982;1125.3641692443907;18333.81666183321;18377.632447350712;18531.258749649864;18596;18972.430827075208;43395.56604433915;44017.559824402626;44944.77527612472;45988.08023839571;46445.303320449544;57917.710411447675;58863;59242.40757592369;59722.104168436636;61413.69293153506;8814.206721395105;8936.24041956415;9061.592228349607;9234.95382523083;9404.717858464257;12057.698557536132;13202.07585469008;13309.66725831862;13368.398422070835;13836.515721949683;12069.155159139127;12069.818952715892;12187.268763874195;12201.145919785884;12246.693832654255;11712.063034957013;11959.342236177094;11997.820032699341;12219.816702749644;12442.191257568229;12244.448999794853;12446.25322480654;12516.311602861566;12521.186122901981;12566.246025238515;8783.824323513621;8927.151920567536;9075.2286055686;9099.454032758056;9167.541622918694;9066.002739698759;12110.697232568904;12258.75482490363;12327.876721233031;12543.937280313905 07:11:00 INFO - PROCESS | 3461 | |3;mootools.html;1357.0975301424553;1534.186880953095;1577.8027746531684;1806.4490330449207;1979.8218160365554;8454.492730436179;9298.116678915509;9607.711768646934;9611.375260608056;9640.710778676634;9210.585523651434;9478.383905046167;9495.525223738803;9709.368891022079;9736.610535578586;2181.160253302482;2251;2485.3662316109458;2541.9364515887114;2598.233521111277;2548.7833534149618;2580.7548282913185;2582.18661121747;2586.237060067285;2588.2235329401196;2506.6240063990367;2514.962275565859;2583.083005533037;2588.430545280045;2591.144922175687;2164.8592841465334;2436.2447641231274;2472.258322503251;2505.2108585795418;2514.333701569086;2537.314924970248;2537.378342306128;2558.385987363038;2560.0527804712187;2561.743825617442;9441.716748497556;9468.289878259158;9470.479123648196;9473.810523789485;9507.90492095077;5544;5715.942840571583;5729.512991395736;5736.655800651933;5747.683877386742;3762.285165818486;3762.717796165271;3775.8112094395447;3803.885883423474;3816.809159542012;1201.4293210724923;1202.6271855724754;1224.8530176378802;1241.8944389726885;1251.7997120460773;13850.238236896967;14017.579472615736;14043.929780351033;14049.43802247909;14143.787843182361;5096.61775366849;5145.562627176732;5185.248139019821;5199.324087868553;5273.393559740679;11725.530978760924;11747.647570572897;11775.23460975034;11828.645140645795;11840;5851.502622277154;5863.442972917566;5910.408959104056;5918.171455996164;5949.167116603679;4772.141014617333;4897.583705385082;5359.5712343012465;5366.409694933554;5385.084535628953;4378.387025816388;4384.6711496637245;4388.4733831940375;4446.088551846864;4461.263891457938;1347.8247827782325;1386.2652794019186;1387.861213878604;1390.9652258693613;1397.6226418867052;913.1097180249204;995.5918073589938;995.865558149655;1017.527964595613;1017.6285655735603;6339.302676705559;6345.777897773648;6517.3808488193545;6667.433268172163;6667.566608170453;498.7456397237435;500.19468655464675;501.4809671989473;503.57447956476716;518.6654607777962;4537.3647689323525;4544.636429085665;4557.794899229542;4558.0428110097255;4562;12091.153619246568;12554.372281386077;12579.37103144839;12595.874041259653;12629.2422454653;11589.24669896454;12087.697807554705;12130.757384852253;12473.126881118234;12478.313692746804;9076.727698169065;9099.81800363989;9133.908660913306;9149.085091490932;9270.30472714549;6374.776882809079;6382.042693595998;6557.114789503356;6572.8356791080605;6773.661316934232;11011.174161937726;11138.108951283715;11180.440977950908;11187.384693841592;11622.0702343814;11436.085113190758;11752.177347585586;11810.350430726392;11822;11944;8699.478031318142;8785.341099417441;9023.684171053981;9168.862467062865;9346.20557252614;9740.366876153028;9801.16690081351;9827.213822894008;9876.160526355341;9878.950605247215;8545.572721364031;8679;8696.086910874266;8717.564121794012;8847.51338676379;8268.2558569729;8310.626021829154;8409.95795021021;8410.201030902055;8493.830123397622;7538.3592394644875;7571.545707257362;7628.54228746277;7631.3131818136635;7648.502847314907;5372.811951581676;5377.462253774591;5490.5607551395;5584.86037849057;5602.971985140048;5429.131338985743;5443.401225865231;5458.5087342139395;5466.562674986071;5574.303212098488 07:11:00 INFO - PROCESS | 3461 | |4;prototype.html;353.99823000884993;355.52892417546747;362.9800360980146;366.3003663003662;367.1775223499362;5536.723163841807;5615.915761263579;5617.494425501704;5631.60578759487;5636.4363563643665;5433.8369848904495;5462.808801691942;5549.889002219953;5582.2694964561015;5596.720163991805;4140.399642051901;4284.892877678068;4287.592678695519;4296.677749168809;4317.11499142675;4232.227890731576;4295.4201182840225;4314.805833737473;4317.625306081658;4317.676174286926;4266.2320782259185;4282.850100246492;4288.421063156465;4291.871243862689;4340.913181736363;4192.895177620553;4259.744415335059;4266.765327906964;4275.102228532012;4320.265554855682;3763.473113764075;3772.5850156482766;3774.999625099351;3780.300644380771;3789.374753165752;5225.634205605609;5255.264263003182;5282.966058067672;5286.748649580519;5308.442613525563;4751.453582837983;4905;4907.1903135982875;4926.162552366106;4929.433115191727;5606.355269144019;5712.828615141552;5724.484796368347;5726.398728133528;5755.769769209227;4106.733062350938;4143.627073563363;4157.524078951989;4169.332906734908;4170.395292682544;5671.63134396267;5942;6004.18943442634;6018.368071352533;6019.127226552169;4204.201201771653;4245.150969806051;4257.914841703148;4262.190183865056;4271.423357846713;4316.978415107905;4318.805653745589;4334.306510958295;4337.262665346899;4350.58669426404;4781.187198176319;4883.145449546386;4903.940345055085;4907.901841963212;4919.77860996256;5749.626274292157;5770.451807078321;5780.1907732917425;5783.248177736868;5801.419858014249;1474.7714104313848;1474.8598883106088;1479.8668119869265;1491.8885430354455;1494.215536843166;921.9585118669676;956.961696559241;959.3140904253493;965.5992763003275;972.0473935543207;4975.875603109951;4976.253561965662;5009.949900500948;5011.699298042129;5046.697198168122;5289.68261904287;5300.3639563252655;5317.468253174651;5324.92012619811;5360.7649956533905;4891.29076283944;5035.974820125876;5061.038402703474;5092.719900405513;5118.206677964921;2857.9711303930567;2862.7566656833988;2864.756495697889;2878.2372671242138;2885.293103189732;5396.379416367089;5442.374126975448;5519.751611177427;5528.336599608073;5529.170624406291;5337.226102215157;5656.9270125509565;5850.210221620112;5986.161937328778;6134.079888016744;5997.610155339976;6007.489363404072;6014.248218972629;6016.278046634432;6168.858761129205;5984.611000284967;5988.311344195299;5988.970055149696;5998.220231369894;6022.638641681513;5637.238972738792;5905.645661260338;5910.940890591039;5923.614965027259;5928.733207005781;5865.4134586541;6023;6074.514038876968;6098.5426093042315;6135.263768347827;4184.267753143248;4194.266003449323;4200.550809970555;4201.159768046342;4212.304969679968;5955.731992060281;5970.08957133713;5979.369077605839;5983.341832398346;5984.611000284967;5646.717907241115;5732.369439361751;5774.711264436845;5805.809808989232;5850.063989761617;5765.682887441231;5765.8558536036935;5774.855628609151;5785.016547186904;5789.507891829073;5503.559715222693;5620.606557540933;5666.631668941505;5689.374168841341;5718.599698021098;5860.970695146497;5872.647641141545;5885.705714714161;5887.941120588739;5893.351731309467;5633.521150702072;5693.5445164387575;5701.344345400332;5707.971460142673;5735.971320143372 07:11:00 INFO - PROCESS | 3461 | |5;yui.html;861.4200469593565;867.73534072108;896.4173287363217;906.6464079009186;910.1308250620662;15837.762433563506;17150.571235719115;17197.656046879056;17237.310507579696;17257.741133882984;15508.922455387736;15735.370585176579;15739;16376.590585235375;17062.573435664115;743.7768669399186;872.3108744092191;893.7988952485688;904.2088172848757;906.5059542549293;896.932730045246;906.3610154840821;910.1353713971753;910.2308549275884;910.9544522773868;788.2787249666549;920.6133423961919;959.472290240365;960.7742180587557;963.6627180486809;943.32552225159;944.9905500944972;945.2910317262053;945.3382632157517;947.6067432015706;695.3533214110874;695.4297476069625;695.4679670052413;695.766918082443;696.0359901536358;16459.177041147894;16488.422905198382;16543.503694889052;16560.50318490435;16578.917105414395;14181.078229915023;14257;14299.714005719932;14333.354999025069;14673.046251993586;13757.830584400337;13831;13945.58163255104;13984.720305593832;13990.300484975813;4610.147122782296;4670.626349892034;4691.319758635013;4702.717836929795;4799.064182484417;83565;83580;83647.5817620914;86097.56951215204;86276.56861715714;12150.392480375946;12245.142840001114;12260.509579616715;12435.129540932228;12454.128211025323;21627.24304649361;21641.78358216398;21647.350579482325;21702.891485542787;21716.23993160232;9047.457152570867;9210.953945230365;9222.354435189472;9298.814023719488;9372.62509499626;4890.779914903838;5088.974555127201;5113;5159.097157997336;5390.191471279261;3473.8436770345397;3510.262844802569;3589;3596.2987217492337;3603.117236277129;707.3598393453932;732.487258918759;740.2634378793027;740.2671355358157;761.7219714804056;664.1797380235405;741.1772932045425;751.8721817291074;777.455780953335;811.1158836867843;10401.375917444977;10716.410597417216;10726.141908647289;10760.56957721698;10764.892351076389;634.1312402009277;682.9965850170718;705.5978092487336;742.3504433620582;768.5964868444;4565.178267911741;4851.320815085891;4970.229614409773;5050.191969284897;5091.210862316347;98587;99118;100417;135620;139540;95053;95310.5234473837;96487.51756241174;98355.50822245843;101253;62184.378156218765;62309.376906231264;91947;92065.079349207;92087;10292.691219263434;10616.681499555025;10655.094316983143;10670.57317707283;10694.572217111228;44185.33721994237;45596.77201613971;50302;55431.44568554424;56755.43244567667;62000;76197.23802761901;76368;77780;79087;14581;14602;14658.340374683377;14674.26628668541;14883.776743349075;13512.527061552799;14072.577822665336;15842.12868292255;15968.840311596736;16534.338626454806;13139.934300328438;14420.134791912518;14877.107373557621;15038.398464061753;15749.921250394133;14805.555833325017;15229.847701523286;15349;15642.296096675449;15882.682346352776;11953.282803031845;12543.623691289276;14611.196384198971;14817;15324.923375383052;12748.808767868304;12885.742285154058;12909.677258068623;13055;13282.734345312847;12294.139410241198;12573.182743121668;12596;12639.810402844148;12675.556355527513 07:11:00 INFO - PROCESS | 3461 | __end_tp_report 07:11:00 INFO - PROCESS | 3461 | __start_cc_report 07:11:00 INFO - PROCESS | 3461 | _x_x_mozilla_cycle_collect,948 07:11:00 INFO - PROCESS | 3461 | __end_cc_report 07:11:00 INFO - PROCESS | 3461 | __startTimestamp1467641460754__endTimestamp 07:11:00 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | ------- Summary: start ------- 07:11:00 INFO - PROCESS | 3461 | Number of tests: 6 07:11:00 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | [#0] dojo.html Cycles:165 Average:5694.67 Median:5907.41 stddev:646.32 (10.9%) stddev-sans-first:623.68 07:11:00 INFO - PROCESS | 3461 | Values: 3441.8 3462.9 3471.6 3494.3 3510.0 5681.7 5692.1 5748.7 5751.2 5792.2 5656.9 5681.4 5702.3 5704.6 5716.9 5085.1 5108.4 5136.8 5141.5 5153.7 5223.0 5263.9 5265.7 5268.8 5274.5 5155.3 5204.9 5229.3 5238.8 5253.0 5290.2 5300.4 5302.5 5309.4 5337.7 5045.3 5076.5 5124.3 5215.9 5220.5 5548.9 5561.0 5563.9 5598.9 5605.5 6141.0 6154.1 6156.2 6157.2 6159.2 6153.4 6163.8 6191.3 6210.4 6240.2 5816.0 5832.4 5861.2 5862.2 5869.9 6075.8 6304.6 6313.8 6316.1 6316.7 6021.5 6031.6 6077.8 6122.9 6133.7 6141.8 6164.8 6165.2 6181.9 6196.8 5969.3 6008.3 6032.6 6033.3 6077.9 5898.5 6056.9 6062.3 6066.7 6101.5 4606.0 4615.3 4619.3 4621.0 4628.8 4115.5 4136.4 4142.2 4153.3 4182.5 5907.4 5929.5 5929.6 5931.5 5942.5 6216.8 6261.6 6265.3 6266.1 6282.2 5716.8 5800.5 5834.3 5856.2 5897.5 5073.4 5074.8 5098.8 5102.5 5141.8 6402.2 6421.9 6424.2 6429.0 6430.1 6090.2 6109.1 6114.2 6118.3 6179.6 6341.7 6371.5 6381.5 6384.0 6384.3 5921.9 6054.9 6059.4 6059.5 6067.2 6063.5 6095.5 6131.5 6133.8 6160.0 5969.0 6020.5 6032.8 6036.3 6055.9 5890.1 5929.3 5989.1 5997.7 6001.4 5800.7 5826.6 5860.4 5863.1 5887.6 6017.8 6045.6 6051.2 6056.2 6057.4 5709.7 5806.5 5827.4 5874.6 5882.0 07:11:00 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | [#1] ext.html Cycles:180 Average:58453.38 Median:37776.93 stddev:111224.31 (294.4%) stddev-sans-first:111451.48 07:11:00 INFO - PROCESS | 3461 | Values: 593.4 642.3 642.8 651.7 661.0 32988.5 37910.2 38543.6 38667.8 42015.4 47942.0 48228.5 48439.0 48464.0 48510.5 8126.1 9016.5 9222.9 10738.9 10999.6 10844.6 10911.8 10945.3 10951.8 10962.2 11072.1 11110.3 11119.3 11124.2 11131.4 8430.9 10940.6 11166.1 11181.5 11212.0 10654.1 10680.8 10710.4 11031.9 11040.1 45787.3 46230.0 46448.0 46999.5 47021.8 3603.4 4022.9 4336.7 4357.3 4380.4 35663.6 36171.3 36429.0 36467.8 36511.5 4576.2 4593.0 4617.6 4705.6 4729.4 384523.0 385267.0 385299.0 386734.1 391260.0 34137.7 34682.7 70414.0 71167.0 71245.0 41369.4 41386.4 41404.0 41622.0 41622.8 14729.6 16906.9 17020.2 17025.7 17027.0 13732.4 14084.2 14112.6 14492.4 14530.6 9087.5 9134.8 9185.8 9247.7 9318.2 3558.2 3571.0 3615.0 3628.3 3716.9 1145.1 1207.3 1210.6 1227.4 1248.5 33173.0 33346.8 33444.3 33623.0 34071.5 1259.1 1271.7 1292.9 1296.9 1303.1 17552.3 17782.8 17923.6 18019.4 18054.5 438087.0 441206.0 442756.0 443801.0 443912.0 59855.4 60344.7 60424.7 60513.0 60785.7 1353.8 1491.5 1504.8 1527.8 1547.8 33864.0 34623.8 35046.8 35134.1 35624.8 53199.2 53242.5 53671.0 53890.0 53947.0 430968.0 433814.0 433967.0 434261.0 434678.0 25374.6 30182.0 30707.1 30879.8 32289.8 42250.2 42293.0 42973.8 43149.4 43591.0 42380.4 43314.6 43770.0 43973.3 44942.0 36207.5 36385.5 36388.3 37256.4 37293.3 42979.6 43461.0 43577.6 44189.3 44210.8 37643.6 39123.8 39161.0 39197.6 39797.0 28974.1 29240.4 29299.0 29458.6 29459.9 07:11:00 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | [#2] jquery.html Cycles:180 Average:29111.78 Median:20845.82 stddev:78133.22 (374.8%) stddev-sans-first:78322.70 07:11:00 INFO - PROCESS | 3461 | Values: 418.5 421.5 422.7 425.6 431.8 18692.8 19465.0 20392.2 20668.4 20787.7 14979.8 19511.2 19617.0 19893.6 20634.3 5671.3 5887.6 5965.5 5967.6 5971.6 5819.0 5909.9 5920.4 5923.1 5936.2 4338.2 5850.0 5853.4 5871.2 6238.3 6531.0 6586.5 6642.9 6662.2 6672.0 5675.3 5956.7 5956.9 5971.8 5973.2 20355.0 20581.1 23358.3 23769.8 23896.4 2545.4 2660.3 2678.2 2752.9 3127.8 14580.6 15215.9 15392.9 15453.3 16096.0 2037.8 2056.9 2070.9 2165.1 2217.7 78707.6 80882.6 81349.0 81614.6 81621.0 10800.9 11188.3 11208.5 11302.4 11305.8 15625.5 15734.6 15737.7 15747.9 15776.5 8698.3 8746.5 8905.3 9003.9 9209.7 8525.0 8542.4 8552.9 8597.6 8672.7 6951.2 7047.3 7068.9 7122.4 7146.1 1989.8 2034.3 2040.4 2060.7 2072.5 1032.8 1090.4 1106.9 1132.1 1171.9 19715.1 20077.6 20674.6 20783.4 20904.0 1093.4 1113.0 1155.7 1205.9 1228.1 9552.9 11567.1 11941.5 11950.5 11974.6 404312.0 406089.0 408037.0 554580.0 559584.0 66415.0 100696.0 103899.5 107682.5 108957.0 1084.1 1091.5 1107.4 1124.2 1125.4 18333.8 18377.6 18531.3 18596.0 18972.4 43395.6 44017.6 44944.8 45988.1 46445.3 57917.7 58863.0 59242.4 59722.1 61413.7 8814.2 8936.2 9061.6 9235.0 9404.7 12057.7 13202.1 13309.7 13368.4 13836.5 12069.2 12069.8 12187.3 12201.1 12246.7 11712.1 11959.3 11997.8 12219.8 12442.2 12244.4 12446.3 12516.3 12521.2 12566.2 8783.8 8927.2 9075.2 9099.5 9167.5 9066.0 12110.7 12258.8 12327.9 12543.9 07:11:00 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | [#3] mootools.html Cycles:180 Average:6426.26 Median:500.84 stddev:3769.33 (752.6%) stddev-sans-first:3760.65 07:11:00 INFO - PROCESS | 3461 | Values: 1357.1 1534.2 1577.8 1806.4 1979.8 8454.5 9298.1 9607.7 9611.4 9640.7 9210.6 9478.4 9495.5 9709.4 9736.6 2181.2 2251.0 2485.4 2541.9 2598.2 2548.8 2580.8 2582.2 2586.2 2588.2 2506.6 2515.0 2583.1 2588.4 2591.1 2164.9 2436.2 2472.3 2505.2 2514.3 2537.3 2537.4 2558.4 2560.1 2561.7 9441.7 9468.3 9470.5 9473.8 9507.9 5544.0 5715.9 5729.5 5736.7 5747.7 3762.3 3762.7 3775.8 3803.9 3816.8 1201.4 1202.6 1224.9 1241.9 1251.8 13850.2 14017.6 14043.9 14049.4 14143.8 5096.6 5145.6 5185.2 5199.3 5273.4 11725.5 11747.6 11775.2 11828.6 11840.0 5851.5 5863.4 5910.4 5918.2 5949.2 4772.1 4897.6 5359.6 5366.4 5385.1 4378.4 4384.7 4388.5 4446.1 4461.3 1347.8 1386.3 1387.9 1391.0 1397.6 913.1 995.6 995.9 1017.5 1017.6 6339.3 6345.8 6517.4 6667.4 6667.6 498.7 500.2 501.5 503.6 518.7 4537.4 4544.6 4557.8 4558.0 4562.0 12091.2 12554.4 12579.4 12595.9 12629.2 11589.2 12087.7 12130.8 12473.1 12478.3 9076.7 9099.8 9133.9 9149.1 9270.3 6374.8 6382.0 6557.1 6572.8 6773.7 11011.2 11138.1 11180.4 11187.4 11622.1 11436.1 11752.2 11810.4 11822.0 11944.0 8699.5 8785.3 9023.7 9168.9 9346.2 9740.4 9801.2 9827.2 9876.2 9879.0 8545.6 8679.0 8696.1 8717.6 8847.5 8268.3 8310.6 8410.0 8410.2 8493.8 7538.4 7571.5 7628.5 7631.3 7648.5 5372.8 5377.5 5490.6 5584.9 5603.0 5429.1 5443.4 5458.5 5466.6 5574.3 07:11:00 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | [#4] prototype.html Cycles:180 Average:4788.22 Median:5378.57 stddev:1405.00 (26.1%) stddev-sans-first:1368.95 07:11:00 INFO - PROCESS | 3461 | Values: 354.0 355.5 363.0 366.3 367.2 5536.7 5615.9 5617.5 5631.6 5636.4 5433.8 5462.8 5549.9 5582.3 5596.7 4140.4 4284.9 4287.6 4296.7 4317.1 4232.2 4295.4 4314.8 4317.6 4317.7 4266.2 4282.9 4288.4 4291.9 4340.9 4192.9 4259.7 4266.8 4275.1 4320.3 3763.5 3772.6 3775.0 3780.3 3789.4 5225.6 5255.3 5283.0 5286.7 5308.4 4751.5 4905.0 4907.2 4926.2 4929.4 5606.4 5712.8 5724.5 5726.4 5755.8 4106.7 4143.6 4157.5 4169.3 4170.4 5671.6 5942.0 6004.2 6018.4 6019.1 4204.2 4245.2 4257.9 4262.2 4271.4 4317.0 4318.8 4334.3 4337.3 4350.6 4781.2 4883.1 4903.9 4907.9 4919.8 5749.6 5770.5 5780.2 5783.2 5801.4 1474.8 1474.9 1479.9 1491.9 1494.2 922.0 957.0 959.3 965.6 972.0 4975.9 4976.3 5009.9 5011.7 5046.7 5289.7 5300.4 5317.5 5324.9 5360.8 4891.3 5036.0 5061.0 5092.7 5118.2 2858.0 2862.8 2864.8 2878.2 2885.3 5396.4 5442.4 5519.8 5528.3 5529.2 5337.2 5656.9 5850.2 5986.2 6134.1 5997.6 6007.5 6014.2 6016.3 6168.9 5984.6 5988.3 5989.0 5998.2 6022.6 5637.2 5905.6 5910.9 5923.6 5928.7 5865.4 6023.0 6074.5 6098.5 6135.3 4184.3 4194.3 4200.6 4201.2 4212.3 5955.7 5970.1 5979.4 5983.3 5984.6 5646.7 5732.4 5774.7 5805.8 5850.1 5765.7 5765.9 5774.9 5785.0 5789.5 5503.6 5620.6 5666.6 5689.4 5718.6 5861.0 5872.6 5885.7 5887.9 5893.4 5633.5 5693.5 5701.3 5708.0 5736.0 07:11:00 INFO - PROCESS | 3461 | 07:11:00 INFO - PROCESS | 3461 | [#5] yui.html Cycles:180 Average:21352.07 Median:25080.98 stddev:29963.88 (119.5%) stddev-sans-first:30008.44 07:11:00 INFO - PROCESS | 3461 | Values: 861.4 867.7 896.4 906.6 910.1 15837.8 17150.6 17197.7 17237.3 17257.7 15508.9 15735.4 15739.0 16376.6 17062.6 743.8 872.3 893.8 904.2 906.5 896.9 906.4 910.1 910.2 911.0 788.3 920.6 959.5 960.8 963.7 943.3 945.0 945.3 945.3 947.6 695.4 695.4 695.5 695.8 696.0 16459.2 16488.4 16543.5 16560.5 16578.9 14181.1 14257.0 14299.7 14333.4 14673.0 13757.8 13831.0 13945.6 13984.7 13990.3 4610.1 4670.6 4691.3 4702.7 4799.1 83565.0 83580.0 83647.6 86097.6 86276.6 12150.4 12245.1 12260.5 12435.1 12454.1 21627.2 21641.8 21647.4 21702.9 21716.2 9047.5 9211.0 9222.4 9298.8 9372.6 4890.8 5089.0 5113.0 5159.1 5390.2 3473.8 3510.3 3589.0 3596.3 3603.1 707.4 732.5 740.3 740.3 761.7 664.2 741.2 751.9 777.5 811.1 10401.4 10716.4 10726.1 10760.6 10764.9 634.1 683.0 705.6 742.4 768.6 4565.2 4851.3 4970.2 5050.2 5091.2 98587.0 99118.0 100417.0 135620.0 139540.0 95053.0 95310.5 96487.5 98355.5 101253.0 62184.4 62309.4 91947.0 92065.1 92087.0 10292.7 10616.7 10655.1 10670.6 10694.6 44185.3 45596.8 50302.0 55431.4 56755.4 62000.0 76197.2 76368.0 77780.0 79087.0 14581.0 14602.0 14658.3 14674.3 14883.8 13512.5 14072.6 15842.1 15968.8 16534.3 13139.9 14420.1 14877.1 15038.4 15749.9 14805.6 15229.8 15349.0 15642.3 15882.7 11953.3 12543.6 14611.2 14817.0 15324.9 12748.8 12885.7 12909.7 13055.0 13282.7 12294.1 12573.2 12596.0 12639.8 12675.6 07:11:00 INFO - PROCESS | 3461 | -------- Summary: end -------- 07:11:00 INFO - PROCESS | 3461 | 07:11:01 INFO - TEST-INFO | 3461: exit 0 07:11:01 INFO - TEST-OK | dromaeo_css | took 1114346ms 07:11:01 INFO - TEST-START | kraken 07:11:01 INFO - operating with platform_type : linux_ 07:11:01 INFO - Initialising browser for kraken test... 07:11:01 INFO - TEST-INFO | started process 3652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCq4Q4r/profile http://localhost:40430/getInfo.html) 07:11:05 INFO - PROCESS | 3652 | __metrics Screen width/height:1600/1200 07:11:05 INFO - PROCESS | 3652 | colorDepth:24 07:11:05 INFO - PROCESS | 3652 | Browser inner width/height: 1024/697 07:11:05 INFO - PROCESS | 3652 | __metrics 07:11:06 ERROR - PROCESS | 3652 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:11:07 INFO - TEST-INFO | 3652: exit 0 07:11:07 INFO - Browser initialized. 07:11:07 INFO - Running cycle 1/1 for kraken test... 07:11:07 INFO - TEST-INFO | started process 3742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCq4Q4r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:18 INFO - PROCESS | 3742 | RSS: Main: 145797120 07:11:18 INFO - PROCESS | 3742 | 07:11:21 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40430/tests/kraken/driver.html?testName=audio-beat-detection) 07:11:22 INFO - PROCESS | 3742 | RSS: Main: 194793472 07:11:22 INFO - PROCESS | 3742 | 07:11:24 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40430/tests/kraken/driver.html?testName=audio-dft) 07:11:25 INFO - PROCESS | 3742 | RSS: Main: 193208320 07:11:25 INFO - PROCESS | 3742 | 07:11:28 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40430/tests/kraken/driver.html?testName=audio-fft) 07:11:28 INFO - PROCESS | 3742 | RSS: Main: 278827008 07:11:28 INFO - PROCESS | 3742 | 07:11:30 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40430/tests/kraken/driver.html?testName=audio-oscillator) 07:11:31 INFO - PROCESS | 3742 | RSS: Main: 187490304 07:11:31 INFO - PROCESS | 3742 | 07:11:33 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:34 INFO - PROCESS | 3742 | RSS: Main: 188346368 07:11:34 INFO - PROCESS | 3742 | 07:11:37 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40430/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:37 INFO - PROCESS | 3742 | RSS: Main: 222457856 07:11:37 INFO - PROCESS | 3742 | 07:11:41 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40430/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:41 INFO - PROCESS | 3742 | RSS: Main: 222318592 07:11:41 INFO - PROCESS | 3742 | 07:11:44 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40430/tests/kraken/driver.html?testName=json-parse-financial) 07:11:45 INFO - PROCESS | 3742 | RSS: Main: 222601216 07:11:45 INFO - PROCESS | 3742 | 07:11:46 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:47 INFO - PROCESS | 3742 | RSS: Main: 201424896 07:11:47 INFO - PROCESS | 3742 | 07:11:48 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40430/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:49 INFO - PROCESS | 3742 | RSS: Main: 201023488 07:11:49 INFO - PROCESS | 3742 | 07:11:51 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:52 INFO - PROCESS | 3742 | RSS: Main: 210845696 07:11:52 INFO - PROCESS | 3742 | 07:11:54 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:55 INFO - PROCESS | 3742 | RSS: Main: 215908352 07:11:55 INFO - PROCESS | 3742 | 07:11:58 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:58 INFO - PROCESS | 3742 | RSS: Main: 214286336 07:11:58 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | Cycle 1(1): loaded http://localhost:40430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40430/tests/kraken/driver.html?testName=ai-astar) 07:12:00 INFO - PROCESS | 3742 | RSS: Main: 257830912 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | __start_tp_report 07:12:00 INFO - PROCESS | 3742 | _x_x_mozilla_page_load 07:12:00 INFO - PROCESS | 3742 | _x_x_mozilla_page_load_details 07:12:00 INFO - PROCESS | 3742 | |i|pagename|runs| 07:12:00 INFO - PROCESS | 3742 | |0;ai-astar;111;104;110;109;109;111;110;111;110;109 07:12:00 INFO - PROCESS | 3742 | |1;audio-beat-detection;149;121;124;177;122;124;149;123;153;122 07:12:00 INFO - PROCESS | 3742 | |2;audio-dft;163;163;164;162;160;161;160;160;163;163 07:12:00 INFO - PROCESS | 3742 | |3;audio-fft;74;74;76;125;76;75;73;75;100;75 07:12:00 INFO - PROCESS | 3742 | |4;audio-oscillator;84;84;112;84;84;83;113;84;84;120 07:12:00 INFO - PROCESS | 3742 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 07:12:00 INFO - PROCESS | 3742 | |6;imaging-darkroom;145;146;145;146;146;145;146;145;146;146 07:12:00 INFO - PROCESS | 3742 | |7;imaging-desaturate;95;95;95;94;94;95;95;94;95;94 07:12:00 INFO - PROCESS | 3742 | |8;json-parse-financial;51;50;51;52;51;71;52;52;54;52 07:12:00 INFO - PROCESS | 3742 | |9;json-stringify-tinderbox;62;62;62;63;64;63;63;63;64;63 07:12:00 INFO - PROCESS | 3742 | |10;stanford-crypto-aes;76;77;76;76;77;78;81;77;105;78 07:12:00 INFO - PROCESS | 3742 | |11;stanford-crypto-ccm;123;125;117;127;124;115;115;117;130;120 07:12:00 INFO - PROCESS | 3742 | |12;stanford-crypto-pbkdf2;161;155;156;156;164;159;152;155;155;157 07:12:00 INFO - PROCESS | 3742 | |13;stanford-crypto-sha256-iterative;62;63;62;60;60;63;61;61;60;62 07:12:00 INFO - PROCESS | 3742 | __end_tp_report 07:12:00 INFO - PROCESS | 3742 | __start_cc_report 07:12:00 INFO - PROCESS | 3742 | _x_x_mozilla_cycle_collect,1562 07:12:00 INFO - PROCESS | 3742 | __end_cc_report 07:12:00 INFO - PROCESS | 3742 | __startTimestamp1467641520510__endTimestamp 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | ------- Summary: start ------- 07:12:00 INFO - PROCESS | 3742 | Number of tests: 14 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.07 (1.9%) stddev-sans-first:2.11 07:12:00 INFO - PROCESS | 3742 | Values: 111.0 104.0 110.0 109.0 109.0 111.0 110.0 111.0 110.0 109.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:136.50 stddev:19.38 (14.2%) stddev-sans-first:20.01 07:12:00 INFO - PROCESS | 3742 | Values: 149.0 121.0 124.0 177.0 122.0 124.0 149.0 123.0 153.0 122.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#2] audio-dft Cycles:10 Average:161.90 Median:163.00 stddev:1.52 (0.9%) stddev-sans-first:1.56 07:12:00 INFO - PROCESS | 3742 | Values: 163.0 163.0 164.0 162.0 160.0 161.0 160.0 160.0 163.0 163.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:17.00 (22.7%) stddev-sans-first:17.76 07:12:00 INFO - PROCESS | 3742 | Values: 74.0 74.0 76.0 125.0 76.0 75.0 73.0 75.0 100.0 75.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:15.19 (18.1%) stddev-sans-first:15.74 07:12:00 INFO - PROCESS | 3742 | Values: 84.0 84.0 112.0 84.0 84.0 83.0 113.0 84.0 84.0 120.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:12:00 INFO - PROCESS | 3742 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:12:00 INFO - PROCESS | 3742 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:12:00 INFO - PROCESS | 3742 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:52.00 stddev:6.20 (11.9%) stddev-sans-first:6.51 07:12:00 INFO - PROCESS | 3742 | Values: 51.0 50.0 51.0 52.0 51.0 71.0 52.0 52.0 54.0 52.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 07:12:00 INFO - PROCESS | 3742 | Values: 62.0 62.0 62.0 63.0 64.0 63.0 63.0 63.0 64.0 63.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:77.00 stddev:8.88 (11.5%) stddev-sans-first:9.29 07:12:00 INFO - PROCESS | 3742 | Values: 76.0 77.0 76.0 76.0 77.0 78.0 81.0 77.0 105.0 78.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:123.50 stddev:5.27 (4.3%) stddev-sans-first:5.56 07:12:00 INFO - PROCESS | 3742 | Values: 123.0 125.0 117.0 127.0 124.0 115.0 115.0 117.0 130.0 120.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:156.50 stddev:3.46 (2.2%) stddev-sans-first:3.36 07:12:00 INFO - PROCESS | 3742 | Values: 161.0 155.0 156.0 156.0 164.0 159.0 152.0 155.0 155.0 157.0 07:12:00 INFO - PROCESS | 3742 | 07:12:00 INFO - PROCESS | 3742 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:1.17 (1.9%) stddev-sans-first:1.22 07:12:00 INFO - PROCESS | 3742 | Values: 62.0 63.0 62.0 60.0 60.0 63.0 61.0 61.0 60.0 62.0 07:12:00 INFO - PROCESS | 3742 | -------- Summary: end -------- 07:12:00 INFO - PROCESS | 3742 | 07:12:01 INFO - TEST-INFO | 3742: exit 0 07:12:01 INFO - TEST-OK | kraken | took 60042ms 07:12:01 INFO - SUITE-END | took 1174s 07:12:01 INFO - Completed test suite (00:19:34) 07:12:01 INFO - javascript benchmark 07:12:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3441.8279086045695, 3462.948055779164, 3471.5834099908016, 3494.2662040971395, 3510.0347404463787, 5681.659100453976, 5692.089265717481, 5748.71256437178, 5751.194832723422, 5792.189093526904, 5656.858578535539, 5681.403452637475, 5702.258706368177, 5704.600677952545, 5716.942830571693, 5085.135526960416, 5108.386993560778, 5136.794528218867, 5141.485851414866, 5153.665011774241, 5222.973885130588, 5263.86840328991, 5265.710385928773, 5268.762905669235, 5274.498922602346, 5155.329807125068, 5204.9219261711105, 5229.3201883755055, 5238.79044838206, 5253.0, 5290.232916227164, 5300.416954135042, 5302.549283310923, 5309.362876454811, 5337.653052551591, 5045.318881950963, 5076.517730815566, 5124.333836601255, 5215.869603259911, 5220.530152286275, 5548.86127846803, 5561.026820306471, 5563.944360556383, 5598.916016259759, 5605.523530499912, 6140.969295153495, 6154.138420621117, 6156.230471191101, 6157.230346206724, 6159.19930409044, 6153.353897840707, 6163.845903852395, 6191.288001879797, 6210.378962103799, 6240.188775459206, 5816.0, 5832.387599302055, 5861.17943487912, 5862.237909071793, 5869.882602347929, 6075.830753971228, 6304.590201636879, 6313.77901773445, 6316.084167795644, 6316.747330106836, 6021.488173505301, 6031.577789554777, 6077.787277445356, 6122.938770612237, 6133.6505968686815, 6141.758258235801, 6164.845878853064, 6165.198524191826, 6181.938180618226, 6196.845078872974, 5969.313528944227, 6008.3390827009, 6032.607880487754, 6033.336333003366, 6077.878442431127, 5898.528117750656, 6056.939430605637, 6062.302835174011, 6066.726997285133, 6101.542384321194, 4605.98668292975, 4615.284630882219, 4619.3071039343695, 4620.953790462119, 4628.791704373311, 4115.464989551339, 4136.358864376027, 4142.212979533879, 4153.252414565347, 4182.53992060873, 5907.409259074144, 5929.525637948954, 5929.555283353766, 5931.466168044896, 5942.465178133989, 6216.844578885564, 6261.5616906816995, 6265.279492858289, 6266.060090986297, 6282.2147231596055, 5716.771329146871, 5800.50695690871, 5834.299884013861, 5856.209411729362, 5897.498712609477, 5073.416557095908, 5074.847754567369, 5098.796048158107, 5102.540771330598, 5141.820036298712, 6402.167718196604, 6421.935780642228, 6424.196975378171, 6428.967855160694, 6430.131932189188, 6090.208272924491, 6109.11417844419, 6114.206128133634, 6118.345080237391, 6179.62922224668, 6341.746330146742, 6371.522135839923, 6381.489480841615, 6384.0, 6384.265809431975, 5921.911171332347, 6054.9091763624465, 6059.363766804422, 6059.545534084873, 6067.211262535842, 6063.484603808725, 6095.51235901118, 6131.48134319063, 6133.754649813957, 6159.969200153971, 5969.04495280753, 6020.488258497901, 6032.788852390146, 6036.305824830025, 6055.878882422415, 5890.087036509348, 5929.288485381781, 5989.131575921554, 5997.730102145327, 6001.4298641628975, 5800.651960882361, 5826.563007774519, 5860.413958604106, 5863.120531920075, 5887.558433117448, 6017.849553761191, 6045.6070355426755, 6051.213342265477, 6056.152138700498, 6057.363976782374, 5709.7145142741865, 5806.477417032487, 5827.388124246893, 5874.647521148574, 5882.0], "value": 5652.001109308126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.3947373678848, 642.2613993907008, 642.8007317731503, 651.7230177174699, 661.0315887225214, 32988.5051724224, 37910.24179516408, 38543.61456385435, 38667.80666096669, 42015.369769453486, 47942.0, 48228.51771482284, 48439.0, 48464.0, 48510.51489485104, 8126.146754590742, 9016.459012459258, 9222.907770922306, 10738.892611073907, 10999.560017599286, 10844.566217351297, 10911.83632245517, 10945.343279403261, 10951.83572246417, 10962.177836662282, 11072.114230861513, 11110.277831940939, 11119.27724697892, 11124.165687573424, 11131.387773672444, 8430.873536896952, 10940.56237750493, 11166.050885674727, 11181.496832642551, 11212.04697600705, 10654.147668186526, 10680.839787403194, 10710.41092739899, 11031.889681103246, 11040.061594764455, 45787.31319030217, 46230.0, 46448.0, 46999.53000469986, 47021.76489117567, 3603.369410353204, 4022.8591999279884, 4336.739795612273, 4357.2592659248, 4380.386745855582, 35663.64336356629, 36171.276574468626, 36429.0, 36467.817660911795, 36511.4523282151, 4576.153411618861, 4592.977035114836, 4617.630589552828, 4705.623550115983, 4729.408823897013, 384523.0, 385267.0, 385299.0, 386734.0663296694, 391260.0, 34137.65862341395, 34682.65317346845, 70414.0, 71167.0, 71245.0, 41369.37945930753, 41386.37920431196, 41404.0, 41622.0, 41622.79188604037, 14729.55811325662, 16906.915465422593, 17020.234089466005, 17025.744613830804, 17027.0, 13732.382042808098, 14084.15495070299, 14112.647183820281, 14492.420303187966, 14530.636734081521, 9087.545622718837, 9134.771630709285, 9185.77035574116, 9247.72256832296, 9318.207952324128, 3558.1994051338243, 3570.9642903571153, 3614.981925090358, 3628.346897558412, 3716.888493345204, 1145.1411441418936, 1207.3178654060428, 1210.5762982955896, 1227.380173012623, 1248.494359784289, 33173.0, 33346.833265834, 33444.33111337759, 33623.0, 34071.48892766561, 1259.1123258103016, 1271.7075072733323, 1292.8836404723431, 1296.8703129686955, 1303.0552849184267, 17552.297908083532, 17782.822171778374, 17923.641527169384, 18019.369322073664, 18054.458366249033, 438087.0, 441206.0, 442756.0, 443801.0, 443912.0, 59855.401445984986, 60344.69827650922, 60424.697876510334, 60513.0, 60785.696071519356, 1353.810466534686, 1491.4779827060659, 1504.7968524249304, 1527.7784721215362, 1547.7678348247853, 33864.0, 34623.82688086543, 35046.82476587601, 35134.12164695801, 35624.821875890455, 53199.20201197063, 53242.46757532375, 53671.0, 53890.0, 53947.0, 430968.0, 433814.0, 433967.0, 434261.0, 434678.0, 25374.619380708937, 30182.0, 30707.07878763641, 30879.845600771852, 32289.838550807097, 42250.15499689928, 42293.0, 42973.785131074146, 43149.352759709254, 43591.0, 42380.36429453622, 43314.56685433105, 43770.0, 43973.34039989467, 44942.0, 36207.45688814722, 36385.45421818622, 36388.27223455463, 37256.44115338218, 37293.25413491769, 42979.570204298805, 43461.0, 43577.56422435735, 44189.348639081756, 44210.83107457164, 37643.62356376401, 39123.80438097791, 39161.020974474726, 39197.60802392053, 39797.0, 28974.130776076752, 29240.415191696473, 29299.0, 29458.558121627764, 29459.85270073636], "value": 20263.22887551743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.47690387016223, 421.5426262505182, 422.74001489084213, 425.6254496043479, 431.7517427479198, 18692.813071869277, 19465.0, 20392.184312627494, 20668.379948601527, 20787.688184677205, 14979.77530337043, 19511.21955121797, 19617.01914904256, 19893.602127957467, 20634.277800276992, 5671.347795003576, 5887.617304875191, 5965.522758179335, 5967.552433567478, 5971.5819892607315, 5819.010768169422, 5909.852253693649, 5920.378360272152, 5923.111533270001, 5936.168936348915, 4338.197433474817, 5849.9707501462435, 5853.414658534134, 5871.236739223917, 6238.282597501277, 6530.967345163268, 6586.538942274043, 6642.900356494656, 6662.20053593567, 6671.999999999975, 5675.318961724578, 5956.702164891782, 5956.910646340309, 5971.820845374646, 5973.223480947492, 20355.0, 20581.07385167671, 23358.299251022498, 23769.762302376927, 23896.402589935216, 2545.350935511433, 2660.3349162709324, 2678.1563807400607, 2752.8898844046216, 3127.796693214934, 14580.562583122522, 15215.923920380437, 15392.923035384863, 15453.304601292968, 16096.0, 2037.7758446570865, 2056.8663036902553, 2070.8861012644297, 2165.1447678167037, 2217.6895234667, 78707.60646196733, 80882.59558702228, 81349.0, 81614.59192704057, 81621.0, 10800.891991080145, 11188.328700278009, 11208.495617697223, 11302.37836918961, 11305.773884522428, 15625.531234062997, 15734.606634834221, 15737.68524629501, 15747.921260393625, 15776.526704198892, 8698.304135669132, 8746.475211487332, 8905.332100092519, 9003.909960900439, 9209.723708288762, 8525.0, 8542.40203185771, 8552.914470855336, 8597.570121494025, 8672.69645562415, 6951.165860096719, 7047.295270472911, 7068.893966590505, 7122.394596459256, 7146.14246290438, 1989.7910719374547, 2034.2879992002681, 2040.367925376248, 2060.6908963655274, 2072.4922394013565, 1032.8244198486275, 1090.432974853072, 1106.9225154239125, 1132.0886686217673, 1171.8769529199483, 19715.11281992285, 20077.59844803125, 20674.58650826975, 20783.376498705064, 20903.95480226013, 1093.3599600599102, 1113.0372228022702, 1155.6706338693432, 1205.879412058787, 1228.0789407944042, 9552.856707149398, 11567.132465064986, 11941.462634181482, 11950.521979120738, 11974.64076077719, 404312.0, 406089.0, 408037.0, 554580.0, 559584.0, 66415.0, 100696.0, 103899.480502597, 107682.46158769312, 108957.0, 1084.1326938449208, 1091.5251865438559, 1107.4352080438873, 1124.2130508643982, 1125.3641692443907, 18333.81666183321, 18377.632447350712, 18531.258749649864, 18596.0, 18972.430827075208, 43395.56604433915, 44017.559824402626, 44944.77527612472, 45988.08023839571, 46445.303320449544, 57917.710411447675, 58863.0, 59242.40757592369, 59722.104168436636, 61413.69293153506, 8814.206721395105, 8936.24041956415, 9061.592228349607, 9234.95382523083, 9404.717858464257, 12057.698557536132, 13202.07585469008, 13309.66725831862, 13368.398422070835, 13836.515721949683, 12069.155159139127, 12069.818952715892, 12187.268763874195, 12201.145919785884, 12246.693832654255, 11712.063034957013, 11959.342236177094, 11997.820032699341, 12219.816702749644, 12442.191257568229, 12244.448999794853, 12446.25322480654, 12516.311602861566, 12521.186122901981, 12566.246025238515, 8783.824323513621, 8927.151920567536, 9075.2286055686, 9099.454032758056, 9167.541622918694, 9066.002739698759, 12110.697232568904, 12258.75482490363, 12327.876721233031, 12543.937280313905], "value": 9885.33235121145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.0975301424553, 1534.186880953095, 1577.8027746531684, 1806.4490330449207, 1979.8218160365554, 8454.492730436179, 9298.116678915509, 9607.711768646934, 9611.375260608056, 9640.710778676634, 9210.585523651434, 9478.383905046167, 9495.525223738803, 9709.368891022079, 9736.610535578586, 2181.160253302482, 2251.0, 2485.3662316109458, 2541.9364515887114, 2598.233521111277, 2548.7833534149618, 2580.7548282913185, 2582.18661121747, 2586.237060067285, 2588.2235329401196, 2506.6240063990367, 2514.962275565859, 2583.083005533037, 2588.430545280045, 2591.144922175687, 2164.8592841465334, 2436.2447641231274, 2472.258322503251, 2505.2108585795418, 2514.333701569086, 2537.314924970248, 2537.378342306128, 2558.385987363038, 2560.0527804712187, 2561.743825617442, 9441.716748497556, 9468.289878259158, 9470.479123648196, 9473.810523789485, 9507.90492095077, 5544.0, 5715.942840571583, 5729.512991395736, 5736.655800651933, 5747.683877386742, 3762.285165818486, 3762.717796165271, 3775.8112094395447, 3803.885883423474, 3816.809159542012, 1201.4293210724923, 1202.6271855724754, 1224.8530176378802, 1241.8944389726885, 1251.7997120460773, 13850.238236896967, 14017.579472615736, 14043.929780351033, 14049.43802247909, 14143.787843182361, 5096.61775366849, 5145.562627176732, 5185.248139019821, 5199.324087868553, 5273.393559740679, 11725.530978760924, 11747.647570572897, 11775.23460975034, 11828.645140645795, 11840.0, 5851.502622277154, 5863.442972917566, 5910.408959104056, 5918.171455996164, 5949.167116603679, 4772.141014617333, 4897.583705385082, 5359.5712343012465, 5366.409694933554, 5385.084535628953, 4378.387025816388, 4384.6711496637245, 4388.4733831940375, 4446.088551846864, 4461.263891457938, 1347.8247827782325, 1386.2652794019186, 1387.861213878604, 1390.9652258693613, 1397.6226418867052, 913.1097180249204, 995.5918073589938, 995.865558149655, 1017.527964595613, 1017.6285655735603, 6339.302676705559, 6345.777897773648, 6517.3808488193545, 6667.433268172163, 6667.566608170453, 498.7456397237435, 500.19468655464675, 501.4809671989473, 503.57447956476716, 518.6654607777962, 4537.3647689323525, 4544.636429085665, 4557.794899229542, 4558.0428110097255, 4562.0, 12091.153619246568, 12554.372281386077, 12579.37103144839, 12595.874041259653, 12629.2422454653, 11589.24669896454, 12087.697807554705, 12130.757384852253, 12473.126881118234, 12478.313692746804, 9076.727698169065, 9099.81800363989, 9133.908660913306, 9149.085091490932, 9270.30472714549, 6374.776882809079, 6382.042693595998, 6557.114789503356, 6572.8356791080605, 6773.661316934232, 11011.174161937726, 11138.108951283715, 11180.440977950908, 11187.384693841592, 11622.0702343814, 11436.085113190758, 11752.177347585586, 11810.350430726392, 11822.0, 11944.0, 8699.478031318142, 8785.341099417441, 9023.684171053981, 9168.862467062865, 9346.20557252614, 9740.366876153028, 9801.16690081351, 9827.213822894008, 9876.160526355341, 9878.950605247215, 8545.572721364031, 8679.0, 8696.086910874266, 8717.564121794012, 8847.51338676379, 8268.2558569729, 8310.626021829154, 8409.95795021021, 8410.201030902055, 8493.830123397622, 7538.3592394644875, 7571.545707257362, 7628.54228746277, 7631.3131818136635, 7648.502847314907, 5372.811951581676, 5377.462253774591, 5490.5607551395, 5584.86037849057, 5602.971985140048, 5429.131338985743, 5443.401225865231, 5458.5087342139395, 5466.562674986071, 5574.303212098488], "value": 5003.150122979921, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.99823000884993, 355.52892417546747, 362.9800360980146, 366.3003663003662, 367.1775223499362, 5536.723163841807, 5615.915761263579, 5617.494425501704, 5631.60578759487, 5636.4363563643665, 5433.8369848904495, 5462.808801691942, 5549.889002219953, 5582.2694964561015, 5596.720163991805, 4140.399642051901, 4284.892877678068, 4287.592678695519, 4296.677749168809, 4317.11499142675, 4232.227890731576, 4295.4201182840225, 4314.805833737473, 4317.625306081658, 4317.676174286926, 4266.2320782259185, 4282.850100246492, 4288.421063156465, 4291.871243862689, 4340.913181736363, 4192.895177620553, 4259.744415335059, 4266.765327906964, 4275.102228532012, 4320.265554855682, 3763.473113764075, 3772.5850156482766, 3774.999625099351, 3780.300644380771, 3789.374753165752, 5225.634205605609, 5255.264263003182, 5282.966058067672, 5286.748649580519, 5308.442613525563, 4751.453582837983, 4905.0, 4907.1903135982875, 4926.162552366106, 4929.433115191727, 5606.355269144019, 5712.828615141552, 5724.484796368347, 5726.398728133528, 5755.769769209227, 4106.733062350938, 4143.627073563363, 4157.524078951989, 4169.332906734908, 4170.395292682544, 5671.63134396267, 5942.0, 6004.18943442634, 6018.368071352533, 6019.127226552169, 4204.201201771653, 4245.150969806051, 4257.914841703148, 4262.190183865056, 4271.423357846713, 4316.978415107905, 4318.805653745589, 4334.306510958295, 4337.262665346899, 4350.58669426404, 4781.187198176319, 4883.145449546386, 4903.940345055085, 4907.901841963212, 4919.77860996256, 5749.626274292157, 5770.451807078321, 5780.1907732917425, 5783.248177736868, 5801.419858014249, 1474.7714104313848, 1474.8598883106088, 1479.8668119869265, 1491.8885430354455, 1494.215536843166, 921.9585118669676, 956.961696559241, 959.3140904253493, 965.5992763003275, 972.0473935543207, 4975.875603109951, 4976.253561965662, 5009.949900500948, 5011.699298042129, 5046.697198168122, 5289.68261904287, 5300.3639563252655, 5317.468253174651, 5324.92012619811, 5360.7649956533905, 4891.29076283944, 5035.974820125876, 5061.038402703474, 5092.719900405513, 5118.206677964921, 2857.9711303930567, 2862.7566656833988, 2864.756495697889, 2878.2372671242138, 2885.293103189732, 5396.379416367089, 5442.374126975448, 5519.751611177427, 5528.336599608073, 5529.170624406291, 5337.226102215157, 5656.9270125509565, 5850.210221620112, 5986.161937328778, 6134.079888016744, 5997.610155339976, 6007.489363404072, 6014.248218972629, 6016.278046634432, 6168.858761129205, 5984.611000284967, 5988.311344195299, 5988.970055149696, 5998.220231369894, 6022.638641681513, 5637.238972738792, 5905.645661260338, 5910.940890591039, 5923.614965027259, 5928.733207005781, 5865.4134586541, 6023.0, 6074.514038876968, 6098.5426093042315, 6135.263768347827, 4184.267753143248, 4194.266003449323, 4200.550809970555, 4201.159768046342, 4212.304969679968, 5955.731992060281, 5970.08957133713, 5979.369077605839, 5983.341832398346, 5984.611000284967, 5646.717907241115, 5732.369439361751, 5774.711264436845, 5805.809808989232, 5850.063989761617, 5765.682887441231, 5765.8558536036935, 5774.855628609151, 5785.016547186904, 5789.507891829073, 5503.559715222693, 5620.606557540933, 5666.631668941505, 5689.374168841341, 5718.599698021098, 5860.970695146497, 5872.647641141545, 5885.705714714161, 5887.941120588739, 5893.351731309467, 5633.521150702072, 5693.5445164387575, 5701.344345400332, 5707.971460142673, 5735.971320143372], "value": 4345.655888953691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.4200469593565, 867.73534072108, 896.4173287363217, 906.6464079009186, 910.1308250620662, 15837.762433563506, 17150.571235719115, 17197.656046879056, 17237.310507579696, 17257.741133882984, 15508.922455387736, 15735.370585176579, 15739.0, 16376.590585235375, 17062.573435664115, 743.7768669399186, 872.3108744092191, 893.7988952485688, 904.2088172848757, 906.5059542549293, 896.932730045246, 906.3610154840821, 910.1353713971753, 910.2308549275884, 910.9544522773868, 788.2787249666549, 920.6133423961919, 959.472290240365, 960.7742180587557, 963.6627180486809, 943.32552225159, 944.9905500944972, 945.2910317262053, 945.3382632157517, 947.6067432015706, 695.3533214110874, 695.4297476069625, 695.4679670052413, 695.766918082443, 696.0359901536358, 16459.177041147894, 16488.422905198382, 16543.503694889052, 16560.50318490435, 16578.917105414395, 14181.078229915023, 14257.0, 14299.714005719932, 14333.354999025069, 14673.046251993586, 13757.830584400337, 13831.0, 13945.58163255104, 13984.720305593832, 13990.300484975813, 4610.147122782296, 4670.626349892034, 4691.319758635013, 4702.717836929795, 4799.064182484417, 83565.0, 83580.0, 83647.5817620914, 86097.56951215204, 86276.56861715714, 12150.392480375946, 12245.142840001114, 12260.509579616715, 12435.129540932228, 12454.128211025323, 21627.24304649361, 21641.78358216398, 21647.350579482325, 21702.891485542787, 21716.23993160232, 9047.457152570867, 9210.953945230365, 9222.354435189472, 9298.814023719488, 9372.62509499626, 4890.779914903838, 5088.974555127201, 5113.0, 5159.097157997336, 5390.191471279261, 3473.8436770345397, 3510.262844802569, 3589.0, 3596.2987217492337, 3603.117236277129, 707.3598393453932, 732.487258918759, 740.2634378793027, 740.2671355358157, 761.7219714804056, 664.1797380235405, 741.1772932045425, 751.8721817291074, 777.455780953335, 811.1158836867843, 10401.375917444977, 10716.410597417216, 10726.141908647289, 10760.56957721698, 10764.892351076389, 634.1312402009277, 682.9965850170718, 705.5978092487336, 742.3504433620582, 768.5964868444, 4565.178267911741, 4851.320815085891, 4970.229614409773, 5050.191969284897, 5091.210862316347, 98587.0, 99118.0, 100417.0, 135620.0, 139540.0, 95053.0, 95310.5234473837, 96487.51756241174, 98355.50822245843, 101253.0, 62184.378156218765, 62309.376906231264, 91947.0, 92065.079349207, 92087.0, 10292.691219263434, 10616.681499555025, 10655.094316983143, 10670.57317707283, 10694.572217111228, 44185.33721994237, 45596.77201613971, 50302.0, 55431.44568554424, 56755.43244567667, 62000.0, 76197.23802761901, 76368.0, 77780.0, 79087.0, 14581.0, 14602.0, 14658.340374683377, 14674.26628668541, 14883.776743349075, 13512.527061552799, 14072.577822665336, 15842.12868292255, 15968.840311596736, 16534.338626454806, 13139.934300328438, 14420.134791912518, 14877.107373557621, 15038.398464061753, 15749.921250394133, 14805.555833325017, 15229.847701523286, 15349.0, 15642.296096675449, 15882.682346352776, 11953.282803031845, 12543.623691289276, 14611.196384198971, 14817.0, 15324.923375383052, 12748.808767868304, 12885.742285154058, 12909.677258068623, 13055.0, 13282.734345312847, 12294.139410241198, 12573.182743121668, 12596.0, 12639.810402844148, 12675.556355527513], "value": 8121.114692103024, "unit": "score"}], "name": "dromaeo_css", "value": 7646.741107875073, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 109.0, 109.0, 111.0, 110.0, 111.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 124.0, 177.0, 122.0, 124.0, 149.0, 123.0, 153.0, 122.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 160.0, 161.0, 160.0, 160.0, 163.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 125.0, 76.0, 75.0, 73.0, 75.0, 100.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 84.0, 83.0, 113.0, 84.0, 84.0, 120.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 52.0, 51.0, 71.0, 52.0, 52.0, 54.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 76.0, 77.0, 78.0, 81.0, 77.0, 105.0, 78.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 117.0, 127.0, 124.0, 115.0, 115.0, 117.0, 130.0, 120.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 156.0, 156.0, 164.0, 159.0, 152.0, 155.0, 155.0, 157.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 60.0, 60.0, 63.0, 61.0, 61.0, 60.0, 62.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1476.5, "alertThreshold": 2.0}]} 07:12:01 INFO - Return code: 0 07:12:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:12:01 ERROR - # TBPL SUCCESS # 07:12:01 INFO - Running post-action listener: _resource_record_post_action 07:12:01 INFO - ##### 07:12:01 INFO - ##### Finished run-tests step (success) 07:12:01 INFO - ##### 07:12:01 INFO - Running post-run listener: _resource_record_post_run 07:12:01 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7938048; Write bytes: 387166208; Read time: 1344; Write time: 325564 07:12:01 INFO - TinderboxPrint: CPU usage
13.1% 07:12:01 INFO - TinderboxPrint: I/O read bytes / time
7,938,048 / 1,344 07:12:01 INFO - TinderboxPrint: I/O write bytes / time
387,166,208 / 325,564 07:12:01 INFO - TinderboxPrint: CPU idle
8,269.2 (86.9%) 07:12:01 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 07:12:01 INFO - TinderboxPrint: Swap in / out
0 / 0 07:12:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 12079104; Read time: 80; Write time: 1996 07:12:01 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6172672; Write bytes: 375087104; Read time: 1228; Write time: 323568 07:12:02 INFO - Running post-run listener: _upload_blobber_files 07:12:02 INFO - Blob upload gear active. 07:12:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:12:02 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 07:12:02 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:12:02 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:12:02 INFO - (blobuploader) - INFO - Open directory for files ... 07:12:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:12:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:12:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:03 INFO - (blobuploader) - INFO - Done attempting. 07:12:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:12:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:12:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:08 INFO - (blobuploader) - INFO - Done attempting. 07:12:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:12:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:12:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:09 INFO - (blobuploader) - INFO - Done attempting. 07:12:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:12:09 INFO - Return code: 0 07:12:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:12:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:12:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a23e76ec5f8fcee6970e540a90d0376d537ada6e836192b0b6802e9c70cb25503fd27636a8aebddd480bea9d6178a00bb738ae942c13dd8a38f6fcc51bd9e65a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24c146b25705e875fc80e5264cf7deb71a1adc9fe3dcd1647f26ad2ffe0879f9f7e766463227c33c3206e228b6e704d18ec39f541287ed2a8a28b28c7ab9da7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40bf9e5daed970a3ab4688693e11c7c5a0d87085435af9605a341af2db7c90b23666d22cdd9132dd507c5e3074004aae886869f8f9bb9acf4ebcf2be2335bfa1"} 07:12:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:12:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:12:09 INFO - Contents: 07:12:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a23e76ec5f8fcee6970e540a90d0376d537ada6e836192b0b6802e9c70cb25503fd27636a8aebddd480bea9d6178a00bb738ae942c13dd8a38f6fcc51bd9e65a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24c146b25705e875fc80e5264cf7deb71a1adc9fe3dcd1647f26ad2ffe0879f9f7e766463227c33c3206e228b6e704d18ec39f541287ed2a8a28b28c7ab9da7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40bf9e5daed970a3ab4688693e11c7c5a0d87085435af9605a341af2db7c90b23666d22cdd9132dd507c5e3074004aae886869f8f9bb9acf4ebcf2be2335bfa1"} 07:12:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:12:09 INFO - Copying logs to upload dir... 07:12:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:12:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.880996 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-04 07:12:09.406141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 07:12:09.409714) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a23e76ec5f8fcee6970e540a90d0376d537ada6e836192b0b6802e9c70cb25503fd27636a8aebddd480bea9d6178a00bb738ae942c13dd8a38f6fcc51bd9e65a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24c146b25705e875fc80e5264cf7deb71a1adc9fe3dcd1647f26ad2ffe0879f9f7e766463227c33c3206e228b6e704d18ec39f541287ed2a8a28b28c7ab9da7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40bf9e5daed970a3ab4688693e11c7c5a0d87085435af9605a341af2db7c90b23666d22cdd9132dd507c5e3074004aae886869f8f9bb9acf4ebcf2be2335bfa1"} build_url:https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/KRq5ph3FS_q_qzC0Jgt7Zg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a23e76ec5f8fcee6970e540a90d0376d537ada6e836192b0b6802e9c70cb25503fd27636a8aebddd480bea9d6178a00bb738ae942c13dd8a38f6fcc51bd9e65a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24c146b25705e875fc80e5264cf7deb71a1adc9fe3dcd1647f26ad2ffe0879f9f7e766463227c33c3206e228b6e704d18ec39f541287ed2a8a28b28c7ab9da7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40bf9e5daed970a3ab4688693e11c7c5a0d87085435af9605a341af2db7c90b23666d22cdd9132dd507c5e3074004aae886869f8f9bb9acf4ebcf2be2335bfa1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 07:12:09.439906) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:12:09.440720) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467637923.312037-398862637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:12:09.524973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 07:12:09.525452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 07:12:09.525754) ========= ========= Total master_lag: 0.18 =========