builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1469183576.6 results: success (0) buildid: 20160722004032 builduid: 394b66c0c8fb4fcdae3849c2df97a692 revision: f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:56.601282) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:56.601776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:56.602051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:56.809111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:56.809552) ========= 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=745a4373a2a16df560f216e000000264-1469183575.808026-825776876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 03:32:56-- 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% 30.7M=0s 2016-07-22 03:32:57 (30.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:57.024481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:57.024823) ========= 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=745a4373a2a16df560f216e000000264-1469183575.808026-825776876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014905 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:57.075154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 03:32:57.075575) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 --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=745a4373a2a16df560f216e000000264-1469183575.808026-825776876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 03:32:57,261 truncating revision to first 12 chars 2016-07-22 03:32:57,261 Setting DEBUG logging. 2016-07-22 03:32:57,261 attempt 1/10 2016-07-22 03:32:57,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f8e3b85fd772?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 03:32:57,983 unpacking tar archive at: mozilla-aurora-f8e3b85fd772/testing/mozharness/ program finished with exit code 0 elapsedTime=1.068340 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 03:32:58.157682) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:58.158018) ========= script_repo_revision: f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:58.158451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:58.158738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 03:32:58.170025) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-22 03:32:58.170400) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1469183575.808026-825776876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:58 INFO - MultiFileLogger online at 20160722 03:32:58 in /builds/slave/test 03:32:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:32:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:58 INFO - {'append_to_log': False, 03:32:58 INFO - 'base_work_dir': '/builds/slave/test', 03:32:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:58 INFO - 'branch': 'Mozilla-Aurora', 03:32:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:58 INFO - 'config_files': ('talos/linux_config.py',), 03:32:58 INFO - 'default_actions': ('clobber', 03:32:58 INFO - 'read-buildbot-config', 03:32:58 INFO - 'download-and-extract', 03:32:58 INFO - 'populate-webroot', 03:32:58 INFO - 'create-virtualenv', 03:32:58 INFO - 'install', 03:32:58 INFO - 'run-tests'), 03:32:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:58 INFO - 'download_minidump_stackwalk': True, 03:32:58 INFO - 'download_symbols': 'ondemand', 03:32:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:58 INFO - 'installer_path': 'installer.exe', 03:32:58 INFO - 'log_level': 'info', 03:32:58 INFO - 'log_name': 'talos', 03:32:58 INFO - 'log_to_console': True, 03:32:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:58 INFO - 'opt_config_files': (), 03:32:58 INFO - 'pip_index': False, 03:32:58 INFO - 'sps_profile': False, 03:32:58 INFO - 'sps_profile_interval': 0, 03:32:58 INFO - 'suite': 'dromaeojs', 03:32:58 INFO - 'system_bits': '32', 03:32:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:58 INFO - 'title': 'talos-linux64-ix-032', 03:32:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:58 INFO - 'use_talos_json': True, 03:32:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:58 INFO - 'work_dir': 'build'} 03:32:58 INFO - ##### 03:32:58 INFO - ##### Running clobber step. 03:32:58 INFO - ##### 03:32:58 INFO - Running pre-action listener: _resource_record_pre_action 03:32:58 INFO - Running main action method: clobber 03:32:58 INFO - rmtree: /builds/slave/test/build 03:32:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:59 INFO - Running post-action listener: _resource_record_post_action 03:32:59 INFO - ##### 03:32:59 INFO - ##### Finished clobber step (success) 03:32:59 INFO - ##### 03:32:59 INFO - ##### 03:32:59 INFO - ##### Running read-buildbot-config step. 03:32:59 INFO - ##### 03:32:59 INFO - Running pre-action listener: _resource_record_pre_action 03:32:59 INFO - Running main action method: read_buildbot_config 03:32:59 INFO - Using buildbot properties: 03:32:59 INFO - { 03:32:59 INFO - "project": "", 03:32:59 INFO - "product": "firefox", 03:32:59 INFO - "script_repo_revision": "production", 03:32:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:32:59 INFO - "repository": "", 03:32:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:32:59 INFO - "buildid": "20160722004032", 03:32:59 INFO - "stage_platform": "linux64-pgo", 03:32:59 INFO - "basedir": "/builds/slave/test", 03:32:59 INFO - "nightly_build": "True", 03:32:59 INFO - "buildnumber": 622, 03:32:59 INFO - "slavename": "talos-linux64-ix-032", 03:32:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:32:59 INFO - "platform": "ubuntu64_hw", 03:32:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:59 INFO - "branch": "mozilla-aurora", 03:32:59 INFO - "repo_path": "releases/mozilla-aurora", 03:32:59 INFO - "revision": "f8e3b85fd772dddaf019197b359b6f82a9fb1bd3", 03:32:59 INFO - "pgo_build": "True", 03:32:59 INFO - "builduid": "394b66c0c8fb4fcdae3849c2df97a692", 03:32:59 INFO - "slavebuilddir": "test" 03:32:59 INFO - } 03:32:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:32:59 INFO - Running post-action listener: _resource_record_post_action 03:32:59 INFO - ##### 03:32:59 INFO - ##### Finished read-buildbot-config step (success) 03:32:59 INFO - ##### 03:32:59 INFO - ##### 03:32:59 INFO - ##### Running download-and-extract step. 03:32:59 INFO - ##### 03:32:59 INFO - Running pre-action listener: _resource_record_pre_action 03:32:59 INFO - Running main action method: download_and_extract 03:32:59 INFO - mkdir: /builds/slave/test/build/tests 03:32: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')]} 03:32:59 INFO - https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:32:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:33:01 INFO - Downloaded 1361 bytes. 03:33:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:33:01 INFO - Using the following test package requirements: 03:33:01 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:01 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:33:01 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:33:01 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:01 INFO - u'jsshell-linux-x86_64.zip'], 03:33:01 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:33:01 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:01 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:33:01 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:33:01 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:33:01 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:33:01 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:01 INFO - https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:33:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:02 INFO - Downloaded 24491064 bytes. 03:33:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:33:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:33:03 INFO - Return code: 0 03:33:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:33: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')]} 03:33:03 INFO - https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:04 INFO - Downloaded 24491064 bytes. 03:33:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:33:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:33:06 INFO - Return code: 0 03:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:06 INFO - https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:33:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:33:07 INFO - Downloaded 10833369 bytes. 03:33:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:33:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:33:07 INFO - Return code: 0 03:33:07 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')]} 03:33:07 INFO - https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:33:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:33:09 INFO - Downloaded 63647713 bytes. 03:33:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:09 INFO - mkdir: /builds/slave/test/properties 03:33:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:09 INFO - Contents: 03:33:09 INFO - build_url:https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:10 INFO - Running post-action listener: _resource_record_post_action 03:33:10 INFO - Running post-action listener: set_extra_try_arguments 03:33:10 INFO - ##### 03:33:10 INFO - ##### Finished download-and-extract step (success) 03:33:10 INFO - ##### 03:33:10 INFO - ##### 03:33:10 INFO - ##### Running populate-webroot step. 03:33:10 INFO - ##### 03:33:10 INFO - Running pre-action listener: _resource_record_pre_action 03:33:10 INFO - Running main action method: populate_webroot 03:33:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:10 INFO - '--tppagecycles', 03:33:10 INFO - '7'], 03:33:10 INFO - 'tests': ['tsvgm']}}, 03:33:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:10 INFO - 'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:10 INFO - 'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['damp', 'tps']}, 03:33:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:10 INFO - 'tests': ['damp', 'tps']}, 03:33:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['dromaeo_dom']}, 03:33:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['a11yr', 03:33:10 INFO - 'ts_paint', 03:33:10 INFO - 'tpaint', 03:33:10 INFO - 'sessionrestore', 03:33:10 INFO - 'sessionrestore_no_auto_restore', 03:33:10 INFO - 'tabpaint']}, 03:33:10 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:10 INFO - 'ts_paint', 03:33:10 INFO - 'tpaint', 03:33:10 INFO - 'sessionrestore', 03:33:10 INFO - 'sessionrestore_no_auto_restore', 03:33:10 INFO - 'tabpaint']}, 03:33:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:10 INFO - 'ts_paint', 03:33:10 INFO - 'tpaint', 03:33:10 INFO - 'sessionrestore', 03:33:10 INFO - 'sessionrestore_no_auto_restore', 03:33:10 INFO - 'tabpaint']}, 03:33:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:10 INFO - 'ts_paint', 03:33:10 INFO - 'tpaint', 03:33:10 INFO - 'sessionrestore', 03:33:10 INFO - 'sessionrestore_no_auto_restore', 03:33:10 INFO - 'tabpaint']}, 03:33:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['a11yr', 03:33:10 INFO - 'ts_paint', 03:33:10 INFO - 'tpaint', 03:33:10 INFO - 'sessionrestore', 03:33:10 INFO - 'sessionrestore_no_auto_restore', 03:33:10 INFO - 'tabpaint']}, 03:33:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['a11yr', 03:33:10 INFO - 'ts_paint', 03:33:10 INFO - 'tpaint', 03:33:10 INFO - 'sessionrestore', 03:33:10 INFO - 'sessionrestore_no_auto_restore', 03:33:10 INFO - 'tabpaint']}, 03:33:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['tsvgx', 03:33:10 INFO - 'tsvgr_opacity', 03:33:10 INFO - 'tart', 03:33:10 INFO - 'tscrollx', 03:33:10 INFO - 'cart']}, 03:33:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:10 INFO - 'tsvgr_opacity', 03:33:10 INFO - 'tart', 03:33:10 INFO - 'tscrollx', 03:33:10 INFO - 'cart']}, 03:33:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:10 INFO - 'talos_options': ['--disable-e10s'], 03:33:10 INFO - 'tests': ['tp5o']}, 03:33:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:10 INFO - 'tests': ['tp5o']}, 03:33:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:10 INFO - 'talos_options': ['--disable-e10s', 03:33:10 INFO - '--xperf_path', 03:33:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:10 INFO - 'tests': ['tp5n']}, 03:33:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:10 INFO - 'talos_options': ['--xperf_path', 03:33:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:10 INFO - 'tests': ['tp5n']}}, 03:33:10 INFO - 'talos.zip': {'path': '', 03:33:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:10 INFO - Running post-action listener: _resource_record_post_action 03:33:10 INFO - ##### 03:33:10 INFO - ##### Finished populate-webroot step (success) 03:33:10 INFO - ##### 03:33:10 INFO - ##### 03:33:10 INFO - ##### Running create-virtualenv step. 03:33:10 INFO - ##### 03:33:10 INFO - Running pre-action listener: _resource_record_pre_action 03:33:10 INFO - Running main action method: create_virtualenv 03:33:10 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:10 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 03:33:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:10 INFO - Using real prefix '/usr' 03:33:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:10 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:12 INFO - Installing pip.................done. 03:33:12 INFO - Return code: 0 03:33:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33: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', 'pip>=1.5'] in /builds/slave/test/build 03:33: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 pip>=1.5 03:33:12 INFO - Using env: {'DISPLAY': ':0', 03:33:12 INFO - 'HOME': '/home/cltbld', 03:33:12 INFO - 'LANG': 'en_US.UTF-8', 03:33:12 INFO - 'LANGUAGE': 'en_US:en', 03:33:12 INFO - 'LOGNAME': 'cltbld', 03:33:12 INFO - 'MAIL': '/var/mail/cltbld', 03:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:12 INFO - 'MOZ_NO_REMOTE': '1', 03:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:12 INFO - 'NO_EM_RESTART': '1', 03:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:12 INFO - 'PWD': '/builds/slave/test', 03:33:12 INFO - 'SHELL': '/bin/bash', 03:33:12 INFO - 'SHLVL': '1', 03:33:12 INFO - 'TERM': 'linux', 03:33:12 INFO - 'TMOUT': '86400', 03:33:12 INFO - 'USER': 'cltbld', 03:33:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:12 INFO - '_': '/tools/buildbot/bin/python'} 03:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:13 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 03:33:13 INFO - Cleaning up... 03:33:13 INFO - Return code: 0 03:33:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:33:13 INFO - Using env: {'DISPLAY': ':0', 03:33:13 INFO - 'HOME': '/home/cltbld', 03:33:13 INFO - 'LANG': 'en_US.UTF-8', 03:33:13 INFO - 'LANGUAGE': 'en_US:en', 03:33:13 INFO - 'LOGNAME': 'cltbld', 03:33:13 INFO - 'MAIL': '/var/mail/cltbld', 03:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:13 INFO - 'MOZ_NO_REMOTE': '1', 03:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:13 INFO - 'NO_EM_RESTART': '1', 03:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:13 INFO - 'PWD': '/builds/slave/test', 03:33:13 INFO - 'SHELL': '/bin/bash', 03:33:13 INFO - 'SHLVL': '1', 03:33:13 INFO - 'TERM': 'linux', 03:33:13 INFO - 'TMOUT': '86400', 03:33:13 INFO - 'USER': 'cltbld', 03:33:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:13 INFO - '_': '/tools/buildbot/bin/python'} 03:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:13 INFO - Downloading/unpacking psutil>=3.1.1 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:15 INFO - Installing collected packages: psutil 03:33:15 INFO - Running setup.py install for psutil 03:33:15 INFO - building 'psutil._psutil_linux' extension 03:33:15 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 03:33:15 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 03:33:15 INFO - building 'psutil._psutil_posix' extension 03:33:15 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 03:33:15 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 03:33:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:15 INFO - Successfully installed psutil 03:33:15 INFO - Cleaning up... 03:33:15 INFO - Return code: 0 03:33:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:33: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 mozsystemmonitor==0.3 03:33:15 INFO - Using env: {'DISPLAY': ':0', 03:33:15 INFO - 'HOME': '/home/cltbld', 03:33:15 INFO - 'LANG': 'en_US.UTF-8', 03:33:15 INFO - 'LANGUAGE': 'en_US:en', 03:33:15 INFO - 'LOGNAME': 'cltbld', 03:33:15 INFO - 'MAIL': '/var/mail/cltbld', 03:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:15 INFO - 'MOZ_NO_REMOTE': '1', 03:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:15 INFO - 'NO_EM_RESTART': '1', 03:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:15 INFO - 'PWD': '/builds/slave/test', 03:33:15 INFO - 'SHELL': '/bin/bash', 03:33:15 INFO - 'SHLVL': '1', 03:33:15 INFO - 'TERM': 'linux', 03:33:15 INFO - 'TMOUT': '86400', 03:33:15 INFO - 'USER': 'cltbld', 03:33:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:15 INFO - '_': '/tools/buildbot/bin/python'} 03:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:16 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 03:33:16 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 03:33:16 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 03:33:16 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 03:33:16 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 03:33:16 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 03:33:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:17 INFO - Installing collected packages: mozsystemmonitor 03:33:17 INFO - Running setup.py install for mozsystemmonitor 03:33:18 INFO - Successfully installed mozsystemmonitor 03:33:18 INFO - Cleaning up... 03:33:18 INFO - Return code: 0 03:33:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:18 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 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33:18 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 03:33:18 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 03:33:18 INFO - Using env: {'DISPLAY': ':0', 03:33:18 INFO - 'HOME': '/home/cltbld', 03:33:18 INFO - 'LANG': 'en_US.UTF-8', 03:33:18 INFO - 'LANGUAGE': 'en_US:en', 03:33:18 INFO - 'LOGNAME': 'cltbld', 03:33:18 INFO - 'MAIL': '/var/mail/cltbld', 03:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:18 INFO - 'MOZ_NO_REMOTE': '1', 03:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:18 INFO - 'NO_EM_RESTART': '1', 03:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:18 INFO - 'PWD': '/builds/slave/test', 03:33:18 INFO - 'SHELL': '/bin/bash', 03:33:18 INFO - 'SHLVL': '1', 03:33:18 INFO - 'TERM': 'linux', 03:33:18 INFO - 'TMOUT': '86400', 03:33:18 INFO - 'USER': 'cltbld', 03:33:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:18 INFO - '_': '/tools/buildbot/bin/python'} 03:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:18 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:18 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 03:33:18 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 03:33:18 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 03:33:18 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 03:33:18 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 03:33:18 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 03:33:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:20 INFO - warning: no files found matching '*.txt' 03:33:20 INFO - no previously-included directories found matching 'build' 03:33:20 INFO - no previously-included directories found matching 'dist' 03:33:20 INFO - no previously-included directories found matching '.git*' 03:33:20 INFO - Installing collected packages: jsonschema, functools32 03:33:20 INFO - Running setup.py install for functools32 03:33:20 INFO - warning: no files found matching '*.txt' 03:33:20 INFO - no previously-included directories found matching 'build' 03:33:20 INFO - no previously-included directories found matching 'dist' 03:33:20 INFO - no previously-included directories found matching '.git*' 03:33:20 INFO - Successfully installed jsonschema functools32 03:33:20 INFO - Cleaning up... 03:33:20 INFO - Return code: 0 03:33:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:20 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')]} 03:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:20 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')]} 03:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:20 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 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33:20 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 03:33:20 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 03:33:20 INFO - Using env: {'DISPLAY': ':0', 03:33:20 INFO - 'HOME': '/home/cltbld', 03:33:20 INFO - 'LANG': 'en_US.UTF-8', 03:33:20 INFO - 'LANGUAGE': 'en_US:en', 03:33:20 INFO - 'LOGNAME': 'cltbld', 03:33:20 INFO - 'MAIL': '/var/mail/cltbld', 03:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:20 INFO - 'MOZ_NO_REMOTE': '1', 03:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:20 INFO - 'NO_EM_RESTART': '1', 03:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:20 INFO - 'PWD': '/builds/slave/test', 03:33:20 INFO - 'SHELL': '/bin/bash', 03:33:20 INFO - 'SHLVL': '1', 03:33:20 INFO - 'TERM': 'linux', 03:33:20 INFO - 'TMOUT': '86400', 03:33:20 INFO - 'USER': 'cltbld', 03:33:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:20 INFO - '_': '/tools/buildbot/bin/python'} 03:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:20 INFO - Downloading/unpacking blobuploader==1.2.4 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:22 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:23 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 03:33:23 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 03:33:23 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 03:33:23 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 03:33:23 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 03:33:23 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 03:33:23 INFO - Downloading docopt-0.6.1.tar.gz 03:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:23 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:23 INFO - Running setup.py install for blobuploader 03:33:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:23 INFO - Running setup.py install for requests 03:33:24 INFO - Running setup.py install for docopt 03:33:24 INFO - Successfully installed blobuploader requests docopt 03:33:24 INFO - Cleaning up... 03:33:24 INFO - Return code: 0 03:33:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:24 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 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33:24 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 03:33:24 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 03:33:24 INFO - Using env: {'DISPLAY': ':0', 03:33:24 INFO - 'HOME': '/home/cltbld', 03:33:24 INFO - 'LANG': 'en_US.UTF-8', 03:33:24 INFO - 'LANGUAGE': 'en_US:en', 03:33:24 INFO - 'LOGNAME': 'cltbld', 03:33:24 INFO - 'MAIL': '/var/mail/cltbld', 03:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:24 INFO - 'MOZ_NO_REMOTE': '1', 03:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:24 INFO - 'NO_EM_RESTART': '1', 03:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:24 INFO - 'PWD': '/builds/slave/test', 03:33:24 INFO - 'SHELL': '/bin/bash', 03:33:24 INFO - 'SHLVL': '1', 03:33:24 INFO - 'TERM': 'linux', 03:33:24 INFO - 'TMOUT': '86400', 03:33:24 INFO - 'USER': 'cltbld', 03:33:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:24 INFO - '_': '/tools/buildbot/bin/python'} 03:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:24 INFO - Running setup.py (path:/tmp/pip-rNm1Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:24 INFO - Running setup.py (path:/tmp/pip-95FXZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:24 INFO - Running setup.py (path:/tmp/pip-DACVc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:24 INFO - Running setup.py (path:/tmp/pip-dPxZx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:24 INFO - Running setup.py (path:/tmp/pip-VUfkD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:24 INFO - Running setup.py (path:/tmp/pip-B60pgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:24 INFO - Running setup.py (path:/tmp/pip-KwEtMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:24 INFO - Running setup.py (path:/tmp/pip-94b5Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:25 INFO - Running setup.py (path:/tmp/pip-1cGbFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:25 INFO - Running setup.py (path:/tmp/pip-oDkz3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:25 INFO - Running setup.py (path:/tmp/pip-xdn5Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:25 INFO - Running setup.py (path:/tmp/pip-pwOPFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:25 INFO - Running setup.py (path:/tmp/pip-ukyMoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:25 INFO - Running setup.py (path:/tmp/pip-3i30VF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:25 INFO - Running setup.py (path:/tmp/pip-UBjuHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:25 INFO - Running setup.py (path:/tmp/pip-XfHW12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:25 INFO - Running setup.py (path:/tmp/pip-p1iN50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:25 INFO - Running setup.py install for manifestparser 03:33:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:25 INFO - Running setup.py install for mozcrash 03:33:25 INFO - Running setup.py install for mozdebug 03:33:25 INFO - Running setup.py install for mozdevice 03:33:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Running setup.py install for mozfile 03:33:26 INFO - Running setup.py install for mozhttpd 03:33:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Running setup.py install for mozinfo 03:33:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Running setup.py install for mozInstall 03:33:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Running setup.py install for mozleak 03:33:26 INFO - Running setup.py install for mozlog 03:33:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Running setup.py install for moznetwork 03:33:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:26 INFO - Running setup.py install for mozprocess 03:33:26 INFO - Running setup.py install for mozprofile 03:33:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:27 INFO - Running setup.py install for mozrunner 03:33:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:27 INFO - Running setup.py install for mozscreenshot 03:33:27 INFO - Running setup.py install for moztest 03:33:27 INFO - Running setup.py install for mozversion 03:33:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:27 INFO - Cleaning up... 03:33:27 INFO - Return code: 0 03:33:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:27 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 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33:27 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 03:33:27 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 03:33:27 INFO - Using env: {'DISPLAY': ':0', 03:33:27 INFO - 'HOME': '/home/cltbld', 03:33:27 INFO - 'LANG': 'en_US.UTF-8', 03:33:27 INFO - 'LANGUAGE': 'en_US:en', 03:33:27 INFO - 'LOGNAME': 'cltbld', 03:33:27 INFO - 'MAIL': '/var/mail/cltbld', 03:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:27 INFO - 'MOZ_NO_REMOTE': '1', 03:33:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:27 INFO - 'NO_EM_RESTART': '1', 03:33:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:27 INFO - 'PWD': '/builds/slave/test', 03:33:27 INFO - 'SHELL': '/bin/bash', 03:33:27 INFO - 'SHLVL': '1', 03:33:27 INFO - 'TERM': 'linux', 03:33:27 INFO - 'TMOUT': '86400', 03:33:27 INFO - 'USER': 'cltbld', 03:33:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:27 INFO - '_': '/tools/buildbot/bin/python'} 03:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:27 INFO - Running setup.py (path:/tmp/pip-hv9t1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:27 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)) 03:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:27 INFO - Running setup.py (path:/tmp/pip-EZM7zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:27 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)) 03:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:27 INFO - Running setup.py (path:/tmp/pip-9mBXcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:27 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)) 03:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:27 INFO - Running setup.py (path:/tmp/pip-XQtO7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:28 INFO - Running setup.py (path:/tmp/pip-sMVkpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:28 INFO - Running setup.py (path:/tmp/pip-uEJqIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:28 INFO - Running setup.py (path:/tmp/pip-2xc6ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:28 INFO - Running setup.py (path:/tmp/pip-K3qHlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:28 INFO - Running setup.py (path:/tmp/pip-aupD9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:28 INFO - Running setup.py (path:/tmp/pip-7C2f4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:28 INFO - Running setup.py (path:/tmp/pip-D5LUF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:28 INFO - Running setup.py (path:/tmp/pip-uLh8Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:28 INFO - Running setup.py (path:/tmp/pip-acNuUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:28 INFO - Running setup.py (path:/tmp/pip-Mr5KoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:28 INFO - Running setup.py (path:/tmp/pip-5CoHaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:28 INFO - Running setup.py (path:/tmp/pip-kDE64s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:28 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)) 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:28 INFO - Running setup.py (path:/tmp/pip-nFrei6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:28 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)) 03:33:28 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)) 03:33:28 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)) 03:33:28 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)) 03:33:28 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)) 03:33:28 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)) 03:33:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:30 INFO - Downloading blessings-1.6.tar.gz 03:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:30 INFO - Installing collected packages: blessings 03:33:30 INFO - Running setup.py install for blessings 03:33:31 INFO - Successfully installed blessings 03:33:31 INFO - Cleaning up... 03:33:31 INFO - Return code: 0 03:33:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:31 INFO - Reading from file tmpfile_stdout 03:33:31 INFO - Current package versions: 03:33:31 INFO - argparse == 1.2.1 03:33:31 INFO - blessings == 1.6 03:33:31 INFO - blobuploader == 1.2.4 03:33:31 INFO - docopt == 0.6.1 03:33:31 INFO - functools32 == 3.2.3-2 03:33:31 INFO - jsonschema == 2.5.1 03:33:31 INFO - manifestparser == 1.1 03:33:31 INFO - mozInstall == 1.12 03:33:31 INFO - mozcrash == 0.17 03:33:31 INFO - mozdebug == 0.1 03:33:31 INFO - mozdevice == 0.48 03:33:31 INFO - mozfile == 1.2 03:33:31 INFO - mozhttpd == 0.7 03:33:31 INFO - mozinfo == 0.9 03:33:31 INFO - mozleak == 0.1 03:33:31 INFO - mozlog == 3.2 03:33:31 INFO - moznetwork == 0.27 03:33:31 INFO - mozprocess == 0.23 03:33:31 INFO - mozprofile == 0.28 03:33:31 INFO - mozrunner == 6.12 03:33:31 INFO - mozscreenshot == 0.1 03:33:31 INFO - mozsystemmonitor == 0.3 03:33:31 INFO - moztest == 0.7 03:33:31 INFO - mozversion == 1.4 03:33:31 INFO - psutil == 3.1.1 03:33:31 INFO - requests == 1.2.3 03:33:31 INFO - wsgiref == 0.1.2 03:33:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:31 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')]} 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 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')]} 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 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 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33:31 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 03:33:31 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 03:33:31 INFO - Using env: {'DISPLAY': ':0', 03:33:31 INFO - 'HOME': '/home/cltbld', 03:33:31 INFO - 'LANG': 'en_US.UTF-8', 03:33:31 INFO - 'LANGUAGE': 'en_US:en', 03:33:31 INFO - 'LOGNAME': 'cltbld', 03:33:31 INFO - 'MAIL': '/var/mail/cltbld', 03:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:31 INFO - 'MOZ_NO_REMOTE': '1', 03:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:31 INFO - 'NO_EM_RESTART': '1', 03:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:31 INFO - 'PWD': '/builds/slave/test', 03:33:31 INFO - 'SHELL': '/bin/bash', 03:33:31 INFO - 'SHLVL': '1', 03:33:31 INFO - 'TERM': 'linux', 03:33:31 INFO - 'TMOUT': '86400', 03:33:31 INFO - 'USER': 'cltbld', 03:33:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:31 INFO - '_': '/tools/buildbot/bin/python'} 03:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 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)) 03:33:31 INFO - Cleaning up... 03:33:31 INFO - Return code: 0 03:33:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:31 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')]} 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 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')]} 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 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 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33:31 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 03:33:31 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 03:33:31 INFO - Using env: {'DISPLAY': ':0', 03:33:31 INFO - 'HOME': '/home/cltbld', 03:33:31 INFO - 'LANG': 'en_US.UTF-8', 03:33:31 INFO - 'LANGUAGE': 'en_US:en', 03:33:31 INFO - 'LOGNAME': 'cltbld', 03:33:31 INFO - 'MAIL': '/var/mail/cltbld', 03:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:31 INFO - 'MOZ_NO_REMOTE': '1', 03:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:31 INFO - 'NO_EM_RESTART': '1', 03:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:31 INFO - 'PWD': '/builds/slave/test', 03:33:31 INFO - 'SHELL': '/bin/bash', 03:33:31 INFO - 'SHLVL': '1', 03:33:31 INFO - 'TERM': 'linux', 03:33:31 INFO - 'TMOUT': '86400', 03:33:31 INFO - 'USER': 'cltbld', 03:33:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:31 INFO - '_': '/tools/buildbot/bin/python'} 03:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:31 INFO - Cleaning up... 03:33:31 INFO - Return code: 0 03:33:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:33:31 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')]} 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 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')]} 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 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 0x7f0b08509f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, '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': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', '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 03:33:31 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 03:33:31 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 03:33:31 INFO - Using env: {'DISPLAY': ':0', 03:33:31 INFO - 'HOME': '/home/cltbld', 03:33:31 INFO - 'LANG': 'en_US.UTF-8', 03:33:31 INFO - 'LANGUAGE': 'en_US:en', 03:33:31 INFO - 'LOGNAME': 'cltbld', 03:33:31 INFO - 'MAIL': '/var/mail/cltbld', 03:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:31 INFO - 'MOZ_NO_REMOTE': '1', 03:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:31 INFO - 'NO_EM_RESTART': '1', 03:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:31 INFO - 'PWD': '/builds/slave/test', 03:33:31 INFO - 'SHELL': '/bin/bash', 03:33:31 INFO - 'SHLVL': '1', 03:33:31 INFO - 'TERM': 'linux', 03:33:31 INFO - 'TMOUT': '86400', 03:33:31 INFO - 'USER': 'cltbld', 03:33:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:31 INFO - '_': '/tools/buildbot/bin/python'} 03:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:31 INFO - Downloading/unpacking flake8 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:33:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:33:33 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 03:33:33 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 03:33:33 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 03:33:33 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 03:33:33 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 03:33:33 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 03:33:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:33:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:33:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:34 INFO - no previously-included directories found matching 'docs/_build' 03:33:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:33:34 INFO - Running setup.py install for pep8 03:33:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:34 INFO - no previously-included directories found matching 'docs/_build' 03:33:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:33:34 INFO - Cleaning up... 03:33:34 INFO - Return code: 0 03:33:34 INFO - Running post-action listener: _resource_record_post_action 03:33:34 INFO - Running post-action listener: _start_resource_monitoring 03:33:34 INFO - Starting resource monitoring. 03:33:34 INFO - ##### 03:33:34 INFO - ##### Finished create-virtualenv step (success) 03:33:34 INFO - ##### 03:33:34 INFO - ##### 03:33:34 INFO - ##### Running install step. 03:33:34 INFO - ##### 03:33:34 INFO - Running pre-action listener: _resource_record_pre_action 03:33:34 INFO - Running main action method: install 03:33:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:35 INFO - Reading from file tmpfile_stdout 03:33:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:35 INFO - Reading from file tmpfile_stdout 03:33:35 INFO - Output received: 03:33:35 INFO - Usage: mozinstall [options] installer 03:33:35 INFO - Options: 03:33:35 INFO - -h, --help show this help message and exit 03:33:35 INFO - -d DEST, --destination=DEST 03:33:35 INFO - Directory to install application into. [default: 03:33:35 INFO - "/builds/slave/test"] 03:33:35 INFO - --app=APP Application being installed. [default: firefox] 03:33:35 INFO - mkdir: /builds/slave/test/build/application 03:33:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:51 INFO - Reading from file tmpfile_stdout 03:33:51 INFO - Output received: 03:33:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:51 INFO - Running post-action listener: _resource_record_post_action 03:33:51 INFO - ##### 03:33:51 INFO - ##### Finished install step (success) 03:33:51 INFO - ##### 03:33:51 INFO - ##### 03:33:51 INFO - ##### Running run-tests step. 03:33:51 INFO - ##### 03:33:51 INFO - Running pre-action listener: _resource_record_pre_action 03:33:51 INFO - Running main action method: run_tests 03:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:51 INFO - Python 2.7.3 03:33:51 INFO - Return code: 0 03:33:51 INFO - grabbing minidump binary from tooltool 03:33:51 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')]} 03:33:51 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 0x14481c0>, '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 0x14490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1449550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:51 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 03:33:51 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 03:33:51 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 03:33:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:51 INFO - Return code: 0 03:33:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:33:52 INFO - Return code: 0 03:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:33:52 INFO - Using env: {'DISPLAY': ':0', 03:33:52 INFO - 'HOME': '/home/cltbld', 03:33:52 INFO - 'LANG': 'en_US.UTF-8', 03:33:52 INFO - 'LANGUAGE': 'en_US:en', 03:33:52 INFO - 'LOGNAME': 'cltbld', 03:33:52 INFO - 'MAIL': '/var/mail/cltbld', 03:33:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:52 INFO - 'MOZ_NO_REMOTE': '1', 03:33:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:52 INFO - 'NO_EM_RESTART': '1', 03:33:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:52 INFO - 'PWD': '/builds/slave/test', 03:33:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:52 INFO - 'SHELL': '/bin/bash', 03:33:52 INFO - 'SHLVL': '1', 03:33:52 INFO - 'TERM': 'linux', 03:33:52 INFO - 'TMOUT': '86400', 03:33:52 INFO - 'USER': 'cltbld', 03:33:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469183575.808026-825776876', 03:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:52 INFO - '_': '/tools/buildbot/bin/python'} 03:33:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:33:52 INFO - mozversion application_buildid: 20160722004032 03:33:52 INFO - mozversion application_changeset: f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 03:33:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:52 INFO - mozversion application_name: Firefox 03:33:52 INFO - mozversion application_remotingname: firefox-dev 03:33:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:52 INFO - mozversion application_vendor: Mozilla 03:33:52 INFO - mozversion application_version: 49.0a2 03:33:52 INFO - mozversion platform_buildid: 20160722004032 03:33:52 INFO - mozversion platform_changeset: f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 03:33:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:52 INFO - mozversion platform_version: 49.0a2 03:33:52 INFO - using testdate: 1469183632 03:33:52 INFO - actual date: 1469183632 03:33:52 INFO - starting webserver on 'localhost:56450' 03:33:52 INFO - SUITE-START | Running 2 tests 03:33:52 INFO - TEST-START | dromaeo_css 03:33:52 INFO - operating with platform_type : linux_ 03:33:52 INFO - Initialising browser for dromaeo_css test... 03:33:52 INFO - TEST-INFO | started process 20618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppaE80I/profile http://localhost:56450/getInfo.html) 03:33:57 INFO - PROCESS | 20618 | __metrics Screen width/height:1600/1200 03:33:57 INFO - PROCESS | 20618 | colorDepth:24 03:33:57 INFO - PROCESS | 20618 | Browser inner width/height: 1024/697 03:33:57 INFO - PROCESS | 20618 | __metrics 03:33:59 INFO - PROCESS | 20618 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:33:59 ERROR - PROCESS | 20618 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:34:00 INFO - TEST-INFO | 20618: exit 0 03:34:00 INFO - Browser initialized. 03:34:00 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:00 INFO - TEST-INFO | started process 20707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppaE80I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:11 INFO - PROCESS | 20707 | RSS: Main: 145702912 03:34:11 INFO - PROCESS | 20707 | 03:35:02 INFO - PROCESS | 20707 | 1469183702566 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] 03:37:11 INFO - PROCESS | 20707 | Cycle 1(1): loaded http://localhost:56450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56450/tests/dromaeo/cssquery-ext.html) 03:37:12 INFO - PROCESS | 20707 | RSS: Main: 249749504 03:37:12 INFO - PROCESS | 20707 | 03:40:14 INFO - PROCESS | 20707 | Cycle 1(1): loaded http://localhost:56450/tests/dromaeo/cssquery-ext.html (next: http://localhost:56450/tests/dromaeo/cssquery-jquery.html) 03:40:15 INFO - PROCESS | 20707 | RSS: Main: 228888576 03:40:15 INFO - PROCESS | 20707 | 03:43:16 INFO - PROCESS | 20707 | Cycle 1(1): loaded http://localhost:56450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56450/tests/dromaeo/cssquery-mootools.html) 03:43:17 INFO - PROCESS | 20707 | RSS: Main: 217403392 03:43:17 INFO - PROCESS | 20707 | 03:46:19 INFO - PROCESS | 20707 | Cycle 1(1): loaded http://localhost:56450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56450/tests/dromaeo/cssquery-prototype.html) 03:46:20 INFO - PROCESS | 20707 | RSS: Main: 223313920 03:46:20 INFO - PROCESS | 20707 | 03:49:22 INFO - PROCESS | 20707 | Cycle 1(1): loaded http://localhost:56450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56450/tests/dromaeo/cssquery-yui.html) 03:49:23 INFO - PROCESS | 20707 | RSS: Main: 202018816 03:49:23 INFO - PROCESS | 20707 | 03:52:25 INFO - PROCESS | 20707 | Cycle 1(1): loaded http://localhost:56450/tests/dromaeo/cssquery-yui.html (next: http://localhost:56450/tests/dromaeo/cssquery-dojo.html) 03:52:26 INFO - PROCESS | 20707 | RSS: Main: 257699840 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - PROCESS | 20707 | __start_tp_report 03:52:26 INFO - PROCESS | 20707 | _x_x_mozilla_page_load 03:52:26 INFO - PROCESS | 20707 | _x_x_mozilla_page_load_details 03:52:26 INFO - PROCESS | 20707 | |i|pagename|runs| 03:52:26 INFO - PROCESS | 20707 | |0;dojo.html;3304.058343372139;3321.8339083045857;3325.251818340874;3335.7331413486922;3366.680165384289;5333.519983201511;5412.431694672062;5419.810306639269;5435.782568697257;5436.972815135924;5342.412334643196;5380.166074258486;5392.1911713243035;5398.946010539893;5401.351837779463;4801.231802911535;4869.245266983606;4871.537203965627;4881.4630390657;4882.218844984804;4821.083994041139;4880.975595122037;4881.4630390657;4922.237053256751;4995.35060442142;4888.291197776338;4971.37857767779;4983.377077865267;4986.376702912136;5012.423571289294;4912.680675756064;4928.704277743311;4947.480514545993;4970.577500912426;4985.1774457214515;4749.240121580565;4768.189407800647;4864.854054378375;4871.464138944713;4886.364772579542;5290.418054014094;5291.894162116774;5306.204069389584;5360.035193665139;5367.651102678314;5568.192612071268;5731.197632331477;5748.942510574882;5759.712014399263;5772.971135144339;5725.541956643458;5784.595078344518;5789.478946894757;5838.766449342022;5843.941560584382;5454.045542030129;5456.809011684572;5457.017736807373;5463.344398672185;5475.09660905946;5729.684867332254;5808.6224395414165;5896.734646940898;5949.672767997802;5961.910571341434;5628.352739435018;5684.147377893349;5720.599558030898;5720.771169153188;5724.198612194296;5760.8271751847515;5761.020626493506;5763.106718458645;5787.797427090031;5802.4197580241635;5550.333959924835;5651.660900345993;5709.8287051388525;5722.284714410699;5729.627574207663;5762.971185144047;5766.538676905838;5769.0192667246665;5777.768889244383;5782.248307720053;4465.0623369092855;4465.285554311359;4476.239039363316;4485.394471746337;4495.617872480811;3881.3983832506005;3958.129211573507;4000.239954408711;4004.8598299059395;4043.534993475788;5514.834554963358;5521.171824226318;5531.225628412026;5541.390447050821;5557.499825015768;5767.682777447197;5782.971085144547;5787.247657804459;5791.594588378773;5794.246747922827;5346.518813306821;5403.297571315782;5454.072807622713;5464.426235245322;5531.8893622128135;4926.3349447824085;4929.162042452792;4929.926051109236;4932.876678083005;4961.355023846877;5981.312149102821;6016.278046634432;6022.789202377983;6026.367231440723;6039;5557.472040156179;5694.515966142759;5763.193152958673;5775.797847075332;5828.795992140254;6022.969885150546;6044.818655440344;6049.062395328731;6050.606710563799;6064.909026364697;5519.420460851713;5698.8290351289525;5702.543796496353;5724.3703192647945;5726.455986681259;5668.631538949955;5708.429157084258;5719.0277652798295;5759.424057594207;5766.798162064308;5576.0799468088935;5593.188987596857;5596.496315331639;5600.551955843604;5607.130894711327;5422.322209723785;5530.944690553204;5583.330000399978;5591.860203494945;5600.635958662674;5418.701971391612;5487;5491.697956612425;5491.917621235764;5537.584681148849;5626.803061892814;5638.295213098363;5646.0683987141665;5654.010548154139;5668;5324.733763311741;5358.089124848707;5418.674879507243;5494.80768173128;5519.420460851713 03:52:26 INFO - PROCESS | 20707 | |1;ext.html;603.2579926690171;652.0382435907038;652.8270008447762;660.922696005511;665.5108495255989;33449.49825752616;36331.091722706944;36335.63664363356;45733.542664573346;47053.7647311763;48123.27815082776;48598.514014859844;48612.27081593779;48645.51354486454;48681.51318486814;9081.046490118542;9224.723258302229;9225.630974761001;9237.445753254793;9239.168474837263;8275.54484503352;8438.78903027423;8480.321574274043;9097.363184577081;10588.629397971072;10793.892061079367;11124.221304508688;11128.721781955475;11131.888681113207;11166.050885674727;11041.282316649393;11093.778124437466;11117.55529778812;11129.054030407426;11131.666050018512;8320.209580089882;10488.528016239288;10905.34567925927;10915.781684366348;10920.617778377718;45569.544304557196;45605.31592026089;45840.54159458396;45883.31175032377;45949.31076033862;3713.3316003119426;3808.695304375671;3903.512060992376;4320.891977700551;4384.013596940695;32854.83572582146;33767.66232337694;33986.49020264698;36599;36602.26795464102;4623.86128416148;4633.212353899811;4637.234856248715;4666.4633567139535;4702.905941881178;386598;390565;390649;390933;393144.03427982965;66681.6665916677;67049.32950670431;67072.6646366765;67171;67190.32809671939;38917;39693.60306396957;39782.40326395106;41878.371824422655;41975;18111.90944045298;18159.092045397676;18264.45206643803;18377.448676539727;18384.35654752104;12156.635300940809;12227.755444891052;12231.327276999851;12232.143749937597;12236.204646697935;18341.541461463305;19877.900610497145;20664.793352066587;20832.47918802042;20979.895100524704;7205.7838264852135;7216;7305.671244793997;7347;7416.258374162649;1009.9040591143829;1057.8095942730229;1065.2131671906448;1231.34123244064;1237.672016915518;33611.15972100717;33795;34443.827780860935;34503.827480862434;34529.48205776916;1108.2187058124002;1141.2866958151155;1157.8842115788523;1216.6289281769145;1286.5046956921653;17801.643967120584;18106;18202.90898545499;18259.63480730378;18276.26894924215;627729;632339;632360;632595;632873;63871.36128638747;64749.352506475276;64768.352316477176;64832.35167648357;64861.35138648647;1319.3271431569776;1393.2894223945657;1393.7839634856614;1408.7745960646248;1445.3206992713408;34158;35878.820605896806;35888.28223435569;36244;36327.27345453129;52840.471595283554;53149.20276195937;53310.733446334074;53364.1995370062;53394.73302633462;446247;448927;449757;449953;450682;26636.8668156658;28780.856095719388;29411;29683.851580741957;31111;50405.49594504155;51691;52313.476865232384;52738;52778.20832687436;42668.359974599785;42990.57009429991;43285.3507197386;43416.78291608648;44004.77997609991;41810.58189418067;42418;42509.5749042518;42569;43507.56492435035;43497.56502434935;43903;44171;44617.10765784731;45142.32286515639;37549.81225093857;39536.802315988236;40071.599284007956;40173.39739903962;40327.798361008005;29922.401551969273;30267.848660756554;30403.695963040085;30428.239294017825;30710.539341909443 03:52:26 INFO - PROCESS | 20707 | |2;jquery.html;411.5740208883806;414.3929143804327;421.9346001369789;431.09470112763194;447.35804121086244;18819;19561.315353962633;20509.17963281467;20722.585548289062;20751.792482075176;19785;19894.701579476285;19946;20713.067911943963;20776.68834967477;5477.780888764454;5649.406812284692;5658.122990936411;5683.801066962657;5702.971485142569;5370.355557333126;5706.1440783882545;5713.8571535711735;5809.593328467009;5814.941850581504;5732.79935202268;5734.942650573483;5752.453516915886;5753.510951569122;5762.971185144069;5532.695701736403;5832.387599302097;5834.183214349994;5873;5886.499647529965;5511.559075273968;5700.543956483471;5745.109508026263;5753.942460575383;5759.481646651821;12807.871921280761;12886.613401597873;13105.86894131056;13222.669433264246;13306.40121194539;2271.704678391815;2272.953843086419;2281.8288628352775;2334.509752951882;2463.679721636194;10268.897311026943;10438.582456701723;10715.35707857531;10829;12242.143049986504;1967.085305333027;2010.5677279385002;2018.0918586636074;2049.907754151067;2125.829933605308;82763.58618206931;86590.54937835303;87334;87887;87914.56042719746;11230.438478076063;11468.197226194254;12169.69575760613;12187.146899716934;12535.122541422013;16609.83390166107;16706.83293167077;16709.91645041767;16720.6655866882;16737.414190503274;8644.135586441305;8725.956370218108;8758.080401557872;8782.429142105742;8871.64513419456;8455.492670439793;8545.658173673108;8617.224449799423;8619.310455163572;8631.266342360845;4918.631102667314;4977.104121258136;4994.80020799164;5029.698218106925;5097.566706829887;1656.6686662667514;2062.5153089024066;2093.528955984891;2103.8737675739503;2114.1395571896633;897.3404547657467;1000.1698590170141;1000.3247807729899;1038.2368958815264;1080.0711388206137;16661.750073748903;19722.70415943762;19857.900710496644;20007.499812504804;20203.898980505004;1016.2581315639625;1024.7643042100358;1037.419045334615;1039.4542864995938;1040.38617215843;10672.519736611872;10873.782524349626;11397.829032564518;11480.540778368939;11538.538458461568;487344;498957;503629;508795;535816;94668;95947;97275.51362243143;97429;98688.50655746675;1035.166690813902;1039.7088815131776;1057.2176589324;1062.1502797761914;1066.5307264803462;17650.5587360317;17901.19444625021;18050.097495125454;18075.186616602547;18138.365157219436;40082.39876401798;40486.1902761949;41256.72588263931;41361.58638413577;41703.7914810424;56182.71908640431;57466;57717.42282577288;58463;58790.11814822866;7866.52800831929;8761.080086590817;8848.867266991128;8891.73324800257;8978.147076027766;12954.28751418681;13430.39563219638;13494.797578036141;13606.455741770218;13644.454221831016;11878.46546905374;11906.107041971714;11928.224665396721;11982.400879956142;12385.19496232742;10848.240623156618;10924.071453926188;10965.451727413438;11081.11351091927;11528.884711152781;12001.699957501132;12133.029357651543;12196.878031219574;12262.816057758962;12478.688032799253;8196.795080123045;8782.604782784661;8850.026497085186;8964.058773828654;8970.865437018581;12105.273683579013;12163;12258.570950017063;12338.074644401526;12373.93813030929 03:52:26 INFO - PROCESS | 20707 | |3;mootools.html;1323.9223192566894;1496.266829253666;1511.9773203401946;1701.6171361443676;1853.2309091726934;9147.817043659123;9546.331756777028;9567.330286879922;9852.753681157974;9853.310268281222;9389;9575.856362154573;9578.185854202384;9581.281403894702;9594.328397012212;2156.4393257753018;2221.0116498158245;2223;2510.748925107484;2539.5428822811887;2505.1607711416696;2587.4307652316556;2589.5856662933934;2604.127617248215;2608.9086881959133;2469.8641574713383;2483.3046746910804;2497.2882728422405;2500.599904015358;2505.473850491399;2110.8100270975688;2435.780779729815;2492.8255022148364;2538.2512158913073;2543.5167318209483;2463.408781892351;2506.3608779761043;2509.473010667762;2511.6232565115197;2521.646969424282;8986.236169925563;9019.503927283997;9029.322800789902;9042.86435703465;9048;5628.54971602275;5791.391903850119;5796.565257605655;5808.12878068289;5813.331466881321;3392.5928888533535;3553.591336996227;3705.74059815813;3706.721995850322;3723.9813800931092;1153.429052618959;1204.7289359893953;1217.3000524698245;1221.865594784573;1232.5131573028602;13564.93217533916;13809.654758631115;13812.240326782023;13845.307734613229;13853.653658658413;5124.92312615311;5172.456892026283;5228.346456692913;5249.133892907627;5279.52484276417;11468.885311146782;11549.538018479167;11559.653210403701;11569.363684997237;11597.072234221241;5839.970800146057;5843.211166492554;5845.736941837543;5850.736716847667;5853.560982926212;4300.634446072119;5123.3339665843205;5151.22731590257;5259.05337039329;5295.338082739658;4179.498460184797;4239.703220774578;4456.131054444352;4473;4473;1374.5120482228665;1385.7020740540831;1396.5112210726165;1399.1255465334166;1424.9287535623384;995.0745806399973;1007.2244371833647;1012.3520946594185;1013.7262939006426;1032.99483502582;6222.968885155546;6245.469135123565;6341.55609107358;6354.555181137369;6471.838204044937;986.4574484033897;997.8253805584139;1046.4506134279563;1061.2359101446946;1062.9787404251872;4384;4526.705764125321;4550.431196100488;4590.724556526552;4624.560666736655;12139.575114870937;12310;12322.691932701755;12347.938260308641;12363.876361236273;11400.942995285137;11795.29228246308;11958.58144964922;12131.878681213251;12206.633800985985;8892.15524525169;9034.277257819358;9046.90953090487;9079.364444488823;9098.363114582047;6400.807975760735;6591.736330546724;6604.801855944329;6629.138212032405;6640.103586016019;10978.176636752116;11241.66275011751;11256.437178141225;11276.436178190894;11319.264247823865;11392.487338069972;11439.14206434504;11498.022668072972;11543.653690389301;11574.18980671345;7443.516171448839;7924.762257132064;8142.51144931306;8359.95820020896;8422.284105851071;9097.59060842277;9386.718398448058;9425.57584908667;9452.669156579486;9458.858117128386;8224.424290299861;8417.621207045575;8507;8598.269147122315;8646.567671616269;7945.920540794518;7997.080335761462;8151.1441298662785;8174.959125204336;8186.140455252113;7398.482106252511;7681.61591920413;7688.769336919901;7824.061112666289;7870.331021863206;5253.448387919213;5299.49654782795;5396.163594642837;5491.75287112073;5506.311711036121;5330.466953304638;5525.226468294361;5531.059719847555;5554.833354999357;5632.2678051853 03:52:26 INFO - PROCESS | 20707 | |4;prototype.html;347.31925426164713;349.07495137884604;354.17477277942396;354.9893503194904;358.49810265628116;5360.731963401829;5386.218998245252;5407.161889907061;5412.377576578685;5426.75579598918;5309.920351194735;5318.574514038877;5371.636479948829;5375.193720941851;5407.161889907071;3957.5250969883655;4211.768352740598;4217;4236.9576304237025;4240.597143271384;4192;4193.287141185991;4207.179599978005;4211.115665710205;4226.767527785971;3980.1641655252433;4170.624643782059;4172.895677608054;4185.446877404781;4191.371294305864;3935.940960885589;4104.40486129511;4110.198511290315;4148.91702165958;4201.747895126302;3696.2607478504406;3699.241655460651;3704.8703295384803;3714.53568303962;3718.442233664945;5196.480351964811;5205.193195054772;5223.537409525301;5236.423993360727;5261.5790736741355;4695.5539223773685;4821.276808478756;4827.734474603895;4839.782209800567;4849.563539281482;5565;5583.8604034899045;5591.916121258185;5602.719864006784;5613.607047506676;4037.2732908076537;4075.4294398784195;4087.1212689271947;4087.816048277835;4113.239050775616;5542.7782888684405;5770.567207459415;5794.710264486759;5806.951350540958;5840.3575606683235;4120.17596480705;4154.667626589866;4155.771432571177;4160.771157586301;4166.7708276045105;4194.6853985951175;4199.118185181146;4208.389783481378;4218.692205416331;4230.598093181143;4672.883177920511;4733.9763301183275;4796.2805579163405;4818.759062046884;4838.637102217348;5623.313006098154;5645.713486038161;5664.886702266014;5720.628159169641;5722.37053924068;1433.5592729307189;1460.1750011243614;1464.8901332399898;1472.1167299620142;1477.0694462488777;908.1780988205685;940.4028441939417;945.7493764152505;948.966786162481;949.6248981652346;4893.119238537098;4898.4772841986405;4898.706077635354;4940.407151141886;4940.505949405031;5118.206677964921;5168.250603662448;5178.404483484373;5185.922211166836;5209.6874187548865;5071.974640126849;5088.465711100355;5334.466553344634;5528.668279903139;5540.168974653753;3049.161480592855;3087.8919237826567;3101.984490077535;3102.488089465258;3107.440660681099;5849;6070.939290607126;6080.209572755602;6080.601461663842;6081.331053584102;5852.473277405054;5891.675957822275;5908.438698323653;5911.290645122613;5917.349091599921;5996.850078747979;6030.517558595389;6040.244969378828;6044.153818465418;6045.425684559959;5684.687342196219;5783.363829978614;5819.4180581943165;5858.94141058584;5873.324567674772;5743.971280143573;5752.856178595569;5755.223044888887;5804.593678442468;5813.593048486566;5909.6158749681135;5937.7921772737745;5974.37269086757;6056.36408177135;6056.878862422815;4194.601512856274;4199;4199.803056128989;4206.705530612828;4222.915541689087;5771.394003629726;5794.739236734273;5797.8550536236935;5833.416658334302;5847.883042339215;5475.67145971243;5548.805791797429;5638.577106716931;5663.2071509989455;5673.546116310603;5600.775968961359;5604.719764011702;5617.314805558234;5628.915566266591;5634.323881134126;5434.212039254365;5444.183372493999;5501.339839219319;5503.064479038653;5542.2795036644975;5196.116660167705;5393.379761327497;5627.212190293444;5628.971855140698;5659.962413531043;5499.202615620793;5524.696141712245;5528.9723551381985;5549.445055494418;5556.555475562026 03:52:26 INFO - PROCESS | 20707 | |5;yui.html;845.5529262665968;850.3622283287526;869.9521526316053;885.5837756254563;898.380117718774;14130.646733831647;16052.117133557664;16494.67010659786;16498.175091245448;16538.255778489965;15090.698186036272;15382.230888455588;15403;15582.376704931818;15606.765898511532;728.3663213004693;837.5058715357937;857.3441317392185;874.637025634361;875.7547886591765;861.0399404663817;868.4398562926908;868.6134670071821;868.7784614923218;869.3002133282705;925.3892430995544;926.972190834276;927.8144371125768;927.9653186696818;928.2666693312309;752.6613024139132;877.2236570635034;913.808100298938;919.5723988345418;920.894097178823;669.6183175589915;670.5674839728397;670.8222321084917;671.2850813883199;671.4024518178825;15333.386664533406;15383.923080384639;15398.692026159413;15433.3826646934;15434.691306173925;14392.881369458488;14407.711845763131;14774.187419691913;14957.551273461813;14980.325885335185;11461.656150315504;11492.425378731114;11516.078713702967;11526.366049867254;11618.360990145538;4583.152116858359;4617.445906491243;4619.5611416915335;4639.141758774637;4682.29765535169;77831.31932210107;79441;79960;80691;80764.19235807625;11221.214514983873;11364.94317528407;11459.083273338112;11704.648860534198;11993.760124797629;21754.673679894815;21793.455163621038;22057.77942220557;22063.33809985703;22228.11087556512;8634.352423568258;8707.825843483095;8872.600732967032;8905.332100092519;8975.506347150838;5048.697078175322;5077.365329333833;5099.566536844335;5275.683458992396;5325.627206095536;3663.6885864701267;3750.643688849555;3755.455458958436;3758.0416993666986;3766.6798322142927;624.0202881476039;626.9247690277195;627.9434850863353;628.8585068359674;629.8488362792897;507.7841917185182;608.4250383387745;644.3974883483958;689.36233983565;720.9639518024078;9605.855912161323;10016.29885907994;10016.799664006825;10137.898621013695;10236.897631023743;638.7572722365564;641.4419455074022;695.9826004349932;711.3668834737089;791.8297566023217;4365.890852728644;4488.5447560660095;4592.563706447882;4595.839145629887;4683.882902927454;100046;112442;112659.4367028176;113041.43479282552;113191;71226;92667;93485;95854.0414595859;98209.50895245478;87424.5628771852;88576.9999999987;88999.55500222457;89458;89562.10437895538;8473.110323416198;8560.529170895661;8585.570721464026;8662.090480499708;8672.956635216784;49469;50751.73928416667;51072.23391649203;51191.744041279555;51202.74398628132;70999;74787.62606186935;75676.24323756913;76594.23405766094;77365.61317193379;12838.614841554769;12879.613611591667;12884.621131376274;12982.675433113869;13083.476660933457;13976.161430314214;14127.505537306144;14269.928650356682;14329.57011289663;14623.780643290147;14597.416103355747;14891.851081489047;15047.623809404853;15186.164760938254;15613.84386156124;12342.691432714253;12650.240985540897;12725.300108494122;12879.034072444792;13083.41124649412;13362.782992821507;14402.351894164998;14484.710305793615;14611.488597899448;15074.09555426678;12016.33910134916;12533.561325353568;12570.560030398892;12596.244225346509;12877.098603097693;12053.698657533632;12348.629541113782;12353.814692779435;12368.628941131781;12419.689507762378 03:52:26 INFO - PROCESS | 20707 | __end_tp_report 03:52:26 INFO - PROCESS | 20707 | __start_cc_report 03:52:26 INFO - PROCESS | 20707 | _x_x_mozilla_cycle_collect,887 03:52:26 INFO - PROCESS | 20707 | __end_cc_report 03:52:26 INFO - PROCESS | 20707 | __startTimestamp1469184746017__endTimestamp 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - PROCESS | 20707 | ------- Summary: start ------- 03:52:26 INFO - PROCESS | 20707 | Number of tests: 6 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - PROCESS | 20707 | [#0] dojo.html Cycles:165 Average:5355.78 Median:5530.94 stddev:577.60 (10.4%) stddev-sans-first:556.49 03:52:26 INFO - PROCESS | 20707 | Values: 3304.1 3321.8 3325.3 3335.7 3366.7 5333.5 5412.4 5419.8 5435.8 5437.0 5342.4 5380.2 5392.2 5398.9 5401.4 4801.2 4869.2 4871.5 4881.5 4882.2 4821.1 4881.0 4881.5 4922.2 4995.4 4888.3 4971.4 4983.4 4986.4 5012.4 4912.7 4928.7 4947.5 4970.6 4985.2 4749.2 4768.2 4864.9 4871.5 4886.4 5290.4 5291.9 5306.2 5360.0 5367.7 5568.2 5731.2 5748.9 5759.7 5773.0 5725.5 5784.6 5789.5 5838.8 5843.9 5454.0 5456.8 5457.0 5463.3 5475.1 5729.7 5808.6 5896.7 5949.7 5961.9 5628.4 5684.1 5720.6 5720.8 5724.2 5760.8 5761.0 5763.1 5787.8 5802.4 5550.3 5651.7 5709.8 5722.3 5729.6 5763.0 5766.5 5769.0 5777.8 5782.2 4465.1 4465.3 4476.2 4485.4 4495.6 3881.4 3958.1 4000.2 4004.9 4043.5 5514.8 5521.2 5531.2 5541.4 5557.5 5767.7 5783.0 5787.2 5791.6 5794.2 5346.5 5403.3 5454.1 5464.4 5531.9 4926.3 4929.2 4929.9 4932.9 4961.4 5981.3 6016.3 6022.8 6026.4 6039.0 5557.5 5694.5 5763.2 5775.8 5828.8 6023.0 6044.8 6049.1 6050.6 6064.9 5519.4 5698.8 5702.5 5724.4 5726.5 5668.6 5708.4 5719.0 5759.4 5766.8 5576.1 5593.2 5596.5 5600.6 5607.1 5422.3 5530.9 5583.3 5591.9 5600.6 5418.7 5487.0 5491.7 5491.9 5537.6 5626.8 5638.3 5646.1 5654.0 5668.0 5324.7 5358.1 5418.7 5494.8 5519.4 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - PROCESS | 20707 | [#1] ext.html Cycles:180 Average:65442.08 Median:39927.00 stddev:133202.49 (333.6%) stddev-sans-first:133487.20 03:52:26 INFO - PROCESS | 20707 | Values: 603.3 652.0 652.8 660.9 665.5 33449.5 36331.1 36335.6 45733.5 47053.8 48123.3 48598.5 48612.3 48645.5 48681.5 9081.0 9224.7 9225.6 9237.4 9239.2 8275.5 8438.8 8480.3 9097.4 10588.6 10793.9 11124.2 11128.7 11131.9 11166.1 11041.3 11093.8 11117.6 11129.1 11131.7 8320.2 10488.5 10905.3 10915.8 10920.6 45569.5 45605.3 45840.5 45883.3 45949.3 3713.3 3808.7 3903.5 4320.9 4384.0 32854.8 33767.7 33986.5 36599.0 36602.3 4623.9 4633.2 4637.2 4666.5 4702.9 386598.0 390565.0 390649.0 390933.0 393144.0 66681.7 67049.3 67072.7 67171.0 67190.3 38917.0 39693.6 39782.4 41878.4 41975.0 18111.9 18159.1 18264.5 18377.4 18384.4 12156.6 12227.8 12231.3 12232.1 12236.2 18341.5 19877.9 20664.8 20832.5 20979.9 7205.8 7216.0 7305.7 7347.0 7416.3 1009.9 1057.8 1065.2 1231.3 1237.7 33611.2 33795.0 34443.8 34503.8 34529.5 1108.2 1141.3 1157.9 1216.6 1286.5 17801.6 18106.0 18202.9 18259.6 18276.3 627729.0 632339.0 632360.0 632595.0 632873.0 63871.4 64749.4 64768.4 64832.4 64861.4 1319.3 1393.3 1393.8 1408.8 1445.3 34158.0 35878.8 35888.3 36244.0 36327.3 52840.5 53149.2 53310.7 53364.2 53394.7 446247.0 448927.0 449757.0 449953.0 450682.0 26636.9 28780.9 29411.0 29683.9 31111.0 50405.5 51691.0 52313.5 52738.0 52778.2 42668.4 42990.6 43285.4 43416.8 44004.8 41810.6 42418.0 42509.6 42569.0 43507.6 43497.6 43903.0 44171.0 44617.1 45142.3 37549.8 39536.8 40071.6 40173.4 40327.8 29922.4 30267.8 30403.7 30428.2 30710.5 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - PROCESS | 20707 | [#2] jquery.html Cycles:180 Average:29705.28 Median:2098.70 stddev:83719.19 (3989.1%) stddev-sans-first:83925.15 03:52:26 INFO - PROCESS | 20707 | Values: 411.6 414.4 421.9 431.1 447.4 18819.0 19561.3 20509.2 20722.6 20751.8 19785.0 19894.7 19946.0 20713.1 20776.7 5477.8 5649.4 5658.1 5683.8 5703.0 5370.4 5706.1 5713.9 5809.6 5814.9 5732.8 5734.9 5752.5 5753.5 5763.0 5532.7 5832.4 5834.2 5873.0 5886.5 5511.6 5700.5 5745.1 5753.9 5759.5 12807.9 12886.6 13105.9 13222.7 13306.4 2271.7 2273.0 2281.8 2334.5 2463.7 10268.9 10438.6 10715.4 10829.0 12242.1 1967.1 2010.6 2018.1 2049.9 2125.8 82763.6 86590.5 87334.0 87887.0 87914.6 11230.4 11468.2 12169.7 12187.1 12535.1 16609.8 16706.8 16709.9 16720.7 16737.4 8644.1 8726.0 8758.1 8782.4 8871.6 8455.5 8545.7 8617.2 8619.3 8631.3 4918.6 4977.1 4994.8 5029.7 5097.6 1656.7 2062.5 2093.5 2103.9 2114.1 897.3 1000.2 1000.3 1038.2 1080.1 16661.8 19722.7 19857.9 20007.5 20203.9 1016.3 1024.8 1037.4 1039.5 1040.4 10672.5 10873.8 11397.8 11480.5 11538.5 487344.0 498957.0 503629.0 508795.0 535816.0 94668.0 95947.0 97275.5 97429.0 98688.5 1035.2 1039.7 1057.2 1062.2 1066.5 17650.6 17901.2 18050.1 18075.2 18138.4 40082.4 40486.2 41256.7 41361.6 41703.8 56182.7 57466.0 57717.4 58463.0 58790.1 7866.5 8761.1 8848.9 8891.7 8978.1 12954.3 13430.4 13494.8 13606.5 13644.5 11878.5 11906.1 11928.2 11982.4 12385.2 10848.2 10924.1 10965.5 11081.1 11528.9 12001.7 12133.0 12196.9 12262.8 12478.7 8196.8 8782.6 8850.0 8964.1 8970.9 12105.3 12163.0 12258.6 12338.1 12373.9 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - PROCESS | 20707 | [#3] mootools.html Cycles:180 Average:6328.48 Median:4570.58 stddev:3667.83 (80.2%) stddev-sans-first:3658.83 03:52:26 INFO - PROCESS | 20707 | Values: 1323.9 1496.3 1512.0 1701.6 1853.2 9147.8 9546.3 9567.3 9852.8 9853.3 9389.0 9575.9 9578.2 9581.3 9594.3 2156.4 2221.0 2223.0 2510.7 2539.5 2505.2 2587.4 2589.6 2604.1 2608.9 2469.9 2483.3 2497.3 2500.6 2505.5 2110.8 2435.8 2492.8 2538.3 2543.5 2463.4 2506.4 2509.5 2511.6 2521.6 8986.2 9019.5 9029.3 9042.9 9048.0 5628.5 5791.4 5796.6 5808.1 5813.3 3392.6 3553.6 3705.7 3706.7 3724.0 1153.4 1204.7 1217.3 1221.9 1232.5 13564.9 13809.7 13812.2 13845.3 13853.7 5124.9 5172.5 5228.3 5249.1 5279.5 11468.9 11549.5 11559.7 11569.4 11597.1 5840.0 5843.2 5845.7 5850.7 5853.6 4300.6 5123.3 5151.2 5259.1 5295.3 4179.5 4239.7 4456.1 4473.0 4473.0 1374.5 1385.7 1396.5 1399.1 1424.9 995.1 1007.2 1012.4 1013.7 1033.0 6223.0 6245.5 6341.6 6354.6 6471.8 986.5 997.8 1046.5 1061.2 1063.0 4384.0 4526.7 4550.4 4590.7 4624.6 12139.6 12310.0 12322.7 12347.9 12363.9 11400.9 11795.3 11958.6 12131.9 12206.6 8892.2 9034.3 9046.9 9079.4 9098.4 6400.8 6591.7 6604.8 6629.1 6640.1 10978.2 11241.7 11256.4 11276.4 11319.3 11392.5 11439.1 11498.0 11543.7 11574.2 7443.5 7924.8 8142.5 8360.0 8422.3 9097.6 9386.7 9425.6 9452.7 9458.9 8224.4 8417.6 8507.0 8598.3 8646.6 7945.9 7997.1 8151.1 8175.0 8186.1 7398.5 7681.6 7688.8 7824.1 7870.3 5253.4 5299.5 5396.2 5491.8 5506.3 5330.5 5525.2 5531.1 5554.8 5632.3 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - PROCESS | 20707 | [#4] prototype.html Cycles:180 Average:4718.34 Median:5347.60 stddev:1379.87 (25.8%) stddev-sans-first:1344.17 03:52:26 INFO - PROCESS | 20707 | Values: 347.3 349.1 354.2 355.0 358.5 5360.7 5386.2 5407.2 5412.4 5426.8 5309.9 5318.6 5371.6 5375.2 5407.2 3957.5 4211.8 4217.0 4237.0 4240.6 4192.0 4193.3 4207.2 4211.1 4226.8 3980.2 4170.6 4172.9 4185.4 4191.4 3935.9 4104.4 4110.2 4148.9 4201.7 3696.3 3699.2 3704.9 3714.5 3718.4 5196.5 5205.2 5223.5 5236.4 5261.6 4695.6 4821.3 4827.7 4839.8 4849.6 5565.0 5583.9 5591.9 5602.7 5613.6 4037.3 4075.4 4087.1 4087.8 4113.2 5542.8 5770.6 5794.7 5807.0 5840.4 4120.2 4154.7 4155.8 4160.8 4166.8 4194.7 4199.1 4208.4 4218.7 4230.6 4672.9 4734.0 4796.3 4818.8 4838.6 5623.3 5645.7 5664.9 5720.6 5722.4 1433.6 1460.2 1464.9 1472.1 1477.1 908.2 940.4 945.7 949.0 949.6 4893.1 4898.5 4898.7 4940.4 4940.5 5118.2 5168.3 5178.4 5185.9 5209.7 5072.0 5088.5 5334.5 5528.7 5540.2 3049.2 3087.9 3102.0 3102.5 3107.4 5849.0 6070.9 6080.2 6080.6 6081.3 5852.5 5891.7 5908.4 5911.3 5917.3 5996.9 6030.5 6040.2 6044.2 6045.4 5684.7 5783.4 5819.4 5858.9 5873.3 5744.0 5752.9 5755.2 5804.6 5813.6 5909.6 5937.8 5974.4 6056.4 6056.9 4194.6 4199.0 4199.8 4206.7 4222.9 5771.4 5794.7 5797.9 5833.4 5847.9 5475.7 5548.8 5638.6 5663.2 5673.5 5600.8 5604.7 5617.3 5628.9 5634.3 5434.2 5444.2 5501.3 5503.1 5542.3 5196.1 5393.4 5627.2 5629.0 5660.0 5499.2 5524.7 5529.0 5549.4 5556.6 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - PROCESS | 20707 | [#5] yui.html Cycles:180 Average:20781.86 Median:4629.35 stddev:29264.86 (632.2%) stddev-sans-first:29308.67 03:52:26 INFO - PROCESS | 20707 | Values: 845.6 850.4 870.0 885.6 898.4 14130.6 16052.1 16494.7 16498.2 16538.3 15090.7 15382.2 15403.0 15582.4 15606.8 728.4 837.5 857.3 874.6 875.8 861.0 868.4 868.6 868.8 869.3 925.4 927.0 927.8 928.0 928.3 752.7 877.2 913.8 919.6 920.9 669.6 670.6 670.8 671.3 671.4 15333.4 15383.9 15398.7 15433.4 15434.7 14392.9 14407.7 14774.2 14957.6 14980.3 11461.7 11492.4 11516.1 11526.4 11618.4 4583.2 4617.4 4619.6 4639.1 4682.3 77831.3 79441.0 79960.0 80691.0 80764.2 11221.2 11364.9 11459.1 11704.6 11993.8 21754.7 21793.5 22057.8 22063.3 22228.1 8634.4 8707.8 8872.6 8905.3 8975.5 5048.7 5077.4 5099.6 5275.7 5325.6 3663.7 3750.6 3755.5 3758.0 3766.7 624.0 626.9 627.9 628.9 629.8 507.8 608.4 644.4 689.4 721.0 9605.9 10016.3 10016.8 10137.9 10236.9 638.8 641.4 696.0 711.4 791.8 4365.9 4488.5 4592.6 4595.8 4683.9 100046.0 112442.0 112659.4 113041.4 113191.0 71226.0 92667.0 93485.0 95854.0 98209.5 87424.6 88577.0 88999.6 89458.0 89562.1 8473.1 8560.5 8585.6 8662.1 8673.0 49469.0 50751.7 51072.2 51191.7 51202.7 70999.0 74787.6 75676.2 76594.2 77365.6 12838.6 12879.6 12884.6 12982.7 13083.5 13976.2 14127.5 14269.9 14329.6 14623.8 14597.4 14891.9 15047.6 15186.2 15613.8 12342.7 12650.2 12725.3 12879.0 13083.4 13362.8 14402.4 14484.7 14611.5 15074.1 12016.3 12533.6 12570.6 12596.2 12877.1 12053.7 12348.6 12353.8 12368.6 12419.7 03:52:26 INFO - PROCESS | 20707 | -------- Summary: end -------- 03:52:26 INFO - PROCESS | 20707 | 03:52:26 INFO - TEST-INFO | 20707: exit 0 03:52:26 INFO - TEST-OK | dromaeo_css | took 1114346ms 03:52:26 INFO - TEST-START | kraken 03:52:26 INFO - operating with platform_type : linux_ 03:52:26 INFO - Initialising browser for kraken test... 03:52:26 INFO - TEST-INFO | started process 20897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkwnhku/profile http://localhost:56450/getInfo.html) 03:52:31 INFO - PROCESS | 20897 | __metrics Screen width/height:1600/1200 03:52:31 INFO - PROCESS | 20897 | colorDepth:24 03:52:31 INFO - PROCESS | 20897 | Browser inner width/height: 1024/697 03:52:31 INFO - PROCESS | 20897 | __metrics 03:52:32 INFO - PROCESS | 20897 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:52:32 ERROR - PROCESS | 20897 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:52:33 INFO - TEST-INFO | 20897: exit 0 03:52:33 INFO - Browser initialized. 03:52:33 INFO - Running cycle 1/1 for kraken test... 03:52:33 INFO - TEST-INFO | started process 20988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkwnhku/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:45 INFO - PROCESS | 20988 | RSS: Main: 149225472 03:52:45 INFO - PROCESS | 20988 | 03:52:47 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56450/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:48 INFO - PROCESS | 20988 | RSS: Main: 198680576 03:52:48 INFO - PROCESS | 20988 | 03:52:51 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56450/tests/kraken/driver.html?testName=audio-dft) 03:52:51 INFO - PROCESS | 20988 | RSS: Main: 194801664 03:52:51 INFO - PROCESS | 20988 | 03:52:54 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56450/tests/kraken/driver.html?testName=audio-fft) 03:52:55 INFO - PROCESS | 20988 | RSS: Main: 281923584 03:52:55 INFO - PROCESS | 20988 | 03:52:57 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56450/tests/kraken/driver.html?testName=audio-oscillator) 03:52:57 INFO - PROCESS | 20988 | RSS: Main: 190119936 03:52:57 INFO - PROCESS | 20988 | 03:53:00 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:00 INFO - PROCESS | 20988 | RSS: Main: 189599744 03:53:00 INFO - PROCESS | 20988 | 03:53:03 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56450/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:04 INFO - PROCESS | 20988 | RSS: Main: 224399360 03:53:04 INFO - PROCESS | 20988 | 03:53:07 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56450/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:08 INFO - PROCESS | 20988 | RSS: Main: 224559104 03:53:08 INFO - PROCESS | 20988 | 03:53:11 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56450/tests/kraken/driver.html?testName=json-parse-financial) 03:53:11 INFO - PROCESS | 20988 | RSS: Main: 225267712 03:53:11 INFO - PROCESS | 20988 | 03:53:13 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:13 INFO - PROCESS | 20988 | RSS: Main: 203481088 03:53:13 INFO - PROCESS | 20988 | 03:53:15 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56450/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:16 INFO - PROCESS | 20988 | RSS: Main: 205127680 03:53:16 INFO - PROCESS | 20988 | 03:53:18 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:18 INFO - PROCESS | 20988 | RSS: Main: 209993728 03:53:18 INFO - PROCESS | 20988 | 03:53:21 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:21 INFO - PROCESS | 20988 | RSS: Main: 217038848 03:53:21 INFO - PROCESS | 20988 | 03:53:24 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:25 INFO - PROCESS | 20988 | RSS: Main: 216948736 03:53:25 INFO - PROCESS | 20988 | 03:53:26 INFO - PROCESS | 20988 | Cycle 1(1): loaded http://localhost:56450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56450/tests/kraken/driver.html?testName=ai-astar) 03:53:27 INFO - PROCESS | 20988 | RSS: Main: 259289088 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | __start_tp_report 03:53:27 INFO - PROCESS | 20988 | _x_x_mozilla_page_load 03:53:27 INFO - PROCESS | 20988 | _x_x_mozilla_page_load_details 03:53:27 INFO - PROCESS | 20988 | |i|pagename|runs| 03:53:27 INFO - PROCESS | 20988 | |0;ai-astar;112;103;109;111;111;111;110;108;110;111 03:53:27 INFO - PROCESS | 20988 | |1;audio-beat-detection;156;123;132;174;126;129;151;132;172;131 03:53:27 INFO - PROCESS | 20988 | |2;audio-dft;161;162;160;161;161;159;161;160;163;160 03:53:27 INFO - PROCESS | 20988 | |3;audio-fft;75;75;76;121;75;76;74;76;98;75 03:53:27 INFO - PROCESS | 20988 | |4;audio-oscillator;84;84;112;85;86;85;119;85;86;137 03:53:27 INFO - PROCESS | 20988 | |5;imaging-gaussian-blur;116;117;117;117;117;121;117;117;117;117 03:53:27 INFO - PROCESS | 20988 | |6;imaging-darkroom;146;146;145;145;146;146;145;146;145;146 03:53:27 INFO - PROCESS | 20988 | |7;imaging-desaturate;96;95;95;96;96;96;95;96;96;95 03:53:27 INFO - PROCESS | 20988 | |8;json-parse-financial;51;54;51;52;51;50;53;50;50;50 03:53:27 INFO - PROCESS | 20988 | |9;json-stringify-tinderbox;60;60;61;60;60;60;60;60;60;59 03:53:27 INFO - PROCESS | 20988 | |10;stanford-crypto-aes;76;77;77;76;79;77;78;77;105;77 03:53:27 INFO - PROCESS | 20988 | |11;stanford-crypto-ccm;124;127;119;115;123;117;122;127;138;129 03:53:27 INFO - PROCESS | 20988 | |12;stanford-crypto-pbkdf2;157;152;152;153;154;158;153;154;154;152 03:53:27 INFO - PROCESS | 20988 | |13;stanford-crypto-sha256-iterative;61;61;60;64;61;63;61;62;60;61 03:53:27 INFO - PROCESS | 20988 | __end_tp_report 03:53:27 INFO - PROCESS | 20988 | __start_cc_report 03:53:27 INFO - PROCESS | 20988 | _x_x_mozilla_cycle_collect,1605 03:53:27 INFO - PROCESS | 20988 | __end_cc_report 03:53:27 INFO - PROCESS | 20988 | __startTimestamp1469184807033__endTimestamp 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | ------- Summary: start ------- 03:53:27 INFO - PROCESS | 20988 | Number of tests: 14 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:2.59 (2.3%) stddev-sans-first:2.60 03:53:27 INFO - PROCESS | 20988 | Values: 112.0 103.0 109.0 111.0 111.0 111.0 110.0 108.0 110.0 111.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:141.50 stddev:19.16 (13.5%) stddev-sans-first:19.70 03:53:27 INFO - PROCESS | 20988 | Values: 156.0 123.0 132.0 174.0 126.0 129.0 151.0 132.0 172.0 131.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 03:53:27 INFO - PROCESS | 20988 | Values: 161.0 162.0 160.0 161.0 161.0 159.0 161.0 160.0 163.0 160.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:15.44 (20.4%) stddev-sans-first:16.16 03:53:27 INFO - PROCESS | 20988 | Values: 75.0 75.0 76.0 121.0 75.0 76.0 74.0 76.0 98.0 75.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:19.20 (22.6%) stddev-sans-first:19.84 03:53:27 INFO - PROCESS | 20988 | Values: 84.0 84.0 112.0 85.0 86.0 85.0 119.0 85.0 86.0 137.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:1.34 (1.1%) stddev-sans-first:1.33 03:53:27 INFO - PROCESS | 20988 | Values: 116.0 117.0 117.0 117.0 117.0 121.0 117.0 117.0 117.0 117.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:53:27 INFO - PROCESS | 20988 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:53:27 INFO - PROCESS | 20988 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.40 (2.7%) stddev-sans-first:1.48 03:53:27 INFO - PROCESS | 20988 | Values: 51.0 54.0 51.0 52.0 51.0 50.0 53.0 50.0 50.0 50.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 03:53:27 INFO - PROCESS | 20988 | Values: 60.0 60.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 59.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:77.00 stddev:8.86 (11.5%) stddev-sans-first:9.29 03:53:27 INFO - PROCESS | 20988 | Values: 76.0 77.0 77.0 76.0 79.0 77.0 78.0 77.0 105.0 77.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.50 stddev:6.66 (5.3%) stddev-sans-first:7.06 03:53:27 INFO - PROCESS | 20988 | Values: 124.0 127.0 119.0 115.0 123.0 117.0 122.0 127.0 138.0 129.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.00 stddev:2.08 (1.3%) stddev-sans-first:1.88 03:53:27 INFO - PROCESS | 20988 | Values: 157.0 152.0 152.0 153.0 154.0 158.0 153.0 154.0 154.0 152.0 03:53:27 INFO - PROCESS | 20988 | 03:53:27 INFO - PROCESS | 20988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:1.33 03:53:27 INFO - PROCESS | 20988 | Values: 61.0 61.0 60.0 64.0 61.0 63.0 61.0 62.0 60.0 61.0 03:53:27 INFO - PROCESS | 20988 | -------- Summary: end -------- 03:53:27 INFO - PROCESS | 20988 | 03:53:28 INFO - TEST-INFO | 20988: exit 0 03:53:28 INFO - TEST-OK | kraken | took 61256ms 03:53:28 INFO - SUITE-END | took 1175s 03:53:28 INFO - Completed test suite (00:19:35) 03:53:28 INFO - javascript benchmark 03:53:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.058343372139, 3321.8339083045857, 3325.251818340874, 3335.7331413486922, 3366.680165384289, 5333.519983201511, 5412.431694672062, 5419.810306639269, 5435.782568697257, 5436.972815135924, 5342.412334643196, 5380.166074258486, 5392.1911713243035, 5398.946010539893, 5401.351837779463, 4801.231802911535, 4869.245266983606, 4871.537203965627, 4881.4630390657, 4882.218844984804, 4821.083994041139, 4880.975595122037, 4881.4630390657, 4922.237053256751, 4995.35060442142, 4888.291197776338, 4971.37857767779, 4983.377077865267, 4986.376702912136, 5012.423571289294, 4912.680675756064, 4928.704277743311, 4947.480514545993, 4970.577500912426, 4985.1774457214515, 4749.240121580565, 4768.189407800647, 4864.854054378375, 4871.464138944713, 4886.364772579542, 5290.418054014094, 5291.894162116774, 5306.204069389584, 5360.035193665139, 5367.651102678314, 5568.192612071268, 5731.197632331477, 5748.942510574882, 5759.712014399263, 5772.971135144339, 5725.541956643458, 5784.595078344518, 5789.478946894757, 5838.766449342022, 5843.941560584382, 5454.045542030129, 5456.809011684572, 5457.017736807373, 5463.344398672185, 5475.09660905946, 5729.684867332254, 5808.6224395414165, 5896.734646940898, 5949.672767997802, 5961.910571341434, 5628.352739435018, 5684.147377893349, 5720.599558030898, 5720.771169153188, 5724.198612194296, 5760.8271751847515, 5761.020626493506, 5763.106718458645, 5787.797427090031, 5802.4197580241635, 5550.333959924835, 5651.660900345993, 5709.8287051388525, 5722.284714410699, 5729.627574207663, 5762.971185144047, 5766.538676905838, 5769.0192667246665, 5777.768889244383, 5782.248307720053, 4465.0623369092855, 4465.285554311359, 4476.239039363316, 4485.394471746337, 4495.617872480811, 3881.3983832506005, 3958.129211573507, 4000.239954408711, 4004.8598299059395, 4043.534993475788, 5514.834554963358, 5521.171824226318, 5531.225628412026, 5541.390447050821, 5557.499825015768, 5767.682777447197, 5782.971085144547, 5787.247657804459, 5791.594588378773, 5794.246747922827, 5346.518813306821, 5403.297571315782, 5454.072807622713, 5464.426235245322, 5531.8893622128135, 4926.3349447824085, 4929.162042452792, 4929.926051109236, 4932.876678083005, 4961.355023846877, 5981.312149102821, 6016.278046634432, 6022.789202377983, 6026.367231440723, 6039.0, 5557.472040156179, 5694.515966142759, 5763.193152958673, 5775.797847075332, 5828.795992140254, 6022.969885150546, 6044.818655440344, 6049.062395328731, 6050.606710563799, 6064.909026364697, 5519.420460851713, 5698.8290351289525, 5702.543796496353, 5724.3703192647945, 5726.455986681259, 5668.631538949955, 5708.429157084258, 5719.0277652798295, 5759.424057594207, 5766.798162064308, 5576.0799468088935, 5593.188987596857, 5596.496315331639, 5600.551955843604, 5607.130894711327, 5422.322209723785, 5530.944690553204, 5583.330000399978, 5591.860203494945, 5600.635958662674, 5418.701971391612, 5487.0, 5491.697956612425, 5491.917621235764, 5537.584681148849, 5626.803061892814, 5638.295213098363, 5646.0683987141665, 5654.010548154139, 5668.0, 5324.733763311741, 5358.089124848707, 5418.674879507243, 5494.80768173128, 5519.420460851713], "value": 5319.853606294533, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.2579926690171, 652.0382435907038, 652.8270008447762, 660.922696005511, 665.5108495255989, 33449.49825752616, 36331.091722706944, 36335.63664363356, 45733.542664573346, 47053.7647311763, 48123.27815082776, 48598.514014859844, 48612.27081593779, 48645.51354486454, 48681.51318486814, 9081.046490118542, 9224.723258302229, 9225.630974761001, 9237.445753254793, 9239.168474837263, 8275.54484503352, 8438.78903027423, 8480.321574274043, 9097.363184577081, 10588.629397971072, 10793.892061079367, 11124.221304508688, 11128.721781955475, 11131.888681113207, 11166.050885674727, 11041.282316649393, 11093.778124437466, 11117.55529778812, 11129.054030407426, 11131.666050018512, 8320.209580089882, 10488.528016239288, 10905.34567925927, 10915.781684366348, 10920.617778377718, 45569.544304557196, 45605.31592026089, 45840.54159458396, 45883.31175032377, 45949.31076033862, 3713.3316003119426, 3808.695304375671, 3903.512060992376, 4320.891977700551, 4384.013596940695, 32854.83572582146, 33767.66232337694, 33986.49020264698, 36599.0, 36602.26795464102, 4623.86128416148, 4633.212353899811, 4637.234856248715, 4666.4633567139535, 4702.905941881178, 386598.0, 390565.0, 390649.0, 390933.0, 393144.03427982965, 66681.6665916677, 67049.32950670431, 67072.6646366765, 67171.0, 67190.32809671939, 38917.0, 39693.60306396957, 39782.40326395106, 41878.371824422655, 41975.0, 18111.90944045298, 18159.092045397676, 18264.45206643803, 18377.448676539727, 18384.35654752104, 12156.635300940809, 12227.755444891052, 12231.327276999851, 12232.143749937597, 12236.204646697935, 18341.541461463305, 19877.900610497145, 20664.793352066587, 20832.47918802042, 20979.895100524704, 7205.7838264852135, 7216.0, 7305.671244793997, 7347.0, 7416.258374162649, 1009.9040591143829, 1057.8095942730229, 1065.2131671906448, 1231.34123244064, 1237.672016915518, 33611.15972100717, 33795.0, 34443.827780860935, 34503.827480862434, 34529.48205776916, 1108.2187058124002, 1141.2866958151155, 1157.8842115788523, 1216.6289281769145, 1286.5046956921653, 17801.643967120584, 18106.0, 18202.90898545499, 18259.63480730378, 18276.26894924215, 627729.0, 632339.0, 632360.0, 632595.0, 632873.0, 63871.36128638747, 64749.352506475276, 64768.352316477176, 64832.35167648357, 64861.35138648647, 1319.3271431569776, 1393.2894223945657, 1393.7839634856614, 1408.7745960646248, 1445.3206992713408, 34158.0, 35878.820605896806, 35888.28223435569, 36244.0, 36327.27345453129, 52840.471595283554, 53149.20276195937, 53310.733446334074, 53364.1995370062, 53394.73302633462, 446247.0, 448927.0, 449757.0, 449953.0, 450682.0, 26636.8668156658, 28780.856095719388, 29411.0, 29683.851580741957, 31111.0, 50405.49594504155, 51691.0, 52313.476865232384, 52738.0, 52778.20832687436, 42668.359974599785, 42990.57009429991, 43285.3507197386, 43416.78291608648, 44004.77997609991, 41810.58189418067, 42418.0, 42509.5749042518, 42569.0, 43507.56492435035, 43497.56502434935, 43903.0, 44171.0, 44617.10765784731, 45142.32286515639, 37549.81225093857, 39536.802315988236, 40071.599284007956, 40173.39739903962, 40327.798361008005, 29922.401551969273, 30267.848660756554, 30403.695963040085, 30428.239294017825, 30710.539341909443], "value": 21410.888277290025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.5740208883806, 414.3929143804327, 421.9346001369789, 431.09470112763194, 447.35804121086244, 18819.0, 19561.315353962633, 20509.17963281467, 20722.585548289062, 20751.792482075176, 19785.0, 19894.701579476285, 19946.0, 20713.067911943963, 20776.68834967477, 5477.780888764454, 5649.406812284692, 5658.122990936411, 5683.801066962657, 5702.971485142569, 5370.355557333126, 5706.1440783882545, 5713.8571535711735, 5809.593328467009, 5814.941850581504, 5732.79935202268, 5734.942650573483, 5752.453516915886, 5753.510951569122, 5762.971185144069, 5532.695701736403, 5832.387599302097, 5834.183214349994, 5873.0, 5886.499647529965, 5511.559075273968, 5700.543956483471, 5745.109508026263, 5753.942460575383, 5759.481646651821, 12807.871921280761, 12886.613401597873, 13105.86894131056, 13222.669433264246, 13306.40121194539, 2271.704678391815, 2272.953843086419, 2281.8288628352775, 2334.509752951882, 2463.679721636194, 10268.897311026943, 10438.582456701723, 10715.35707857531, 10829.0, 12242.143049986504, 1967.085305333027, 2010.5677279385002, 2018.0918586636074, 2049.907754151067, 2125.829933605308, 82763.58618206931, 86590.54937835303, 87334.0, 87887.0, 87914.56042719746, 11230.438478076063, 11468.197226194254, 12169.69575760613, 12187.146899716934, 12535.122541422013, 16609.83390166107, 16706.83293167077, 16709.91645041767, 16720.6655866882, 16737.414190503274, 8644.135586441305, 8725.956370218108, 8758.080401557872, 8782.429142105742, 8871.64513419456, 8455.492670439793, 8545.658173673108, 8617.224449799423, 8619.310455163572, 8631.266342360845, 4918.631102667314, 4977.104121258136, 4994.80020799164, 5029.698218106925, 5097.566706829887, 1656.6686662667514, 2062.5153089024066, 2093.528955984891, 2103.8737675739503, 2114.1395571896633, 897.3404547657467, 1000.1698590170141, 1000.3247807729899, 1038.2368958815264, 1080.0711388206137, 16661.750073748903, 19722.70415943762, 19857.900710496644, 20007.499812504804, 20203.898980505004, 1016.2581315639625, 1024.7643042100358, 1037.419045334615, 1039.4542864995938, 1040.38617215843, 10672.519736611872, 10873.782524349626, 11397.829032564518, 11480.540778368939, 11538.538458461568, 487344.0, 498957.0, 503629.0, 508795.0, 535816.0, 94668.0, 95947.0, 97275.51362243143, 97429.0, 98688.50655746675, 1035.166690813902, 1039.7088815131776, 1057.2176589324, 1062.1502797761914, 1066.5307264803462, 17650.5587360317, 17901.19444625021, 18050.097495125454, 18075.186616602547, 18138.365157219436, 40082.39876401798, 40486.1902761949, 41256.72588263931, 41361.58638413577, 41703.7914810424, 56182.71908640431, 57466.0, 57717.42282577288, 58463.0, 58790.11814822866, 7866.52800831929, 8761.080086590817, 8848.867266991128, 8891.73324800257, 8978.147076027766, 12954.28751418681, 13430.39563219638, 13494.797578036141, 13606.455741770218, 13644.454221831016, 11878.46546905374, 11906.107041971714, 11928.224665396721, 11982.400879956142, 12385.19496232742, 10848.240623156618, 10924.071453926188, 10965.451727413438, 11081.11351091927, 11528.884711152781, 12001.699957501132, 12133.029357651543, 12196.878031219574, 12262.816057758962, 12478.688032799253, 8196.795080123045, 8782.604782784661, 8850.026497085186, 8964.058773828654, 8970.865437018581, 12105.273683579013, 12163.0, 12258.570950017063, 12338.074644401526, 12373.93813030929], "value": 9357.206361942212, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.9223192566894, 1496.266829253666, 1511.9773203401946, 1701.6171361443676, 1853.2309091726934, 9147.817043659123, 9546.331756777028, 9567.330286879922, 9852.753681157974, 9853.310268281222, 9389.0, 9575.856362154573, 9578.185854202384, 9581.281403894702, 9594.328397012212, 2156.4393257753018, 2221.0116498158245, 2223.0, 2510.748925107484, 2539.5428822811887, 2505.1607711416696, 2587.4307652316556, 2589.5856662933934, 2604.127617248215, 2608.9086881959133, 2469.8641574713383, 2483.3046746910804, 2497.2882728422405, 2500.599904015358, 2505.473850491399, 2110.8100270975688, 2435.780779729815, 2492.8255022148364, 2538.2512158913073, 2543.5167318209483, 2463.408781892351, 2506.3608779761043, 2509.473010667762, 2511.6232565115197, 2521.646969424282, 8986.236169925563, 9019.503927283997, 9029.322800789902, 9042.86435703465, 9048.0, 5628.54971602275, 5791.391903850119, 5796.565257605655, 5808.12878068289, 5813.331466881321, 3392.5928888533535, 3553.591336996227, 3705.74059815813, 3706.721995850322, 3723.9813800931092, 1153.429052618959, 1204.7289359893953, 1217.3000524698245, 1221.865594784573, 1232.5131573028602, 13564.93217533916, 13809.654758631115, 13812.240326782023, 13845.307734613229, 13853.653658658413, 5124.92312615311, 5172.456892026283, 5228.346456692913, 5249.133892907627, 5279.52484276417, 11468.885311146782, 11549.538018479167, 11559.653210403701, 11569.363684997237, 11597.072234221241, 5839.970800146057, 5843.211166492554, 5845.736941837543, 5850.736716847667, 5853.560982926212, 4300.634446072119, 5123.3339665843205, 5151.22731590257, 5259.05337039329, 5295.338082739658, 4179.498460184797, 4239.703220774578, 4456.131054444352, 4473.0, 4473.0, 1374.5120482228665, 1385.7020740540831, 1396.5112210726165, 1399.1255465334166, 1424.9287535623384, 995.0745806399973, 1007.2244371833647, 1012.3520946594185, 1013.7262939006426, 1032.99483502582, 6222.968885155546, 6245.469135123565, 6341.55609107358, 6354.555181137369, 6471.838204044937, 986.4574484033897, 997.8253805584139, 1046.4506134279563, 1061.2359101446946, 1062.9787404251872, 4384.0, 4526.705764125321, 4550.431196100488, 4590.724556526552, 4624.560666736655, 12139.575114870937, 12310.0, 12322.691932701755, 12347.938260308641, 12363.876361236273, 11400.942995285137, 11795.29228246308, 11958.58144964922, 12131.878681213251, 12206.633800985985, 8892.15524525169, 9034.277257819358, 9046.90953090487, 9079.364444488823, 9098.363114582047, 6400.807975760735, 6591.736330546724, 6604.801855944329, 6629.138212032405, 6640.103586016019, 10978.176636752116, 11241.66275011751, 11256.437178141225, 11276.436178190894, 11319.264247823865, 11392.487338069972, 11439.14206434504, 11498.022668072972, 11543.653690389301, 11574.18980671345, 7443.516171448839, 7924.762257132064, 8142.51144931306, 8359.95820020896, 8422.284105851071, 9097.59060842277, 9386.718398448058, 9425.57584908667, 9452.669156579486, 9458.858117128386, 8224.424290299861, 8417.621207045575, 8507.0, 8598.269147122315, 8646.567671616269, 7945.920540794518, 7997.080335761462, 8151.1441298662785, 8174.959125204336, 8186.140455252113, 7398.482106252511, 7681.61591920413, 7688.769336919901, 7824.061112666289, 7870.331021863206, 5253.448387919213, 5299.49654782795, 5396.163594642837, 5491.75287112073, 5506.311711036121, 5330.466953304638, 5525.226468294361, 5531.059719847555, 5554.833354999357, 5632.2678051853], "value": 5026.356749846543, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.31925426164713, 349.07495137884604, 354.17477277942396, 354.9893503194904, 358.49810265628116, 5360.731963401829, 5386.218998245252, 5407.161889907061, 5412.377576578685, 5426.75579598918, 5309.920351194735, 5318.574514038877, 5371.636479948829, 5375.193720941851, 5407.161889907071, 3957.5250969883655, 4211.768352740598, 4217.0, 4236.9576304237025, 4240.597143271384, 4192.0, 4193.287141185991, 4207.179599978005, 4211.115665710205, 4226.767527785971, 3980.1641655252433, 4170.624643782059, 4172.895677608054, 4185.446877404781, 4191.371294305864, 3935.940960885589, 4104.40486129511, 4110.198511290315, 4148.91702165958, 4201.747895126302, 3696.2607478504406, 3699.241655460651, 3704.8703295384803, 3714.53568303962, 3718.442233664945, 5196.480351964811, 5205.193195054772, 5223.537409525301, 5236.423993360727, 5261.5790736741355, 4695.5539223773685, 4821.276808478756, 4827.734474603895, 4839.782209800567, 4849.563539281482, 5565.0, 5583.8604034899045, 5591.916121258185, 5602.719864006784, 5613.607047506676, 4037.2732908076537, 4075.4294398784195, 4087.1212689271947, 4087.816048277835, 4113.239050775616, 5542.7782888684405, 5770.567207459415, 5794.710264486759, 5806.951350540958, 5840.3575606683235, 4120.17596480705, 4154.667626589866, 4155.771432571177, 4160.771157586301, 4166.7708276045105, 4194.6853985951175, 4199.118185181146, 4208.389783481378, 4218.692205416331, 4230.598093181143, 4672.883177920511, 4733.9763301183275, 4796.2805579163405, 4818.759062046884, 4838.637102217348, 5623.313006098154, 5645.713486038161, 5664.886702266014, 5720.628159169641, 5722.37053924068, 1433.5592729307189, 1460.1750011243614, 1464.8901332399898, 1472.1167299620142, 1477.0694462488777, 908.1780988205685, 940.4028441939417, 945.7493764152505, 948.966786162481, 949.6248981652346, 4893.119238537098, 4898.4772841986405, 4898.706077635354, 4940.407151141886, 4940.505949405031, 5118.206677964921, 5168.250603662448, 5178.404483484373, 5185.922211166836, 5209.6874187548865, 5071.974640126849, 5088.465711100355, 5334.466553344634, 5528.668279903139, 5540.168974653753, 3049.161480592855, 3087.8919237826567, 3101.984490077535, 3102.488089465258, 3107.440660681099, 5849.0, 6070.939290607126, 6080.209572755602, 6080.601461663842, 6081.331053584102, 5852.473277405054, 5891.675957822275, 5908.438698323653, 5911.290645122613, 5917.349091599921, 5996.850078747979, 6030.517558595389, 6040.244969378828, 6044.153818465418, 6045.425684559959, 5684.687342196219, 5783.363829978614, 5819.4180581943165, 5858.94141058584, 5873.324567674772, 5743.971280143573, 5752.856178595569, 5755.223044888887, 5804.593678442468, 5813.593048486566, 5909.6158749681135, 5937.7921772737745, 5974.37269086757, 6056.36408177135, 6056.878862422815, 4194.601512856274, 4199.0, 4199.803056128989, 4206.705530612828, 4222.915541689087, 5771.394003629726, 5794.739236734273, 5797.8550536236935, 5833.416658334302, 5847.883042339215, 5475.67145971243, 5548.805791797429, 5638.577106716931, 5663.2071509989455, 5673.546116310603, 5600.775968961359, 5604.719764011702, 5617.314805558234, 5628.915566266591, 5634.323881134126, 5434.212039254365, 5444.183372493999, 5501.339839219319, 5503.064479038653, 5542.2795036644975, 5196.116660167705, 5393.379761327497, 5627.212190293444, 5628.971855140698, 5659.962413531043, 5499.202615620793, 5524.696141712245, 5528.9723551381985, 5549.445055494418, 5556.555475562026], "value": 4283.773649334642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.5529262665968, 850.3622283287526, 869.9521526316053, 885.5837756254563, 898.380117718774, 14130.646733831647, 16052.117133557664, 16494.67010659786, 16498.175091245448, 16538.255778489965, 15090.698186036272, 15382.230888455588, 15403.0, 15582.376704931818, 15606.765898511532, 728.3663213004693, 837.5058715357937, 857.3441317392185, 874.637025634361, 875.7547886591765, 861.0399404663817, 868.4398562926908, 868.6134670071821, 868.7784614923218, 869.3002133282705, 925.3892430995544, 926.972190834276, 927.8144371125768, 927.9653186696818, 928.2666693312309, 752.6613024139132, 877.2236570635034, 913.808100298938, 919.5723988345418, 920.894097178823, 669.6183175589915, 670.5674839728397, 670.8222321084917, 671.2850813883199, 671.4024518178825, 15333.386664533406, 15383.923080384639, 15398.692026159413, 15433.3826646934, 15434.691306173925, 14392.881369458488, 14407.711845763131, 14774.187419691913, 14957.551273461813, 14980.325885335185, 11461.656150315504, 11492.425378731114, 11516.078713702967, 11526.366049867254, 11618.360990145538, 4583.152116858359, 4617.445906491243, 4619.5611416915335, 4639.141758774637, 4682.29765535169, 77831.31932210107, 79441.0, 79960.0, 80691.0, 80764.19235807625, 11221.214514983873, 11364.94317528407, 11459.083273338112, 11704.648860534198, 11993.760124797629, 21754.673679894815, 21793.455163621038, 22057.77942220557, 22063.33809985703, 22228.11087556512, 8634.352423568258, 8707.825843483095, 8872.600732967032, 8905.332100092519, 8975.506347150838, 5048.697078175322, 5077.365329333833, 5099.566536844335, 5275.683458992396, 5325.627206095536, 3663.6885864701267, 3750.643688849555, 3755.455458958436, 3758.0416993666986, 3766.6798322142927, 624.0202881476039, 626.9247690277195, 627.9434850863353, 628.8585068359674, 629.8488362792897, 507.7841917185182, 608.4250383387745, 644.3974883483958, 689.36233983565, 720.9639518024078, 9605.855912161323, 10016.29885907994, 10016.799664006825, 10137.898621013695, 10236.897631023743, 638.7572722365564, 641.4419455074022, 695.9826004349932, 711.3668834737089, 791.8297566023217, 4365.890852728644, 4488.5447560660095, 4592.563706447882, 4595.839145629887, 4683.882902927454, 100046.0, 112442.0, 112659.4367028176, 113041.43479282552, 113191.0, 71226.0, 92667.0, 93485.0, 95854.0414595859, 98209.50895245478, 87424.5628771852, 88576.9999999987, 88999.55500222457, 89458.0, 89562.10437895538, 8473.110323416198, 8560.529170895661, 8585.570721464026, 8662.090480499708, 8672.956635216784, 49469.0, 50751.73928416667, 51072.23391649203, 51191.744041279555, 51202.74398628132, 70999.0, 74787.62606186935, 75676.24323756913, 76594.23405766094, 77365.61317193379, 12838.614841554769, 12879.613611591667, 12884.621131376274, 12982.675433113869, 13083.476660933457, 13976.161430314214, 14127.505537306144, 14269.928650356682, 14329.57011289663, 14623.780643290147, 14597.416103355747, 14891.851081489047, 15047.623809404853, 15186.164760938254, 15613.84386156124, 12342.691432714253, 12650.240985540897, 12725.300108494122, 12879.034072444792, 13083.41124649412, 13362.782992821507, 14402.351894164998, 14484.710305793615, 14611.488597899448, 15074.09555426678, 12016.33910134916, 12533.561325353568, 12570.560030398892, 12596.244225346509, 12877.098603097693, 12053.698657533632, 12348.629541113782, 12353.814692779435, 12368.628941131781, 12419.689507762378], "value": 7745.651098888499, "unit": "score"}], "name": "dromaeo_css", "value": 7498.547848336137, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 103.0, 109.0, 111.0, 111.0, 111.0, 110.0, 108.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 132.0, 174.0, 126.0, 129.0, 151.0, 132.0, 172.0, 131.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 159.0, 161.0, 160.0, 163.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 121.0, 75.0, 76.0, 74.0, 76.0, 98.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 85.0, 86.0, 85.0, 119.0, 85.0, 86.0, 137.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 121.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 51.0, 52.0, 51.0, 50.0, 53.0, 50.0, 50.0, 50.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 76.0, 79.0, 77.0, 78.0, 77.0, 105.0, 77.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 127.0, 119.0, 115.0, 123.0, 117.0, 122.0, 127.0, 138.0, 129.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 152.0, 152.0, 153.0, 154.0, 158.0, 153.0, 154.0, 154.0, 152.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 64.0, 61.0, 63.0, 61.0, 62.0, 60.0, 61.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1480.4, "alertThreshold": 2.0}]} 03:53:28 INFO - Return code: 0 03:53:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:28 ERROR - # TBPL SUCCESS # 03:53:28 INFO - Running post-action listener: _resource_record_post_action 03:53:28 INFO - ##### 03:53:28 INFO - ##### Finished run-tests step (success) 03:53:28 INFO - ##### 03:53:28 INFO - Running post-run listener: _resource_record_post_run 03:53:28 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 290816; Write bytes: 502792192; Read time: 48; Write time: 1162252 03:53:28 INFO - TinderboxPrint: CPU usage
13.2% 03:53:28 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 48 03:53:28 INFO - TinderboxPrint: I/O write bytes / time
502,792,192 / 1,162,252 03:53:28 INFO - TinderboxPrint: CPU idle
8,268.1 (86.8%) 03:53:28 INFO - TinderboxPrint: CPU user
1,197.5 (12.6%) 03:53:28 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:28 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 252444672; Read time: 0; Write time: 751472 03:53:28 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250347520; Read time: 36; Write time: 410780 03:53:28 INFO - Running post-run listener: _upload_blobber_files 03:53:28 INFO - Blob upload gear active. 03:53:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:28 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 03:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:43 INFO - (blobuploader) - INFO - Done attempting. 03:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:53:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:43 INFO - (blobuploader) - INFO - Done attempting. 03:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:53:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:44 INFO - (blobuploader) - INFO - Done attempting. 03:53:44 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:44 INFO - Return code: 0 03:53:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849acc5b3ca4173913898b90b3ac82c4a71487517af03275a5f259627e7ea0bd901f95718393e59f1d0dabead150c577ea07e1bec1bc6a062a28fe2747a9b17a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a1740465b02ca2bc389a838078f8b19ec41a39cbe4b1389bcca9305ccbe37a6328fa73e5b1e7c4d66fc30374e3305ac893b8c83fc296eaf292a9ffb2faaec69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcbd9194c6e003194e89abc5c601c6a2798060d4d176170cc9a11268332899f7e0af4162802d9d62662669b488d65d432ac776927e34735d8b39f593dc951b8a"} 03:53:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:44 INFO - Contents: 03:53:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849acc5b3ca4173913898b90b3ac82c4a71487517af03275a5f259627e7ea0bd901f95718393e59f1d0dabead150c577ea07e1bec1bc6a062a28fe2747a9b17a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a1740465b02ca2bc389a838078f8b19ec41a39cbe4b1389bcca9305ccbe37a6328fa73e5b1e7c4d66fc30374e3305ac893b8c83fc296eaf292a9ffb2faaec69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcbd9194c6e003194e89abc5c601c6a2798060d4d176170cc9a11268332899f7e0af4162802d9d62662669b488d65d432ac776927e34735d8b39f593dc951b8a"} 03:53:44 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:44 INFO - Copying logs to upload dir... 03:53:44 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.398316 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-22 03:53:44.586255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 03:53:44.589755) ========= 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=745a4373a2a16df560f216e000000264-1469183575.808026-825776876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849acc5b3ca4173913898b90b3ac82c4a71487517af03275a5f259627e7ea0bd901f95718393e59f1d0dabead150c577ea07e1bec1bc6a062a28fe2747a9b17a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a1740465b02ca2bc389a838078f8b19ec41a39cbe4b1389bcca9305ccbe37a6328fa73e5b1e7c4d66fc30374e3305ac893b8c83fc296eaf292a9ffb2faaec69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcbd9194c6e003194e89abc5c601c6a2798060d4d176170cc9a11268332899f7e0af4162802d9d62662669b488d65d432ac776927e34735d8b39f593dc951b8a"} build_url:https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/ASItgprSS8ijFYKDIygjnQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849acc5b3ca4173913898b90b3ac82c4a71487517af03275a5f259627e7ea0bd901f95718393e59f1d0dabead150c577ea07e1bec1bc6a062a28fe2747a9b17a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a1740465b02ca2bc389a838078f8b19ec41a39cbe4b1389bcca9305ccbe37a6328fa73e5b1e7c4d66fc30374e3305ac893b8c83fc296eaf292a9ffb2faaec69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcbd9194c6e003194e89abc5c601c6a2798060d4d176170cc9a11268332899f7e0af4162802d9d62662669b488d65d432ac776927e34735d8b39f593dc951b8a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 03:53:44.614799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 03:53:44.615136) ========= 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=745a4373a2a16df560f216e000000264-1469183575.808026-825776876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 03:53:44.697212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 03:53:44.697543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 03:53:44.697851) ========= ========= Total master_lag: 0.17 =========