builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1465212158.05 results: success (0) buildid: 20160606025732 builduid: 6fbeeb8900d44f169ac73357babe7d71 revision: 0a3b6e2df6567d845f31c000c68dd67816c6153d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.047933) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.048436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.048765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.064011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.064373) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 04:22:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-06-06 04:22:39 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.339132 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.417306) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.417653) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013874 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.464499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:38.464855) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0a3b6e2df6567d845f31c000c68dd67816c6153d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0a3b6e2df6567d845f31c000c68dd67816c6153d --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=a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 04:22:39,286 truncating revision to first 12 chars 2016-06-06 04:22:39,286 Setting DEBUG logging. 2016-06-06 04:22:39,286 attempt 1/10 2016-06-06 04:22:39,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0a3b6e2df656?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 04:22:39,882 unpacking tar archive at: mozilla-central-0a3b6e2df656/testing/mozharness/ program finished with exit code 0 elapsedTime=0.932566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:39.410512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:39.410845) ========= script_repo_revision: 0a3b6e2df6567d845f31c000c68dd67816c6153d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:39.411257) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:39.411553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 04:22:39.421936) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-06 04:22:39.422325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:40 INFO - MultiFileLogger online at 20160606 04:22:40 in /builds/slave/test 04:22:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:22:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:40 INFO - {'append_to_log': False, 04:22:40 INFO - 'base_work_dir': '/builds/slave/test', 04:22:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:22:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:40 INFO - 'branch': 'Firefox-Non-PGO', 04:22:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:40 INFO - 'config_files': ('talos/linux_config.py',), 04:22:40 INFO - 'default_actions': ('clobber', 04:22:40 INFO - 'read-buildbot-config', 04:22:40 INFO - 'download-and-extract', 04:22:40 INFO - 'populate-webroot', 04:22:40 INFO - 'create-virtualenv', 04:22:40 INFO - 'install', 04:22:40 INFO - 'run-tests'), 04:22:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:40 INFO - 'download_minidump_stackwalk': True, 04:22:40 INFO - 'download_symbols': 'ondemand', 04:22:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:40 INFO - 'installer_path': 'installer.exe', 04:22:40 INFO - 'log_level': 'info', 04:22:40 INFO - 'log_name': 'talos', 04:22:40 INFO - 'log_to_console': True, 04:22:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:40 INFO - 'opt_config_files': (), 04:22:40 INFO - 'pip_index': False, 04:22:40 INFO - 'sps_profile': False, 04:22:40 INFO - 'sps_profile_interval': 0, 04:22:40 INFO - 'suite': 'dromaeojs-e10s', 04:22:40 INFO - 'system_bits': '32', 04:22:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:40 INFO - 'title': 'talos-linux64-ix-062', 04:22:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:40 INFO - 'use_talos_json': True, 04:22:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:40 INFO - 'work_dir': 'build'} 04:22:40 INFO - ##### 04:22:40 INFO - ##### Running clobber step. 04:22:40 INFO - ##### 04:22:40 INFO - Running pre-action listener: _resource_record_pre_action 04:22:40 INFO - Running main action method: clobber 04:22:40 INFO - rmtree: /builds/slave/test/build 04:22:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:40 INFO - Running post-action listener: _resource_record_post_action 04:22:40 INFO - ##### 04:22:40 INFO - ##### Finished clobber step (success) 04:22:40 INFO - ##### 04:22:40 INFO - ##### 04:22:40 INFO - ##### Running read-buildbot-config step. 04:22:40 INFO - ##### 04:22:40 INFO - Running pre-action listener: _resource_record_pre_action 04:22:40 INFO - Running main action method: read_buildbot_config 04:22:40 INFO - Using buildbot properties: 04:22:40 INFO - { 04:22:40 INFO - "project": "", 04:22:40 INFO - "product": "firefox", 04:22:40 INFO - "script_repo_revision": "production", 04:22:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:22:40 INFO - "repository": "", 04:22:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:22:40 INFO - "buildid": "20160606025732", 04:22:40 INFO - "pgo_build": "False", 04:22:40 INFO - "basedir": "/builds/slave/test", 04:22:40 INFO - "buildnumber": 78, 04:22:40 INFO - "slavename": "talos-linux64-ix-062", 04:22:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:22:40 INFO - "platform": "ubuntu64_hw", 04:22:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:22:40 INFO - "branch": "mozilla-central", 04:22:40 INFO - "repo_path": "mozilla-central", 04:22:40 INFO - "revision": "0a3b6e2df6567d845f31c000c68dd67816c6153d", 04:22:40 INFO - "stage_platform": "linux64", 04:22:40 INFO - "builduid": "6fbeeb8900d44f169ac73357babe7d71", 04:22:40 INFO - "slavebuilddir": "test" 04:22:40 INFO - } 04:22:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:22:40 INFO - Running post-action listener: _resource_record_post_action 04:22:40 INFO - ##### 04:22:40 INFO - ##### Finished read-buildbot-config step (success) 04:22:40 INFO - ##### 04:22:40 INFO - ##### 04:22:40 INFO - ##### Running download-and-extract step. 04:22:40 INFO - ##### 04:22:40 INFO - Running pre-action listener: _resource_record_pre_action 04:22:40 INFO - Running main action method: download_and_extract 04:22:40 INFO - mkdir: /builds/slave/test/build/tests 04:22: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')]} 04:22:40 INFO - https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:22:41 INFO - Downloaded 1361 bytes. 04:22:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:22:41 INFO - Using the following test package requirements: 04:22:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:22:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:41 INFO - u'jsshell-linux-x86_64.zip'], 04:22:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:41 INFO - https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:22:42 INFO - Downloaded 22870969 bytes. 04:22:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:22:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:22:43 INFO - Return code: 0 04:22:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:43 INFO - https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:22:45 INFO - Downloaded 22870969 bytes. 04:22:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:22:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:22:46 INFO - Return code: 0 04:22: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')]} 04:22:46 INFO - https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:22:47 INFO - Downloaded 10833369 bytes. 04:22:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:22:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:22:47 INFO - Return code: 0 04:22:47 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')]} 04:22:47 INFO - https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:22:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:22:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:22:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:22:49 INFO - Downloaded 55202497 bytes. 04:22:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:22:49 INFO - mkdir: /builds/slave/test/properties 04:22:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:49 INFO - Contents: 04:22:49 INFO - build_url:https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:22:51 INFO - Running post-action listener: _resource_record_post_action 04:22:51 INFO - Running post-action listener: set_extra_try_arguments 04:22:51 INFO - ##### 04:22:51 INFO - ##### Finished download-and-extract step (success) 04:22:51 INFO - ##### 04:22:51 INFO - ##### 04:22:51 INFO - ##### Running populate-webroot step. 04:22:51 INFO - ##### 04:22:51 INFO - Running pre-action listener: _resource_record_pre_action 04:22:51 INFO - Running main action method: populate_webroot 04:22:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:51 INFO - '--tppagecycles', 04:22:51 INFO - '7'], 04:22:51 INFO - 'tests': ['tsvgm']}}, 04:22:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:51 INFO - 'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:51 INFO - 'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['damp', 'tps']}, 04:22:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:51 INFO - 'tests': ['damp', 'tps']}, 04:22:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['dromaeo_dom']}, 04:22:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['a11yr', 04:22:51 INFO - 'ts_paint', 04:22:51 INFO - 'tpaint', 04:22:51 INFO - 'sessionrestore', 04:22:51 INFO - 'sessionrestore_no_auto_restore', 04:22:51 INFO - 'tabpaint']}, 04:22:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:51 INFO - 'ts_paint', 04:22:51 INFO - 'tpaint', 04:22:51 INFO - 'sessionrestore', 04:22:51 INFO - 'sessionrestore_no_auto_restore', 04:22:51 INFO - 'tabpaint']}, 04:22:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:22:51 INFO - 'ts_paint', 04:22:51 INFO - 'tpaint', 04:22:51 INFO - 'sessionrestore', 04:22:51 INFO - 'sessionrestore_no_auto_restore', 04:22:51 INFO - 'tabpaint']}, 04:22:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:22:51 INFO - 'ts_paint', 04:22:51 INFO - 'tpaint', 04:22:51 INFO - 'sessionrestore', 04:22:51 INFO - 'sessionrestore_no_auto_restore', 04:22:51 INFO - 'tabpaint']}, 04:22:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['a11yr', 04:22:51 INFO - 'ts_paint', 04:22:51 INFO - 'tpaint', 04:22:51 INFO - 'sessionrestore', 04:22:51 INFO - 'sessionrestore_no_auto_restore', 04:22:51 INFO - 'tabpaint']}, 04:22:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['a11yr', 04:22:51 INFO - 'ts_paint', 04:22:51 INFO - 'tpaint', 04:22:51 INFO - 'sessionrestore', 04:22:51 INFO - 'sessionrestore_no_auto_restore', 04:22:51 INFO - 'tabpaint']}, 04:22:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['tsvgx', 04:22:51 INFO - 'tsvgr_opacity', 04:22:51 INFO - 'tart', 04:22:51 INFO - 'tscrollx', 04:22:51 INFO - 'cart']}, 04:22:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:51 INFO - 'tsvgr_opacity', 04:22:51 INFO - 'tart', 04:22:51 INFO - 'tscrollx', 04:22:51 INFO - 'cart']}, 04:22:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:51 INFO - 'talos_options': ['--disable-e10s'], 04:22:51 INFO - 'tests': ['tp5o']}, 04:22:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:51 INFO - 'tests': ['tp5o']}, 04:22:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:51 INFO - 'talos_options': ['--disable-e10s', 04:22:51 INFO - '--xperf_path', 04:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:51 INFO - 'tests': ['tp5n']}, 04:22:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:51 INFO - 'talos_options': ['--xperf_path', 04:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:51 INFO - 'tests': ['tp5n']}}, 04:22:51 INFO - 'talos.zip': {'path': '', 04:22:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:51 INFO - Running post-action listener: _resource_record_post_action 04:22:51 INFO - ##### 04:22:51 INFO - ##### Finished populate-webroot step (success) 04:22:51 INFO - ##### 04:22:51 INFO - ##### 04:22:51 INFO - ##### Running create-virtualenv step. 04:22:51 INFO - ##### 04:22:51 INFO - Running pre-action listener: _resource_record_pre_action 04:22:51 INFO - Running main action method: create_virtualenv 04:22:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:51 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 04:22:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:51 INFO - Using real prefix '/usr' 04:22:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:54 INFO - Installing pip.................done. 04:22:54 INFO - Return code: 0 04:22:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:22: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', 'pip>=1.5'] in /builds/slave/test/build 04:22: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 pip>=1.5 04:22:54 INFO - Using env: {'DISPLAY': ':0', 04:22:54 INFO - 'HOME': '/home/cltbld', 04:22:54 INFO - 'LANG': 'en_US.UTF-8', 04:22:54 INFO - 'LANGUAGE': 'en_US:en', 04:22:54 INFO - 'LOGNAME': 'cltbld', 04:22:54 INFO - 'MAIL': '/var/mail/cltbld', 04:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:54 INFO - 'MOZ_NO_REMOTE': '1', 04:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:54 INFO - 'NO_EM_RESTART': '1', 04:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:54 INFO - 'PWD': '/builds/slave/test', 04:22:54 INFO - 'SHELL': '/bin/bash', 04:22:54 INFO - 'SHLVL': '1', 04:22:54 INFO - 'TERM': 'linux', 04:22:54 INFO - 'TMOUT': '86400', 04:22:54 INFO - 'USER': 'cltbld', 04:22:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:54 INFO - '_': '/tools/buildbot/bin/python'} 04:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:54 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 04:22:54 INFO - Cleaning up... 04:22:54 INFO - Return code: 0 04:22:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', '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 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:22: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 psutil>=3.1.1 04:22:54 INFO - Using env: {'DISPLAY': ':0', 04:22:54 INFO - 'HOME': '/home/cltbld', 04:22:54 INFO - 'LANG': 'en_US.UTF-8', 04:22:54 INFO - 'LANGUAGE': 'en_US:en', 04:22:54 INFO - 'LOGNAME': 'cltbld', 04:22:54 INFO - 'MAIL': '/var/mail/cltbld', 04:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:54 INFO - 'MOZ_NO_REMOTE': '1', 04:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:54 INFO - 'NO_EM_RESTART': '1', 04:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:54 INFO - 'PWD': '/builds/slave/test', 04:22:54 INFO - 'SHELL': '/bin/bash', 04:22:54 INFO - 'SHLVL': '1', 04:22:54 INFO - 'TERM': 'linux', 04:22:54 INFO - 'TMOUT': '86400', 04:22:54 INFO - 'USER': 'cltbld', 04:22:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:54 INFO - '_': '/tools/buildbot/bin/python'} 04:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:54 INFO - Downloading/unpacking psutil>=3.1.1 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:56 INFO - Installing collected packages: psutil 04:22:56 INFO - Running setup.py install for psutil 04:22:56 INFO - building 'psutil._psutil_linux' extension 04:22:56 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 04:22:56 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 04:22:56 INFO - building 'psutil._psutil_posix' extension 04:22:56 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 04:22:57 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 04:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:57 INFO - Successfully installed psutil 04:22:57 INFO - Cleaning up... 04:22:57 INFO - Return code: 0 04:22:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:22:57 INFO - Using env: {'DISPLAY': ':0', 04:22:57 INFO - 'HOME': '/home/cltbld', 04:22:57 INFO - 'LANG': 'en_US.UTF-8', 04:22:57 INFO - 'LANGUAGE': 'en_US:en', 04:22:57 INFO - 'LOGNAME': 'cltbld', 04:22:57 INFO - 'MAIL': '/var/mail/cltbld', 04:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:57 INFO - 'MOZ_NO_REMOTE': '1', 04:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:57 INFO - 'NO_EM_RESTART': '1', 04:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:57 INFO - 'PWD': '/builds/slave/test', 04:22:57 INFO - 'SHELL': '/bin/bash', 04:22:57 INFO - 'SHLVL': '1', 04:22:57 INFO - 'TERM': 'linux', 04:22:57 INFO - 'TMOUT': '86400', 04:22:57 INFO - 'USER': 'cltbld', 04:22:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:57 INFO - '_': '/tools/buildbot/bin/python'} 04:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:22:59 INFO - Installing collected packages: mozsystemmonitor 04:22:59 INFO - Running setup.py install for mozsystemmonitor 04:22:59 INFO - Successfully installed mozsystemmonitor 04:22:59 INFO - Cleaning up... 04:22:59 INFO - Return code: 0 04:22:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:59 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 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:22:59 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 04:22:59 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 04:22:59 INFO - Using env: {'DISPLAY': ':0', 04:22:59 INFO - 'HOME': '/home/cltbld', 04:22:59 INFO - 'LANG': 'en_US.UTF-8', 04:22:59 INFO - 'LANGUAGE': 'en_US:en', 04:22:59 INFO - 'LOGNAME': 'cltbld', 04:22:59 INFO - 'MAIL': '/var/mail/cltbld', 04:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:59 INFO - 'MOZ_NO_REMOTE': '1', 04:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:59 INFO - 'NO_EM_RESTART': '1', 04:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:59 INFO - 'PWD': '/builds/slave/test', 04:22:59 INFO - 'SHELL': '/bin/bash', 04:22:59 INFO - 'SHLVL': '1', 04:22:59 INFO - 'TERM': 'linux', 04:22:59 INFO - 'TMOUT': '86400', 04:22:59 INFO - 'USER': 'cltbld', 04:22:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:59 INFO - '_': '/tools/buildbot/bin/python'} 04:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23:01 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 04:23:01 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 04:23:01 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 04:23:01 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 04:23:01 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 04:23:01 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 04:23:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:02 INFO - warning: no files found matching '*.txt' 04:23:02 INFO - no previously-included directories found matching 'build' 04:23:02 INFO - no previously-included directories found matching 'dist' 04:23:02 INFO - no previously-included directories found matching '.git*' 04:23:02 INFO - Installing collected packages: jsonschema, functools32 04:23:02 INFO - Running setup.py install for functools32 04:23:02 INFO - warning: no files found matching '*.txt' 04:23:02 INFO - no previously-included directories found matching 'build' 04:23:02 INFO - no previously-included directories found matching 'dist' 04:23:02 INFO - no previously-included directories found matching '.git*' 04:23:02 INFO - Successfully installed jsonschema functools32 04:23:02 INFO - Cleaning up... 04:23:02 INFO - Return code: 0 04:23:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:23:02 INFO - Using env: {'DISPLAY': ':0', 04:23:02 INFO - 'HOME': '/home/cltbld', 04:23:02 INFO - 'LANG': 'en_US.UTF-8', 04:23:02 INFO - 'LANGUAGE': 'en_US:en', 04:23:02 INFO - 'LOGNAME': 'cltbld', 04:23:02 INFO - 'MAIL': '/var/mail/cltbld', 04:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:02 INFO - 'MOZ_NO_REMOTE': '1', 04:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:02 INFO - 'NO_EM_RESTART': '1', 04:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:02 INFO - 'PWD': '/builds/slave/test', 04:23:02 INFO - 'SHELL': '/bin/bash', 04:23:02 INFO - 'SHLVL': '1', 04:23:02 INFO - 'TERM': 'linux', 04:23:02 INFO - 'TMOUT': '86400', 04:23:02 INFO - 'USER': 'cltbld', 04:23:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:02 INFO - '_': '/tools/buildbot/bin/python'} 04:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:04 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 04:23:04 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 04:23:04 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 04:23:04 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 04:23:04 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 04:23:04 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 04:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:04 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 04:23:04 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 04:23:04 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 04:23:04 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 04:23:04 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 04:23:04 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 04:23:05 INFO - Downloading docopt-0.6.1.tar.gz 04:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:05 INFO - Running setup.py install for blobuploader 04:23:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:05 INFO - Running setup.py install for requests 04:23:05 INFO - Running setup.py install for docopt 04:23:05 INFO - Successfully installed blobuploader requests docopt 04:23:05 INFO - Cleaning up... 04:23:05 INFO - Return code: 0 04:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:05 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 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:23:05 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 04:23:05 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 04:23:05 INFO - Using env: {'DISPLAY': ':0', 04:23:05 INFO - 'HOME': '/home/cltbld', 04:23:05 INFO - 'LANG': 'en_US.UTF-8', 04:23:05 INFO - 'LANGUAGE': 'en_US:en', 04:23:05 INFO - 'LOGNAME': 'cltbld', 04:23:05 INFO - 'MAIL': '/var/mail/cltbld', 04:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:05 INFO - 'MOZ_NO_REMOTE': '1', 04:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:05 INFO - 'NO_EM_RESTART': '1', 04:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:05 INFO - 'PWD': '/builds/slave/test', 04:23:05 INFO - 'SHELL': '/bin/bash', 04:23:05 INFO - 'SHLVL': '1', 04:23:05 INFO - 'TERM': 'linux', 04:23:05 INFO - 'TMOUT': '86400', 04:23:05 INFO - 'USER': 'cltbld', 04:23:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:05 INFO - '_': '/tools/buildbot/bin/python'} 04:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:06 INFO - Running setup.py (path:/tmp/pip-xDGQCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:06 INFO - Running setup.py (path:/tmp/pip-4QTzYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:06 INFO - Running setup.py (path:/tmp/pip-QC5wUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:06 INFO - Running setup.py (path:/tmp/pip-hQ9Te4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:06 INFO - Running setup.py (path:/tmp/pip-pXzVaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:06 INFO - Running setup.py (path:/tmp/pip-xJKPvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:06 INFO - Running setup.py (path:/tmp/pip-IhwyEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:06 INFO - Running setup.py (path:/tmp/pip-ZFSYdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:06 INFO - Running setup.py (path:/tmp/pip-550um7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:06 INFO - Running setup.py (path:/tmp/pip-XFRnFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:06 INFO - Running setup.py (path:/tmp/pip-fWEdJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:06 INFO - Running setup.py (path:/tmp/pip-tIar_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:06 INFO - Running setup.py (path:/tmp/pip-3opcvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:06 INFO - Running setup.py (path:/tmp/pip-wtYsVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:07 INFO - Running setup.py (path:/tmp/pip-JhJR8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:07 INFO - Running setup.py (path:/tmp/pip-8WIiST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:07 INFO - Running setup.py (path:/tmp/pip-9ZvcqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:07 INFO - Running setup.py install for manifestparser 04:23:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:07 INFO - Running setup.py install for mozcrash 04:23:07 INFO - Running setup.py install for mozdebug 04:23:07 INFO - Running setup.py install for mozdevice 04:23:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:07 INFO - Running setup.py install for mozfile 04:23:07 INFO - Running setup.py install for mozhttpd 04:23:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:07 INFO - Running setup.py install for mozinfo 04:23:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:07 INFO - Running setup.py install for mozInstall 04:23:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Running setup.py install for mozleak 04:23:08 INFO - Running setup.py install for mozlog 04:23:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Running setup.py install for moznetwork 04:23:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Running setup.py install for mozprocess 04:23:08 INFO - Running setup.py install for mozprofile 04:23:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Running setup.py install for mozrunner 04:23:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:08 INFO - Running setup.py install for mozscreenshot 04:23:08 INFO - Running setup.py install for moztest 04:23:08 INFO - Running setup.py install for mozversion 04:23:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:09 INFO - Cleaning up... 04:23:09 INFO - Return code: 0 04:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:09 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')]} 04:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:09 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')]} 04:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:09 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 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:23:09 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 04:23:09 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 04:23:09 INFO - Using env: {'DISPLAY': ':0', 04:23:09 INFO - 'HOME': '/home/cltbld', 04:23:09 INFO - 'LANG': 'en_US.UTF-8', 04:23:09 INFO - 'LANGUAGE': 'en_US:en', 04:23:09 INFO - 'LOGNAME': 'cltbld', 04:23:09 INFO - 'MAIL': '/var/mail/cltbld', 04:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:09 INFO - 'MOZ_NO_REMOTE': '1', 04:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:09 INFO - 'NO_EM_RESTART': '1', 04:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:09 INFO - 'PWD': '/builds/slave/test', 04:23:09 INFO - 'SHELL': '/bin/bash', 04:23:09 INFO - 'SHLVL': '1', 04:23:09 INFO - 'TERM': 'linux', 04:23:09 INFO - 'TMOUT': '86400', 04:23:09 INFO - 'USER': 'cltbld', 04:23:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:09 INFO - '_': '/tools/buildbot/bin/python'} 04:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:09 INFO - Running setup.py (path:/tmp/pip-xhlRvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:09 INFO - Running setup.py (path:/tmp/pip-f28Utk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:09 INFO - Running setup.py (path:/tmp/pip-pWFuyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:09 INFO - Running setup.py (path:/tmp/pip-TQXLYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:09 INFO - Running setup.py (path:/tmp/pip-PF9Jl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:09 INFO - Running setup.py (path:/tmp/pip-8yVDkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:09 INFO - Running setup.py (path:/tmp/pip-gEhwnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:09 INFO - Running setup.py (path:/tmp/pip-ffgIcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:09 INFO - Running setup.py (path:/tmp/pip-wy4hxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:09 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)) 04:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:09 INFO - Running setup.py (path:/tmp/pip-RxbkSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:10 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)) 04:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:10 INFO - Running setup.py (path:/tmp/pip-euc7dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:10 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)) 04:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:10 INFO - Running setup.py (path:/tmp/pip-hWgZ7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:10 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)) 04:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:10 INFO - Running setup.py (path:/tmp/pip-cr1xZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:10 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)) 04:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:10 INFO - Running setup.py (path:/tmp/pip-oAnYn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:10 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)) 04:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:10 INFO - Running setup.py (path:/tmp/pip-usps0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:10 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)) 04:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:10 INFO - Running setup.py (path:/tmp/pip-2QP7Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:10 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)) 04:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:10 INFO - Running setup.py (path:/tmp/pip-WKazVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:10 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)) 04:23:10 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)) 04:23:10 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)) 04:23:10 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)) 04:23:10 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)) 04:23:10 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)) 04:23:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:12 INFO - Downloading blessings-1.6.tar.gz 04:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:12 INFO - Installing collected packages: blessings 04:23:12 INFO - Running setup.py install for blessings 04:23:12 INFO - Successfully installed blessings 04:23:12 INFO - Cleaning up... 04:23:12 INFO - Return code: 0 04:23:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:12 INFO - Reading from file tmpfile_stdout 04:23:12 INFO - Current package versions: 04:23:12 INFO - argparse == 1.2.1 04:23:12 INFO - blessings == 1.6 04:23:12 INFO - blobuploader == 1.2.4 04:23:12 INFO - docopt == 0.6.1 04:23:12 INFO - functools32 == 3.2.3-2 04:23:12 INFO - jsonschema == 2.5.1 04:23:12 INFO - manifestparser == 1.1 04:23:12 INFO - mozInstall == 1.12 04:23:12 INFO - mozcrash == 0.17 04:23:12 INFO - mozdebug == 0.1 04:23:12 INFO - mozdevice == 0.48 04:23:12 INFO - mozfile == 1.2 04:23:12 INFO - mozhttpd == 0.7 04:23:12 INFO - mozinfo == 0.9 04:23:12 INFO - mozleak == 0.1 04:23:12 INFO - mozlog == 3.2 04:23:12 INFO - moznetwork == 0.27 04:23:12 INFO - mozprocess == 0.22 04:23:12 INFO - mozprofile == 0.28 04:23:12 INFO - mozrunner == 6.11 04:23:12 INFO - mozscreenshot == 0.1 04:23:12 INFO - mozsystemmonitor == 0.3 04:23:12 INFO - moztest == 0.7 04:23:12 INFO - mozversion == 1.4 04:23:12 INFO - psutil == 3.1.1 04:23:12 INFO - requests == 1.2.3 04:23:12 INFO - wsgiref == 0.1.2 04:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:12 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')]} 04:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:12 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')]} 04:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:12 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 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:23:12 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 04:23:12 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 04:23:12 INFO - Using env: {'DISPLAY': ':0', 04:23:12 INFO - 'HOME': '/home/cltbld', 04:23:12 INFO - 'LANG': 'en_US.UTF-8', 04:23:12 INFO - 'LANGUAGE': 'en_US:en', 04:23:12 INFO - 'LOGNAME': 'cltbld', 04:23:12 INFO - 'MAIL': '/var/mail/cltbld', 04:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:12 INFO - 'MOZ_NO_REMOTE': '1', 04:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:12 INFO - 'NO_EM_RESTART': '1', 04:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:12 INFO - 'PWD': '/builds/slave/test', 04:23:12 INFO - 'SHELL': '/bin/bash', 04:23:12 INFO - 'SHLVL': '1', 04:23:12 INFO - 'TERM': 'linux', 04:23:12 INFO - 'TMOUT': '86400', 04:23:12 INFO - 'USER': 'cltbld', 04:23:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:12 INFO - '_': '/tools/buildbot/bin/python'} 04:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 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)) 04:23:13 INFO - Cleaning up... 04:23:13 INFO - Return code: 0 04:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:23:13 INFO - Using env: {'DISPLAY': ':0', 04:23:13 INFO - 'HOME': '/home/cltbld', 04:23:13 INFO - 'LANG': 'en_US.UTF-8', 04:23:13 INFO - 'LANGUAGE': 'en_US:en', 04:23:13 INFO - 'LOGNAME': 'cltbld', 04:23:13 INFO - 'MAIL': '/var/mail/cltbld', 04:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:13 INFO - 'MOZ_NO_REMOTE': '1', 04:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:13 INFO - 'NO_EM_RESTART': '1', 04:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:13 INFO - 'PWD': '/builds/slave/test', 04:23:13 INFO - 'SHELL': '/bin/bash', 04:23:13 INFO - 'SHLVL': '1', 04:23:13 INFO - 'TERM': 'linux', 04:23:13 INFO - 'TMOUT': '86400', 04:23:13 INFO - 'USER': 'cltbld', 04:23:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:13 INFO - '_': '/tools/buildbot/bin/python'} 04:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:13 INFO - Cleaning up... 04:23:13 INFO - Return code: 0 04:23:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa028cf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe65020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', '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 04:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:23:13 INFO - Using env: {'DISPLAY': ':0', 04:23:13 INFO - 'HOME': '/home/cltbld', 04:23:13 INFO - 'LANG': 'en_US.UTF-8', 04:23:13 INFO - 'LANGUAGE': 'en_US:en', 04:23:13 INFO - 'LOGNAME': 'cltbld', 04:23:13 INFO - 'MAIL': '/var/mail/cltbld', 04:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:13 INFO - 'MOZ_NO_REMOTE': '1', 04:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:13 INFO - 'NO_EM_RESTART': '1', 04:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:13 INFO - 'PWD': '/builds/slave/test', 04:23:13 INFO - 'SHELL': '/bin/bash', 04:23:13 INFO - 'SHLVL': '1', 04:23:13 INFO - 'TERM': 'linux', 04:23:13 INFO - 'TMOUT': '86400', 04:23:13 INFO - 'USER': 'cltbld', 04:23:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:13 INFO - '_': '/tools/buildbot/bin/python'} 04:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:13 INFO - Downloading/unpacking flake8 04:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:16 INFO - no previously-included directories found matching 'docs/_build' 04:23:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:16 INFO - Running setup.py install for pep8 04:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:16 INFO - no previously-included directories found matching 'docs/_build' 04:23:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:16 INFO - Cleaning up... 04:23:16 INFO - Return code: 0 04:23:16 INFO - Running post-action listener: _resource_record_post_action 04:23:16 INFO - Running post-action listener: _start_resource_monitoring 04:23:16 INFO - Starting resource monitoring. 04:23:16 INFO - ##### 04:23:16 INFO - ##### Finished create-virtualenv step (success) 04:23:16 INFO - ##### 04:23:16 INFO - ##### 04:23:16 INFO - ##### Running install step. 04:23:16 INFO - ##### 04:23:16 INFO - Running pre-action listener: _resource_record_pre_action 04:23:16 INFO - Running main action method: install 04:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:16 INFO - Reading from file tmpfile_stdout 04:23:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:16 INFO - Reading from file tmpfile_stdout 04:23:16 INFO - Output received: 04:23:16 INFO - Usage: mozinstall [options] installer 04:23:16 INFO - Options: 04:23:16 INFO - -h, --help show this help message and exit 04:23:16 INFO - -d DEST, --destination=DEST 04:23:16 INFO - Directory to install application into. [default: 04:23:16 INFO - "/builds/slave/test"] 04:23:16 INFO - --app=APP Application being installed. [default: firefox] 04:23:16 INFO - mkdir: /builds/slave/test/build/application 04:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:23:32 INFO - Reading from file tmpfile_stdout 04:23:32 INFO - Output received: 04:23:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:32 INFO - Running post-action listener: _resource_record_post_action 04:23:32 INFO - ##### 04:23:32 INFO - ##### Finished install step (success) 04:23:32 INFO - ##### 04:23:32 INFO - ##### 04:23:32 INFO - ##### Running run-tests step. 04:23:32 INFO - ##### 04:23:32 INFO - Running pre-action listener: _resource_record_pre_action 04:23:32 INFO - Running main action method: run_tests 04:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:32 INFO - Python 2.7.3 04:23:32 INFO - Return code: 0 04:23:32 INFO - grabbing minidump binary from tooltool 04:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:32 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 0xef72e0>, '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 0xe63140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe635d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:32 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 04:23:32 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 04:23:32 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 04:23:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:32 INFO - Return code: 0 04:23:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:23:33 INFO - Return code: 0 04:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:23:33 INFO - Using env: {'DISPLAY': ':0', 04:23:33 INFO - 'HOME': '/home/cltbld', 04:23:33 INFO - 'LANG': 'en_US.UTF-8', 04:23:33 INFO - 'LANGUAGE': 'en_US:en', 04:23:33 INFO - 'LOGNAME': 'cltbld', 04:23:33 INFO - 'MAIL': '/var/mail/cltbld', 04:23:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:33 INFO - 'MOZ_NO_REMOTE': '1', 04:23:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:33 INFO - 'NO_EM_RESTART': '1', 04:23:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:33 INFO - 'PWD': '/builds/slave/test', 04:23:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:33 INFO - 'SHELL': '/bin/bash', 04:23:33 INFO - 'SHLVL': '1', 04:23:33 INFO - 'TERM': 'linux', 04:23:33 INFO - 'TMOUT': '86400', 04:23:33 INFO - 'USER': 'cltbld', 04:23:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073', 04:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:33 INFO - '_': '/tools/buildbot/bin/python'} 04:23:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:23:33 INFO - mozversion application_buildid: 20160606025732 04:23:33 INFO - mozversion application_changeset: 0a3b6e2df6567d845f31c000c68dd67816c6153d 04:23:33 INFO - mozversion application_display_name: Nightly 04:23:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:33 INFO - mozversion application_name: Firefox 04:23:33 INFO - mozversion application_remotingname: firefox 04:23:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:33 INFO - mozversion application_vendor: Mozilla 04:23:33 INFO - mozversion application_version: 49.0a1 04:23:33 INFO - mozversion platform_buildid: 20160606025732 04:23:33 INFO - mozversion platform_changeset: 0a3b6e2df6567d845f31c000c68dd67816c6153d 04:23:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:33 INFO - mozversion platform_version: 49.0a1 04:23:33 INFO - using testdate: 1465212213 04:23:33 INFO - actual date: 1465212213 04:23:33 INFO - starting webserver on 'localhost:45248' 04:23:33 INFO - SUITE-START | Running 2 tests 04:23:33 INFO - TEST-START | dromaeo_css 04:23:33 INFO - operating with platform_type : linux_ 04:23:33 INFO - Initialising browser for dromaeo_css test... 04:23:33 INFO - TEST-INFO | started process 6507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2rkPt9/profile http://localhost:45248/getInfo.html) 04:23:38 INFO - PROCESS | 6507 | __metrics Screen width/height:1600/1200 04:23:38 INFO - PROCESS | 6507 | colorDepth:24 04:23:38 INFO - PROCESS | 6507 | Browser inner width/height: 1024/697 04:23:38 INFO - PROCESS | 6507 | __metrics 04:23:39 ERROR - PROCESS | 6507 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 04:23:40 INFO - TEST-INFO | 6507: exit 0 04:23:40 INFO - Browser initialized. 04:23:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:40 INFO - TEST-INFO | started process 6625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2rkPt9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:52 INFO - PROCESS | 6625 | RSS: Main: 168194048 04:23:52 INFO - PROCESS | 6625 | 04:24:41 INFO - PROCESS | 6625 | 1465212281866 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] 04:26:52 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:45248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45248/tests/dromaeo/cssquery-ext.html) 04:26:53 INFO - PROCESS | 6625 | RSS: Main: 172380160 04:26:53 INFO - PROCESS | 6625 | 04:29:56 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:45248/tests/dromaeo/cssquery-ext.html (next: http://localhost:45248/tests/dromaeo/cssquery-jquery.html) 04:29:56 INFO - PROCESS | 6625 | RSS: Main: 170295296 04:29:56 INFO - PROCESS | 6625 | 04:32:58 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:45248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45248/tests/dromaeo/cssquery-mootools.html) 04:32:59 INFO - PROCESS | 6625 | RSS: Main: 171913216 04:32:59 INFO - PROCESS | 6625 | 04:36:01 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:45248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45248/tests/dromaeo/cssquery-prototype.html) 04:36:01 INFO - PROCESS | 6625 | RSS: Main: 169820160 04:36:01 INFO - PROCESS | 6625 | 04:39:04 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:45248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45248/tests/dromaeo/cssquery-yui.html) 04:39:05 INFO - PROCESS | 6625 | RSS: Main: 171524096 04:39:05 INFO - PROCESS | 6625 | 04:42:07 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:45248/tests/dromaeo/cssquery-yui.html (next: http://localhost:45248/tests/dromaeo/cssquery-dojo.html) 04:42:08 INFO - PROCESS | 6625 | RSS: Main: 172462080 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - PROCESS | 6625 | __start_tp_report 04:42:08 INFO - PROCESS | 6625 | _x_x_mozilla_page_load 04:42:08 INFO - PROCESS | 6625 | _x_x_mozilla_page_load_details 04:42:08 INFO - PROCESS | 6625 | |i|pagename|runs| 04:42:08 INFO - PROCESS | 6625 | |0;dojo.html;2701.311165652758;2722.0472834507923;2741.068036867465;2744.3413580740616;2748.1892841611734;4753.405824271966;4784.378030855988;4855.781489832957;4882.731449770261;4914.311996320518;4770.332153498513;4820.469748327681;4840.346553215315;4905.975470122653;4907.779149938252;4467.597916187542;4474.709143905652;4515.2324104902245;4541.318802179667;4564.612007979325;4495.056038231975;4507.977460112695;4523.6607254455885;4560.110778398213;4644.535546445345;56.726124048539724;4564.8174073037035;4594.908101837961;4609.884752881171;4621.607163391116;4426.136903303857;4433.534478879704;4533.795979180944;4557.270836666151;4574.496805351442;4498.932516012263;4515.390422292981;4517.480489743689;4527.479339875924;4567.748773817439;4588.311753237008;4799.496052914428;4810.110129625996;4822.083804077214;4866.02679464105;5153.3558305211845;5198.194279886624;5201.037808005493;5225.555827754645;5239.502247286539;5220.92168617471;5242.55438287746;5242.8689282767855;5248.71132087735;5273.050850846846;4813.253945638432;4816.590589799836;4860.586850117745;4875.219964805649;4878.853634390974;5255.159174532057;5292.92060619091;5329.626926115212;5340.439253878287;5391.272178255964;5070.543651071347;5120.692758434506;5131.61512886535;5146.485351464824;5202.14164662834;5111.616628752859;5197.272381866542;5212.035773381936;5213.087709650796;5238.292830467914;5221.112410890158;5233.921491177635;5239.952009598096;5271.973640131775;5277.9472205278225;5228.215767634809;5230.503102205284;5231.8168864089575;5248.895022099537;5283.735813209324;4372.191144638252;4445.5776701213335;4456.598906098467;4467.218236808546;4523.705959112647;3820.3887378019385;3853.9614603854166;3861.5559210690567;3877.2439374322303;3892.902677433087;4487.865364039084;4490.842820501267;4501.815008033601;4512.638988880947;4544.091181763661;5055.039542486916;5193.948060519347;5261.894762104736;5277.366715994029;5278.9208161877605;4464.776761161929;4479.70881892676;4492.146492166478;4535.501094879561;4541.114482675913;4672.43930728308;4725.220338644154;4742.5257474252985;4750.406199225097;4812.951870481321;4775.76121193932;4864.975675121602;4907.460179380194;4909.852704418801;4959.380077490314;5269.1569348903995;5307.097793375058;5307.150855863043;5326.946730532645;5357.517823395913;4941.258811178208;4963.627727920348;4970.726610036482;4978.327925730125;5010.3737032870895;4916.950830491649;5127.256547800623;5155.458676838878;5156.1750119980625;5214.661047031931;5208.765605547836;5223.085959956917;5235.60732945023;5246.685198888079;5251.816186433456;5112.284280200849;5115.4373018967135;5121.052605268037;5123.718195499283;5155.767990440514;4984.40187177541;5039.370078740158;5044.0920634286185;5069.493050694901;5147.459516750687;5009.073321435546;5014.749262536931;5043.445221025758;5075.213341932006;5110.897782044412;5003.049420610072;5128.897422051613;5165.92251116226;5167.199084141964;5191.805884646477;4925.605951523941;4942.777575009061;4998.575121114746;5003.249512573143;5027.547520723152 04:42:08 INFO - PROCESS | 6625 | |1;ext.html;541.73197492163;589.9852254122908;593.0629605223747;600.1507866369088;610.7007566292518;38144.427833582486;38467.61532384675;38885.41671874924;39215.21569568607;39219.803900980456;40091.599084009154;40672.79663601685;40837.18325633486;40934.795326023326;41028.58971410285;7636.732714355013;7781.688732450695;7865.252800983897;7869.4884832486;7871.21287871214;7643.273888980566;7698.307152356287;7715.074191097048;7718.652660630257;7737;7675.194104619019;7696.615169241543;7743.993280873478;7749.380049596019;7782;7646.3882889369;7700.345470634975;7704.114026886924;7712.190220026872;7713.228677132298;7785.260400261966;7800.102988156378;7870.724524641667;7873.5275883447175;7924.207579242087;37696.24607507862;37736.62263377386;38116.61883381186;38167.8091609543;38216.42675359844;2506.736792636765;2985.626796650419;3095.4428202923464;3495.632958539368;3686.225892562565;27570.724292757015;27717.168484945483;28146;28370.148895532962;28741.425171496452;3350.229447227127;3354.463285874273;3392.135005573563;3446.6897979181995;3455.7580969332157;204930;205251;206389.9680501603;206878;207517;31544.842275788473;31596.210094747355;31628.841855790575;31903.36193276168;32068.518972215435;32637.347253054806;34182.14544636404;34417.483737743954;34642;34747.13132171665;13459.327033648475;13595.116317439335;13597.660058498617;13622.182669039888;13671.794923076162;11128.833067503994;11183.944080279547;11261.38062406559;11265.943670281596;11278.379689117013;7931.920680793118;8009.759707208793;8009.8398032040195;8021.719239826695;8078.596070196467;3117.4700300948894;3131.749460043191;3140.3562269735107;3159.3365393267213;3222.726068284175;882.289756745813;994.9801003980025;1003.6738060130341;1024.538957469142;1044.065561322612;28438.85780571084;28517.572236416472;28898.42203155925;29052.41895162085;29140.708592914223;961.0677642686583;965.9517024148764;987.0573602209872;1010.3079390617451;1080.4867687848366;14967.925160374347;15397.84602153964;15469.767953480707;15630.218489075729;15633;363243;365794;367192;368642;368784;49687.50312496901;49821.50178498169;49950.500494995315;50074;50199.498005020214;1159.5825502818977;1171.1860257121389;1174.8942595166477;1183.5206741269972;1199.5381778015353;26890.731092688824;28228.71771282261;28581.28546786264;28712.712872871838;28730.138095857157;37997.430038549996;38090;38233.23533529258;38261.4260786094;38434.2313153741;322329.38835305674;323617;324610;324762;325176;25240.873795630905;25398.74601253964;25822.354441139123;26119.347016324744;26391.868040659672;41718.37422438726;42007.78996105;42549.57450425456;42602;42974.785126074166;36212.63787362093;36323.63676363203;36459.81770091133;36820.07949801276;36998.260034798615;35887.28225435424;36331.45502817407;36609.26781464409;36805.63194368022;36923;31669.683303166672;35168;36055.63944360523;36157.45763813597;37453.62546374501;31757;33450.66549334476;33667.83166084154;33761.324773503904;34058.82970585131;25550.616740748534;25730.228093157235;26116.8694156528;26120.34699132537;26142.477150457264 04:42:08 INFO - PROCESS | 6625 | |2;jquery.html;356.89471605876264;360.4377171612285;367.8179301245882;376.43722634661185;383.8407061069656;15442.922785386072;15992;16782.24479898403;16782.328706851713;16817.66364672706;15672.138032408213;16238.594035149126;16787.24457399417;16789;16795.244214010367;4992.400911890578;5144.382674079097;5190.117679994391;5195.610329225305;5201.9479805201845;3669.5046168767276;5075.720835354054;5665.490105890469;6029.427204415573;6056.788012419566;6048.092786082079;6076;6084.756609735606;6089.147519347295;6094.725737341831;4756;5018.34761481007;5035.0685123252315;5046.772895219724;5131.332926719502;4918.0901533216465;4936.4076310842565;4956.430010548797;5239.240310155006;5281.181416880351;10944.23390362675;11254.43727813606;11365.204435689506;11394.829077563843;11472;1726.18869131508;1730.766346543213;1751.0456801043335;1902.3627084926566;1932.1498540642071;8275.172482751737;8834.514101724468;9812.90187098127;10127.746806329827;12888.935555322258;1701.8553422959064;1706.8122506524273;1707.4109432245855;1737.1487970894298;1762.770839790819;65797.67101164463;68705.65647171783;69051.96422053724;69928.30071699269;70481.2951870485;8840.8673869892;9031.548422578844;9533.094356036165;9537.952310238405;9566.091221333962;12821.35893205336;12884.355782210852;13002.414891329912;13011.438627364776;13096.869031309565;6982.67329207449;7139.286071392819;7160.892586611205;7273.527220730635;7410.5183163094225;6789.388954993976;6927.757528486479;6944.652767361612;7058.611776352247;7142.5714457132735;3745.438184272381;3827.9043023924623;4078.979605102015;4163.271427500175;4196.265653510623;1510.3656464285027;1650.3811070848433;1752.5572673273446;1768.2926829268395;1796.1827368547279;811.614934906897;830.8130670599188;865.3682811547606;946.2430055955208;950.6102497975935;16174.272157752694;16349.83650163483;16366.099864507567;16497.17514124313;16837.326506939586;794.4677066365549;832;833.7540425574471;901.8106197698556;935.6584846531103;7219.602921839244;9278;9468.100530449734;9471.147596716191;9673.758156046155;365280;379745;388019;388967;396815;79971;82044.58977705073;83884;84450.57774711087;85470.57264713636;971.1259866120548;978.3836183204536;986.1420564109271;995.2436148527026;1009.6466236817055;15533.378664853279;15571.532854014398;15780.289886954884;15801.36794528206;16133.435329763872;35369.82315088408;35870.46194307035;36226;36426.8178659105;36788;45542.54457455383;50003.249951250036;50026;50439;50767.49232507627;5550.417206193453;7312.926870731225;7450.254974502724;7467.402607791472;7588.203238659861;8994.460332380078;11251;11424.028957538701;11628.186026978368;11862.644120676394;9291.907080929104;9948.850767238642;10020.849687254551;10265.897341026493;10311.690649280234;10186.134178594903;10288.228382871464;10355.792884142425;10424.166066714797;10536.420496872746;9957.800843983225;10155.796884062425;10534.315269507457;10583.682489525327;10816.567337306735;6581.243157036811;6788.93211067883;6871.14110736158;6949.722011119701;7343.8531229376185;7319.8536029280185;8756.649734010569;10159.44123073238;10270.383776973107;10283 04:42:08 INFO - PROCESS | 6625 | |3;mootools.html;1431.1913768720676;1435.91384516929;1584.9683006339874;1730.5500569851843;1751.903645299508;6819.21579018413;7437.851242975144;7567.356774674159;7868.606569671515;7890.329322007637;7636.618169091551;7769.7669069928;7800.648970796314;7804.531728096318;7817;2157.514559224174;2195.6596727507263;2200.273909609825;2203.8347123965686;2207.668849672546;2150.215171462413;2184.3010236724253;2192.7149470568884;2219.622664147099;2222.377734234417;2178.4336072621154;2180.672899065145;2181.334692918659;2191.8356123290737;2212.0930418528405;2099.9055042523046;2114.0698092839257;2115.9259425920095;2133.466633341672;2139.7967193116783;2092.3618296419586;2117.301290574107;2118.364490652798;2118.7245658064353;2151.085788539864;7823.3350165236025;7854.096778870446;7872.881906771403;7878.763637090839;7912.643931023118;4461.5315391883705;4539.84110556129;4550.658700597435;4576.885577860547;4593.770311484413;2823.167165686107;2871.305929501604;2911.2867347499996;2918.1829087855435;2933.4279815436;784.4940013691137;824.8020475085996;828.747232094211;832.3757182113415;1693.3057446446899;9844.60621575136;10078.748031299203;10307;10321.225908056926;10331.328463649914;4169;4277.572242775697;4333.9133217335475;4351.912961740747;4354.542773008852;8899.377043607015;8936.597853096626;8949.418287811402;8968.730938071869;9008.144226298491;4608.5852273294895;4644.7213167210075;4659.930101048487;4661.743604101739;4673.275642275453;3623.710103191738;4116.58834116586;4134.73124246929;4187.330027195634;4274.337477690963;3611.4402267648557;3622.3298689742483;3702.278055779151;3748.9250214995545;3764.5482542095124;1155.797970111075;1201.6575276046285;1207.9094067944764;1211.9697007574705;1212.763511115324;852.7313896122826;875.1598465473216;892.6652505310509;898.8247291778172;921.760342311004;5511.311086114236;5533.280673512498;5540.085885828793;5583.776648933997;5686.147077938343;398.0923494432698;400.77156021067714;404.6277424769219;411.21663231543954;425.2154774441151;3632.0919770057485;3669.284489524517;3676.338259113332;3725;3729.9813500932323;9190.943041550307;9620.567074481665;9661.13049825519;9710.368826026286;9722.2708296878;9519.381240219502;9536.56951457287;9542.284328675238;9578;9591.376560523544;6960.79117626472;7206.531575447684;7209.927900721031;7214.458915581353;7230.746923857745;5119.257707632298;5232.895342093213;5279.868003299948;5282.656627319212;5424.07790675594;8565;8631.69789057405;8633.611487483204;8690.956545217234;8717.869231961398;8341.45780524264;8710.433821801562;8739.737807865775;8775.122487751429;9049.366544341832;6152.876942461216;6613.768518101843;6754.6622668865375;6776.051352810709;6885.483588730765;7499;7553.169151393233;7576.469647124869;7648.502847314907;7664.770056898302;6670.66646667655;6872.965635171792;6887.621180835102;6969.233384327821;7063.82340441493;6643.335666433318;6710;6794.3545363190415;6876.312368763083;6940.9652951734915;6226.097215903578;6234.657093859882;6307.148534947907;6319.273283572448;6327.493800495858;4775.6657034007285;4803.207470767285;4818.301346304696;4831.661783675109;4850.684705494132;4901.3383193268455;4931.211006238985;4971.080350135237;4986.32684587576;5015.673981191211 04:42:08 INFO - PROCESS | 6625 | |4;prototype.html;283.0517765485623;284.36586412300574;289.3619568850683;292.34660533707154;293.0724257724303;5017.623678224134;5119.3856737191545;5162.380514338275;5167.431582525919;5180.430152683211;5011.774470148843;5070.619703522232;5086.364204474441;5123.077845987721;5126.256692779545;3948.940765888514;3985.1431942132435;3991.7604943703473;3993.4808474898223;4008.3586626139822;3317.303366293081;3723.497327860745;3963.1677347757004;3965.583613720561;3977.86077487288;3705.6664900159117;3739.2521495700967;3772.849086036555;3824.5984171661994;3853.807309634521;3855.7108216883707;3858.112634094146;3876.7480113792653;3877.263319969197;3879.301725689375;3224.4357237483346;3247.447933851251;3350.849211785451;3357.3285342931513;3391.491276308549;4777.703384664605;4803.615710743132;4817.975910120427;4828.903421931542;4859.562639362439;4421.5187912049505;4430.335449682541;4448.3549885266775;4450.821967121311;4473.373727678128;5036.370453693288;5284.674743113018;5322.92015619766;5348.919766203471;5372.54333381663;3628.6734193922675;3630.509881166035;3638.3632864248652;3643.67206951373;3647.069997150736;5557.861053473655;5599.524040456566;5614.438556144394;5625.54995600351;5670.489655930986;3665.157013886821;3762.4168253920684;3763.717721170923;3775.9433608495897;3776.4335349697767;3734.57052438973;3735.458358537997;3735.551733791908;3771.585125636178;3781.2248489059675;4306.80619372129;4361.5856493633055;4382.452193475816;4396.516383197845;4401.185780630593;5292.867678308073;5318.095923692981;5338.412774594792;5369.95285919242;5424.159255315432;1243.6952946527977;1283.9037072219435;1287.3370214339623;1291.347869326003;1293.2822283632486;789.7709664197433;792.6353877216545;800.195803217774;804.766617680866;809.8906647602616;4157.10622216225;4179.791010449465;4183.372494125905;4225.619694227473;4263.786810659517;4910.533499317559;4948.554630083309;4948.678335908155;4985.376827896513;4988.351514303117;4269.124829409963;4286.249906266391;4291.23215525984;4299.505556860939;4305.892352691208;2552.3236342369287;2576.2400091972913;2619.5153896529205;2638.696549896748;2780.5551111822415;5039.319691841628;5157.149070403417;5162.277281180638;5166.7782853372655;5170.71561064145;5576.737608499074;5633.718314084279;5643.504471315105;5650.576206784425;5681.261436013292;4970.701757894465;5099.974500127476;5113.3097031900215;5177.534021937969;5189.714565698923;5473.042217611823;5481.616286859881;5518.834434966958;5541.279633647761;5541.528970037431;5375.3012108425655;5381.865453363697;5408.486193811582;5415.404305526467;5436.157395603688;4872.244802055687;5149.871253218699;5159.948400515947;5166.535011848951;5181.896362072813;3745.6254374562327;3756.530433695788;3763.6800871925097;3765.4351847223134;3791.8386519683518;5429.321334833146;5504.761428678516;5506.174073888788;5513.558915286687;5547.33431988164;5093.490650934877;5290;5308.2568440419145;5322.654027488201;5359.410464848941;5288.550473209821;5292.603054770984;5323.760430780701;5339.973300133474;5344.465553444625;5235.74342157887;5246.108161612611;5270.288511050959;5288.048151332797;5305.124654431976;5089.185730283137;5358.571314294769;5378.515933565998;5378.623496355218;5410.648307859977;5220.321358223407;5220.843374698765;5243.011483454395;5262.342207224097;5278.498542638443 04:42:08 INFO - PROCESS | 6625 | |5;yui.html;608.2791891608441;639.996800016;646.3084499585444;657.1949362031512;658.3844105761117;12150.270983740971;12479.313637749932;12669.936650316748;12760.106792524526;12927.935360323185;12919.289439080847;12946.870531294684;13014.154079984817;13027.088103832735;13034.087613867034;623.9032949892751;773.446985405435;783.8275579372544;801.034753122489;806.0931452116369;789.9052113746359;790.8141586727114;791.3273717340244;795.4630624328584;797.5852556670528;818.3167055508658;820.9712660056899;824.9587520623975;830.5182993863575;831.8003679116998;813.2030610002172;817.0358976407837;818.3248819723751;819.7171975668385;819.8934138561979;595.6128516464289;600.76870404894;602.7167231401235;603.2459425717852;605.824310949824;12356;12455.439505222286;12522.874771252353;12544;12549.247045177319;13337.866621333857;13510.527131550447;13833.446662133503;13876.514321998682;14050.929745351208;9980.650677226262;10063.446510441923;10295.588176472933;10389.688309350731;10628.681139565826;3331.3338720311854;3352.4133276676484;3425.4348032574594;3444.896653100411;3475.200703838106;58713.41286587122;58934;58949.41050589482;60744;61098.38901611016;10734.463276836283;10764.300320479144;10764.892351076545;10893.237473376788;11076.833847492295;19655.115519801642;19767.209311627375;19952.70070948937;20005.799942000685;20464.69302960457;6863.965680171567;7086.759817031999;7139.82150446243;7340.4127669786285;7374.668139933716;3830.214805964826;3903.726739128234;3914.941275880864;3923.6076392360537;3931.6658084063174;2770.2104900103373;2849.301921029361;2876.0652787844033;2877.8848846045926;2895.841663334641;522.2766468441237;523.2204016016185;532.4329588987715;536.1528784520449;539.4147350125158;555.4445554445555;644.9419552240226;649.6784091874458;660.2769966886252;663.9070530125787;8582;8697.739067827975;8848.247898928663;8927.419717718327;9006.684766033157;530.8540151458379;580.6109906362747;592.3572923378097;597.7041364524501;601.8796240751867;3633;3919.4904662393706;3935.5670876203594;3971.404289356562;4007.1584967157223;52740;53728.73135634297;84655;86887.56556217305;88137;46625.5337446628;62828;75492;76116.38836116344;78557;69605.65197174084;70993.64503177554;71055;71205.14082092095;71422;7960.391328912582;8086.353091752763;8198.959005205174;8215.2606265434;8238.138170865926;41789.164216716104;41981;42737;42824;43977.12045759131;50345.74827125841;50598.24102638537;51742.482575173766;58093.41906581049;59791;10784.730381740519;11062.336259824437;11121.666350009513;11318.94340528292;11393.430328483708;13124.868751312364;13183.934080329536;13440.46238150463;13547.729045418839;13711.17732935987;9261.907380926374;12054.216475929037;12340.81488777687;12587.811182832447;12593.433295501907;10549.314294570828;10936.23446358779;11096.833547496633;11296.83054754163;11346.773064538827;12141.939290303491;12242.632721018384;12509.937450312691;12603.432845522157;12699.428525716181;9380.530973451436;9772.511374431393;9820.361676491291;9823.563626963143;9828.16460600857;10066.547005384922;10539;10543.94728026355;10616.787664246825;10682.359058456517 04:42:08 INFO - PROCESS | 6625 | __end_tp_report 04:42:08 INFO - PROCESS | 6625 | __start_cc_report 04:42:08 INFO - PROCESS | 6625 | _x_x_mozilla_cycle_collect,384 04:42:08 INFO - PROCESS | 6625 | __end_cc_report 04:42:08 INFO - PROCESS | 6625 | __startTimestamp1465213328098__endTimestamp 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - PROCESS | 6625 | ------- Summary: start ------- 04:42:08 INFO - PROCESS | 6625 | Number of tests: 6 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - PROCESS | 6625 | [#0] dojo.html Cycles:165 Average:4804.76 Median:4959.38 stddev:625.07 (12.6%) stddev-sans-first:604.81 04:42:08 INFO - PROCESS | 6625 | Values: 2701.3 2722.0 2741.1 2744.3 2748.2 4753.4 4784.4 4855.8 4882.7 4914.3 4770.3 4820.5 4840.3 4906.0 4907.8 4467.6 4474.7 4515.2 4541.3 4564.6 4495.1 4508.0 4523.7 4560.1 4644.5 56.7 4564.8 4594.9 4609.9 4621.6 4426.1 4433.5 4533.8 4557.3 4574.5 4498.9 4515.4 4517.5 4527.5 4567.7 4588.3 4799.5 4810.1 4822.1 4866.0 5153.4 5198.2 5201.0 5225.6 5239.5 5220.9 5242.6 5242.9 5248.7 5273.1 4813.3 4816.6 4860.6 4875.2 4878.9 5255.2 5292.9 5329.6 5340.4 5391.3 5070.5 5120.7 5131.6 5146.5 5202.1 5111.6 5197.3 5212.0 5213.1 5238.3 5221.1 5233.9 5240.0 5272.0 5277.9 5228.2 5230.5 5231.8 5248.9 5283.7 4372.2 4445.6 4456.6 4467.2 4523.7 3820.4 3854.0 3861.6 3877.2 3892.9 4487.9 4490.8 4501.8 4512.6 4544.1 5055.0 5193.9 5261.9 5277.4 5278.9 4464.8 4479.7 4492.1 4535.5 4541.1 4672.4 4725.2 4742.5 4750.4 4813.0 4775.8 4865.0 4907.5 4909.9 4959.4 5269.2 5307.1 5307.2 5326.9 5357.5 4941.3 4963.6 4970.7 4978.3 5010.4 4917.0 5127.3 5155.5 5156.2 5214.7 5208.8 5223.1 5235.6 5246.7 5251.8 5112.3 5115.4 5121.1 5123.7 5155.8 4984.4 5039.4 5044.1 5069.5 5147.5 5009.1 5014.7 5043.4 5075.2 5110.9 5003.0 5128.9 5165.9 5167.2 5191.8 4925.6 4942.8 4998.6 5003.2 5027.5 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - PROCESS | 6625 | [#1] ext.html Cycles:180 Average:44166.15 Median:35527.64 stddev:80863.91 (227.6%) stddev-sans-first:81024.42 04:42:08 INFO - PROCESS | 6625 | Values: 541.7 590.0 593.1 600.2 610.7 38144.4 38467.6 38885.4 39215.2 39219.8 40091.6 40672.8 40837.2 40934.8 41028.6 7636.7 7781.7 7865.3 7869.5 7871.2 7643.3 7698.3 7715.1 7718.7 7737.0 7675.2 7696.6 7744.0 7749.4 7782.0 7646.4 7700.3 7704.1 7712.2 7713.2 7785.3 7800.1 7870.7 7873.5 7924.2 37696.2 37736.6 38116.6 38167.8 38216.4 2506.7 2985.6 3095.4 3495.6 3686.2 27570.7 27717.2 28146.0 28370.1 28741.4 3350.2 3354.5 3392.1 3446.7 3455.8 204930.0 205251.0 206390.0 206878.0 207517.0 31544.8 31596.2 31628.8 31903.4 32068.5 32637.3 34182.1 34417.5 34642.0 34747.1 13459.3 13595.1 13597.7 13622.2 13671.8 11128.8 11183.9 11261.4 11265.9 11278.4 7931.9 8009.8 8009.8 8021.7 8078.6 3117.5 3131.7 3140.4 3159.3 3222.7 882.3 995.0 1003.7 1024.5 1044.1 28438.9 28517.6 28898.4 29052.4 29140.7 961.1 966.0 987.1 1010.3 1080.5 14967.9 15397.8 15469.8 15630.2 15633.0 363243.0 365794.0 367192.0 368642.0 368784.0 49687.5 49821.5 49950.5 50074.0 50199.5 1159.6 1171.2 1174.9 1183.5 1199.5 26890.7 28228.7 28581.3 28712.7 28730.1 37997.4 38090.0 38233.2 38261.4 38434.2 322329.4 323617.0 324610.0 324762.0 325176.0 25240.9 25398.7 25822.4 26119.3 26391.9 41718.4 42007.8 42549.6 42602.0 42974.8 36212.6 36323.6 36459.8 36820.1 36998.3 35887.3 36331.5 36609.3 36805.6 36923.0 31669.7 35168.0 36055.6 36157.5 37453.6 31757.0 33450.7 33667.8 33761.3 34058.8 25550.6 25730.2 26116.9 26120.3 26142.5 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - PROCESS | 6625 | [#2] jquery.html Cycles:180 Average:23805.29 Median:4927.25 stddev:63622.43 (1291.2%) stddev-sans-first:63776.55 04:42:08 INFO - PROCESS | 6625 | Values: 356.9 360.4 367.8 376.4 383.8 15442.9 15992.0 16782.2 16782.3 16817.7 15672.1 16238.6 16787.2 16789.0 16795.2 4992.4 5144.4 5190.1 5195.6 5201.9 3669.5 5075.7 5665.5 6029.4 6056.8 6048.1 6076.0 6084.8 6089.1 6094.7 4756.0 5018.3 5035.1 5046.8 5131.3 4918.1 4936.4 4956.4 5239.2 5281.2 10944.2 11254.4 11365.2 11394.8 11472.0 1726.2 1730.8 1751.0 1902.4 1932.1 8275.2 8834.5 9812.9 10127.7 12888.9 1701.9 1706.8 1707.4 1737.1 1762.8 65797.7 68705.7 69052.0 69928.3 70481.3 8840.9 9031.5 9533.1 9538.0 9566.1 12821.4 12884.4 13002.4 13011.4 13096.9 6982.7 7139.3 7160.9 7273.5 7410.5 6789.4 6927.8 6944.7 7058.6 7142.6 3745.4 3827.9 4079.0 4163.3 4196.3 1510.4 1650.4 1752.6 1768.3 1796.2 811.6 830.8 865.4 946.2 950.6 16174.3 16349.8 16366.1 16497.2 16837.3 794.5 832.0 833.8 901.8 935.7 7219.6 9278.0 9468.1 9471.1 9673.8 365280.0 379745.0 388019.0 388967.0 396815.0 79971.0 82044.6 83884.0 84450.6 85470.6 971.1 978.4 986.1 995.2 1009.6 15533.4 15571.5 15780.3 15801.4 16133.4 35369.8 35870.5 36226.0 36426.8 36788.0 45542.5 50003.2 50026.0 50439.0 50767.5 5550.4 7312.9 7450.3 7467.4 7588.2 8994.5 11251.0 11424.0 11628.2 11862.6 9291.9 9948.9 10020.8 10265.9 10311.7 10186.1 10288.2 10355.8 10424.2 10536.4 9957.8 10155.8 10534.3 10583.7 10816.6 6581.2 6788.9 6871.1 6949.7 7343.9 7319.9 8756.6 10159.4 10270.4 10283.0 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - PROCESS | 6625 | [#3] mootools.html Cycles:180 Average:5124.33 Median:5176.08 stddev:2828.97 (54.7%) stddev-sans-first:2823.29 04:42:08 INFO - PROCESS | 6625 | Values: 1431.2 1435.9 1585.0 1730.6 1751.9 6819.2 7437.9 7567.4 7868.6 7890.3 7636.6 7769.8 7800.6 7804.5 7817.0 2157.5 2195.7 2200.3 2203.8 2207.7 2150.2 2184.3 2192.7 2219.6 2222.4 2178.4 2180.7 2181.3 2191.8 2212.1 2099.9 2114.1 2115.9 2133.5 2139.8 2092.4 2117.3 2118.4 2118.7 2151.1 7823.3 7854.1 7872.9 7878.8 7912.6 4461.5 4539.8 4550.7 4576.9 4593.8 2823.2 2871.3 2911.3 2918.2 2933.4 784.5 824.8 828.7 832.4 1693.3 9844.6 10078.7 10307.0 10321.2 10331.3 4169.0 4277.6 4333.9 4351.9 4354.5 8899.4 8936.6 8949.4 8968.7 9008.1 4608.6 4644.7 4659.9 4661.7 4673.3 3623.7 4116.6 4134.7 4187.3 4274.3 3611.4 3622.3 3702.3 3748.9 3764.5 1155.8 1201.7 1207.9 1212.0 1212.8 852.7 875.2 892.7 898.8 921.8 5511.3 5533.3 5540.1 5583.8 5686.1 398.1 400.8 404.6 411.2 425.2 3632.1 3669.3 3676.3 3725.0 3730.0 9190.9 9620.6 9661.1 9710.4 9722.3 9519.4 9536.6 9542.3 9578.0 9591.4 6960.8 7206.5 7209.9 7214.5 7230.7 5119.3 5232.9 5279.9 5282.7 5424.1 8565.0 8631.7 8633.6 8691.0 8717.9 8341.5 8710.4 8739.7 8775.1 9049.4 6152.9 6613.8 6754.7 6776.1 6885.5 7499.0 7553.2 7576.5 7648.5 7664.8 6670.7 6873.0 6887.6 6969.2 7063.8 6643.3 6710.0 6794.4 6876.3 6941.0 6226.1 6234.7 6307.1 6319.3 6327.5 4775.7 4803.2 4818.3 4831.7 4850.7 4901.3 4931.2 4971.1 4986.3 5015.7 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - PROCESS | 6625 | [#4] prototype.html Cycles:180 Average:4333.57 Median:4986.86 stddev:1316.84 (26.4%) stddev-sans-first:1284.96 04:42:08 INFO - PROCESS | 6625 | Values: 283.1 284.4 289.4 292.3 293.1 5017.6 5119.4 5162.4 5167.4 5180.4 5011.8 5070.6 5086.4 5123.1 5126.3 3948.9 3985.1 3991.8 3993.5 4008.4 3317.3 3723.5 3963.2 3965.6 3977.9 3705.7 3739.3 3772.8 3824.6 3853.8 3855.7 3858.1 3876.7 3877.3 3879.3 3224.4 3247.4 3350.8 3357.3 3391.5 4777.7 4803.6 4818.0 4828.9 4859.6 4421.5 4430.3 4448.4 4450.8 4473.4 5036.4 5284.7 5322.9 5348.9 5372.5 3628.7 3630.5 3638.4 3643.7 3647.1 5557.9 5599.5 5614.4 5625.5 5670.5 3665.2 3762.4 3763.7 3775.9 3776.4 3734.6 3735.5 3735.6 3771.6 3781.2 4306.8 4361.6 4382.5 4396.5 4401.2 5292.9 5318.1 5338.4 5370.0 5424.2 1243.7 1283.9 1287.3 1291.3 1293.3 789.8 792.6 800.2 804.8 809.9 4157.1 4179.8 4183.4 4225.6 4263.8 4910.5 4948.6 4948.7 4985.4 4988.4 4269.1 4286.2 4291.2 4299.5 4305.9 2552.3 2576.2 2619.5 2638.7 2780.6 5039.3 5157.1 5162.3 5166.8 5170.7 5576.7 5633.7 5643.5 5650.6 5681.3 4970.7 5100.0 5113.3 5177.5 5189.7 5473.0 5481.6 5518.8 5541.3 5541.5 5375.3 5381.9 5408.5 5415.4 5436.2 4872.2 5149.9 5159.9 5166.5 5181.9 3745.6 3756.5 3763.7 3765.4 3791.8 5429.3 5504.8 5506.2 5513.6 5547.3 5093.5 5290.0 5308.3 5322.7 5359.4 5288.6 5292.6 5323.8 5340.0 5344.5 5235.7 5246.1 5270.3 5288.0 5305.1 5089.2 5358.6 5378.5 5378.6 5410.6 5220.3 5220.8 5243.0 5262.3 5278.5 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - PROCESS | 6625 | [#5] yui.html Cycles:180 Average:16269.71 Median:51170.36 stddev:21583.15 (42.2%) stddev-sans-first:21611.66 04:42:08 INFO - PROCESS | 6625 | Values: 608.3 640.0 646.3 657.2 658.4 12150.3 12479.3 12669.9 12760.1 12927.9 12919.3 12946.9 13014.2 13027.1 13034.1 623.9 773.4 783.8 801.0 806.1 789.9 790.8 791.3 795.5 797.6 818.3 821.0 825.0 830.5 831.8 813.2 817.0 818.3 819.7 819.9 595.6 600.8 602.7 603.2 605.8 12356.0 12455.4 12522.9 12544.0 12549.2 13337.9 13510.5 13833.4 13876.5 14050.9 9980.7 10063.4 10295.6 10389.7 10628.7 3331.3 3352.4 3425.4 3444.9 3475.2 58713.4 58934.0 58949.4 60744.0 61098.4 10734.5 10764.3 10764.9 10893.2 11076.8 19655.1 19767.2 19952.7 20005.8 20464.7 6864.0 7086.8 7139.8 7340.4 7374.7 3830.2 3903.7 3914.9 3923.6 3931.7 2770.2 2849.3 2876.1 2877.9 2895.8 522.3 523.2 532.4 536.2 539.4 555.4 644.9 649.7 660.3 663.9 8582.0 8697.7 8848.2 8927.4 9006.7 530.9 580.6 592.4 597.7 601.9 3633.0 3919.5 3935.6 3971.4 4007.2 52740.0 53728.7 84655.0 86887.6 88137.0 46625.5 62828.0 75492.0 76116.4 78557.0 69605.7 70993.6 71055.0 71205.1 71422.0 7960.4 8086.4 8199.0 8215.3 8238.1 41789.2 41981.0 42737.0 42824.0 43977.1 50345.7 50598.2 51742.5 58093.4 59791.0 10784.7 11062.3 11121.7 11318.9 11393.4 13124.9 13183.9 13440.5 13547.7 13711.2 9261.9 12054.2 12340.8 12587.8 12593.4 10549.3 10936.2 11096.8 11296.8 11346.8 12141.9 12242.6 12509.9 12603.4 12699.4 9380.5 9772.5 9820.4 9823.6 9828.2 10066.5 10539.0 10543.9 10616.8 10682.4 04:42:08 INFO - PROCESS | 6625 | -------- Summary: end -------- 04:42:08 INFO - PROCESS | 6625 | 04:42:08 INFO - TEST-INFO | 6625: exit 0 04:42:08 INFO - TEST-OK | dromaeo_css | took 1114959ms 04:42:08 INFO - TEST-START | kraken 04:42:08 INFO - operating with platform_type : linux_ 04:42:08 INFO - Initialising browser for kraken test... 04:42:08 INFO - TEST-INFO | started process 6860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdWYRat/profile http://localhost:45248/getInfo.html) 04:42:13 INFO - PROCESS | 6860 | __metrics Screen width/height:1600/1200 04:42:13 INFO - PROCESS | 6860 | colorDepth:24 04:42:13 INFO - PROCESS | 6860 | Browser inner width/height: 1024/697 04:42:13 INFO - PROCESS | 6860 | __metrics 04:42:13 ERROR - PROCESS | 6860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 04:42:14 INFO - TEST-INFO | 6860: exit 0 04:42:14 INFO - Browser initialized. 04:42:14 INFO - Running cycle 1/1 for kraken test... 04:42:14 INFO - TEST-INFO | started process 6977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdWYRat/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:26 INFO - PROCESS | 6977 | RSS: Main: 168681472 04:42:26 INFO - PROCESS | 6977 | 04:42:29 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45248/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:30 INFO - PROCESS | 6977 | RSS: Main: 172998656 04:42:30 INFO - PROCESS | 6977 | 04:42:33 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45248/tests/kraken/driver.html?testName=audio-dft) 04:42:34 INFO - PROCESS | 6977 | RSS: Main: 172511232 04:42:34 INFO - PROCESS | 6977 | 04:42:36 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45248/tests/kraken/driver.html?testName=audio-fft) 04:42:37 INFO - PROCESS | 6977 | RSS: Main: 167907328 04:42:37 INFO - PROCESS | 6977 | 04:42:39 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45248/tests/kraken/driver.html?testName=audio-oscillator) 04:42:40 INFO - PROCESS | 6977 | RSS: Main: 168660992 04:42:40 INFO - PROCESS | 6977 | 04:42:42 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:43 INFO - PROCESS | 6977 | RSS: Main: 168755200 04:42:43 INFO - PROCESS | 6977 | 04:42:46 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45248/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:47 INFO - PROCESS | 6977 | RSS: Main: 169291776 04:42:47 INFO - PROCESS | 6977 | 04:42:50 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45248/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:51 INFO - PROCESS | 6977 | RSS: Main: 166793216 04:42:51 INFO - PROCESS | 6977 | 04:42:54 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45248/tests/kraken/driver.html?testName=json-parse-financial) 04:42:54 INFO - PROCESS | 6977 | RSS: Main: 168468480 04:42:54 INFO - PROCESS | 6977 | 04:42:56 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:57 INFO - PROCESS | 6977 | RSS: Main: 168624128 04:42:57 INFO - PROCESS | 6977 | 04:42:59 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45248/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:59 INFO - PROCESS | 6977 | RSS: Main: 169107456 04:42:59 INFO - PROCESS | 6977 | 04:43:01 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:02 INFO - PROCESS | 6977 | RSS: Main: 169320448 04:43:02 INFO - PROCESS | 6977 | 04:43:05 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:06 INFO - PROCESS | 6977 | RSS: Main: 169177088 04:43:06 INFO - PROCESS | 6977 | 04:43:09 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:09 INFO - PROCESS | 6977 | RSS: Main: 169054208 04:43:09 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:45248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45248/tests/kraken/driver.html?testName=ai-astar) 04:43:11 INFO - PROCESS | 6977 | RSS: Main: 169943040 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | __start_tp_report 04:43:11 INFO - PROCESS | 6977 | _x_x_mozilla_page_load 04:43:11 INFO - PROCESS | 6977 | _x_x_mozilla_page_load_details 04:43:11 INFO - PROCESS | 6977 | |i|pagename|runs| 04:43:11 INFO - PROCESS | 6977 | |0;ai-astar;117;109;116;117;114;114;115;113;115;115 04:43:11 INFO - PROCESS | 6977 | |1;audio-beat-detection;164;137;158;184;131;167;157;135;186;130 04:43:11 INFO - PROCESS | 6977 | |2;audio-dft;162;167;166;177;163;165;165;166;163;162 04:43:11 INFO - PROCESS | 6977 | |3;audio-fft;77;79;76;160;77;78;76;75;155;76 04:43:11 INFO - PROCESS | 6977 | |4;audio-oscillator;88;87;156;88;87;87;145;87;87;140 04:43:11 INFO - PROCESS | 6977 | |5;imaging-gaussian-blur;118;119;118;118;118;118;118;118;118;118 04:43:11 INFO - PROCESS | 6977 | |6;imaging-darkroom;147;149;148;147;149;149;147;148;148;149 04:43:11 INFO - PROCESS | 6977 | |7;imaging-desaturate;96;96;95;95;96;96;97;96;96;96 04:43:11 INFO - PROCESS | 6977 | |8;json-parse-financial;65;69;66;68;70;65;66;68;70;73 04:43:11 INFO - PROCESS | 6977 | |9;json-stringify-tinderbox;66;66;66;66;66;65;67;66;67;66 04:43:11 INFO - PROCESS | 6977 | |10;stanford-crypto-aes;85;83;84;90;87;85;85;86;122;85 04:43:11 INFO - PROCESS | 6977 | |11;stanford-crypto-ccm;145;134;135;134;133;131;134;134;138;139 04:43:11 INFO - PROCESS | 6977 | |12;stanford-crypto-pbkdf2;173;172;177;173;170;169;170;180;170;170 04:43:11 INFO - PROCESS | 6977 | |13;stanford-crypto-sha256-iterative;70;69;67;69;67;68;68;68;67;68 04:43:11 INFO - PROCESS | 6977 | __end_tp_report 04:43:11 INFO - PROCESS | 6977 | __start_cc_report 04:43:11 INFO - PROCESS | 6977 | _x_x_mozilla_cycle_collect,987 04:43:11 INFO - PROCESS | 6977 | __end_cc_report 04:43:11 INFO - PROCESS | 6977 | __startTimestamp1465213391717__endTimestamp 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | ------- Summary: start ------- 04:43:11 INFO - PROCESS | 6977 | Number of tests: 14 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.32 (2.0%) stddev-sans-first:2.28 04:43:11 INFO - PROCESS | 6977 | Values: 117.0 109.0 116.0 117.0 114.0 114.0 115.0 113.0 115.0 115.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:161.00 stddev:20.99 (13.0%) stddev-sans-first:22.00 04:43:11 INFO - PROCESS | 6977 | Values: 164.0 137.0 158.0 184.0 131.0 167.0 157.0 135.0 186.0 130.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:4.38 (2.6%) stddev-sans-first:4.44 04:43:11 INFO - PROCESS | 6977 | Values: 162.0 167.0 166.0 177.0 163.0 165.0 165.0 166.0 163.0 162.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.50 stddev:34.09 (44.6%) stddev-sans-first:35.67 04:43:11 INFO - PROCESS | 6977 | Values: 77.0 79.0 76.0 160.0 77.0 78.0 76.0 75.0 155.0 76.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:87.00 stddev:29.10 (33.5%) stddev-sans-first:30.20 04:43:11 INFO - PROCESS | 6977 | Values: 88.0 87.0 156.0 88.0 87.0 87.0 145.0 87.0 87.0 140.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:43:11 INFO - PROCESS | 6977 | Values: 118.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 04:43:11 INFO - PROCESS | 6977 | Values: 147.0 149.0 148.0 147.0 149.0 149.0 147.0 148.0 148.0 149.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:43:11 INFO - PROCESS | 6977 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.50 stddev:2.58 (3.8%) stddev-sans-first:2.50 04:43:11 INFO - PROCESS | 6977 | Values: 65.0 69.0 66.0 68.0 70.0 65.0 66.0 68.0 70.0 73.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 04:43:11 INFO - PROCESS | 6977 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 67.0 66.0 67.0 66.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:85.00 stddev:11.68 (13.7%) stddev-sans-first:12.29 04:43:11 INFO - PROCESS | 6977 | Values: 85.0 83.0 84.0 90.0 87.0 85.0 85.0 86.0 122.0 85.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:134.50 stddev:4.00 (3.0%) stddev-sans-first:2.45 04:43:11 INFO - PROCESS | 6977 | Values: 145.0 134.0 135.0 134.0 133.0 131.0 134.0 134.0 138.0 139.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.50 stddev:3.57 (2.1%) stddev-sans-first:3.77 04:43:11 INFO - PROCESS | 6977 | Values: 173.0 172.0 177.0 173.0 170.0 169.0 170.0 180.0 170.0 170.0 04:43:11 INFO - PROCESS | 6977 | 04:43:11 INFO - PROCESS | 6977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:0.78 04:43:11 INFO - PROCESS | 6977 | Values: 70.0 69.0 67.0 69.0 67.0 68.0 68.0 68.0 67.0 68.0 04:43:11 INFO - PROCESS | 6977 | -------- Summary: end -------- 04:43:11 INFO - PROCESS | 6977 | 04:43:12 INFO - TEST-INFO | 6977: exit 0 04:43:12 INFO - TEST-OK | kraken | took 63934ms 04:43:12 INFO - SUITE-END | took 1178s 04:43:12 INFO - Completed test suite (00:19:38) 04:43:12 INFO - javascript benchmark 04:43:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6315.853565189438, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2701.311165652758, 2722.0472834507923, 2741.068036867465, 2744.3413580740616, 2748.1892841611734, 4753.405824271966, 4784.378030855988, 4855.781489832957, 4882.731449770261, 4914.311996320518, 4770.332153498513, 4820.469748327681, 4840.346553215315, 4905.975470122653, 4907.779149938252, 4467.597916187542, 4474.709143905652, 4515.2324104902245, 4541.318802179667, 4564.612007979325, 4495.056038231975, 4507.977460112695, 4523.6607254455885, 4560.110778398213, 4644.535546445345, 56.726124048539724, 4564.8174073037035, 4594.908101837961, 4609.884752881171, 4621.607163391116, 4426.136903303857, 4433.534478879704, 4533.795979180944, 4557.270836666151, 4574.496805351442, 4498.932516012263, 4515.390422292981, 4517.480489743689, 4527.479339875924, 4567.748773817439, 4588.311753237008, 4799.496052914428, 4810.110129625996, 4822.083804077214, 4866.02679464105, 5153.3558305211845, 5198.194279886624, 5201.037808005493, 5225.555827754645, 5239.502247286539, 5220.92168617471, 5242.55438287746, 5242.8689282767855, 5248.71132087735, 5273.050850846846, 4813.253945638432, 4816.590589799836, 4860.586850117745, 4875.219964805649, 4878.853634390974, 5255.159174532057, 5292.92060619091, 5329.626926115212, 5340.439253878287, 5391.272178255964, 5070.543651071347, 5120.692758434506, 5131.61512886535, 5146.485351464824, 5202.14164662834, 5111.616628752859, 5197.272381866542, 5212.035773381936, 5213.087709650796, 5238.292830467914, 5221.112410890158, 5233.921491177635, 5239.952009598096, 5271.973640131775, 5277.9472205278225, 5228.215767634809, 5230.503102205284, 5231.8168864089575, 5248.895022099537, 5283.735813209324, 4372.191144638252, 4445.5776701213335, 4456.598906098467, 4467.218236808546, 4523.705959112647, 3820.3887378019385, 3853.9614603854166, 3861.5559210690567, 3877.2439374322303, 3892.902677433087, 4487.865364039084, 4490.842820501267, 4501.815008033601, 4512.638988880947, 4544.091181763661, 5055.039542486916, 5193.948060519347, 5261.894762104736, 5277.366715994029, 5278.9208161877605, 4464.776761161929, 4479.70881892676, 4492.146492166478, 4535.501094879561, 4541.114482675913, 4672.43930728308, 4725.220338644154, 4742.5257474252985, 4750.406199225097, 4812.951870481321, 4775.76121193932, 4864.975675121602, 4907.460179380194, 4909.852704418801, 4959.380077490314, 5269.1569348903995, 5307.097793375058, 5307.150855863043, 5326.946730532645, 5357.517823395913, 4941.258811178208, 4963.627727920348, 4970.726610036482, 4978.327925730125, 5010.3737032870895, 4916.950830491649, 5127.256547800623, 5155.458676838878, 5156.1750119980625, 5214.661047031931, 5208.765605547836, 5223.085959956917, 5235.60732945023, 5246.685198888079, 5251.816186433456, 5112.284280200849, 5115.4373018967135, 5121.052605268037, 5123.718195499283, 5155.767990440514, 4984.40187177541, 5039.370078740158, 5044.0920634286185, 5069.493050694901, 5147.459516750687, 5009.073321435546, 5014.749262536931, 5043.445221025758, 5075.213341932006, 5110.897782044412, 5003.049420610072, 5128.897422051613, 5165.92251116226, 5167.199084141964, 5191.805884646477, 4925.605951523941, 4942.777575009061, 4998.575121114746, 5003.249512573143, 5027.547520723152], "value": 4768.425297823552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.73197492163, 589.9852254122908, 593.0629605223747, 600.1507866369088, 610.7007566292518, 38144.427833582486, 38467.61532384675, 38885.41671874924, 39215.21569568607, 39219.803900980456, 40091.599084009154, 40672.79663601685, 40837.18325633486, 40934.795326023326, 41028.58971410285, 7636.732714355013, 7781.688732450695, 7865.252800983897, 7869.4884832486, 7871.21287871214, 7643.273888980566, 7698.307152356287, 7715.074191097048, 7718.652660630257, 7737.0, 7675.194104619019, 7696.615169241543, 7743.993280873478, 7749.380049596019, 7782.0, 7646.3882889369, 7700.345470634975, 7704.114026886924, 7712.190220026872, 7713.228677132298, 7785.260400261966, 7800.102988156378, 7870.724524641667, 7873.5275883447175, 7924.207579242087, 37696.24607507862, 37736.62263377386, 38116.61883381186, 38167.8091609543, 38216.42675359844, 2506.736792636765, 2985.626796650419, 3095.4428202923464, 3495.632958539368, 3686.225892562565, 27570.724292757015, 27717.168484945483, 28146.0, 28370.148895532962, 28741.425171496452, 3350.229447227127, 3354.463285874273, 3392.135005573563, 3446.6897979181995, 3455.7580969332157, 204930.0, 205251.0, 206389.9680501603, 206878.0, 207517.0, 31544.842275788473, 31596.210094747355, 31628.841855790575, 31903.36193276168, 32068.518972215435, 32637.347253054806, 34182.14544636404, 34417.483737743954, 34642.0, 34747.13132171665, 13459.327033648475, 13595.116317439335, 13597.660058498617, 13622.182669039888, 13671.794923076162, 11128.833067503994, 11183.944080279547, 11261.38062406559, 11265.943670281596, 11278.379689117013, 7931.920680793118, 8009.759707208793, 8009.8398032040195, 8021.719239826695, 8078.596070196467, 3117.4700300948894, 3131.749460043191, 3140.3562269735107, 3159.3365393267213, 3222.726068284175, 882.289756745813, 994.9801003980025, 1003.6738060130341, 1024.538957469142, 1044.065561322612, 28438.85780571084, 28517.572236416472, 28898.42203155925, 29052.41895162085, 29140.708592914223, 961.0677642686583, 965.9517024148764, 987.0573602209872, 1010.3079390617451, 1080.4867687848366, 14967.925160374347, 15397.84602153964, 15469.767953480707, 15630.218489075729, 15633.0, 363243.0, 365794.0, 367192.0, 368642.0, 368784.0, 49687.50312496901, 49821.50178498169, 49950.500494995315, 50074.0, 50199.498005020214, 1159.5825502818977, 1171.1860257121389, 1174.8942595166477, 1183.5206741269972, 1199.5381778015353, 26890.731092688824, 28228.71771282261, 28581.28546786264, 28712.712872871838, 28730.138095857157, 37997.430038549996, 38090.0, 38233.23533529258, 38261.4260786094, 38434.2313153741, 322329.38835305674, 323617.0, 324610.0, 324762.0, 325176.0, 25240.873795630905, 25398.74601253964, 25822.354441139123, 26119.347016324744, 26391.868040659672, 41718.37422438726, 42007.78996105, 42549.57450425456, 42602.0, 42974.785126074166, 36212.63787362093, 36323.63676363203, 36459.81770091133, 36820.07949801276, 36998.260034798615, 35887.28225435424, 36331.45502817407, 36609.26781464409, 36805.63194368022, 36923.0, 31669.683303166672, 35168.0, 36055.63944360523, 36157.45763813597, 37453.62546374501, 31757.0, 33450.66549334476, 33667.83166084154, 33761.324773503904, 34058.82970585131, 25550.616740748534, 25730.228093157235, 26116.8694156528, 26120.34699132537, 26142.477150457264], "value": 16239.793045747538, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.89471605876264, 360.4377171612285, 367.8179301245882, 376.43722634661185, 383.8407061069656, 15442.922785386072, 15992.0, 16782.24479898403, 16782.328706851713, 16817.66364672706, 15672.138032408213, 16238.594035149126, 16787.24457399417, 16789.0, 16795.244214010367, 4992.400911890578, 5144.382674079097, 5190.117679994391, 5195.610329225305, 5201.9479805201845, 3669.5046168767276, 5075.720835354054, 5665.490105890469, 6029.427204415573, 6056.788012419566, 6048.092786082079, 6076.0, 6084.756609735606, 6089.147519347295, 6094.725737341831, 4756.0, 5018.34761481007, 5035.0685123252315, 5046.772895219724, 5131.332926719502, 4918.0901533216465, 4936.4076310842565, 4956.430010548797, 5239.240310155006, 5281.181416880351, 10944.23390362675, 11254.43727813606, 11365.204435689506, 11394.829077563843, 11472.0, 1726.18869131508, 1730.766346543213, 1751.0456801043335, 1902.3627084926566, 1932.1498540642071, 8275.172482751737, 8834.514101724468, 9812.90187098127, 10127.746806329827, 12888.935555322258, 1701.8553422959064, 1706.8122506524273, 1707.4109432245855, 1737.1487970894298, 1762.770839790819, 65797.67101164463, 68705.65647171783, 69051.96422053724, 69928.30071699269, 70481.2951870485, 8840.8673869892, 9031.548422578844, 9533.094356036165, 9537.952310238405, 9566.091221333962, 12821.35893205336, 12884.355782210852, 13002.414891329912, 13011.438627364776, 13096.869031309565, 6982.67329207449, 7139.286071392819, 7160.892586611205, 7273.527220730635, 7410.5183163094225, 6789.388954993976, 6927.757528486479, 6944.652767361612, 7058.611776352247, 7142.5714457132735, 3745.438184272381, 3827.9043023924623, 4078.979605102015, 4163.271427500175, 4196.265653510623, 1510.3656464285027, 1650.3811070848433, 1752.5572673273446, 1768.2926829268395, 1796.1827368547279, 811.614934906897, 830.8130670599188, 865.3682811547606, 946.2430055955208, 950.6102497975935, 16174.272157752694, 16349.83650163483, 16366.099864507567, 16497.17514124313, 16837.326506939586, 794.4677066365549, 832.0, 833.7540425574471, 901.8106197698556, 935.6584846531103, 7219.602921839244, 9278.0, 9468.100530449734, 9471.147596716191, 9673.758156046155, 365280.0, 379745.0, 388019.0, 388967.0, 396815.0, 79971.0, 82044.58977705073, 83884.0, 84450.57774711087, 85470.57264713636, 971.1259866120548, 978.3836183204536, 986.1420564109271, 995.2436148527026, 1009.6466236817055, 15533.378664853279, 15571.532854014398, 15780.289886954884, 15801.36794528206, 16133.435329763872, 35369.82315088408, 35870.46194307035, 36226.0, 36426.8178659105, 36788.0, 45542.54457455383, 50003.249951250036, 50026.0, 50439.0, 50767.49232507627, 5550.417206193453, 7312.926870731225, 7450.254974502724, 7467.402607791472, 7588.203238659861, 8994.460332380078, 11251.0, 11424.028957538701, 11628.186026978368, 11862.644120676394, 9291.907080929104, 9948.850767238642, 10020.849687254551, 10265.897341026493, 10311.690649280234, 10186.134178594903, 10288.228382871464, 10355.792884142425, 10424.166066714797, 10536.420496872746, 9957.800843983225, 10155.796884062425, 10534.315269507457, 10583.682489525327, 10816.567337306735, 6581.243157036811, 6788.93211067883, 6871.14110736158, 6949.722011119701, 7343.8531229376185, 7319.8536029280185, 8756.649734010569, 10159.44123073238, 10270.383776973107, 10283.0], "value": 7918.807480492398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.1913768720676, 1435.91384516929, 1584.9683006339874, 1730.5500569851843, 1751.903645299508, 6819.21579018413, 7437.851242975144, 7567.356774674159, 7868.606569671515, 7890.329322007637, 7636.618169091551, 7769.7669069928, 7800.648970796314, 7804.531728096318, 7817.0, 2157.514559224174, 2195.6596727507263, 2200.273909609825, 2203.8347123965686, 2207.668849672546, 2150.215171462413, 2184.3010236724253, 2192.7149470568884, 2219.622664147099, 2222.377734234417, 2178.4336072621154, 2180.672899065145, 2181.334692918659, 2191.8356123290737, 2212.0930418528405, 2099.9055042523046, 2114.0698092839257, 2115.9259425920095, 2133.466633341672, 2139.7967193116783, 2092.3618296419586, 2117.301290574107, 2118.364490652798, 2118.7245658064353, 2151.085788539864, 7823.3350165236025, 7854.096778870446, 7872.881906771403, 7878.763637090839, 7912.643931023118, 4461.5315391883705, 4539.84110556129, 4550.658700597435, 4576.885577860547, 4593.770311484413, 2823.167165686107, 2871.305929501604, 2911.2867347499996, 2918.1829087855435, 2933.4279815436, 784.4940013691137, 824.8020475085996, 828.747232094211, 832.3757182113415, 1693.3057446446899, 9844.60621575136, 10078.748031299203, 10307.0, 10321.225908056926, 10331.328463649914, 4169.0, 4277.572242775697, 4333.9133217335475, 4351.912961740747, 4354.542773008852, 8899.377043607015, 8936.597853096626, 8949.418287811402, 8968.730938071869, 9008.144226298491, 4608.5852273294895, 4644.7213167210075, 4659.930101048487, 4661.743604101739, 4673.275642275453, 3623.710103191738, 4116.58834116586, 4134.73124246929, 4187.330027195634, 4274.337477690963, 3611.4402267648557, 3622.3298689742483, 3702.278055779151, 3748.9250214995545, 3764.5482542095124, 1155.797970111075, 1201.6575276046285, 1207.9094067944764, 1211.9697007574705, 1212.763511115324, 852.7313896122826, 875.1598465473216, 892.6652505310509, 898.8247291778172, 921.760342311004, 5511.311086114236, 5533.280673512498, 5540.085885828793, 5583.776648933997, 5686.147077938343, 398.0923494432698, 400.77156021067714, 404.6277424769219, 411.21663231543954, 425.2154774441151, 3632.0919770057485, 3669.284489524517, 3676.338259113332, 3725.0, 3729.9813500932323, 9190.943041550307, 9620.567074481665, 9661.13049825519, 9710.368826026286, 9722.2708296878, 9519.381240219502, 9536.56951457287, 9542.284328675238, 9578.0, 9591.376560523544, 6960.79117626472, 7206.531575447684, 7209.927900721031, 7214.458915581353, 7230.746923857745, 5119.257707632298, 5232.895342093213, 5279.868003299948, 5282.656627319212, 5424.07790675594, 8565.0, 8631.69789057405, 8633.611487483204, 8690.956545217234, 8717.869231961398, 8341.45780524264, 8710.433821801562, 8739.737807865775, 8775.122487751429, 9049.366544341832, 6152.876942461216, 6613.768518101843, 6754.6622668865375, 6776.051352810709, 6885.483588730765, 7499.0, 7553.169151393233, 7576.469647124869, 7648.502847314907, 7664.770056898302, 6670.66646667655, 6872.965635171792, 6887.621180835102, 6969.233384327821, 7063.82340441493, 6643.335666433318, 6710.0, 6794.3545363190415, 6876.312368763083, 6940.9652951734915, 6226.097215903578, 6234.657093859882, 6307.148534947907, 6319.273283572448, 6327.493800495858, 4775.6657034007285, 4803.207470767285, 4818.301346304696, 4831.661783675109, 4850.684705494132, 4901.3383193268455, 4931.211006238985, 4971.080350135237, 4986.32684587576, 5015.673981191211], "value": 4085.972699050268, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.0517765485623, 284.36586412300574, 289.3619568850683, 292.34660533707154, 293.0724257724303, 5017.623678224134, 5119.3856737191545, 5162.380514338275, 5167.431582525919, 5180.430152683211, 5011.774470148843, 5070.619703522232, 5086.364204474441, 5123.077845987721, 5126.256692779545, 3948.940765888514, 3985.1431942132435, 3991.7604943703473, 3993.4808474898223, 4008.3586626139822, 3317.303366293081, 3723.497327860745, 3963.1677347757004, 3965.583613720561, 3977.86077487288, 3705.6664900159117, 3739.2521495700967, 3772.849086036555, 3824.5984171661994, 3853.807309634521, 3855.7108216883707, 3858.112634094146, 3876.7480113792653, 3877.263319969197, 3879.301725689375, 3224.4357237483346, 3247.447933851251, 3350.849211785451, 3357.3285342931513, 3391.491276308549, 4777.703384664605, 4803.615710743132, 4817.975910120427, 4828.903421931542, 4859.562639362439, 4421.5187912049505, 4430.335449682541, 4448.3549885266775, 4450.821967121311, 4473.373727678128, 5036.370453693288, 5284.674743113018, 5322.92015619766, 5348.919766203471, 5372.54333381663, 3628.6734193922675, 3630.509881166035, 3638.3632864248652, 3643.67206951373, 3647.069997150736, 5557.861053473655, 5599.524040456566, 5614.438556144394, 5625.54995600351, 5670.489655930986, 3665.157013886821, 3762.4168253920684, 3763.717721170923, 3775.9433608495897, 3776.4335349697767, 3734.57052438973, 3735.458358537997, 3735.551733791908, 3771.585125636178, 3781.2248489059675, 4306.80619372129, 4361.5856493633055, 4382.452193475816, 4396.516383197845, 4401.185780630593, 5292.867678308073, 5318.095923692981, 5338.412774594792, 5369.95285919242, 5424.159255315432, 1243.6952946527977, 1283.9037072219435, 1287.3370214339623, 1291.347869326003, 1293.2822283632486, 789.7709664197433, 792.6353877216545, 800.195803217774, 804.766617680866, 809.8906647602616, 4157.10622216225, 4179.791010449465, 4183.372494125905, 4225.619694227473, 4263.786810659517, 4910.533499317559, 4948.554630083309, 4948.678335908155, 4985.376827896513, 4988.351514303117, 4269.124829409963, 4286.249906266391, 4291.23215525984, 4299.505556860939, 4305.892352691208, 2552.3236342369287, 2576.2400091972913, 2619.5153896529205, 2638.696549896748, 2780.5551111822415, 5039.319691841628, 5157.149070403417, 5162.277281180638, 5166.7782853372655, 5170.71561064145, 5576.737608499074, 5633.718314084279, 5643.504471315105, 5650.576206784425, 5681.261436013292, 4970.701757894465, 5099.974500127476, 5113.3097031900215, 5177.534021937969, 5189.714565698923, 5473.042217611823, 5481.616286859881, 5518.834434966958, 5541.279633647761, 5541.528970037431, 5375.3012108425655, 5381.865453363697, 5408.486193811582, 5415.404305526467, 5436.157395603688, 4872.244802055687, 5149.871253218699, 5159.948400515947, 5166.535011848951, 5181.896362072813, 3745.6254374562327, 3756.530433695788, 3763.6800871925097, 3765.4351847223134, 3791.8386519683518, 5429.321334833146, 5504.761428678516, 5506.174073888788, 5513.558915286687, 5547.33431988164, 5093.490650934877, 5290.0, 5308.2568440419145, 5322.654027488201, 5359.410464848941, 5288.550473209821, 5292.603054770984, 5323.760430780701, 5339.973300133474, 5344.465553444625, 5235.74342157887, 5246.108161612611, 5270.288511050959, 5288.048151332797, 5305.124654431976, 5089.185730283137, 5358.571314294769, 5378.515933565998, 5378.623496355218, 5410.648307859977, 5220.321358223407, 5220.843374698765, 5243.011483454395, 5262.342207224097, 5278.498542638443], "value": 3902.3392430150575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.2791891608441, 639.996800016, 646.3084499585444, 657.1949362031512, 658.3844105761117, 12150.270983740971, 12479.313637749932, 12669.936650316748, 12760.106792524526, 12927.935360323185, 12919.289439080847, 12946.870531294684, 13014.154079984817, 13027.088103832735, 13034.087613867034, 623.9032949892751, 773.446985405435, 783.8275579372544, 801.034753122489, 806.0931452116369, 789.9052113746359, 790.8141586727114, 791.3273717340244, 795.4630624328584, 797.5852556670528, 818.3167055508658, 820.9712660056899, 824.9587520623975, 830.5182993863575, 831.8003679116998, 813.2030610002172, 817.0358976407837, 818.3248819723751, 819.7171975668385, 819.8934138561979, 595.6128516464289, 600.76870404894, 602.7167231401235, 603.2459425717852, 605.824310949824, 12356.0, 12455.439505222286, 12522.874771252353, 12544.0, 12549.247045177319, 13337.866621333857, 13510.527131550447, 13833.446662133503, 13876.514321998682, 14050.929745351208, 9980.650677226262, 10063.446510441923, 10295.588176472933, 10389.688309350731, 10628.681139565826, 3331.3338720311854, 3352.4133276676484, 3425.4348032574594, 3444.896653100411, 3475.200703838106, 58713.41286587122, 58934.0, 58949.41050589482, 60744.0, 61098.38901611016, 10734.463276836283, 10764.300320479144, 10764.892351076545, 10893.237473376788, 11076.833847492295, 19655.115519801642, 19767.209311627375, 19952.70070948937, 20005.799942000685, 20464.69302960457, 6863.965680171567, 7086.759817031999, 7139.82150446243, 7340.4127669786285, 7374.668139933716, 3830.214805964826, 3903.726739128234, 3914.941275880864, 3923.6076392360537, 3931.6658084063174, 2770.2104900103373, 2849.301921029361, 2876.0652787844033, 2877.8848846045926, 2895.841663334641, 522.2766468441237, 523.2204016016185, 532.4329588987715, 536.1528784520449, 539.4147350125158, 555.4445554445555, 644.9419552240226, 649.6784091874458, 660.2769966886252, 663.9070530125787, 8582.0, 8697.739067827975, 8848.247898928663, 8927.419717718327, 9006.684766033157, 530.8540151458379, 580.6109906362747, 592.3572923378097, 597.7041364524501, 601.8796240751867, 3633.0, 3919.4904662393706, 3935.5670876203594, 3971.404289356562, 4007.1584967157223, 52740.0, 53728.73135634297, 84655.0, 86887.56556217305, 88137.0, 46625.5337446628, 62828.0, 75492.0, 76116.38836116344, 78557.0, 69605.65197174084, 70993.64503177554, 71055.0, 71205.14082092095, 71422.0, 7960.391328912582, 8086.353091752763, 8198.959005205174, 8215.2606265434, 8238.138170865926, 41789.164216716104, 41981.0, 42737.0, 42824.0, 43977.12045759131, 50345.74827125841, 50598.24102638537, 51742.482575173766, 58093.41906581049, 59791.0, 10784.730381740519, 11062.336259824437, 11121.666350009513, 11318.94340528292, 11393.430328483708, 13124.868751312364, 13183.934080329536, 13440.46238150463, 13547.729045418839, 13711.17732935987, 9261.907380926374, 12054.216475929037, 12340.81488777687, 12587.811182832447, 12593.433295501907, 10549.314294570828, 10936.23446358779, 11096.833547496633, 11296.83054754163, 11346.773064538827, 12141.939290303491, 12242.632721018384, 12509.937450312691, 12603.432845522157, 12699.428525716181, 9380.530973451436, 9772.511374431393, 9820.361676491291, 9823.563626963143, 9828.16460600857, 10066.547005384922, 10539.0, 10543.94728026355, 10616.787664246825, 10682.359058456517], "value": 6491.006020279117, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 116.0, 117.0, 114.0, 114.0, 115.0, 113.0, 115.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 137.0, 158.0, 184.0, 131.0, 167.0, 157.0, 135.0, 186.0, 130.0], "value": 154.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 166.0, 177.0, 163.0, 165.0, 165.0, 166.0, 163.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 76.0, 160.0, 77.0, 78.0, 76.0, 75.0, 155.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 156.0, 88.0, 87.0, 87.0, 145.0, 87.0, 87.0, 140.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 147.0, 149.0, 149.0, 147.0, 148.0, 148.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 66.0, 68.0, 70.0, 65.0, 66.0, 68.0, 70.0, 73.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 67.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 90.0, 87.0, 85.0, 85.0, 86.0, 122.0, 85.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 135.0, 134.0, 133.0, 131.0, 134.0, 134.0, 138.0, 139.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 177.0, 173.0, 170.0, 169.0, 170.0, 180.0, 170.0, 170.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 67.0, 69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0], "value": 68.1, "unit": "score"}]}]} 04:43:12 INFO - Return code: 0 04:43:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:13 ERROR - # TBPL SUCCESS # 04:43:13 INFO - Running post-action listener: _resource_record_post_action 04:43:13 INFO - ##### 04:43:13 INFO - ##### Finished run-tests step (success) 04:43:13 INFO - ##### 04:43:13 INFO - Running post-run listener: _resource_record_post_run 04:43:13 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524328960; Read time: 16; Write time: 458344 04:43:13 INFO - TinderboxPrint: CPU usage
13.5% 04:43:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:43:13 INFO - TinderboxPrint: I/O write bytes / time
524,328,960 / 458,344 04:43:13 INFO - TinderboxPrint: CPU idle
8,252.8 (86.5%) 04:43:13 INFO - TinderboxPrint: CPU user
1,233.3 (12.9%) 04:43:13 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237723648; Read time: 0; Write time: 263540 04:43:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286605312; Read time: 16; Write time: 194804 04:43:13 INFO - Running post-run listener: _upload_blobber_files 04:43:13 INFO - Blob upload gear active. 04:43:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:13 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 04:43:13 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:13 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:14 INFO - (blobuploader) - INFO - Done attempting. 04:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:19 INFO - (blobuploader) - INFO - Done attempting. 04:43:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:43:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:20 INFO - (blobuploader) - INFO - Done attempting. 04:43:20 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:20 INFO - Return code: 0 04:43:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29d1f5c5f2c9fbcfa8ceb7f70f2c7ebcc3e15dfba26aa952515bcb48e0ec584bca43232ed8923ed316c356215ca622660dbd19ae0d2b8572eecfda6a393aa516", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ca52ae5b9351b97fea8ea79cef08ee881b390926f14c79143f70c63c0375a8a7d33629cbf4d67d5bed86c676ee8d5b1c75cec3bf5fa0f5f90b1ae2e484a7893", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4301965c4bdc60bb3b154458bbdb1eeb14ca84d784bce9c1e8bece22c7afd3b1b9a27225ddbdb0da80a155fa9541357de423229a0a1e7f654d5e4eb8dcbdfa69"} 04:43:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:20 INFO - Contents: 04:43:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29d1f5c5f2c9fbcfa8ceb7f70f2c7ebcc3e15dfba26aa952515bcb48e0ec584bca43232ed8923ed316c356215ca622660dbd19ae0d2b8572eecfda6a393aa516", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ca52ae5b9351b97fea8ea79cef08ee881b390926f14c79143f70c63c0375a8a7d33629cbf4d67d5bed86c676ee8d5b1c75cec3bf5fa0f5f90b1ae2e484a7893", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4301965c4bdc60bb3b154458bbdb1eeb14ca84d784bce9c1e8bece22c7afd3b1b9a27225ddbdb0da80a155fa9541357de423229a0a1e7f654d5e4eb8dcbdfa69"} 04:43:20 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:20 INFO - Copying logs to upload dir... 04:43:20 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.912576 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-06 04:43:19.347715) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 04:43:19.350815) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29d1f5c5f2c9fbcfa8ceb7f70f2c7ebcc3e15dfba26aa952515bcb48e0ec584bca43232ed8923ed316c356215ca622660dbd19ae0d2b8572eecfda6a393aa516", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ca52ae5b9351b97fea8ea79cef08ee881b390926f14c79143f70c63c0375a8a7d33629cbf4d67d5bed86c676ee8d5b1c75cec3bf5fa0f5f90b1ae2e484a7893", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4301965c4bdc60bb3b154458bbdb1eeb14ca84d784bce9c1e8bece22c7afd3b1b9a27225ddbdb0da80a155fa9541357de423229a0a1e7f654d5e4eb8dcbdfa69"} build_url:https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/LQ_1_llMQVO1fhNkrktx3w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29d1f5c5f2c9fbcfa8ceb7f70f2c7ebcc3e15dfba26aa952515bcb48e0ec584bca43232ed8923ed316c356215ca622660dbd19ae0d2b8572eecfda6a393aa516", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ca52ae5b9351b97fea8ea79cef08ee881b390926f14c79143f70c63c0375a8a7d33629cbf4d67d5bed86c676ee8d5b1c75cec3bf5fa0f5f90b1ae2e484a7893", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4301965c4bdc60bb3b154458bbdb1eeb14ca84d784bce9c1e8bece22c7afd3b1b9a27225ddbdb0da80a155fa9541357de423229a0a1e7f654d5e4eb8dcbdfa69"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 04:43:19.375767) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:43:19.376050) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465212158.27324-1380003073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:43:19.458111) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 04:43:19.458461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 04:43:19.458736) ========= ========= Total master_lag: 0.16 =========