builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1466966319.19 results: success (0) buildid: 20160626030213 builduid: 6cc10c895584475aa1670d3cf7e45221 revision: c2da34d96746288b5fee27bf6542a12c9f410988 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.193708) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.194194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.194516) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.277727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.278107) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 11:38:42-- 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% 70.6M=0s 2016-06-26 11:38:42 (70.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.312755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.609787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.610240) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016787 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.660460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:39.660872) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2da34d96746288b5fee27bf6542a12c9f410988 --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 c2da34d96746288b5fee27bf6542a12c9f410988 --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=97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 11:38:42,563 truncating revision to first 12 chars 2016-06-26 11:38:42,563 Setting DEBUG logging. 2016-06-26 11:38:42,563 attempt 1/10 2016-06-26 11:38:42,563 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2da34d96746?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 11:38:42,861 unpacking tar archive at: mozilla-central-c2da34d96746/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:40.307766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:40.308104) ========= script_repo_revision: c2da34d96746288b5fee27bf6542a12c9f410988 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:40.308565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:40.308991) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 11:38:40.320413) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-26 11:38:40.320723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:38:43 INFO - MultiFileLogger online at 20160626 11:38:43 in /builds/slave/test 11:38:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:38:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:38:43 INFO - {'append_to_log': False, 11:38:43 INFO - 'base_work_dir': '/builds/slave/test', 11:38:43 INFO - 'blob_upload_branch': 'Firefox', 11:38:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:38:43 INFO - 'branch': 'Firefox', 11:38:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:43 INFO - 'config_files': ('talos/linux_config.py',), 11:38:43 INFO - 'default_actions': ('clobber', 11:38:43 INFO - 'read-buildbot-config', 11:38:43 INFO - 'download-and-extract', 11:38:43 INFO - 'populate-webroot', 11:38:43 INFO - 'create-virtualenv', 11:38:43 INFO - 'install', 11:38:43 INFO - 'run-tests'), 11:38:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:43 INFO - 'download_minidump_stackwalk': True, 11:38:43 INFO - 'download_symbols': 'ondemand', 11:38:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:43 INFO - 'installer_path': 'installer.exe', 11:38:43 INFO - 'log_level': 'info', 11:38:43 INFO - 'log_name': 'talos', 11:38:43 INFO - 'log_to_console': True, 11:38:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:38:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:38:43 INFO - 'opt_config_files': (), 11:38:43 INFO - 'pip_index': False, 11:38:43 INFO - 'sps_profile': False, 11:38:43 INFO - 'sps_profile_interval': 0, 11:38:43 INFO - 'suite': 'dromaeojs-e10s', 11:38:43 INFO - 'system_bits': '32', 11:38:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:43 INFO - 'title': 'talos-linux64-ix-068', 11:38:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:43 INFO - 'use_talos_json': True, 11:38:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:38:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:43 INFO - 'work_dir': 'build'} 11:38:43 INFO - ##### 11:38:43 INFO - ##### Running clobber step. 11:38:43 INFO - ##### 11:38:43 INFO - Running pre-action listener: _resource_record_pre_action 11:38:43 INFO - Running main action method: clobber 11:38:43 INFO - rmtree: /builds/slave/test/build 11:38:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:38:44 INFO - Running post-action listener: _resource_record_post_action 11:38:44 INFO - ##### 11:38:44 INFO - ##### Finished clobber step (success) 11:38:44 INFO - ##### 11:38:44 INFO - ##### 11:38:44 INFO - ##### Running read-buildbot-config step. 11:38:44 INFO - ##### 11:38:44 INFO - Running pre-action listener: _resource_record_pre_action 11:38:44 INFO - Running main action method: read_buildbot_config 11:38:44 INFO - Using buildbot properties: 11:38:44 INFO - { 11:38:44 INFO - "project": "", 11:38:44 INFO - "product": "firefox", 11:38:44 INFO - "script_repo_revision": "production", 11:38:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:38:44 INFO - "repository": "", 11:38:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:38:44 INFO - "buildid": "20160626030213", 11:38:44 INFO - "stage_platform": "linux64-pgo", 11:38:44 INFO - "basedir": "/builds/slave/test", 11:38:44 INFO - "nightly_build": "True", 11:38:44 INFO - "buildnumber": 761, 11:38:44 INFO - "slavename": "talos-linux64-ix-068", 11:38:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:38:44 INFO - "platform": "ubuntu64_hw", 11:38:44 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:38:44 INFO - "branch": "mozilla-central", 11:38:44 INFO - "repo_path": "mozilla-central", 11:38:44 INFO - "revision": "c2da34d96746288b5fee27bf6542a12c9f410988", 11:38:44 INFO - "pgo_build": "True", 11:38:44 INFO - "builduid": "6cc10c895584475aa1670d3cf7e45221", 11:38:44 INFO - "slavebuilddir": "test" 11:38:44 INFO - } 11:38:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:38:44 INFO - Running post-action listener: _resource_record_post_action 11:38:44 INFO - ##### 11:38:44 INFO - ##### Finished read-buildbot-config step (success) 11:38:44 INFO - ##### 11:38:44 INFO - ##### 11:38:44 INFO - ##### Running download-and-extract step. 11:38:44 INFO - ##### 11:38:44 INFO - Running pre-action listener: _resource_record_pre_action 11:38:44 INFO - Running main action method: download_and_extract 11:38:44 INFO - mkdir: /builds/slave/test/build/tests 11:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:44 INFO - https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:38:50 INFO - Downloaded 1361 bytes. 11:38:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:50 INFO - Using the following test package requirements: 11:38:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:38:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:38:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:50 INFO - u'jsshell-linux-x86_64.zip'], 11:38:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:38:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:38:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:38:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:38:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:38:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:50 INFO - https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:38:58 INFO - Downloaded 24279200 bytes. 11:38:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:38:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:38:59 INFO - Return code: 0 11:38:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:38: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')]} 11:38:59 INFO - https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:39:01 INFO - Downloaded 24279200 bytes. 11:39:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:39:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:39:03 INFO - Return code: 0 11:39:03 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')]} 11:39:03 INFO - https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:39:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:39:04 INFO - Downloaded 14405240 bytes. 11:39:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:39:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:39:04 INFO - Return code: 0 11:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:04 INFO - https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:39:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:39:06 INFO - Downloaded 60156174 bytes. 11:39:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:06 INFO - mkdir: /builds/slave/test/properties 11:39:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:06 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:06 INFO - Contents: 11:39:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:07 INFO - Running post-action listener: _resource_record_post_action 11:39:07 INFO - Running post-action listener: set_extra_try_arguments 11:39:07 INFO - ##### 11:39:07 INFO - ##### Finished download-and-extract step (success) 11:39:07 INFO - ##### 11:39:07 INFO - ##### 11:39:07 INFO - ##### Running populate-webroot step. 11:39:07 INFO - ##### 11:39:07 INFO - Running pre-action listener: _resource_record_pre_action 11:39:07 INFO - Running main action method: populate_webroot 11:39:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:39:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:39:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:39:07 INFO - '--tppagecycles', 11:39:07 INFO - '7'], 11:39:07 INFO - 'tests': ['tsvgm']}}, 11:39:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:39:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:39:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:39:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:39:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:07 INFO - 'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:07 INFO - 'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['damp', 'tps']}, 11:39:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:07 INFO - 'tests': ['damp', 'tps']}, 11:39:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['dromaeo_dom']}, 11:39:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:39:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['basic_compositor_video']}, 11:39:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:39:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['a11yr', 11:39:07 INFO - 'ts_paint', 11:39:07 INFO - 'tpaint', 11:39:07 INFO - 'sessionrestore', 11:39:07 INFO - 'sessionrestore_no_auto_restore', 11:39:07 INFO - 'tabpaint']}, 11:39:07 INFO - 'other-e10s': {'tests': ['a11yr', 11:39:07 INFO - 'ts_paint', 11:39:07 INFO - 'tpaint', 11:39:07 INFO - 'sessionrestore', 11:39:07 INFO - 'sessionrestore_no_auto_restore', 11:39:07 INFO - 'tabpaint']}, 11:39:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:39:07 INFO - 'ts_paint', 11:39:07 INFO - 'tpaint', 11:39:07 INFO - 'sessionrestore', 11:39:07 INFO - 'sessionrestore_no_auto_restore', 11:39:07 INFO - 'tabpaint']}, 11:39:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:39:07 INFO - 'ts_paint', 11:39:07 INFO - 'tpaint', 11:39:07 INFO - 'sessionrestore', 11:39:07 INFO - 'sessionrestore_no_auto_restore', 11:39:07 INFO - 'tabpaint']}, 11:39:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['a11yr', 11:39:07 INFO - 'ts_paint', 11:39:07 INFO - 'tpaint', 11:39:07 INFO - 'sessionrestore', 11:39:07 INFO - 'sessionrestore_no_auto_restore', 11:39:07 INFO - 'tabpaint']}, 11:39:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['a11yr', 11:39:07 INFO - 'ts_paint', 11:39:07 INFO - 'tpaint', 11:39:07 INFO - 'sessionrestore', 11:39:07 INFO - 'sessionrestore_no_auto_restore', 11:39:07 INFO - 'tabpaint']}, 11:39:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['tsvgx', 11:39:07 INFO - 'tsvgr_opacity', 11:39:07 INFO - 'tart', 11:39:07 INFO - 'tscrollx', 11:39:07 INFO - 'cart']}, 11:39:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:39:07 INFO - 'tsvgr_opacity', 11:39:07 INFO - 'tart', 11:39:07 INFO - 'tscrollx', 11:39:07 INFO - 'cart']}, 11:39:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:07 INFO - 'talos_options': ['--disable-e10s'], 11:39:07 INFO - 'tests': ['tp5o']}, 11:39:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:07 INFO - 'tests': ['tp5o']}, 11:39:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:07 INFO - 'talos_options': ['--disable-e10s', 11:39:07 INFO - '--xperf_path', 11:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:07 INFO - 'tests': ['tp5n']}, 11:39:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:07 INFO - 'talos_options': ['--xperf_path', 11:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:07 INFO - 'tests': ['tp5n']}}, 11:39:07 INFO - 'talos.zip': {'path': '', 11:39:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:39:07 INFO - Running post-action listener: _resource_record_post_action 11:39:07 INFO - ##### 11:39:07 INFO - ##### Finished populate-webroot step (success) 11:39:07 INFO - ##### 11:39:07 INFO - ##### 11:39:07 INFO - ##### Running create-virtualenv step. 11:39:07 INFO - ##### 11:39:07 INFO - Running pre-action listener: _resource_record_pre_action 11:39:07 INFO - Running main action method: create_virtualenv 11:39:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39:07 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 11:39:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:39:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:07 INFO - Using real prefix '/usr' 11:39:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:07 INFO - Installing distribute.............................................................................................................................................................................................done. 11:39:09 INFO - Installing pip.................done. 11:39:09 INFO - Return code: 0 11:39:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:09 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:09 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 11:39:09 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 11:39:09 INFO - Using env: {'DISPLAY': ':0', 11:39:09 INFO - 'HOME': '/home/cltbld', 11:39:09 INFO - 'LANG': 'en_US.UTF-8', 11:39:09 INFO - 'LANGUAGE': 'en_US:en', 11:39:09 INFO - 'LOGNAME': 'cltbld', 11:39:09 INFO - 'MAIL': '/var/mail/cltbld', 11:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:09 INFO - 'MOZ_NO_REMOTE': '1', 11:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:09 INFO - 'NO_EM_RESTART': '1', 11:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:09 INFO - 'PWD': '/builds/slave/test', 11:39:09 INFO - 'SHELL': '/bin/bash', 11:39:09 INFO - 'SHLVL': '1', 11:39:09 INFO - 'TERM': 'linux', 11:39:09 INFO - 'TMOUT': '86400', 11:39:09 INFO - 'USER': 'cltbld', 11:39:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:09 INFO - '_': '/tools/buildbot/bin/python'} 11:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:09 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 11:39:09 INFO - Cleaning up... 11:39:09 INFO - Return code: 0 11:39:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:09 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:09 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 11:39:09 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 11:39:09 INFO - Using env: {'DISPLAY': ':0', 11:39:09 INFO - 'HOME': '/home/cltbld', 11:39:09 INFO - 'LANG': 'en_US.UTF-8', 11:39:09 INFO - 'LANGUAGE': 'en_US:en', 11:39:09 INFO - 'LOGNAME': 'cltbld', 11:39:09 INFO - 'MAIL': '/var/mail/cltbld', 11:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:09 INFO - 'MOZ_NO_REMOTE': '1', 11:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:09 INFO - 'NO_EM_RESTART': '1', 11:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:09 INFO - 'PWD': '/builds/slave/test', 11:39:09 INFO - 'SHELL': '/bin/bash', 11:39:09 INFO - 'SHLVL': '1', 11:39:09 INFO - 'TERM': 'linux', 11:39:09 INFO - 'TMOUT': '86400', 11:39:09 INFO - 'USER': 'cltbld', 11:39:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:09 INFO - '_': '/tools/buildbot/bin/python'} 11:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:10 INFO - Downloading/unpacking psutil>=3.1.1 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:39:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:12 INFO - Installing collected packages: psutil 11:39:12 INFO - Running setup.py install for psutil 11:39:12 INFO - building 'psutil._psutil_linux' extension 11:39:12 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 11:39:12 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 11:39:12 INFO - building 'psutil._psutil_posix' extension 11:39:12 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 11:39:12 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 11:39:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:12 INFO - Successfully installed psutil 11:39:12 INFO - Cleaning up... 11:39:12 INFO - Return code: 0 11:39:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:12 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:12 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 11:39:12 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 11:39:12 INFO - Using env: {'DISPLAY': ':0', 11:39:12 INFO - 'HOME': '/home/cltbld', 11:39:12 INFO - 'LANG': 'en_US.UTF-8', 11:39:12 INFO - 'LANGUAGE': 'en_US:en', 11:39:12 INFO - 'LOGNAME': 'cltbld', 11:39:12 INFO - 'MAIL': '/var/mail/cltbld', 11:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:12 INFO - 'MOZ_NO_REMOTE': '1', 11:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:12 INFO - 'NO_EM_RESTART': '1', 11:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:12 INFO - 'PWD': '/builds/slave/test', 11:39:12 INFO - 'SHELL': '/bin/bash', 11:39:12 INFO - 'SHLVL': '1', 11:39:12 INFO - 'TERM': 'linux', 11:39:12 INFO - 'TMOUT': '86400', 11:39:12 INFO - 'USER': 'cltbld', 11:39:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:12 INFO - '_': '/tools/buildbot/bin/python'} 11:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:39:14 INFO - Installing collected packages: mozsystemmonitor 11:39:14 INFO - Running setup.py install for mozsystemmonitor 11:39:14 INFO - Successfully installed mozsystemmonitor 11:39:14 INFO - Cleaning up... 11:39:15 INFO - Return code: 0 11:39:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:39:15 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')]} 11:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:15 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')]} 11:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:15 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:15 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 11:39:15 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 11:39:15 INFO - Using env: {'DISPLAY': ':0', 11:39:15 INFO - 'HOME': '/home/cltbld', 11:39:15 INFO - 'LANG': 'en_US.UTF-8', 11:39:15 INFO - 'LANGUAGE': 'en_US:en', 11:39:15 INFO - 'LOGNAME': 'cltbld', 11:39:15 INFO - 'MAIL': '/var/mail/cltbld', 11:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:15 INFO - 'MOZ_NO_REMOTE': '1', 11:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:15 INFO - 'NO_EM_RESTART': '1', 11:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:15 INFO - 'PWD': '/builds/slave/test', 11:39:15 INFO - 'SHELL': '/bin/bash', 11:39:15 INFO - 'SHLVL': '1', 11:39:15 INFO - 'TERM': 'linux', 11:39:15 INFO - 'TMOUT': '86400', 11:39:15 INFO - 'USER': 'cltbld', 11:39:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:15 INFO - '_': '/tools/buildbot/bin/python'} 11:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:15 INFO - Downloading/unpacking jsonschema==2.5.1 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:17 INFO - warning: no files found matching '*.txt' 11:39:17 INFO - no previously-included directories found matching 'build' 11:39:17 INFO - no previously-included directories found matching 'dist' 11:39:17 INFO - no previously-included directories found matching '.git*' 11:39:17 INFO - Installing collected packages: jsonschema, functools32 11:39:17 INFO - Running setup.py install for functools32 11:39:17 INFO - warning: no files found matching '*.txt' 11:39:17 INFO - no previously-included directories found matching 'build' 11:39:17 INFO - no previously-included directories found matching 'dist' 11:39:17 INFO - no previously-included directories found matching '.git*' 11:39:17 INFO - Successfully installed jsonschema functools32 11:39:17 INFO - Cleaning up... 11:39:17 INFO - Return code: 0 11:39:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:17 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:17 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 11:39:17 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 11:39:17 INFO - Using env: {'DISPLAY': ':0', 11:39:17 INFO - 'HOME': '/home/cltbld', 11:39:17 INFO - 'LANG': 'en_US.UTF-8', 11:39:17 INFO - 'LANGUAGE': 'en_US:en', 11:39:17 INFO - 'LOGNAME': 'cltbld', 11:39:17 INFO - 'MAIL': '/var/mail/cltbld', 11:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:17 INFO - 'MOZ_NO_REMOTE': '1', 11:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:17 INFO - 'NO_EM_RESTART': '1', 11:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:17 INFO - 'PWD': '/builds/slave/test', 11:39:17 INFO - 'SHELL': '/bin/bash', 11:39:17 INFO - 'SHLVL': '1', 11:39:17 INFO - 'TERM': 'linux', 11:39:17 INFO - 'TMOUT': '86400', 11:39:17 INFO - 'USER': 'cltbld', 11:39:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:17 INFO - '_': '/tools/buildbot/bin/python'} 11:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:17 INFO - Downloading/unpacking blobuploader==1.2.4 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:19 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39:19 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 11:39:19 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 11:39:19 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 11:39:19 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 11:39:19 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 11:39:19 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 11:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:39:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39:20 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 11:39:20 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 11:39:20 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 11:39:20 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 11:39:20 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 11:39:20 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 11:39:20 INFO - Downloading docopt-0.6.1.tar.gz 11:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:20 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:20 INFO - Running setup.py install for blobuploader 11:39:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:39:20 INFO - Running setup.py install for requests 11:39:20 INFO - Running setup.py install for docopt 11:39:20 INFO - Successfully installed blobuploader requests docopt 11:39:20 INFO - Cleaning up... 11:39:21 INFO - Return code: 0 11:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:21 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')]} 11:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:21 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')]} 11:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:21 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:21 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 11:39:21 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 11:39:21 INFO - Using env: {'DISPLAY': ':0', 11:39:21 INFO - 'HOME': '/home/cltbld', 11:39:21 INFO - 'LANG': 'en_US.UTF-8', 11:39:21 INFO - 'LANGUAGE': 'en_US:en', 11:39:21 INFO - 'LOGNAME': 'cltbld', 11:39:21 INFO - 'MAIL': '/var/mail/cltbld', 11:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:21 INFO - 'MOZ_NO_REMOTE': '1', 11:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:21 INFO - 'NO_EM_RESTART': '1', 11:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:21 INFO - 'PWD': '/builds/slave/test', 11:39:21 INFO - 'SHELL': '/bin/bash', 11:39:21 INFO - 'SHLVL': '1', 11:39:21 INFO - 'TERM': 'linux', 11:39:21 INFO - 'TMOUT': '86400', 11:39:21 INFO - 'USER': 'cltbld', 11:39:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:21 INFO - '_': '/tools/buildbot/bin/python'} 11:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:21 INFO - Running setup.py (path:/tmp/pip-vbYete-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:21 INFO - Running setup.py (path:/tmp/pip-IcJrqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:21 INFO - Running setup.py (path:/tmp/pip-SWn50c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:21 INFO - Running setup.py (path:/tmp/pip-Tk8VS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:21 INFO - Running setup.py (path:/tmp/pip-8LN7EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:21 INFO - Running setup.py (path:/tmp/pip-irXmlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:21 INFO - Running setup.py (path:/tmp/pip-zuZ_vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:21 INFO - Running setup.py (path:/tmp/pip-yn5HDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:21 INFO - Running setup.py (path:/tmp/pip-exbJMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:21 INFO - Running setup.py (path:/tmp/pip-NXoJfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:21 INFO - Running setup.py (path:/tmp/pip-3gs0h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:22 INFO - Running setup.py (path:/tmp/pip-StzpgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:22 INFO - Running setup.py (path:/tmp/pip-hTAqqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:22 INFO - Running setup.py (path:/tmp/pip-o5Vja1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:22 INFO - Running setup.py (path:/tmp/pip-zFSsb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:22 INFO - Running setup.py (path:/tmp/pip-9YPsnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:22 INFO - Running setup.py (path:/tmp/pip-OJUzrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:39:22 INFO - Running setup.py install for manifestparser 11:39:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:39:22 INFO - Running setup.py install for mozcrash 11:39:22 INFO - Running setup.py install for mozdebug 11:39:22 INFO - Running setup.py install for mozdevice 11:39:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:39:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:39:22 INFO - Running setup.py install for mozfile 11:39:23 INFO - Running setup.py install for mozhttpd 11:39:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Running setup.py install for mozinfo 11:39:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Running setup.py install for mozInstall 11:39:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Running setup.py install for mozleak 11:39:23 INFO - Running setup.py install for mozlog 11:39:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Running setup.py install for moznetwork 11:39:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Running setup.py install for mozprocess 11:39:23 INFO - Running setup.py install for mozprofile 11:39:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Running setup.py install for mozrunner 11:39:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:39:23 INFO - Running setup.py install for mozscreenshot 11:39:24 INFO - Running setup.py install for moztest 11:39:24 INFO - Running setup.py install for mozversion 11:39:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:24 INFO - Cleaning up... 11:39:24 INFO - Return code: 0 11:39:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:24 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:24 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 11:39:24 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 11:39:24 INFO - Using env: {'DISPLAY': ':0', 11:39:24 INFO - 'HOME': '/home/cltbld', 11:39:24 INFO - 'LANG': 'en_US.UTF-8', 11:39:24 INFO - 'LANGUAGE': 'en_US:en', 11:39:24 INFO - 'LOGNAME': 'cltbld', 11:39:24 INFO - 'MAIL': '/var/mail/cltbld', 11:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:24 INFO - 'MOZ_NO_REMOTE': '1', 11:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:24 INFO - 'NO_EM_RESTART': '1', 11:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:24 INFO - 'PWD': '/builds/slave/test', 11:39:24 INFO - 'SHELL': '/bin/bash', 11:39:24 INFO - 'SHLVL': '1', 11:39:24 INFO - 'TERM': 'linux', 11:39:24 INFO - 'TMOUT': '86400', 11:39:24 INFO - 'USER': 'cltbld', 11:39:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:24 INFO - '_': '/tools/buildbot/bin/python'} 11:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:24 INFO - Running setup.py (path:/tmp/pip-ZiWDCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:24 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)) 11:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:24 INFO - Running setup.py (path:/tmp/pip-Qfz2ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:24 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)) 11:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:24 INFO - Running setup.py (path:/tmp/pip-WfQ1Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:24 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)) 11:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:24 INFO - Running setup.py (path:/tmp/pip-BrflHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:24 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)) 11:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:24 INFO - Running setup.py (path:/tmp/pip-pzvUWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:24 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)) 11:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:24 INFO - Running setup.py (path:/tmp/pip-U2APcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:24 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)) 11:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:24 INFO - Running setup.py (path:/tmp/pip-H6AyIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:25 INFO - Running setup.py (path:/tmp/pip-R0pniL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:25 INFO - Running setup.py (path:/tmp/pip-DgdIvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:25 INFO - Running setup.py (path:/tmp/pip-mK8KYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:25 INFO - Running setup.py (path:/tmp/pip-xJjyg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:25 INFO - Running setup.py (path:/tmp/pip-4k7FFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:25 INFO - Running setup.py (path:/tmp/pip-AcYkjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:25 INFO - Running setup.py (path:/tmp/pip-Nspxyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:25 INFO - Running setup.py (path:/tmp/pip-1SDsmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:25 INFO - Running setup.py (path:/tmp/pip-uPfVzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:25 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)) 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:25 INFO - Running setup.py (path:/tmp/pip-cWCm8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:25 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)) 11:39:25 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)) 11:39:25 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)) 11:39:25 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)) 11:39:25 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)) 11:39:25 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)) 11:39:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:25 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 11:39:25 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 11:39:25 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 11:39:25 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 11:39:25 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 11:39:25 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 11:39:27 INFO - Downloading blessings-1.6.tar.gz 11:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:27 INFO - Installing collected packages: blessings 11:39:27 INFO - Running setup.py install for blessings 11:39:27 INFO - Successfully installed blessings 11:39:27 INFO - Cleaning up... 11:39:27 INFO - Return code: 0 11:39:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:39:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:28 INFO - Reading from file tmpfile_stdout 11:39:28 INFO - Current package versions: 11:39:28 INFO - argparse == 1.2.1 11:39:28 INFO - blessings == 1.6 11:39:28 INFO - blobuploader == 1.2.4 11:39:28 INFO - docopt == 0.6.1 11:39:28 INFO - functools32 == 3.2.3-2 11:39:28 INFO - jsonschema == 2.5.1 11:39:28 INFO - manifestparser == 1.1 11:39:28 INFO - mozInstall == 1.12 11:39:28 INFO - mozcrash == 0.17 11:39:28 INFO - mozdebug == 0.1 11:39:28 INFO - mozdevice == 0.48 11:39:28 INFO - mozfile == 1.2 11:39:28 INFO - mozhttpd == 0.7 11:39:28 INFO - mozinfo == 0.9 11:39:28 INFO - mozleak == 0.1 11:39:28 INFO - mozlog == 3.2 11:39:28 INFO - moznetwork == 0.27 11:39:28 INFO - mozprocess == 0.22 11:39:28 INFO - mozprofile == 0.28 11:39:28 INFO - mozrunner == 6.11 11:39:28 INFO - mozscreenshot == 0.1 11:39:28 INFO - mozsystemmonitor == 0.3 11:39:28 INFO - moztest == 0.7 11:39:28 INFO - mozversion == 1.4 11:39:28 INFO - psutil == 3.1.1 11:39:28 INFO - requests == 1.2.3 11:39:28 INFO - wsgiref == 0.1.2 11:39:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:28 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')]} 11:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:28 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')]} 11:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:28 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:28 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 11:39:28 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 11:39:28 INFO - Using env: {'DISPLAY': ':0', 11:39:28 INFO - 'HOME': '/home/cltbld', 11:39:28 INFO - 'LANG': 'en_US.UTF-8', 11:39:28 INFO - 'LANGUAGE': 'en_US:en', 11:39:28 INFO - 'LOGNAME': 'cltbld', 11:39:28 INFO - 'MAIL': '/var/mail/cltbld', 11:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:28 INFO - 'MOZ_NO_REMOTE': '1', 11:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:28 INFO - 'NO_EM_RESTART': '1', 11:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:28 INFO - 'PWD': '/builds/slave/test', 11:39:28 INFO - 'SHELL': '/bin/bash', 11:39:28 INFO - 'SHLVL': '1', 11:39:28 INFO - 'TERM': 'linux', 11:39:28 INFO - 'TMOUT': '86400', 11:39:28 INFO - 'USER': 'cltbld', 11:39:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:28 INFO - '_': '/tools/buildbot/bin/python'} 11:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 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)) 11:39:28 INFO - Cleaning up... 11:39:28 INFO - Return code: 0 11:39:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:39:28 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')]} 11:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:28 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')]} 11:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:28 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:28 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 11:39:28 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 11:39:28 INFO - Using env: {'DISPLAY': ':0', 11:39:28 INFO - 'HOME': '/home/cltbld', 11:39:28 INFO - 'LANG': 'en_US.UTF-8', 11:39:28 INFO - 'LANGUAGE': 'en_US:en', 11:39:28 INFO - 'LOGNAME': 'cltbld', 11:39:28 INFO - 'MAIL': '/var/mail/cltbld', 11:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:28 INFO - 'MOZ_NO_REMOTE': '1', 11:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:28 INFO - 'NO_EM_RESTART': '1', 11:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:28 INFO - 'PWD': '/builds/slave/test', 11:39:28 INFO - 'SHELL': '/bin/bash', 11:39:28 INFO - 'SHLVL': '1', 11:39:28 INFO - 'TERM': 'linux', 11:39:28 INFO - 'TMOUT': '86400', 11:39:28 INFO - 'USER': 'cltbld', 11:39:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:28 INFO - '_': '/tools/buildbot/bin/python'} 11:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:39:28 INFO - Cleaning up... 11:39:28 INFO - Return code: 0 11:39:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:39:28 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')]} 11:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:28 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')]} 11:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:28 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 0x7f19fb244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', '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 11:39:28 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 11:39:28 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 11:39:28 INFO - Using env: {'DISPLAY': ':0', 11:39:28 INFO - 'HOME': '/home/cltbld', 11:39:28 INFO - 'LANG': 'en_US.UTF-8', 11:39:28 INFO - 'LANGUAGE': 'en_US:en', 11:39:28 INFO - 'LOGNAME': 'cltbld', 11:39:28 INFO - 'MAIL': '/var/mail/cltbld', 11:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:28 INFO - 'MOZ_NO_REMOTE': '1', 11:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:28 INFO - 'NO_EM_RESTART': '1', 11:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:28 INFO - 'PWD': '/builds/slave/test', 11:39:28 INFO - 'SHELL': '/bin/bash', 11:39:28 INFO - 'SHLVL': '1', 11:39:28 INFO - 'TERM': 'linux', 11:39:28 INFO - 'TMOUT': '86400', 11:39:28 INFO - 'USER': 'cltbld', 11:39:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:28 INFO - '_': '/tools/buildbot/bin/python'} 11:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:28 INFO - Downloading/unpacking flake8 11:39:28 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 11:39:28 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 11:39:28 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 11:39:28 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 11:39:28 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 11:39:28 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 11:39:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:39:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:39:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:39:31 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 11:39:31 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 11:39:31 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 11:39:31 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 11:39:31 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 11:39:31 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 11:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:39:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:39:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:39:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:39:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:39:31 INFO - no previously-included directories found matching 'docs/_build' 11:39:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:39:31 INFO - Running setup.py install for pep8 11:39:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:39:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:39:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:39:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:39:31 INFO - no previously-included directories found matching 'docs/_build' 11:39:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:39:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:39:31 INFO - Cleaning up... 11:39:31 INFO - Return code: 0 11:39:31 INFO - Running post-action listener: _resource_record_post_action 11:39:31 INFO - Running post-action listener: _start_resource_monitoring 11:39:31 INFO - Starting resource monitoring. 11:39:31 INFO - ##### 11:39:31 INFO - ##### Finished create-virtualenv step (success) 11:39:31 INFO - ##### 11:39:31 INFO - ##### 11:39:31 INFO - ##### Running install step. 11:39:31 INFO - ##### 11:39:31 INFO - Running pre-action listener: _resource_record_pre_action 11:39:31 INFO - Running main action method: install 11:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:31 INFO - Reading from file tmpfile_stdout 11:39:31 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:39:31 INFO - Reading from file tmpfile_stdout 11:39:31 INFO - Output received: 11:39:31 INFO - Usage: mozinstall [options] installer 11:39:31 INFO - Options: 11:39:31 INFO - -h, --help show this help message and exit 11:39:31 INFO - -d DEST, --destination=DEST 11:39:31 INFO - Directory to install application into. [default: 11:39:31 INFO - "/builds/slave/test"] 11:39:31 INFO - --app=APP Application being installed. [default: firefox] 11:39:31 INFO - mkdir: /builds/slave/test/build/application 11:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:39:48 INFO - Reading from file tmpfile_stdout 11:39:48 INFO - Output received: 11:39:48 INFO - /builds/slave/test/build/application/firefox/firefox 11:39:49 INFO - Running post-action listener: _resource_record_post_action 11:39:49 INFO - ##### 11:39:49 INFO - ##### Finished install step (success) 11:39:49 INFO - ##### 11:39:49 INFO - ##### 11:39:49 INFO - ##### Running run-tests step. 11:39:49 INFO - ##### 11:39:49 INFO - Running pre-action listener: _resource_record_pre_action 11:39:49 INFO - Running main action method: run_tests 11:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:39:49 INFO - Python 2.7.3 11:39:49 INFO - Return code: 0 11:39:49 INFO - grabbing minidump binary from tooltool 11:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:49 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 0x22fb570>, '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 0x2268610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268ac0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:39:49 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 11:39:49 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 11:39:49 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 11:39:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:49 INFO - Return code: 0 11:39:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:39:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:39:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:39:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:39:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:39:49 INFO - Return code: 0 11:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 11:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 11:39:50 INFO - Using env: {'DISPLAY': ':0', 11:39:50 INFO - 'HOME': '/home/cltbld', 11:39:50 INFO - 'LANG': 'en_US.UTF-8', 11:39:50 INFO - 'LANGUAGE': 'en_US:en', 11:39:50 INFO - 'LOGNAME': 'cltbld', 11:39:50 INFO - 'MAIL': '/var/mail/cltbld', 11:39:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:50 INFO - 'MOZ_NO_REMOTE': '1', 11:39:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:50 INFO - 'NO_EM_RESTART': '1', 11:39:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:50 INFO - 'PWD': '/builds/slave/test', 11:39:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:50 INFO - 'SHELL': '/bin/bash', 11:39:50 INFO - 'SHLVL': '1', 11:39:50 INFO - 'TERM': 'linux', 11:39:50 INFO - 'TMOUT': '86400', 11:39:50 INFO - 'USER': 'cltbld', 11:39:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724', 11:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:50 INFO - '_': '/tools/buildbot/bin/python'} 11:39:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 11:39:50 INFO - mozversion application_buildid: 20160626030213 11:39:50 INFO - mozversion application_changeset: c2da34d96746288b5fee27bf6542a12c9f410988 11:39:50 INFO - mozversion application_display_name: Nightly 11:39:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:50 INFO - mozversion application_name: Firefox 11:39:50 INFO - mozversion application_remotingname: firefox 11:39:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:39:50 INFO - mozversion application_vendor: Mozilla 11:39:50 INFO - mozversion application_version: 50.0a1 11:39:50 INFO - mozversion platform_buildid: 20160626030213 11:39:50 INFO - mozversion platform_changeset: c2da34d96746288b5fee27bf6542a12c9f410988 11:39:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:39:50 INFO - mozversion platform_version: 50.0a1 11:39:50 INFO - using testdate: 1466966390 11:39:50 INFO - actual date: 1466966390 11:39:50 INFO - starting webserver on 'localhost:48178' 11:39:50 INFO - SUITE-START | Running 2 tests 11:39:50 INFO - TEST-START | dromaeo_css 11:39:50 INFO - operating with platform_type : linux_ 11:39:50 INFO - Initialising browser for dromaeo_css test... 11:39:50 INFO - TEST-INFO | started process 4212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkjuEXT/profile http://localhost:48178/getInfo.html) 11:39:55 INFO - PROCESS | 4212 | __metrics Screen width/height:1600/1200 11:39:55 INFO - PROCESS | 4212 | colorDepth:24 11:39:55 INFO - PROCESS | 4212 | Browser inner width/height: 1024/697 11:39:55 INFO - PROCESS | 4212 | __metrics 11:39:56 ERROR - PROCESS | 4212 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:39:57 INFO - TEST-INFO | 4212: exit 0 11:39:57 INFO - Browser initialized. 11:39:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:39:57 INFO - TEST-INFO | started process 4332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkjuEXT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:09 INFO - PROCESS | 4332 | RSS: Main: 184954880 11:40:09 INFO - PROCESS | 4332 | 11:40:58 INFO - PROCESS | 4332 | 1466966458814 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] 11:43:06 INFO - PROCESS | 4332 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48178/tests/dromaeo/cssquery-ext.html) 11:43:08 INFO - PROCESS | 4332 | RSS: Main: 188366848 11:43:08 INFO - PROCESS | 4332 | 11:46:10 INFO - PROCESS | 4332 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-ext.html (next: http://localhost:48178/tests/dromaeo/cssquery-jquery.html) 11:46:10 INFO - PROCESS | 4332 | RSS: Main: 187834368 11:46:10 INFO - PROCESS | 4332 | 11:49:12 INFO - PROCESS | 4332 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48178/tests/dromaeo/cssquery-mootools.html) 11:49:13 INFO - PROCESS | 4332 | RSS: Main: 188997632 11:49:13 INFO - PROCESS | 4332 | 11:52:14 INFO - PROCESS | 4332 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48178/tests/dromaeo/cssquery-prototype.html) 11:52:15 INFO - PROCESS | 4332 | RSS: Main: 186445824 11:52:15 INFO - PROCESS | 4332 | 11:55:17 INFO - PROCESS | 4332 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48178/tests/dromaeo/cssquery-yui.html) 11:55:18 INFO - PROCESS | 4332 | RSS: Main: 189128704 11:55:18 INFO - PROCESS | 4332 | 11:58:20 INFO - PROCESS | 4332 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-yui.html (next: http://localhost:48178/tests/dromaeo/cssquery-dojo.html) 11:58:21 INFO - PROCESS | 4332 | RSS: Main: 189652992 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - PROCESS | 4332 | __start_tp_report 11:58:21 INFO - PROCESS | 4332 | _x_x_mozilla_page_load 11:58:21 INFO - PROCESS | 4332 | _x_x_mozilla_page_load_details 11:58:21 INFO - PROCESS | 4332 | |i|pagename|runs| 11:58:21 INFO - PROCESS | 4332 | |0;dojo.html;3087.66035736069;3139.5447660089303;3171.0169847347315;3172.492401215806;3177.793443426177;5385.730713464326;5443.727813609318;5448.891022179554;5504.119340905456;5531.806386776464;5306.336707911511;5415.431379705134;5451.672899626015;5468.125099984003;5482;4849.927251091228;4936.580390666798;5041.747912604374;5042.142835717937;5079.923801142986;740.5049724259337;4935.7532123393685;5013.147764879961;5025.748712564357;5055.545000949914;4923.18767403378;4946.802127914879;4948.604111671076;4960.553550180483;5005.524475174852;4878.585320247783;4959.132151873444;4971.502849715036;4987.102321582114;5024.145895197825;4781.880452988703;4824.445188803297;4829.879253018667;4835.226363781813;4870.6103511718975;5310.840674779763;5396.64921780083;5407.702576358338;5418.566514678816;5425.538829199523;5686.5735069869925;5767.1637612546365;5773.624714393593;5794.536437085023;5795.362510123883;5807.390224026501;5858.443447872445;5861.853453663693;5866.6186697864505;5912;5446.91829622552;5459.863503412406;5460.481254280837;5478.671279723229;5506.587005974568;5759.65442073477;5787.131930210502;5835.562332825055;5857.531397488191;5940.732667029907;5655.293088363955;5658.603897727119;5670.5747068969995;5675.432456754292;5677.403872593318;5746.080627099644;5750.6837123958585;5765.481106700333;5793.159991801165;5804.82585522435;5597.188407680945;5682.659040457585;5696.686682232434;5737.08206686928;5784.132380143013;5687.232223649837;5692.743826527816;5738.741756620962;5790.957627626984;5791.913121303184;4428.535003824616;4428.977855110704;4429.468463784367;4433.7118087324225;4479.776011199427;3854.2484215577692;3901.726879118491;3917.882463526099;3963.02905788078;3968.4840970674204;5418.160185171305;5445.264889239902;5450.91823622646;5484.808031718871;5508.669479831223;5616.438356164351;5801.158831969341;5816.069428891357;5841.912371314434;5847.590668653153;5450.31871016123;5459.808906688247;5472.425395333512;5493.807716729895;5499.725013749377;5043.823466178666;5046.066477701637;5056.443791182967;5069.340985671913;5131.923021154686;5828.154917537018;5912.201852749909;6061.787837425757;6062.878742425215;6063.272407311063;5759.568032397587;5804.970975145097;5814.94185058144;5815.476607105381;5816.447437493432;5974.581779275582;5980.461758441761;6015.518758499222;6022.789202377896;6028.849278767891;5539.975104605661;5599.32808063035;5630;5706.629069110494;5711.971440142939;5754.108113242454;5775.9133612995;5777.826665200051;5797;5837.153612726046;5612.579056570855;5621.55027597783;5627.184058311604;5633.352164501135;5641.097424412074;5509.559235261249;5539.667619942817;5643.238162847963;5682.9147562785765;5710.086386178192;5311.336082989626;5511.779528818963;5518.144687573433;5527.723613819373;5582.804601838916;5610.242617246619;5757.3379061406795;5764.164196191613;5775.758211984444;5778.595498315078;5497.8075767347955;5576.553875690016;5626.465485778845;5643.294588176478;5662.518685911579 11:58:21 INFO - PROCESS | 4332 | |1;ext.html;565.4063233604714;611.9112728654345;627.858731785348;629.5026928726306;635.8601107756292;41108.79445602772;43025.98818082736;43266.78366608167;43341.34987975175;46781;43522.129557408836;44031.11937761243;44102.117957640905;44118.11763764723;44282;8935.597898094586;9095.590698418588;9105.043970383114;9109.225715814164;9121.817563648756;8913.955430222839;9026.323025773061;9039.909600904006;9044.276457883387;9083.591238394256;9031.729048128534;9044.819103617923;9069.637214511444;9086.091390860927;9098.636054557843;9070.77323066922;9077.409968352102;9108.59011344491;9132.999999999967;9134.862977055349;8762.430442021312;8830.514321712304;8858.202761751474;8868.8669669955;8878.778030549223;40654.79672601647;40847.183056339;41000.79499602513;41153.58846411527;41188.38217426741;3567.7680950738118;3595.8921232363073;3628.0567052566257;3664.72514561409;3693.409054551286;32404.18989525257;32422;32802.343953121046;32863.342733145204;33925.15187120317;4010.2380547696134;4123.154753275571;4285.914281714379;4297.505786834523;4394.055278115221;345521;346289;348379.99999999744;348459;349547;34026.149346266044;60888;61721.38278617156;61827;61854;34682.47976280358;36176.81911590478;36475.452868207;36576.63423365785;36784.08039798973;14827.40690372373;14984.925075374771;15021.399144034334;15036.699266014619;15037.699246015018;12515.12394132402;12523.499060037679;12577.685557861127;12602.873971260353;12605.747885042249;8345.165483451729;8387.790305242295;8419.873701894476;8490.320774338039;8508.532030738368;3215.4083728554047;3220.8872689456225;3251.902442926716;3311.65227651098;3329.766916315835;985.9654912078042;1058.2380685906135;1066.226985435553;1069.994650026745;1098.8461615373853;32069.35861282808;32217.677823221937;32606.184845379055;32627.836860815543;32870.835645822095;1088.9782204355868;1124.2299025167622;1162.5698491558178;1165.8018136916576;1181.7400171962154;16551.91724041396;17193;17218.655626887394;17361.218745156497;17430.47708568745;606430;608027;608133.9186608166;609052;614309;58742.706286468296;59419.70290148608;59537.70231148817;59682;59870;1343.6909510812372;1345.818314527546;1357.307773035739;1358.7078778062566;1365.8312714502458;30223.546646799874;30705.53941690921;31520.527192092595;31788.364232715678;32158.356832862744;51427.74286128546;51953;51999.74000129975;52178.739106305744;52229;451093;461115;463378;464515;464840;26233;26294.4741105173;26492.205233843015;26637.200883973514;28834.855825720737;47708.76145619388;49079.75460122676;49385.259221110995;50324.24513632225;50333.49666503288;41171.7941410291;42381.94045148896;42622.57377426186;43286.350704740085;43368.56631433772;41060.58939410687;42681.57318426776;42920.35619465648;43138;43690.78154609207;35145.64854351424;39577.406338904366;40106.59893401029;40730.79634601808;41117.79441102895;34706.47940280847;36628.45057324089;37098.25803483861;37392.25215495729;37643.2471350566;28475.01012393669;28749.56875646909;28797;29020.709792902646;29183 11:58:21 INFO - PROCESS | 4332 | |2;jquery.html;390.6698839480638;393.3548979673336;397.5249576755777;401.6927050806132;410.710449133361;17878.731819022723;19498.317558885443;19538.609227815436;19818.801811981877;19834.801651983475;17699;17851.553711157227;17955.551111222227;19221.32725354613;19242.51893702658;5706.429357064302;5793.913091303634;5872.7063646817705;5894.6168499047635;5912.645241285515;5668.178114173463;5742.971285143569;5794.797182098628;5802.12968054791;5831.446012628793;5658.179563963223;5733.426657334275;5775.364709881931;5838.241028666289;5839.708014599274;5740.483356497914;5750.856228594298;5766;5767;5803.419658034205;4812.951870481285;5042.4201216860165;5060.1903695408555;5168.405633352175;5178.042062218502;12850.228986260854;13073.561908190091;13093.47626094955;13096.934515327363;13177.736445271137;2123.7770034146347;2214.76744941782;2449.2774631483753;2652.005497938273;2788.3308006078596;9579.952100239454;9902.603895844157;9961.203103751683;10055.949720251425;10231.181505479544;1834.1012903677235;1919.7984211657715;1927.9421617351502;1974.7334109895123;1995.0523501336893;77162.61418692926;83066;83303;83337;84346;10214.387136771817;10425.687229383131;10963.451827408599;11111.277766945122;11122.61070862516;15186.924065379602;15230.46693365727;15230.923845380703;15242.618934526725;15306.617334566725;7611.1627720950655;7770.844583108306;7903.407244456574;8039.276465118168;8041;7314.670839812221;7347.7795666130105;7368.784150615195;7488.588127653032;7635.847283054308;4652.371929789503;4706.670533062653;4720.433547974197;4781.402324709411;4807.711537307773;1936.951576210606;2040.734704488407;2063.7007633893;2078.958420831605;2090.153487837428;924.9537523123817;988.906053924876;1027.9640212592524;1071.4428497181577;1104.861892263467;19096.427107186806;19268.807311926983;19597;19645.607087858163;19699.803001970082;965.4689920543673;998.5406712912142;999.6401295533602;1004.8392257238806;1006.1950439648399;10839.458027098613;10863.728406789893;10979.28634638746;10998.175136864607;11242;401781;425597;435554;436542;437837;48340;52472.475275247525;53127.734361327944;76564.23435765682;81987.5900620493;987.1461186074138;1018.8828284747201;1026.471367245869;1027.7071034755058;1030.2273295028879;17380.73928891093;17478.21348039316;17671.204795783964;17750.733738993666;17979.280828766703;29859;40780;41543;42470.575294246664;42971.78514107409;57531;59421.405785941584;59636.403635963085;59684;59982;8047.074586422402;8113.8377232456205;8141.755747327353;8164.7550573482895;8842.734717958472;12042.277463351877;12442.191257568229;12749;13164;13770.518031868836;11304.152188585724;11411;11667.941660291644;11677.591284305008;11898.167128300936;11143.052840508648;11153.665390038312;11391.430428478709;11514.596989105341;11961;11563.074954003492;11667.474963626488;11710.531578737096;11735.882641173479;11934.045276377696;8126.634301456331;8141.348692104499;8203.26170644621;8206.384521160817;9038.502882341534;10419.791604167722;11502.309861408343;11620.593279235187;11720.003799677123;11728.589499367481 11:58:21 INFO - PROCESS | 4332 | |3;mootools.html;1456.8178977627797;1460.3939365163455;1564.4993602047343;1701.3789966662173;1718.9054601996893;7976.601169941494;8560.785980350494;8691.56542172892;9168.449893006416;9172.128647778467;8758.912410875906;8875.68935087272;8999.82000359994;9055.683051093212;9057.320700947423;2290.65640153977;2319.7912187903084;2336.2290444153473;2336.4392545788974;2345.4839935214227;2300.8389412741117;2303.942401439969;2309.9653505197434;2337.567550003246;2338.9532209355802;2297.5290065536524;2307.2040146149634;2320.686707294519;2320.8491448055825;2323.2217207235594;2235.485838257202;2268.092762894839;2279.065583110933;2291.7593652666396;2299.218265789623;2282.3038973113194;2297.4830663100834;2304.9654255186188;2304.9884750576307;2308.307507747669;8944.821103577891;8985.326100542485;9041.412308199946;9076.364654474124;9086.727398178065;5193.246979187997;5299.894002119974;5302.522772950453;5305.257263983045;5309.548688361494;3308.239105005838;3328.567286252796;3373.780704254216;3424.945032980192;3530.5763308402898;1076.1982323169289;1103.9227254092136;1113.847168180937;1123.1856903744801;1140.7034171115486;12624.053196010243;12628.621141365682;12722;12729.299888506128;12739.68150796219;4671.416072990876;4719.702081927498;4810.807567697323;4813;4832;10650.201234907257;10672.786544269227;10737.570497180182;10763.623273185402;10771.56913723458;5302.09864323066;5325.9733701332025;5352.277442545206;5360.973195133999;5374.6506477078865;4220.894477638084;4794.424669039738;4842.104210721028;4954.702717836942;4977.676451030671;4069.918601627951;4100.712950093465;4119.752814831119;4123.5063721494225;4130.235906357333;1268.9175203611735;1273.707047379108;1280.692633767889;1319.4128612767418;1327.283267035809;969.3166317745972;970.4613939263777;974.546835721393;975.7267964969819;989.5052473763119;5968.791092311748;5975.790847320323;6048.427408873725;6152.507799376039;6239.313675495692;456.5252137776675;460.728170379471;463.6568938985127;470.6164475952088;476.5758474957291;3883.436901649245;4024.8591299304385;4050.1292222171787;4077.592240775958;4080.3882466425594;10798.946005269923;11084.445777711244;11116.555337786398;11199.328040317607;11259.549618015351;10961.780764384826;11137.941895520074;11141.498632561554;11175;11182.378555109464;7906.7627971160955;8227;8246.793830154174;8416;8512.702055428153;5924.7926322578505;6181.81454556364;6203.379662033761;6247.406496382836;6348.365163483615;10143.949280253551;10303.330283531546;10355.17158627323;10382.42896640692;10635.680929572125;10645.574177033142;10672.146228301563;10781.191410644076;10791.082757965347;10802.621908233174;7938.126806051445;7981.561014144278;8201.630926608197;8277.337812974827;8291.378146638906;8540.70107546233;8580.742577722429;8601.182887625666;8805.339599529932;8863.113688631085;7456.254374562501;7532.096148462219;7697.730579429693;7715.1513333534385;7935.365170786438;7484.363829074372;7501.924980750341;7587.468877178544;7662.387009039375;7770.53376797394;7021.894671580033;7052.823679408056;7058.894116588152;7105.786826395217;7126.144862616519;5140.691558506502;5320;5395.919061214006;5418.431064738145;5433.538149257357;5253.658512196695;5300.761465733974;5389.461053894579;5408.405075441619;5417.1874218865905 11:58:21 INFO - PROCESS | 4332 | |4;prototype.html;327.4073926193589;327.8836013215309;330.48114460297336;332.0106083870067;332.16791936199814;5570.916436253455;5659.8585035374135;5679.545636349092;5684.516816070629;5710.800121995731;5561.610687251894;5567.661582135513;5577.107662773957;5581.441855814416;5617.41017193194;4125.422440858275;4150.066235097094;4290.678199135062;4325.567443255681;4342.848000319989;4315.8994456413575;4342.261815491358;4347.7826108694435;4352.39066530686;4353.891152721176;4313.654907607384;4336.8265269389185;4352.173087113454;4365.607095361417;4367.825286988516;4267.871963841089;4274.957250427503;4303.257180841764;4322.222000039991;4333.8699839004885;3778.1688028633657;3781.6785573226307;3799.9930018545106;3827.923441531154;3836.271108489378;5293.782430041074;5406.405295417501;5443.2107344434835;5445.039785677153;5456.781728730846;4842.15262329091;4984.651074424792;4991.600671946236;4996.875078123039;5016.423111342206;5836.57782020461;5840.853978650525;5861.4724674779045;5887.587868849182;5920;4218.704690671654;4224.260754368004;4241.787910604488;4248.936265956013;4258.446401967755;5792.855178620568;6081.817545473643;6104.755809767604;6117.327094019654;6135.141080248769;4063.167050754588;4080.3879418087527;4084.6528045116497;4089.1412803311637;4102.2410853992105;4168.291390463629;4171.853985110507;4177.811998460076;4183.1215444756335;4184.497860256789;4792.281157826354;4859.514048595112;4862.562369386772;4885.6335774817035;4912.410510738663;5968.761249550056;5985.281766187998;5994.430529099728;6004.42957918997;6011.3086994995265;1472.963175920589;1473.2633683158422;1476.402057166849;1479.9122644856022;1492.79847220626;862.7929296968682;866.2117473099576;866.3112825303898;869.9826003480022;907.5915837872983;4893.730844803499;4924.901501969941;4925.1873440881855;4992.525710057539;5015.598752099896;5294.655847369909;5345.599080069011;5349.518543331119;5385.8114965976;5390.137577987503;4745.928811067837;4959.752012399365;4992.850214493571;5002.89994200114;5021.924671129936;2888.2201805512395;2893.6816950135467;2896.391757730858;2901.5792710057344;2911.02050605586;5546.667199967934;5572.832815015556;5610.85972850682;5611.579131565149;5623.409541998031;5821.359650438449;6190.938090619126;6220.284667263322;6287.717052732638;6303.054541818764;6298.370162983665;6318.652474113968;6340.239171299474;6368.872622547523;6391.105245265667;6060.636361818305;6079.240094988127;6160.691965401802;6164.178209510133;6198.2252218472695;5959.970200148971;6055.515558755377;6065.2418447694035;6136.2636483622255;6146.385361463817;6130.356312587114;6196.189343553772;6262.307207900464;6264.373562643699;6276.74893004293;4152.065785198306;4162.812673429642;4183.686223533308;4194;4200.096979149497;5858.736356864037;5908.793192238251;6120.60216085953;6163.96918015407;6206.317305096526;5854.795082172103;5866.178734977021;5872.559558033079;5921.407859214044;5971.05940569308;5843.065109582446;5858.297004359504;5880.206172166874;5893;5908.3796201399955;5606.803761868315;5748.798792042258;5757.280339957505;5776.19133321327;5823.475887170006;5886.735096920735;5902.966980778432;5937.2578427696535;5949.732262048132;5968.820935371946;5588.77644894216;5712.942870571241;5793.9420605795085;5807.970960145172;5829.242198514166 11:58:21 INFO - PROCESS | 4332 | |5;yui.html;756.9016027916371;758.5221310574337;790.5217343507178;798.2297083314602;854.0562678240542;14857.40570377185;15998.120103394338;16064.678706425864;16094.919525402356;16273.267702953366;14443.927780361084;14601.561953141423;14643.19462429566;14702;14738.968272220949;670.5373292428221;781.1797612506845;789.4316092413453;795.2604078207265;798.6765360029198;798.6086817459432;798.9480683755567;800.8838718385831;802.1817745899208;804.2721337189853;866.4541338956449;866.7919699272193;867.1328671328671;869.4652788535037;869.7303835810919;857.8627419612832;861.2507118806647;861.3625916821507;861.5390765940223;862.4006315610653;620.4632992461488;622.3092367472102;625.0312016374601;625.1685258606088;626.1546911669255;14851.70296594062;14854.480093196686;14900;14931.776023359658;14980.1011939284;13660.521881734092;15001.774973375408;15325.23373831304;15334.846651533566;15375.692486150327;12996.675083122998;13525.458981640722;13558.525451609146;13605.659858503517;13611.591652250348;4548.727076375428;4559.407277053995;4566.383538222364;4571.337156112379;4595.494495605481;77353.22646773516;77940.99999999943;78312.21687783106;80579.59710201412;82032;10897.891021089847;11062.170337224741;11161.162912781574;11384.430778461045;11644.2431241969;20196.394108176777;20215.39353819388;20238.797612023987;20558.177672892918;21180.258690945742;8257.95871020653;8284.212999765012;8297.12880147588;8303.211194936472;8324.500529968222;4520.660950428665;4622.583967442879;4641.535846415331;4646.349511068385;4744.074905393415;3291.325278317939;3408.454647256427;3420.640832712529;3429.1941393772445;3437.1750779813165;588.9087191485327;596.5496050481945;620.798240571816;655.3381085104079;657.2934095846983;614.4347200575481;617.4319625944142;751.1962200445471;766.8351304469566;801.410962942237;9761.804763904682;9865.950670246602;10182.745431364276;10528.947355263175;11094.112471002461;710.4103594016954;770.6416516319938;777.8949841771401;792.8414317136596;805.2430715127762;4961.627877909171;5144.948550514522;5156.097682905476;5162.199859021857;5173.249878767558;123797;127424.36287818688;128341.3582932098;128368;132232;66564.6671766638;89083;109368.4531577337;109871.45064274628;113820;88645.11354886497;88766;88928.11071889199;91168.54415727878;91215.08784912065;9228.584713687766;9277.257819374568;9441.952790236004;9566.234701224024;9612;55582;55914.16128758153;56086;56631.71684141553;57747;64243.357566423736;65216;72176.27823721696;76229.27465672257;76789;12692.682682933;12927.612171634866;13080.542181023618;13116.737665246832;13524.932375338454;14101.365438555085;14402.135871847722;14536.055156414799;14601.73026571225;15417.84582154209;13959.860401396263;14126.223057731924;14226.502072427415;14474;15232.086074835544;14042.859571404564;14557.563273101823;14707.92646036763;14789.630259243606;15338.386464541294;14043.789343159657;14697.191654459108;15125.54623361301;15174.089554626758;15485.011283976555;11023.559057637605;11044.043809931238;11777.587784427504;11844.170908036354;11883.76232475363;10266.435346056038;10466.267361284637;10761.515731791931;10786.622468213574;11124.944375278395 11:58:21 INFO - PROCESS | 4332 | __end_tp_report 11:58:21 INFO - PROCESS | 4332 | __start_cc_report 11:58:21 INFO - PROCESS | 4332 | _x_x_mozilla_cycle_collect,336 11:58:21 INFO - PROCESS | 4332 | __end_cc_report 11:58:21 INFO - PROCESS | 4332 | __startTimestamp1466967501095__endTimestamp 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - PROCESS | 4332 | ------- Summary: start ------- 11:58:21 INFO - PROCESS | 4332 | Number of tests: 6 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - PROCESS | 4332 | [#0] dojo.html Cycles:165 Average:5350.82 Median:5576.55 stddev:700.40 (12.6%) stddev-sans-first:679.67 11:58:21 INFO - PROCESS | 4332 | Values: 3087.7 3139.5 3171.0 3172.5 3177.8 5385.7 5443.7 5448.9 5504.1 5531.8 5306.3 5415.4 5451.7 5468.1 5482.0 4849.9 4936.6 5041.7 5042.1 5079.9 740.5 4935.8 5013.1 5025.7 5055.5 4923.2 4946.8 4948.6 4960.6 5005.5 4878.6 4959.1 4971.5 4987.1 5024.1 4781.9 4824.4 4829.9 4835.2 4870.6 5310.8 5396.6 5407.7 5418.6 5425.5 5686.6 5767.2 5773.6 5794.5 5795.4 5807.4 5858.4 5861.9 5866.6 5912.0 5446.9 5459.9 5460.5 5478.7 5506.6 5759.7 5787.1 5835.6 5857.5 5940.7 5655.3 5658.6 5670.6 5675.4 5677.4 5746.1 5750.7 5765.5 5793.2 5804.8 5597.2 5682.7 5696.7 5737.1 5784.1 5687.2 5692.7 5738.7 5791.0 5791.9 4428.5 4429.0 4429.5 4433.7 4479.8 3854.2 3901.7 3917.9 3963.0 3968.5 5418.2 5445.3 5450.9 5484.8 5508.7 5616.4 5801.2 5816.1 5841.9 5847.6 5450.3 5459.8 5472.4 5493.8 5499.7 5043.8 5046.1 5056.4 5069.3 5131.9 5828.2 5912.2 6061.8 6062.9 6063.3 5759.6 5805.0 5814.9 5815.5 5816.4 5974.6 5980.5 6015.5 6022.8 6028.8 5540.0 5599.3 5630.0 5706.6 5712.0 5754.1 5775.9 5777.8 5797.0 5837.2 5612.6 5621.6 5627.2 5633.4 5641.1 5509.6 5539.7 5643.2 5682.9 5710.1 5311.3 5511.8 5518.1 5527.7 5582.8 5610.2 5757.3 5764.2 5775.8 5778.6 5497.8 5576.6 5626.5 5643.3 5662.5 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - PROCESS | 4332 | [#1] ext.html Cycles:180 Average:61846.63 Median:41135.69 stddev:129240.95 (314.2%) stddev-sans-first:129521.61 11:58:21 INFO - PROCESS | 4332 | Values: 565.4 611.9 627.9 629.5 635.9 41108.8 43026.0 43266.8 43341.3 46781.0 43522.1 44031.1 44102.1 44118.1 44282.0 8935.6 9095.6 9105.0 9109.2 9121.8 8914.0 9026.3 9039.9 9044.3 9083.6 9031.7 9044.8 9069.6 9086.1 9098.6 9070.8 9077.4 9108.6 9133.0 9134.9 8762.4 8830.5 8858.2 8868.9 8878.8 40654.8 40847.2 41000.8 41153.6 41188.4 3567.8 3595.9 3628.1 3664.7 3693.4 32404.2 32422.0 32802.3 32863.3 33925.2 4010.2 4123.2 4285.9 4297.5 4394.1 345521.0 346289.0 348380.0 348459.0 349547.0 34026.1 60888.0 61721.4 61827.0 61854.0 34682.5 36176.8 36475.5 36576.6 36784.1 14827.4 14984.9 15021.4 15036.7 15037.7 12515.1 12523.5 12577.7 12602.9 12605.7 8345.2 8387.8 8419.9 8490.3 8508.5 3215.4 3220.9 3251.9 3311.7 3329.8 986.0 1058.2 1066.2 1070.0 1098.8 32069.4 32217.7 32606.2 32627.8 32870.8 1089.0 1124.2 1162.6 1165.8 1181.7 16551.9 17193.0 17218.7 17361.2 17430.5 606430.0 608027.0 608133.9 609052.0 614309.0 58742.7 59419.7 59537.7 59682.0 59870.0 1343.7 1345.8 1357.3 1358.7 1365.8 30223.5 30705.5 31520.5 31788.4 32158.4 51427.7 51953.0 51999.7 52178.7 52229.0 451093.0 461115.0 463378.0 464515.0 464840.0 26233.0 26294.5 26492.2 26637.2 28834.9 47708.8 49079.8 49385.3 50324.2 50333.5 41171.8 42381.9 42622.6 43286.4 43368.6 41060.6 42681.6 42920.4 43138.0 43690.8 35145.6 39577.4 40106.6 40730.8 41117.8 34706.5 36628.5 37098.3 37392.3 37643.2 28475.0 28749.6 28797.0 29020.7 29183.0 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - PROCESS | 4332 | [#2] jquery.html Cycles:180 Average:26096.20 Median:16323.67 stddev:70443.97 (431.5%) stddev-sans-first:70615.14 11:58:21 INFO - PROCESS | 4332 | Values: 390.7 393.4 397.5 401.7 410.7 17878.7 19498.3 19538.6 19818.8 19834.8 17699.0 17851.6 17955.6 19221.3 19242.5 5706.4 5793.9 5872.7 5894.6 5912.6 5668.2 5743.0 5794.8 5802.1 5831.4 5658.2 5733.4 5775.4 5838.2 5839.7 5740.5 5750.9 5766.0 5767.0 5803.4 4813.0 5042.4 5060.2 5168.4 5178.0 12850.2 13073.6 13093.5 13096.9 13177.7 2123.8 2214.8 2449.3 2652.0 2788.3 9580.0 9902.6 9961.2 10055.9 10231.2 1834.1 1919.8 1927.9 1974.7 1995.1 77162.6 83066.0 83303.0 83337.0 84346.0 10214.4 10425.7 10963.5 11111.3 11122.6 15186.9 15230.5 15230.9 15242.6 15306.6 7611.2 7770.8 7903.4 8039.3 8041.0 7314.7 7347.8 7368.8 7488.6 7635.8 4652.4 4706.7 4720.4 4781.4 4807.7 1937.0 2040.7 2063.7 2079.0 2090.2 925.0 988.9 1028.0 1071.4 1104.9 19096.4 19268.8 19597.0 19645.6 19699.8 965.5 998.5 999.6 1004.8 1006.2 10839.5 10863.7 10979.3 10998.2 11242.0 401781.0 425597.0 435554.0 436542.0 437837.0 48340.0 52472.5 53127.7 76564.2 81987.6 987.1 1018.9 1026.5 1027.7 1030.2 17380.7 17478.2 17671.2 17750.7 17979.3 29859.0 40780.0 41543.0 42470.6 42971.8 57531.0 59421.4 59636.4 59684.0 59982.0 8047.1 8113.8 8141.8 8164.8 8842.7 12042.3 12442.2 12749.0 13164.0 13770.5 11304.2 11411.0 11667.9 11677.6 11898.2 11143.1 11153.7 11391.4 11514.6 11961.0 11563.1 11667.5 11710.5 11735.9 11934.0 8126.6 8141.3 8203.3 8206.4 9038.5 10419.8 11502.3 11620.6 11720.0 11728.6 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - PROCESS | 4332 | [#3] mootools.html Cycles:180 Average:5900.65 Median:2595.16 stddev:3418.10 (131.7%) stddev-sans-first:3411.37 11:58:21 INFO - PROCESS | 4332 | Values: 1456.8 1460.4 1564.5 1701.4 1718.9 7976.6 8560.8 8691.6 9168.4 9172.1 8758.9 8875.7 8999.8 9055.7 9057.3 2290.7 2319.8 2336.2 2336.4 2345.5 2300.8 2303.9 2310.0 2337.6 2339.0 2297.5 2307.2 2320.7 2320.8 2323.2 2235.5 2268.1 2279.1 2291.8 2299.2 2282.3 2297.5 2305.0 2305.0 2308.3 8944.8 8985.3 9041.4 9076.4 9086.7 5193.2 5299.9 5302.5 5305.3 5309.5 3308.2 3328.6 3373.8 3424.9 3530.6 1076.2 1103.9 1113.8 1123.2 1140.7 12624.1 12628.6 12722.0 12729.3 12739.7 4671.4 4719.7 4810.8 4813.0 4832.0 10650.2 10672.8 10737.6 10763.6 10771.6 5302.1 5326.0 5352.3 5361.0 5374.7 4220.9 4794.4 4842.1 4954.7 4977.7 4069.9 4100.7 4119.8 4123.5 4130.2 1268.9 1273.7 1280.7 1319.4 1327.3 969.3 970.5 974.5 975.7 989.5 5968.8 5975.8 6048.4 6152.5 6239.3 456.5 460.7 463.7 470.6 476.6 3883.4 4024.9 4050.1 4077.6 4080.4 10798.9 11084.4 11116.6 11199.3 11259.5 10961.8 11137.9 11141.5 11175.0 11182.4 7906.8 8227.0 8246.8 8416.0 8512.7 5924.8 6181.8 6203.4 6247.4 6348.4 10143.9 10303.3 10355.2 10382.4 10635.7 10645.6 10672.1 10781.2 10791.1 10802.6 7938.1 7981.6 8201.6 8277.3 8291.4 8540.7 8580.7 8601.2 8805.3 8863.1 7456.3 7532.1 7697.7 7715.2 7935.4 7484.4 7501.9 7587.5 7662.4 7770.5 7021.9 7052.8 7058.9 7105.8 7126.1 5140.7 5320.0 5395.9 5418.4 5433.5 5253.7 5300.8 5389.5 5408.4 5417.2 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - PROCESS | 4332 | [#4] prototype.html Cycles:180 Average:4853.18 Median:5554.14 stddev:1467.95 (26.4%) stddev-sans-first:1432.23 11:58:21 INFO - PROCESS | 4332 | Values: 327.4 327.9 330.5 332.0 332.2 5570.9 5659.9 5679.5 5684.5 5710.8 5561.6 5567.7 5577.1 5581.4 5617.4 4125.4 4150.1 4290.7 4325.6 4342.8 4315.9 4342.3 4347.8 4352.4 4353.9 4313.7 4336.8 4352.2 4365.6 4367.8 4267.9 4275.0 4303.3 4322.2 4333.9 3778.2 3781.7 3800.0 3827.9 3836.3 5293.8 5406.4 5443.2 5445.0 5456.8 4842.2 4984.7 4991.6 4996.9 5016.4 5836.6 5840.9 5861.5 5887.6 5920.0 4218.7 4224.3 4241.8 4248.9 4258.4 5792.9 6081.8 6104.8 6117.3 6135.1 4063.2 4080.4 4084.7 4089.1 4102.2 4168.3 4171.9 4177.8 4183.1 4184.5 4792.3 4859.5 4862.6 4885.6 4912.4 5968.8 5985.3 5994.4 6004.4 6011.3 1473.0 1473.3 1476.4 1479.9 1492.8 862.8 866.2 866.3 870.0 907.6 4893.7 4924.9 4925.2 4992.5 5015.6 5294.7 5345.6 5349.5 5385.8 5390.1 4745.9 4959.8 4992.9 5002.9 5021.9 2888.2 2893.7 2896.4 2901.6 2911.0 5546.7 5572.8 5610.9 5611.6 5623.4 5821.4 6190.9 6220.3 6287.7 6303.1 6298.4 6318.7 6340.2 6368.9 6391.1 6060.6 6079.2 6160.7 6164.2 6198.2 5960.0 6055.5 6065.2 6136.3 6146.4 6130.4 6196.2 6262.3 6264.4 6276.7 4152.1 4162.8 4183.7 4194.0 4200.1 5858.7 5908.8 6120.6 6164.0 6206.3 5854.8 5866.2 5872.6 5921.4 5971.1 5843.1 5858.3 5880.2 5893.0 5908.4 5606.8 5748.8 5757.3 5776.2 5823.5 5886.7 5903.0 5937.3 5949.7 5968.8 5588.8 5712.9 5793.9 5808.0 5829.2 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - PROCESS | 4332 | [#5] yui.html Cycles:180 Average:21499.86 Median:4583.42 stddev:31477.92 (686.8%) stddev-sans-first:31527.70 11:58:21 INFO - PROCESS | 4332 | Values: 756.9 758.5 790.5 798.2 854.1 14857.4 15998.1 16064.7 16094.9 16273.3 14443.9 14601.6 14643.2 14702.0 14739.0 670.5 781.2 789.4 795.3 798.7 798.6 798.9 800.9 802.2 804.3 866.5 866.8 867.1 869.5 869.7 857.9 861.3 861.4 861.5 862.4 620.5 622.3 625.0 625.2 626.2 14851.7 14854.5 14900.0 14931.8 14980.1 13660.5 15001.8 15325.2 15334.8 15375.7 12996.7 13525.5 13558.5 13605.7 13611.6 4548.7 4559.4 4566.4 4571.3 4595.5 77353.2 77941.0 78312.2 80579.6 82032.0 10897.9 11062.2 11161.2 11384.4 11644.2 20196.4 20215.4 20238.8 20558.2 21180.3 8258.0 8284.2 8297.1 8303.2 8324.5 4520.7 4622.6 4641.5 4646.3 4744.1 3291.3 3408.5 3420.6 3429.2 3437.2 588.9 596.5 620.8 655.3 657.3 614.4 617.4 751.2 766.8 801.4 9761.8 9866.0 10182.7 10528.9 11094.1 710.4 770.6 777.9 792.8 805.2 4961.6 5144.9 5156.1 5162.2 5173.2 123797.0 127424.4 128341.4 128368.0 132232.0 66564.7 89083.0 109368.5 109871.5 113820.0 88645.1 88766.0 88928.1 91168.5 91215.1 9228.6 9277.3 9442.0 9566.2 9612.0 55582.0 55914.2 56086.0 56631.7 57747.0 64243.4 65216.0 72176.3 76229.3 76789.0 12692.7 12927.6 13080.5 13116.7 13524.9 14101.4 14402.1 14536.1 14601.7 15417.8 13959.9 14126.2 14226.5 14474.0 15232.1 14042.9 14557.6 14707.9 14789.6 15338.4 14043.8 14697.2 15125.5 15174.1 15485.0 11023.6 11044.0 11777.6 11844.2 11883.8 10266.4 10466.3 10761.5 10786.6 11124.9 11:58:21 INFO - PROCESS | 4332 | -------- Summary: end -------- 11:58:21 INFO - PROCESS | 4332 | 11:58:21 INFO - TEST-INFO | 4332: exit 0 11:58:21 INFO - TEST-OK | dromaeo_css | took 1111684ms 11:58:21 INFO - TEST-START | kraken 11:58:21 INFO - operating with platform_type : linux_ 11:58:21 INFO - Initialising browser for kraken test... 11:58:21 INFO - TEST-INFO | started process 4571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuO_Gv5/profile http://localhost:48178/getInfo.html) 11:58:26 INFO - PROCESS | 4571 | __metrics Screen width/height:1600/1200 11:58:26 INFO - PROCESS | 4571 | colorDepth:24 11:58:26 INFO - PROCESS | 4571 | Browser inner width/height: 1024/697 11:58:26 INFO - PROCESS | 4571 | __metrics 11:58:27 ERROR - PROCESS | 4571 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:58:28 INFO - TEST-INFO | 4571: exit 0 11:58:28 INFO - Browser initialized. 11:58:28 INFO - Running cycle 1/1 for kraken test... 11:58:28 INFO - TEST-INFO | started process 4692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuO_Gv5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:40 INFO - PROCESS | 4692 | RSS: Main: 185417728 11:58:40 INFO - PROCESS | 4692 | 11:58:42 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48178/tests/kraken/driver.html?testName=audio-beat-detection) 11:58:43 INFO - PROCESS | 4692 | RSS: Main: 191127552 11:58:43 INFO - PROCESS | 4692 | 11:58:46 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48178/tests/kraken/driver.html?testName=audio-dft) 11:58:47 INFO - PROCESS | 4692 | RSS: Main: 190148608 11:58:47 INFO - PROCESS | 4692 | 11:58:49 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48178/tests/kraken/driver.html?testName=audio-fft) 11:58:50 INFO - PROCESS | 4692 | RSS: Main: 184582144 11:58:50 INFO - PROCESS | 4692 | 11:58:52 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48178/tests/kraken/driver.html?testName=audio-oscillator) 11:58:53 INFO - PROCESS | 4692 | RSS: Main: 185348096 11:58:53 INFO - PROCESS | 4692 | 11:58:55 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48178/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:58:56 INFO - PROCESS | 4692 | RSS: Main: 185937920 11:58:56 INFO - PROCESS | 4692 | 11:58:59 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48178/tests/kraken/driver.html?testName=imaging-darkroom) 11:58:59 INFO - PROCESS | 4692 | RSS: Main: 186388480 11:58:59 INFO - PROCESS | 4692 | 11:59:03 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48178/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:03 INFO - PROCESS | 4692 | RSS: Main: 184340480 11:59:03 INFO - PROCESS | 4692 | 11:59:06 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48178/tests/kraken/driver.html?testName=json-parse-financial) 11:59:07 INFO - PROCESS | 4692 | RSS: Main: 185184256 11:59:07 INFO - PROCESS | 4692 | 11:59:09 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48178/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:59:09 INFO - PROCESS | 4692 | RSS: Main: 185520128 11:59:09 INFO - PROCESS | 4692 | 11:59:11 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:59:12 INFO - PROCESS | 4692 | RSS: Main: 185733120 11:59:12 INFO - PROCESS | 4692 | 11:59:14 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:59:14 INFO - PROCESS | 4692 | RSS: Main: 185749504 11:59:14 INFO - PROCESS | 4692 | 11:59:17 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:59:18 INFO - PROCESS | 4692 | RSS: Main: 186568704 11:59:18 INFO - PROCESS | 4692 | 11:59:20 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:59:21 INFO - PROCESS | 4692 | RSS: Main: 186245120 11:59:21 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48178/tests/kraken/driver.html?testName=ai-astar) 11:59:23 INFO - PROCESS | 4692 | RSS: Main: 187260928 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | __start_tp_report 11:59:23 INFO - PROCESS | 4692 | _x_x_mozilla_page_load 11:59:23 INFO - PROCESS | 4692 | _x_x_mozilla_page_load_details 11:59:23 INFO - PROCESS | 4692 | |i|pagename|runs| 11:59:23 INFO - PROCESS | 4692 | |0;ai-astar;104;111;107;111;113;112;114;111;112;111 11:59:23 INFO - PROCESS | 4692 | |1;audio-beat-detection;156;133;162;181;132;165;171;136;179;136 11:59:23 INFO - PROCESS | 4692 | |2;audio-dft;163;164;164;166;175;166;164;164;162;163 11:59:23 INFO - PROCESS | 4692 | |3;audio-fft;76;74;77;173;77;77;78;75;169;77 11:59:23 INFO - PROCESS | 4692 | |4;audio-oscillator;85;85;139;88;87;86;136;86;85;153 11:59:23 INFO - PROCESS | 4692 | |5;imaging-gaussian-blur;117;118;118;118;118;118;118;117;117;117 11:59:23 INFO - PROCESS | 4692 | |6;imaging-darkroom;147;149;148;148;147;148;149;149;148;147 11:59:23 INFO - PROCESS | 4692 | |7;imaging-desaturate;96;97;95;95;96;96;95;98;100;98 11:59:23 INFO - PROCESS | 4692 | |8;json-parse-financial;56;55;54;55;53;56;55;56;53;55 11:59:23 INFO - PROCESS | 4692 | |9;json-stringify-tinderbox;62;62;63;63;62;62;63;62;62;63 11:59:23 INFO - PROCESS | 4692 | |10;stanford-crypto-aes;79;80;80;79;84;80;80;85;99;79 11:59:23 INFO - PROCESS | 4692 | |11;stanford-crypto-ccm;128;128;157;125;122;124;127;121;131;128 11:59:23 INFO - PROCESS | 4692 | |12;stanford-crypto-pbkdf2;168;160;160;163;161;165;165;160;165;160 11:59:23 INFO - PROCESS | 4692 | |13;stanford-crypto-sha256-iterative;65;65;69;65;62;64;63;63;64;66 11:59:23 INFO - PROCESS | 4692 | __end_tp_report 11:59:23 INFO - PROCESS | 4692 | __start_cc_report 11:59:23 INFO - PROCESS | 4692 | _x_x_mozilla_cycle_collect,904 11:59:23 INFO - PROCESS | 4692 | __end_cc_report 11:59:23 INFO - PROCESS | 4692 | __startTimestamp1466967563372__endTimestamp 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | ------- Summary: start ------- 11:59:23 INFO - PROCESS | 4692 | Number of tests: 14 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.95 (2.6%) stddev-sans-first:1.94 11:59:23 INFO - PROCESS | 4692 | Values: 104.0 111.0 107.0 111.0 113.0 112.0 114.0 111.0 112.0 111.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:163.50 stddev:19.42 (11.9%) stddev-sans-first:20.59 11:59:23 INFO - PROCESS | 4692 | Values: 156.0 133.0 162.0 181.0 132.0 165.0 171.0 136.0 179.0 136.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:3.70 (2.3%) stddev-sans-first:3.84 11:59:23 INFO - PROCESS | 4692 | Values: 163.0 164.0 164.0 166.0 175.0 166.0 164.0 164.0 162.0 163.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#3] audio-fft Cycles:10 Average:95.30 Median:77.00 stddev:39.93 (51.9%) stddev-sans-first:41.73 11:59:23 INFO - PROCESS | 4692 | Values: 76.0 74.0 77.0 173.0 77.0 77.0 78.0 75.0 169.0 77.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.50 stddev:27.72 (32.4%) stddev-sans-first:28.63 11:59:23 INFO - PROCESS | 4692 | Values: 85.0 85.0 139.0 88.0 87.0 86.0 136.0 86.0 85.0 153.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:59:23 INFO - PROCESS | 4692 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 11:59:23 INFO - PROCESS | 4692 | Values: 147.0 149.0 148.0 148.0 147.0 148.0 149.0 149.0 148.0 147.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.65 (1.7%) stddev-sans-first:1.73 11:59:23 INFO - PROCESS | 4692 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 95.0 98.0 100.0 98.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:1.12 11:59:23 INFO - PROCESS | 4692 | Values: 56.0 55.0 54.0 55.0 53.0 56.0 55.0 56.0 53.0 55.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 11:59:23 INFO - PROCESS | 4692 | Values: 62.0 62.0 63.0 63.0 62.0 62.0 63.0 62.0 62.0 63.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:80.00 stddev:6.17 (7.7%) stddev-sans-first:6.41 11:59:23 INFO - PROCESS | 4692 | Values: 79.0 80.0 80.0 79.0 84.0 80.0 80.0 85.0 99.0 79.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:128.00 stddev:10.27 (8.0%) stddev-sans-first:10.88 11:59:23 INFO - PROCESS | 4692 | Values: 128.0 128.0 157.0 125.0 122.0 124.0 127.0 121.0 131.0 128.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:164.00 stddev:2.91 (1.8%) stddev-sans-first:2.37 11:59:23 INFO - PROCESS | 4692 | Values: 168.0 160.0 160.0 163.0 161.0 165.0 165.0 160.0 165.0 160.0 11:59:23 INFO - PROCESS | 4692 | 11:59:23 INFO - PROCESS | 4692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.96 (3.0%) stddev-sans-first:2.07 11:59:23 INFO - PROCESS | 4692 | Values: 65.0 65.0 69.0 65.0 62.0 64.0 63.0 63.0 64.0 66.0 11:59:23 INFO - PROCESS | 4692 | -------- Summary: end -------- 11:59:23 INFO - PROCESS | 4692 | 11:59:24 INFO - TEST-INFO | 4692: exit 0 11:59:24 INFO - TEST-OK | kraken | took 62506ms 11:59:24 INFO - SUITE-END | took 1174s 11:59:24 INFO - Completed test suite (00:19:34) 11:59:24 INFO - javascript benchmark 11:59:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7212.997681284981, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.66035736069, 3139.5447660089303, 3171.0169847347315, 3172.492401215806, 3177.793443426177, 5385.730713464326, 5443.727813609318, 5448.891022179554, 5504.119340905456, 5531.806386776464, 5306.336707911511, 5415.431379705134, 5451.672899626015, 5468.125099984003, 5482.0, 4849.927251091228, 4936.580390666798, 5041.747912604374, 5042.142835717937, 5079.923801142986, 740.5049724259337, 4935.7532123393685, 5013.147764879961, 5025.748712564357, 5055.545000949914, 4923.18767403378, 4946.802127914879, 4948.604111671076, 4960.553550180483, 5005.524475174852, 4878.585320247783, 4959.132151873444, 4971.502849715036, 4987.102321582114, 5024.145895197825, 4781.880452988703, 4824.445188803297, 4829.879253018667, 4835.226363781813, 4870.6103511718975, 5310.840674779763, 5396.64921780083, 5407.702576358338, 5418.566514678816, 5425.538829199523, 5686.5735069869925, 5767.1637612546365, 5773.624714393593, 5794.536437085023, 5795.362510123883, 5807.390224026501, 5858.443447872445, 5861.853453663693, 5866.6186697864505, 5912.0, 5446.91829622552, 5459.863503412406, 5460.481254280837, 5478.671279723229, 5506.587005974568, 5759.65442073477, 5787.131930210502, 5835.562332825055, 5857.531397488191, 5940.732667029907, 5655.293088363955, 5658.603897727119, 5670.5747068969995, 5675.432456754292, 5677.403872593318, 5746.080627099644, 5750.6837123958585, 5765.481106700333, 5793.159991801165, 5804.82585522435, 5597.188407680945, 5682.659040457585, 5696.686682232434, 5737.08206686928, 5784.132380143013, 5687.232223649837, 5692.743826527816, 5738.741756620962, 5790.957627626984, 5791.913121303184, 4428.535003824616, 4428.977855110704, 4429.468463784367, 4433.7118087324225, 4479.776011199427, 3854.2484215577692, 3901.726879118491, 3917.882463526099, 3963.02905788078, 3968.4840970674204, 5418.160185171305, 5445.264889239902, 5450.91823622646, 5484.808031718871, 5508.669479831223, 5616.438356164351, 5801.158831969341, 5816.069428891357, 5841.912371314434, 5847.590668653153, 5450.31871016123, 5459.808906688247, 5472.425395333512, 5493.807716729895, 5499.725013749377, 5043.823466178666, 5046.066477701637, 5056.443791182967, 5069.340985671913, 5131.923021154686, 5828.154917537018, 5912.201852749909, 6061.787837425757, 6062.878742425215, 6063.272407311063, 5759.568032397587, 5804.970975145097, 5814.94185058144, 5815.476607105381, 5816.447437493432, 5974.581779275582, 5980.461758441761, 6015.518758499222, 6022.789202377896, 6028.849278767891, 5539.975104605661, 5599.32808063035, 5630.0, 5706.629069110494, 5711.971440142939, 5754.108113242454, 5775.9133612995, 5777.826665200051, 5797.0, 5837.153612726046, 5612.579056570855, 5621.55027597783, 5627.184058311604, 5633.352164501135, 5641.097424412074, 5509.559235261249, 5539.667619942817, 5643.238162847963, 5682.9147562785765, 5710.086386178192, 5311.336082989626, 5511.779528818963, 5518.144687573433, 5527.723613819373, 5582.804601838916, 5610.242617246619, 5757.3379061406795, 5764.164196191613, 5775.758211984444, 5778.595498315078, 5497.8075767347955, 5576.553875690016, 5626.465485778845, 5643.294588176478, 5662.518685911579], "value": 5306.4679970125935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4063233604714, 611.9112728654345, 627.858731785348, 629.5026928726306, 635.8601107756292, 41108.79445602772, 43025.98818082736, 43266.78366608167, 43341.34987975175, 46781.0, 43522.129557408836, 44031.11937761243, 44102.117957640905, 44118.11763764723, 44282.0, 8935.597898094586, 9095.590698418588, 9105.043970383114, 9109.225715814164, 9121.817563648756, 8913.955430222839, 9026.323025773061, 9039.909600904006, 9044.276457883387, 9083.591238394256, 9031.729048128534, 9044.819103617923, 9069.637214511444, 9086.091390860927, 9098.636054557843, 9070.77323066922, 9077.409968352102, 9108.59011344491, 9132.999999999967, 9134.862977055349, 8762.430442021312, 8830.514321712304, 8858.202761751474, 8868.8669669955, 8878.778030549223, 40654.79672601647, 40847.183056339, 41000.79499602513, 41153.58846411527, 41188.38217426741, 3567.7680950738118, 3595.8921232363073, 3628.0567052566257, 3664.72514561409, 3693.409054551286, 32404.18989525257, 32422.0, 32802.343953121046, 32863.342733145204, 33925.15187120317, 4010.2380547696134, 4123.154753275571, 4285.914281714379, 4297.505786834523, 4394.055278115221, 345521.0, 346289.0, 348379.99999999744, 348459.0, 349547.0, 34026.149346266044, 60888.0, 61721.38278617156, 61827.0, 61854.0, 34682.47976280358, 36176.81911590478, 36475.452868207, 36576.63423365785, 36784.08039798973, 14827.40690372373, 14984.925075374771, 15021.399144034334, 15036.699266014619, 15037.699246015018, 12515.12394132402, 12523.499060037679, 12577.685557861127, 12602.873971260353, 12605.747885042249, 8345.165483451729, 8387.790305242295, 8419.873701894476, 8490.320774338039, 8508.532030738368, 3215.4083728554047, 3220.8872689456225, 3251.902442926716, 3311.65227651098, 3329.766916315835, 985.9654912078042, 1058.2380685906135, 1066.226985435553, 1069.994650026745, 1098.8461615373853, 32069.35861282808, 32217.677823221937, 32606.184845379055, 32627.836860815543, 32870.835645822095, 1088.9782204355868, 1124.2299025167622, 1162.5698491558178, 1165.8018136916576, 1181.7400171962154, 16551.91724041396, 17193.0, 17218.655626887394, 17361.218745156497, 17430.47708568745, 606430.0, 608027.0, 608133.9186608166, 609052.0, 614309.0, 58742.706286468296, 59419.70290148608, 59537.70231148817, 59682.0, 59870.0, 1343.6909510812372, 1345.818314527546, 1357.307773035739, 1358.7078778062566, 1365.8312714502458, 30223.546646799874, 30705.53941690921, 31520.527192092595, 31788.364232715678, 32158.356832862744, 51427.74286128546, 51953.0, 51999.74000129975, 52178.739106305744, 52229.0, 451093.0, 461115.0, 463378.0, 464515.0, 464840.0, 26233.0, 26294.4741105173, 26492.205233843015, 26637.200883973514, 28834.855825720737, 47708.76145619388, 49079.75460122676, 49385.259221110995, 50324.24513632225, 50333.49666503288, 41171.7941410291, 42381.94045148896, 42622.57377426186, 43286.350704740085, 43368.56631433772, 41060.58939410687, 42681.57318426776, 42920.35619465648, 43138.0, 43690.78154609207, 35145.64854351424, 39577.406338904366, 40106.59893401029, 40730.79634601808, 41117.79441102895, 34706.47940280847, 36628.45057324089, 37098.25803483861, 37392.25215495729, 37643.2471350566, 28475.01012393669, 28749.56875646909, 28797.0, 29020.709792902646, 29183.0], "value": 19104.83144078935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.6698839480638, 393.3548979673336, 397.5249576755777, 401.6927050806132, 410.710449133361, 17878.731819022723, 19498.317558885443, 19538.609227815436, 19818.801811981877, 19834.801651983475, 17699.0, 17851.553711157227, 17955.551111222227, 19221.32725354613, 19242.51893702658, 5706.429357064302, 5793.913091303634, 5872.7063646817705, 5894.6168499047635, 5912.645241285515, 5668.178114173463, 5742.971285143569, 5794.797182098628, 5802.12968054791, 5831.446012628793, 5658.179563963223, 5733.426657334275, 5775.364709881931, 5838.241028666289, 5839.708014599274, 5740.483356497914, 5750.856228594298, 5766.0, 5767.0, 5803.419658034205, 4812.951870481285, 5042.4201216860165, 5060.1903695408555, 5168.405633352175, 5178.042062218502, 12850.228986260854, 13073.561908190091, 13093.47626094955, 13096.934515327363, 13177.736445271137, 2123.7770034146347, 2214.76744941782, 2449.2774631483753, 2652.005497938273, 2788.3308006078596, 9579.952100239454, 9902.603895844157, 9961.203103751683, 10055.949720251425, 10231.181505479544, 1834.1012903677235, 1919.7984211657715, 1927.9421617351502, 1974.7334109895123, 1995.0523501336893, 77162.61418692926, 83066.0, 83303.0, 83337.0, 84346.0, 10214.387136771817, 10425.687229383131, 10963.451827408599, 11111.277766945122, 11122.61070862516, 15186.924065379602, 15230.46693365727, 15230.923845380703, 15242.618934526725, 15306.617334566725, 7611.1627720950655, 7770.844583108306, 7903.407244456574, 8039.276465118168, 8041.0, 7314.670839812221, 7347.7795666130105, 7368.784150615195, 7488.588127653032, 7635.847283054308, 4652.371929789503, 4706.670533062653, 4720.433547974197, 4781.402324709411, 4807.711537307773, 1936.951576210606, 2040.734704488407, 2063.7007633893, 2078.958420831605, 2090.153487837428, 924.9537523123817, 988.906053924876, 1027.9640212592524, 1071.4428497181577, 1104.861892263467, 19096.427107186806, 19268.807311926983, 19597.0, 19645.607087858163, 19699.803001970082, 965.4689920543673, 998.5406712912142, 999.6401295533602, 1004.8392257238806, 1006.1950439648399, 10839.458027098613, 10863.728406789893, 10979.28634638746, 10998.175136864607, 11242.0, 401781.0, 425597.0, 435554.0, 436542.0, 437837.0, 48340.0, 52472.475275247525, 53127.734361327944, 76564.23435765682, 81987.5900620493, 987.1461186074138, 1018.8828284747201, 1026.471367245869, 1027.7071034755058, 1030.2273295028879, 17380.73928891093, 17478.21348039316, 17671.204795783964, 17750.733738993666, 17979.280828766703, 29859.0, 40780.0, 41543.0, 42470.575294246664, 42971.78514107409, 57531.0, 59421.405785941584, 59636.403635963085, 59684.0, 59982.0, 8047.074586422402, 8113.8377232456205, 8141.755747327353, 8164.7550573482895, 8842.734717958472, 12042.277463351877, 12442.191257568229, 12749.0, 13164.0, 13770.518031868836, 11304.152188585724, 11411.0, 11667.941660291644, 11677.591284305008, 11898.167128300936, 11143.052840508648, 11153.665390038312, 11391.430428478709, 11514.596989105341, 11961.0, 11563.074954003492, 11667.474963626488, 11710.531578737096, 11735.882641173479, 11934.045276377696, 8126.634301456331, 8141.348692104499, 8203.26170644621, 8206.384521160817, 9038.502882341534, 10419.791604167722, 11502.309861408343, 11620.593279235187, 11720.003799677123, 11728.589499367481], "value": 8889.875990745908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.8178977627797, 1460.3939365163455, 1564.4993602047343, 1701.3789966662173, 1718.9054601996893, 7976.601169941494, 8560.785980350494, 8691.56542172892, 9168.449893006416, 9172.128647778467, 8758.912410875906, 8875.68935087272, 8999.82000359994, 9055.683051093212, 9057.320700947423, 2290.65640153977, 2319.7912187903084, 2336.2290444153473, 2336.4392545788974, 2345.4839935214227, 2300.8389412741117, 2303.942401439969, 2309.9653505197434, 2337.567550003246, 2338.9532209355802, 2297.5290065536524, 2307.2040146149634, 2320.686707294519, 2320.8491448055825, 2323.2217207235594, 2235.485838257202, 2268.092762894839, 2279.065583110933, 2291.7593652666396, 2299.218265789623, 2282.3038973113194, 2297.4830663100834, 2304.9654255186188, 2304.9884750576307, 2308.307507747669, 8944.821103577891, 8985.326100542485, 9041.412308199946, 9076.364654474124, 9086.727398178065, 5193.246979187997, 5299.894002119974, 5302.522772950453, 5305.257263983045, 5309.548688361494, 3308.239105005838, 3328.567286252796, 3373.780704254216, 3424.945032980192, 3530.5763308402898, 1076.1982323169289, 1103.9227254092136, 1113.847168180937, 1123.1856903744801, 1140.7034171115486, 12624.053196010243, 12628.621141365682, 12722.0, 12729.299888506128, 12739.68150796219, 4671.416072990876, 4719.702081927498, 4810.807567697323, 4813.0, 4832.0, 10650.201234907257, 10672.786544269227, 10737.570497180182, 10763.623273185402, 10771.56913723458, 5302.09864323066, 5325.9733701332025, 5352.277442545206, 5360.973195133999, 5374.6506477078865, 4220.894477638084, 4794.424669039738, 4842.104210721028, 4954.702717836942, 4977.676451030671, 4069.918601627951, 4100.712950093465, 4119.752814831119, 4123.5063721494225, 4130.235906357333, 1268.9175203611735, 1273.707047379108, 1280.692633767889, 1319.4128612767418, 1327.283267035809, 969.3166317745972, 970.4613939263777, 974.546835721393, 975.7267964969819, 989.5052473763119, 5968.791092311748, 5975.790847320323, 6048.427408873725, 6152.507799376039, 6239.313675495692, 456.5252137776675, 460.728170379471, 463.6568938985127, 470.6164475952088, 476.5758474957291, 3883.436901649245, 4024.8591299304385, 4050.1292222171787, 4077.592240775958, 4080.3882466425594, 10798.946005269923, 11084.445777711244, 11116.555337786398, 11199.328040317607, 11259.549618015351, 10961.780764384826, 11137.941895520074, 11141.498632561554, 11175.0, 11182.378555109464, 7906.7627971160955, 8227.0, 8246.793830154174, 8416.0, 8512.702055428153, 5924.7926322578505, 6181.81454556364, 6203.379662033761, 6247.406496382836, 6348.365163483615, 10143.949280253551, 10303.330283531546, 10355.17158627323, 10382.42896640692, 10635.680929572125, 10645.574177033142, 10672.146228301563, 10781.191410644076, 10791.082757965347, 10802.621908233174, 7938.126806051445, 7981.561014144278, 8201.630926608197, 8277.337812974827, 8291.378146638906, 8540.70107546233, 8580.742577722429, 8601.182887625666, 8805.339599529932, 8863.113688631085, 7456.254374562501, 7532.096148462219, 7697.730579429693, 7715.1513333534385, 7935.365170786438, 7484.363829074372, 7501.924980750341, 7587.468877178544, 7662.387009039375, 7770.53376797394, 7021.894671580033, 7052.823679408056, 7058.894116588152, 7105.786826395217, 7126.144862616519, 5140.691558506502, 5320.0, 5395.919061214006, 5418.431064738145, 5433.538149257357, 5253.658512196695, 5300.761465733974, 5389.461053894579, 5408.405075441619, 5417.1874218865905], "value": 4616.93702962224, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.4073926193589, 327.8836013215309, 330.48114460297336, 332.0106083870067, 332.16791936199814, 5570.916436253455, 5659.8585035374135, 5679.545636349092, 5684.516816070629, 5710.800121995731, 5561.610687251894, 5567.661582135513, 5577.107662773957, 5581.441855814416, 5617.41017193194, 4125.422440858275, 4150.066235097094, 4290.678199135062, 4325.567443255681, 4342.848000319989, 4315.8994456413575, 4342.261815491358, 4347.7826108694435, 4352.39066530686, 4353.891152721176, 4313.654907607384, 4336.8265269389185, 4352.173087113454, 4365.607095361417, 4367.825286988516, 4267.871963841089, 4274.957250427503, 4303.257180841764, 4322.222000039991, 4333.8699839004885, 3778.1688028633657, 3781.6785573226307, 3799.9930018545106, 3827.923441531154, 3836.271108489378, 5293.782430041074, 5406.405295417501, 5443.2107344434835, 5445.039785677153, 5456.781728730846, 4842.15262329091, 4984.651074424792, 4991.600671946236, 4996.875078123039, 5016.423111342206, 5836.57782020461, 5840.853978650525, 5861.4724674779045, 5887.587868849182, 5920.0, 4218.704690671654, 4224.260754368004, 4241.787910604488, 4248.936265956013, 4258.446401967755, 5792.855178620568, 6081.817545473643, 6104.755809767604, 6117.327094019654, 6135.141080248769, 4063.167050754588, 4080.3879418087527, 4084.6528045116497, 4089.1412803311637, 4102.2410853992105, 4168.291390463629, 4171.853985110507, 4177.811998460076, 4183.1215444756335, 4184.497860256789, 4792.281157826354, 4859.514048595112, 4862.562369386772, 4885.6335774817035, 4912.410510738663, 5968.761249550056, 5985.281766187998, 5994.430529099728, 6004.42957918997, 6011.3086994995265, 1472.963175920589, 1473.2633683158422, 1476.402057166849, 1479.9122644856022, 1492.79847220626, 862.7929296968682, 866.2117473099576, 866.3112825303898, 869.9826003480022, 907.5915837872983, 4893.730844803499, 4924.901501969941, 4925.1873440881855, 4992.525710057539, 5015.598752099896, 5294.655847369909, 5345.599080069011, 5349.518543331119, 5385.8114965976, 5390.137577987503, 4745.928811067837, 4959.752012399365, 4992.850214493571, 5002.89994200114, 5021.924671129936, 2888.2201805512395, 2893.6816950135467, 2896.391757730858, 2901.5792710057344, 2911.02050605586, 5546.667199967934, 5572.832815015556, 5610.85972850682, 5611.579131565149, 5623.409541998031, 5821.359650438449, 6190.938090619126, 6220.284667263322, 6287.717052732638, 6303.054541818764, 6298.370162983665, 6318.652474113968, 6340.239171299474, 6368.872622547523, 6391.105245265667, 6060.636361818305, 6079.240094988127, 6160.691965401802, 6164.178209510133, 6198.2252218472695, 5959.970200148971, 6055.515558755377, 6065.2418447694035, 6136.2636483622255, 6146.385361463817, 6130.356312587114, 6196.189343553772, 6262.307207900464, 6264.373562643699, 6276.74893004293, 4152.065785198306, 4162.812673429642, 4183.686223533308, 4194.0, 4200.096979149497, 5858.736356864037, 5908.793192238251, 6120.60216085953, 6163.96918015407, 6206.317305096526, 5854.795082172103, 5866.178734977021, 5872.559558033079, 5921.407859214044, 5971.05940569308, 5843.065109582446, 5858.297004359504, 5880.206172166874, 5893.0, 5908.3796201399955, 5606.803761868315, 5748.798792042258, 5757.280339957505, 5776.19133321327, 5823.475887170006, 5886.735096920735, 5902.966980778432, 5937.2578427696535, 5949.732262048132, 5968.820935371946, 5588.77644894216, 5712.942870571241, 5793.9420605795085, 5807.970960145172, 5829.242198514166], "value": 4373.774756224256, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.9016027916371, 758.5221310574337, 790.5217343507178, 798.2297083314602, 854.0562678240542, 14857.40570377185, 15998.120103394338, 16064.678706425864, 16094.919525402356, 16273.267702953366, 14443.927780361084, 14601.561953141423, 14643.19462429566, 14702.0, 14738.968272220949, 670.5373292428221, 781.1797612506845, 789.4316092413453, 795.2604078207265, 798.6765360029198, 798.6086817459432, 798.9480683755567, 800.8838718385831, 802.1817745899208, 804.2721337189853, 866.4541338956449, 866.7919699272193, 867.1328671328671, 869.4652788535037, 869.7303835810919, 857.8627419612832, 861.2507118806647, 861.3625916821507, 861.5390765940223, 862.4006315610653, 620.4632992461488, 622.3092367472102, 625.0312016374601, 625.1685258606088, 626.1546911669255, 14851.70296594062, 14854.480093196686, 14900.0, 14931.776023359658, 14980.1011939284, 13660.521881734092, 15001.774973375408, 15325.23373831304, 15334.846651533566, 15375.692486150327, 12996.675083122998, 13525.458981640722, 13558.525451609146, 13605.659858503517, 13611.591652250348, 4548.727076375428, 4559.407277053995, 4566.383538222364, 4571.337156112379, 4595.494495605481, 77353.22646773516, 77940.99999999943, 78312.21687783106, 80579.59710201412, 82032.0, 10897.891021089847, 11062.170337224741, 11161.162912781574, 11384.430778461045, 11644.2431241969, 20196.394108176777, 20215.39353819388, 20238.797612023987, 20558.177672892918, 21180.258690945742, 8257.95871020653, 8284.212999765012, 8297.12880147588, 8303.211194936472, 8324.500529968222, 4520.660950428665, 4622.583967442879, 4641.535846415331, 4646.349511068385, 4744.074905393415, 3291.325278317939, 3408.454647256427, 3420.640832712529, 3429.1941393772445, 3437.1750779813165, 588.9087191485327, 596.5496050481945, 620.798240571816, 655.3381085104079, 657.2934095846983, 614.4347200575481, 617.4319625944142, 751.1962200445471, 766.8351304469566, 801.410962942237, 9761.804763904682, 9865.950670246602, 10182.745431364276, 10528.947355263175, 11094.112471002461, 710.4103594016954, 770.6416516319938, 777.8949841771401, 792.8414317136596, 805.2430715127762, 4961.627877909171, 5144.948550514522, 5156.097682905476, 5162.199859021857, 5173.249878767558, 123797.0, 127424.36287818688, 128341.3582932098, 128368.0, 132232.0, 66564.6671766638, 89083.0, 109368.4531577337, 109871.45064274628, 113820.0, 88645.11354886497, 88766.0, 88928.11071889199, 91168.54415727878, 91215.08784912065, 9228.584713687766, 9277.257819374568, 9441.952790236004, 9566.234701224024, 9612.0, 55582.0, 55914.16128758153, 56086.0, 56631.71684141553, 57747.0, 64243.357566423736, 65216.0, 72176.27823721696, 76229.27465672257, 76789.0, 12692.682682933, 12927.612171634866, 13080.542181023618, 13116.737665246832, 13524.932375338454, 14101.365438555085, 14402.135871847722, 14536.055156414799, 14601.73026571225, 15417.84582154209, 13959.860401396263, 14126.223057731924, 14226.502072427415, 14474.0, 15232.086074835544, 14042.859571404564, 14557.563273101823, 14707.92646036763, 14789.630259243606, 15338.386464541294, 14043.789343159657, 14697.191654459108, 15125.54623361301, 15174.089554626758, 15485.011283976555, 11023.559057637605, 11044.043809931238, 11777.587784427504, 11844.170908036354, 11883.76232475363, 10266.435346056038, 10466.267361284637, 10761.515731791931, 10786.622468213574, 11124.944375278395], "value": 7737.457602523872, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 107.0, 111.0, 113.0, 112.0, 114.0, 111.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 162.0, 181.0, 132.0, 165.0, 171.0, 136.0, 179.0, 136.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 166.0, 175.0, 166.0, 164.0, 164.0, 162.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 173.0, 77.0, 77.0, 78.0, 75.0, 169.0, 77.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 139.0, 88.0, 87.0, 86.0, 136.0, 86.0, 85.0, 153.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 147.0, 148.0, 149.0, 149.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 98.0, 100.0, 98.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 53.0, 56.0, 55.0, 56.0, 53.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 79.0, 84.0, 80.0, 80.0, 85.0, 99.0, 79.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 157.0, 125.0, 122.0, 124.0, 127.0, 121.0, 131.0, 128.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 160.0, 160.0, 163.0, 161.0, 165.0, 165.0, 160.0, 165.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 65.0, 62.0, 64.0, 63.0, 63.0, 64.0, 66.0], "value": 64.6, "unit": "score"}]}]} 11:59:24 INFO - Return code: 0 11:59:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:24 ERROR - # TBPL SUCCESS # 11:59:24 INFO - Running post-action listener: _resource_record_post_action 11:59:24 INFO - ##### 11:59:24 INFO - ##### Finished run-tests step (success) 11:59:24 INFO - ##### 11:59:24 INFO - Running post-run listener: _resource_record_post_run 11:59:24 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 551956480; Read time: 0; Write time: 693424 11:59:24 INFO - TinderboxPrint: CPU usage
13.4% 11:59:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:59:24 INFO - TinderboxPrint: I/O write bytes / time
551,956,480 / 693,424 11:59:24 INFO - TinderboxPrint: CPU idle
8,227.3 (86.5%) 11:59:24 INFO - TinderboxPrint: CPU user
1,218.4 (12.8%) 11:59:24 INFO - TinderboxPrint: Swap in / out
0 / 0 11:59:24 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 252551168; Read time: 0; Write time: 383836 11:59:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294739968; Read time: 0; Write time: 308988 11:59:25 INFO - Running post-run listener: _upload_blobber_files 11:59:25 INFO - Blob upload gear active. 11:59:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:25 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 11:59:25 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:59:25 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:59:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:59:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:59:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:26 INFO - (blobuploader) - INFO - Done attempting. 11:59:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:59:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:59:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:30 INFO - (blobuploader) - INFO - Done attempting. 11:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:59:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:30 INFO - (blobuploader) - INFO - Done attempting. 11:59:30 INFO - (blobuploader) - INFO - Iteration through files over. 11:59:31 INFO - Return code: 0 11:59:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:59:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:59:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b065a900b2e4e5fab7c682cbe4ec354f94d80dac78b54e540855eb4fcdc28cd4c165bd4c70e6d3c8eb4360cfc4a1a421e4c7dafb25a4433adcf4bab17b16348", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0b57024360ca5ef4ab28cb5a65124d4a8bb48fa5039ad857c7931d62d82c2227a81383d034a430745759f42a0ca875ad629eb531020e57857a4ad2bfac06c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08e7ce6d9073d6d28352f48dd3909e81248eb8e15057f2879f2f2d443ecd5bf8ed6996e03944cb7df17362c196907a7b7ce9265233293904f2a722fcdf14d5c7"} 11:59:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:59:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:59:31 INFO - Contents: 11:59:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b065a900b2e4e5fab7c682cbe4ec354f94d80dac78b54e540855eb4fcdc28cd4c165bd4c70e6d3c8eb4360cfc4a1a421e4c7dafb25a4433adcf4bab17b16348", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0b57024360ca5ef4ab28cb5a65124d4a8bb48fa5039ad857c7931d62d82c2227a81383d034a430745759f42a0ca875ad629eb531020e57857a4ad2bfac06c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08e7ce6d9073d6d28352f48dd3909e81248eb8e15057f2879f2f2d443ecd5bf8ed6996e03944cb7df17362c196907a7b7ce9265233293904f2a722fcdf14d5c7"} 11:59:31 INFO - Running post-run listener: copy_logs_to_upload_dir 11:59:31 INFO - Copying logs to upload dir... 11:59:31 INFO - mkdir: /builds/slave/test/build/upload/logs 11:59:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.863878 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-26 11:59:28.189396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 11:59:28.193606) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724 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/sha512/7b065a900b2e4e5fab7c682cbe4ec354f94d80dac78b54e540855eb4fcdc28cd4c165bd4c70e6d3c8eb4360cfc4a1a421e4c7dafb25a4433adcf4bab17b16348", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0b57024360ca5ef4ab28cb5a65124d4a8bb48fa5039ad857c7931d62d82c2227a81383d034a430745759f42a0ca875ad629eb531020e57857a4ad2bfac06c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08e7ce6d9073d6d28352f48dd3909e81248eb8e15057f2879f2f2d443ecd5bf8ed6996e03944cb7df17362c196907a7b7ce9265233293904f2a722fcdf14d5c7"} build_url:https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/Th-bm6NNTDSdWRPmAHK44w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b065a900b2e4e5fab7c682cbe4ec354f94d80dac78b54e540855eb4fcdc28cd4c165bd4c70e6d3c8eb4360cfc4a1a421e4c7dafb25a4433adcf4bab17b16348", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0b57024360ca5ef4ab28cb5a65124d4a8bb48fa5039ad857c7931d62d82c2227a81383d034a430745759f42a0ca875ad629eb531020e57857a4ad2bfac06c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08e7ce6d9073d6d28352f48dd3909e81248eb8e15057f2879f2f2d443ecd5bf8ed6996e03944cb7df17362c196907a7b7ce9265233293904f2a722fcdf14d5c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 11:59:28.221203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:59:28.221606) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466964024.712959-67719724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004336 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:59:28.303738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 11:59:28.304154) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 11:59:28.304562) ========= ========= Total master_lag: 0.17 =========