builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1469269260.11 results: success (0) buildid: 20160723004004 builduid: 48f67a88a8c841379722efa8471a45cc revision: 02b002977b46df0249540aed40854f0905340bd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.109997) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.110681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.110972) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.126468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.127113) ========= 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=ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-23 03:21:00-- 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% 218M=0s 2016-07-23 03:21:01 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.306493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.306816) ========= 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=ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020257 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.357096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:00.357426) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 02b002977b46df0249540aed40854f0905340bd4 --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 02b002977b46df0249540aed40854f0905340bd4 --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=ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-23 03:21:01,271 truncating revision to first 12 chars 2016-07-23 03:21:01,271 Setting DEBUG logging. 2016-07-23 03:21:01,272 attempt 1/10 2016-07-23 03:21:01,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/02b002977b46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-23 03:21:01,642 unpacking tar archive at: mozilla-aurora-02b002977b46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:01.205452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:01.205795) ========= script_repo_revision: 02b002977b46df0249540aed40854f0905340bd4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:01.206225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:01.206503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-23 03:21:01.214770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-23 03:21:01.215157) ========= /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=ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:02 INFO - MultiFileLogger online at 20160723 03:21:02 in /builds/slave/test 03:21:02 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:21:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:02 INFO - {'append_to_log': False, 03:21:02 INFO - 'base_work_dir': '/builds/slave/test', 03:21:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:02 INFO - 'branch': 'Mozilla-Aurora', 03:21:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:02 INFO - 'config_files': ('talos/linux_config.py',), 03:21:02 INFO - 'default_actions': ('clobber', 03:21:02 INFO - 'read-buildbot-config', 03:21:02 INFO - 'download-and-extract', 03:21:02 INFO - 'populate-webroot', 03:21:02 INFO - 'create-virtualenv', 03:21:02 INFO - 'install', 03:21:02 INFO - 'run-tests'), 03:21:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:02 INFO - 'download_minidump_stackwalk': True, 03:21:02 INFO - 'download_symbols': 'ondemand', 03:21:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:02 INFO - 'installer_path': 'installer.exe', 03:21:02 INFO - 'log_level': 'info', 03:21:02 INFO - 'log_name': 'talos', 03:21:02 INFO - 'log_to_console': True, 03:21:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:02 INFO - 'opt_config_files': (), 03:21:02 INFO - 'pip_index': False, 03:21:02 INFO - 'sps_profile': False, 03:21:02 INFO - 'sps_profile_interval': 0, 03:21:02 INFO - 'suite': 'dromaeojs', 03:21:02 INFO - 'system_bits': '32', 03:21:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:02 INFO - 'title': 'talos-linux64-ix-035', 03:21:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:02 INFO - 'use_talos_json': True, 03:21:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:02 INFO - 'work_dir': 'build'} 03:21:02 INFO - ##### 03:21:02 INFO - ##### Running clobber step. 03:21:02 INFO - ##### 03:21:02 INFO - Running pre-action listener: _resource_record_pre_action 03:21:02 INFO - Running main action method: clobber 03:21:02 INFO - rmtree: /builds/slave/test/build 03:21:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:02 INFO - Running post-action listener: _resource_record_post_action 03:21:02 INFO - ##### 03:21:02 INFO - ##### Finished clobber step (success) 03:21:02 INFO - ##### 03:21:02 INFO - ##### 03:21:02 INFO - ##### Running read-buildbot-config step. 03:21:02 INFO - ##### 03:21:02 INFO - Running pre-action listener: _resource_record_pre_action 03:21:02 INFO - Running main action method: read_buildbot_config 03:21:02 INFO - Using buildbot properties: 03:21:02 INFO - { 03:21:02 INFO - "project": "", 03:21:02 INFO - "product": "firefox", 03:21:02 INFO - "script_repo_revision": "production", 03:21:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:21:02 INFO - "repository": "", 03:21:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:21:02 INFO - "buildid": "20160723004004", 03:21:02 INFO - "stage_platform": "linux64-pgo", 03:21:02 INFO - "basedir": "/builds/slave/test", 03:21:02 INFO - "nightly_build": "True", 03:21:02 INFO - "buildnumber": 382, 03:21:02 INFO - "slavename": "talos-linux64-ix-035", 03:21:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:21:02 INFO - "platform": "ubuntu64_hw", 03:21:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:21:02 INFO - "branch": "mozilla-aurora", 03:21:02 INFO - "repo_path": "releases/mozilla-aurora", 03:21:02 INFO - "revision": "02b002977b46df0249540aed40854f0905340bd4", 03:21:02 INFO - "pgo_build": "True", 03:21:02 INFO - "builduid": "48f67a88a8c841379722efa8471a45cc", 03:21:02 INFO - "slavebuilddir": "test" 03:21:02 INFO - } 03:21:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:21:02 INFO - Running post-action listener: _resource_record_post_action 03:21:02 INFO - ##### 03:21:02 INFO - ##### Finished read-buildbot-config step (success) 03:21:02 INFO - ##### 03:21:02 INFO - ##### 03:21:02 INFO - ##### Running download-and-extract step. 03:21:02 INFO - ##### 03:21:02 INFO - Running pre-action listener: _resource_record_pre_action 03:21:02 INFO - Running main action method: download_and_extract 03:21:02 INFO - mkdir: /builds/slave/test/build/tests 03:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:02 INFO - https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:07 INFO - Downloaded 1361 bytes. 03:21:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:07 INFO - Using the following test package requirements: 03:21:07 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:07 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:21:07 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:21:07 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:07 INFO - u'jsshell-linux-x86_64.zip'], 03:21:07 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:21:07 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:07 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:21:07 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:21:07 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:21:07 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:21:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:21: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:21:07 INFO - https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:19 INFO - Downloaded 24493514 bytes. 03:21:19 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:21:19 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:21:21 INFO - Return code: 0 03:21:21 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:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:21 INFO - https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:22 INFO - Downloaded 24493514 bytes. 03:21:22 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:21:22 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:21:23 INFO - Return code: 0 03:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:23 INFO - https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:24 INFO - Downloaded 10833369 bytes. 03:21:24 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:21:24 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:21:24 INFO - Return code: 0 03:21: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:21:24 INFO - https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:21:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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:21:26 INFO - Downloaded 63640685 bytes. 03:21:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:26 INFO - mkdir: /builds/slave/test/properties 03:21:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:26 INFO - Contents: 03:21:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:26 INFO - Running post-action listener: _resource_record_post_action 03:21:26 INFO - Running post-action listener: set_extra_try_arguments 03:21:26 INFO - ##### 03:21:26 INFO - ##### Finished download-and-extract step (success) 03:21:26 INFO - ##### 03:21:26 INFO - ##### 03:21:26 INFO - ##### Running populate-webroot step. 03:21:26 INFO - ##### 03:21:26 INFO - Running pre-action listener: _resource_record_pre_action 03:21:26 INFO - Running main action method: populate_webroot 03:21:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:26 INFO - '--tppagecycles', 03:21:26 INFO - '7'], 03:21:26 INFO - 'tests': ['tsvgm']}}, 03:21:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:26 INFO - 'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:26 INFO - 'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['damp', 'tps']}, 03:21:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:26 INFO - 'tests': ['damp', 'tps']}, 03:21:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['dromaeo_dom']}, 03:21:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['a11yr', 03:21:26 INFO - 'ts_paint', 03:21:26 INFO - 'tpaint', 03:21:26 INFO - 'sessionrestore', 03:21:26 INFO - 'sessionrestore_no_auto_restore', 03:21:26 INFO - 'tabpaint']}, 03:21:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:26 INFO - 'ts_paint', 03:21:26 INFO - 'tpaint', 03:21:26 INFO - 'sessionrestore', 03:21:26 INFO - 'sessionrestore_no_auto_restore', 03:21:26 INFO - 'tabpaint']}, 03:21:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:26 INFO - 'ts_paint', 03:21:26 INFO - 'tpaint', 03:21:26 INFO - 'sessionrestore', 03:21:26 INFO - 'sessionrestore_no_auto_restore', 03:21:26 INFO - 'tabpaint']}, 03:21:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:26 INFO - 'ts_paint', 03:21:26 INFO - 'tpaint', 03:21:26 INFO - 'sessionrestore', 03:21:26 INFO - 'sessionrestore_no_auto_restore', 03:21:26 INFO - 'tabpaint']}, 03:21:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['a11yr', 03:21:26 INFO - 'ts_paint', 03:21:26 INFO - 'tpaint', 03:21:26 INFO - 'sessionrestore', 03:21:26 INFO - 'sessionrestore_no_auto_restore', 03:21:26 INFO - 'tabpaint']}, 03:21:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['a11yr', 03:21:26 INFO - 'ts_paint', 03:21:26 INFO - 'tpaint', 03:21:26 INFO - 'sessionrestore', 03:21:26 INFO - 'sessionrestore_no_auto_restore', 03:21:26 INFO - 'tabpaint']}, 03:21:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['tsvgx', 03:21:26 INFO - 'tsvgr_opacity', 03:21:26 INFO - 'tart', 03:21:26 INFO - 'tscrollx', 03:21:26 INFO - 'cart']}, 03:21:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:26 INFO - 'tsvgr_opacity', 03:21:26 INFO - 'tart', 03:21:26 INFO - 'tscrollx', 03:21:26 INFO - 'cart']}, 03:21:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:26 INFO - 'talos_options': ['--disable-e10s'], 03:21:26 INFO - 'tests': ['tp5o']}, 03:21:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:26 INFO - 'tests': ['tp5o']}, 03:21:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:26 INFO - 'talos_options': ['--disable-e10s', 03:21:26 INFO - '--xperf_path', 03:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:26 INFO - 'tests': ['tp5n']}, 03:21:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:26 INFO - 'talos_options': ['--xperf_path', 03:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:26 INFO - 'tests': ['tp5n']}}, 03:21:26 INFO - 'talos.zip': {'path': '', 03:21:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:26 INFO - Running post-action listener: _resource_record_post_action 03:21:26 INFO - ##### 03:21:26 INFO - ##### Finished populate-webroot step (success) 03:21:26 INFO - ##### 03:21:26 INFO - ##### 03:21:26 INFO - ##### Running create-virtualenv step. 03:21:26 INFO - ##### 03:21:26 INFO - Running pre-action listener: _resource_record_pre_action 03:21:26 INFO - Running main action method: create_virtualenv 03:21:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:26 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:21:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:26 INFO - Using real prefix '/usr' 03:21:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:29 INFO - Installing pip.................done. 03:21:29 INFO - Return code: 0 03:21:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:29 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:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:29 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:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:29 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:29 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:21:29 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:21:29 INFO - Using env: {'DISPLAY': ':0', 03:21:29 INFO - 'HOME': '/home/cltbld', 03:21:29 INFO - 'LANG': 'en_US.UTF-8', 03:21:29 INFO - 'LANGUAGE': 'en_US:en', 03:21:29 INFO - 'LOGNAME': 'cltbld', 03:21:29 INFO - 'MAIL': '/var/mail/cltbld', 03:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:29 INFO - 'MOZ_NO_REMOTE': '1', 03:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:29 INFO - 'NO_EM_RESTART': '1', 03:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:29 INFO - 'PWD': '/builds/slave/test', 03:21:29 INFO - 'SHELL': '/bin/bash', 03:21:29 INFO - 'SHLVL': '1', 03:21:29 INFO - 'TERM': 'linux', 03:21:29 INFO - 'TMOUT': '86400', 03:21:29 INFO - 'USER': 'cltbld', 03:21:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:29 INFO - '_': '/tools/buildbot/bin/python'} 03:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:29 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:21:29 INFO - Cleaning up... 03:21:29 INFO - Return code: 0 03:21:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:21:29 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:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:29 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:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:29 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:29 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:21:29 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:21:29 INFO - Using env: {'DISPLAY': ':0', 03:21:29 INFO - 'HOME': '/home/cltbld', 03:21:29 INFO - 'LANG': 'en_US.UTF-8', 03:21:29 INFO - 'LANGUAGE': 'en_US:en', 03:21:29 INFO - 'LOGNAME': 'cltbld', 03:21:29 INFO - 'MAIL': '/var/mail/cltbld', 03:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:29 INFO - 'MOZ_NO_REMOTE': '1', 03:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:29 INFO - 'NO_EM_RESTART': '1', 03:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:29 INFO - 'PWD': '/builds/slave/test', 03:21:29 INFO - 'SHELL': '/bin/bash', 03:21:29 INFO - 'SHLVL': '1', 03:21:29 INFO - 'TERM': 'linux', 03:21:29 INFO - 'TMOUT': '86400', 03:21:29 INFO - 'USER': 'cltbld', 03:21:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:29 INFO - '_': '/tools/buildbot/bin/python'} 03:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:29 INFO - Downloading/unpacking psutil>=3.1.1 03:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:31 INFO - Installing collected packages: psutil 03:21:31 INFO - Running setup.py install for psutil 03:21:31 INFO - building 'psutil._psutil_linux' extension 03:21:31 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:21:32 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:21:32 INFO - building 'psutil._psutil_posix' extension 03:21:32 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:21:32 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:21:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:32 INFO - Successfully installed psutil 03:21:32 INFO - Cleaning up... 03:21:32 INFO - Return code: 0 03:21:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:32 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:32 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:21:32 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:21:32 INFO - Using env: {'DISPLAY': ':0', 03:21:32 INFO - 'HOME': '/home/cltbld', 03:21:32 INFO - 'LANG': 'en_US.UTF-8', 03:21:32 INFO - 'LANGUAGE': 'en_US:en', 03:21:32 INFO - 'LOGNAME': 'cltbld', 03:21:32 INFO - 'MAIL': '/var/mail/cltbld', 03:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:32 INFO - 'MOZ_NO_REMOTE': '1', 03:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:32 INFO - 'NO_EM_RESTART': '1', 03:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:32 INFO - 'PWD': '/builds/slave/test', 03:21:32 INFO - 'SHELL': '/bin/bash', 03:21:32 INFO - 'SHLVL': '1', 03:21:32 INFO - 'TERM': 'linux', 03:21:32 INFO - 'TMOUT': '86400', 03:21:32 INFO - 'USER': 'cltbld', 03:21:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:32 INFO - '_': '/tools/buildbot/bin/python'} 03:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:21:32 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:21:32 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:21:32 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:21:32 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:21:32 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:21:32 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:21:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:21:34 INFO - Installing collected packages: mozsystemmonitor 03:21:34 INFO - Running setup.py install for mozsystemmonitor 03:21:34 INFO - Successfully installed mozsystemmonitor 03:21:34 INFO - Cleaning up... 03:21:34 INFO - Return code: 0 03:21:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:21:34 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:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:34 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:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:34 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:34 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:21:34 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:21:34 INFO - Using env: {'DISPLAY': ':0', 03:21:34 INFO - 'HOME': '/home/cltbld', 03:21:34 INFO - 'LANG': 'en_US.UTF-8', 03:21:34 INFO - 'LANGUAGE': 'en_US:en', 03:21:34 INFO - 'LOGNAME': 'cltbld', 03:21:34 INFO - 'MAIL': '/var/mail/cltbld', 03:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:34 INFO - 'MOZ_NO_REMOTE': '1', 03:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:34 INFO - 'NO_EM_RESTART': '1', 03:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:34 INFO - 'PWD': '/builds/slave/test', 03:21:34 INFO - 'SHELL': '/bin/bash', 03:21:34 INFO - 'SHLVL': '1', 03:21:34 INFO - 'TERM': 'linux', 03:21:34 INFO - 'TMOUT': '86400', 03:21:34 INFO - 'USER': 'cltbld', 03:21:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:34 INFO - '_': '/tools/buildbot/bin/python'} 03:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:21: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:21: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:21: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:21: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:21: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:21: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:21:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:21:36 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:21:36 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:21:36 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:21:36 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:21:36 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:21:36 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:21:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:37 INFO - warning: no files found matching '*.txt' 03:21:37 INFO - no previously-included directories found matching 'build' 03:21:37 INFO - no previously-included directories found matching 'dist' 03:21:37 INFO - no previously-included directories found matching '.git*' 03:21:37 INFO - Installing collected packages: jsonschema, functools32 03:21:37 INFO - Running setup.py install for functools32 03:21:37 INFO - warning: no files found matching '*.txt' 03:21:37 INFO - no previously-included directories found matching 'build' 03:21:37 INFO - no previously-included directories found matching 'dist' 03:21:37 INFO - no previously-included directories found matching '.git*' 03:21:37 INFO - Successfully installed jsonschema functools32 03:21:37 INFO - Cleaning up... 03:21:37 INFO - Return code: 0 03:21:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:37 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:37 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:21:37 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:21:37 INFO - Using env: {'DISPLAY': ':0', 03:21:37 INFO - 'HOME': '/home/cltbld', 03:21:37 INFO - 'LANG': 'en_US.UTF-8', 03:21:37 INFO - 'LANGUAGE': 'en_US:en', 03:21:37 INFO - 'LOGNAME': 'cltbld', 03:21:37 INFO - 'MAIL': '/var/mail/cltbld', 03:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:37 INFO - 'MOZ_NO_REMOTE': '1', 03:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:37 INFO - 'NO_EM_RESTART': '1', 03:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:37 INFO - 'PWD': '/builds/slave/test', 03:21:37 INFO - 'SHELL': '/bin/bash', 03:21:37 INFO - 'SHLVL': '1', 03:21:37 INFO - 'TERM': 'linux', 03:21:37 INFO - 'TMOUT': '86400', 03:21:37 INFO - 'USER': 'cltbld', 03:21:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:37 INFO - '_': '/tools/buildbot/bin/python'} 03:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:37 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:21:37 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:21:37 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:21:37 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:21:37 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:21:37 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:21:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:39 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:21:39 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:21:39 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:21:39 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:21:39 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:21:39 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:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:39 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:21:39 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:21:39 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:21:39 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:21:39 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:21:39 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:21:40 INFO - Downloading docopt-0.6.1.tar.gz 03:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:40 INFO - Running setup.py install for blobuploader 03:21:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:40 INFO - Running setup.py install for requests 03:21:40 INFO - Running setup.py install for docopt 03:21:40 INFO - Successfully installed blobuploader requests docopt 03:21:40 INFO - Cleaning up... 03:21:40 INFO - Return code: 0 03:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:40 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:40 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:21:40 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:21:40 INFO - Using env: {'DISPLAY': ':0', 03:21:40 INFO - 'HOME': '/home/cltbld', 03:21:40 INFO - 'LANG': 'en_US.UTF-8', 03:21:40 INFO - 'LANGUAGE': 'en_US:en', 03:21:40 INFO - 'LOGNAME': 'cltbld', 03:21:40 INFO - 'MAIL': '/var/mail/cltbld', 03:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:40 INFO - 'MOZ_NO_REMOTE': '1', 03:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:40 INFO - 'NO_EM_RESTART': '1', 03:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:40 INFO - 'PWD': '/builds/slave/test', 03:21:40 INFO - 'SHELL': '/bin/bash', 03:21:40 INFO - 'SHLVL': '1', 03:21:40 INFO - 'TERM': 'linux', 03:21:40 INFO - 'TMOUT': '86400', 03:21:40 INFO - 'USER': 'cltbld', 03:21:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:40 INFO - '_': '/tools/buildbot/bin/python'} 03:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:41 INFO - Running setup.py (path:/tmp/pip-0eMOEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:41 INFO - Running setup.py (path:/tmp/pip-H9yZZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:41 INFO - Running setup.py (path:/tmp/pip-MfH9ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:41 INFO - Running setup.py (path:/tmp/pip-Os5znk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:41 INFO - Running setup.py (path:/tmp/pip-evRGdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:41 INFO - Running setup.py (path:/tmp/pip-0FGg06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:41 INFO - Running setup.py (path:/tmp/pip-cbUxg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:41 INFO - Running setup.py (path:/tmp/pip-1eX_YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:41 INFO - Running setup.py (path:/tmp/pip-zFztPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:41 INFO - Running setup.py (path:/tmp/pip-2bX6_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:41 INFO - Running setup.py (path:/tmp/pip-6Y6n6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:41 INFO - Running setup.py (path:/tmp/pip-aHvvBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:41 INFO - Running setup.py (path:/tmp/pip-csxiFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:41 INFO - Running setup.py (path:/tmp/pip-Y72qPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:42 INFO - Running setup.py (path:/tmp/pip-k0pGqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:42 INFO - Running setup.py (path:/tmp/pip-P4BiSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:42 INFO - Running setup.py (path:/tmp/pip-R4Um1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:42 INFO - Running setup.py install for manifestparser 03:21:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:42 INFO - Running setup.py install for mozcrash 03:21:42 INFO - Running setup.py install for mozdebug 03:21:42 INFO - Running setup.py install for mozdevice 03:21:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:21:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:42 INFO - Running setup.py install for mozfile 03:21:42 INFO - Running setup.py install for mozhttpd 03:21:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:42 INFO - Running setup.py install for mozinfo 03:21:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:42 INFO - Running setup.py install for mozInstall 03:21:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Running setup.py install for mozleak 03:21:43 INFO - Running setup.py install for mozlog 03:21:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Running setup.py install for moznetwork 03:21:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Running setup.py install for mozprocess 03:21:43 INFO - Running setup.py install for mozprofile 03:21:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Running setup.py install for mozrunner 03:21:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:43 INFO - Running setup.py install for mozscreenshot 03:21:43 INFO - Running setup.py install for moztest 03:21:43 INFO - Running setup.py install for mozversion 03:21:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:44 INFO - Cleaning up... 03:21:44 INFO - Return code: 0 03:21:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:44 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:44 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:21:44 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:21:44 INFO - Using env: {'DISPLAY': ':0', 03:21:44 INFO - 'HOME': '/home/cltbld', 03:21:44 INFO - 'LANG': 'en_US.UTF-8', 03:21:44 INFO - 'LANGUAGE': 'en_US:en', 03:21:44 INFO - 'LOGNAME': 'cltbld', 03:21:44 INFO - 'MAIL': '/var/mail/cltbld', 03:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:44 INFO - 'MOZ_NO_REMOTE': '1', 03:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:44 INFO - 'NO_EM_RESTART': '1', 03:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:44 INFO - 'PWD': '/builds/slave/test', 03:21:44 INFO - 'SHELL': '/bin/bash', 03:21:44 INFO - 'SHLVL': '1', 03:21:44 INFO - 'TERM': 'linux', 03:21:44 INFO - 'TMOUT': '86400', 03:21:44 INFO - 'USER': 'cltbld', 03:21:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:44 INFO - '_': '/tools/buildbot/bin/python'} 03:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:44 INFO - Running setup.py (path:/tmp/pip-n3yolB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:44 INFO - Running setup.py (path:/tmp/pip-L3IBbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:44 INFO - Running setup.py (path:/tmp/pip-tzUN4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:44 INFO - Running setup.py (path:/tmp/pip-792jGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:44 INFO - Running setup.py (path:/tmp/pip-wB64i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:44 INFO - Running setup.py (path:/tmp/pip-URSthX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:44 INFO - Running setup.py (path:/tmp/pip-yAbXm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:44 INFO - Running setup.py (path:/tmp/pip-_F2Pr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:44 INFO - Running setup.py (path:/tmp/pip-yp1JKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:44 INFO - Running setup.py (path:/tmp/pip-DNtnru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:45 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:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:45 INFO - Running setup.py (path:/tmp/pip-piSJvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:45 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:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:45 INFO - Running setup.py (path:/tmp/pip-kJaU9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:45 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:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:45 INFO - Running setup.py (path:/tmp/pip-s92bRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:45 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:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:45 INFO - Running setup.py (path:/tmp/pip-et6wHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:45 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:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:45 INFO - Running setup.py (path:/tmp/pip-dl0Lfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:45 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:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:45 INFO - Running setup.py (path:/tmp/pip-nIuq4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:45 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:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:45 INFO - Running setup.py (path:/tmp/pip-Qy9U6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:45 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:21:45 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:21:45 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:21:45 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:21:45 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:21:45 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:21:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:45 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:21:45 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:21:45 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:21:45 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:21:45 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:21:45 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:21:47 INFO - Downloading blessings-1.6.tar.gz 03:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:47 INFO - Installing collected packages: blessings 03:21:47 INFO - Running setup.py install for blessings 03:21:47 INFO - Successfully installed blessings 03:21:47 INFO - Cleaning up... 03:21:47 INFO - Return code: 0 03:21:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:47 INFO - Reading from file tmpfile_stdout 03:21:47 INFO - Current package versions: 03:21:47 INFO - argparse == 1.2.1 03:21:47 INFO - blessings == 1.6 03:21:47 INFO - blobuploader == 1.2.4 03:21:47 INFO - docopt == 0.6.1 03:21:47 INFO - functools32 == 3.2.3-2 03:21:47 INFO - jsonschema == 2.5.1 03:21:47 INFO - manifestparser == 1.1 03:21:47 INFO - mozInstall == 1.12 03:21:47 INFO - mozcrash == 0.17 03:21:47 INFO - mozdebug == 0.1 03:21:47 INFO - mozdevice == 0.48 03:21:47 INFO - mozfile == 1.2 03:21:47 INFO - mozhttpd == 0.7 03:21:47 INFO - mozinfo == 0.9 03:21:47 INFO - mozleak == 0.1 03:21:47 INFO - mozlog == 3.2 03:21:47 INFO - moznetwork == 0.27 03:21:47 INFO - mozprocess == 0.23 03:21:47 INFO - mozprofile == 0.28 03:21:47 INFO - mozrunner == 6.12 03:21:47 INFO - mozscreenshot == 0.1 03:21:47 INFO - mozsystemmonitor == 0.3 03:21:47 INFO - moztest == 0.7 03:21:47 INFO - mozversion == 1.4 03:21:47 INFO - psutil == 3.1.1 03:21:47 INFO - requests == 1.2.3 03:21:47 INFO - wsgiref == 0.1.2 03:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:47 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:47 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:21:47 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:21:47 INFO - Using env: {'DISPLAY': ':0', 03:21:47 INFO - 'HOME': '/home/cltbld', 03:21:47 INFO - 'LANG': 'en_US.UTF-8', 03:21:47 INFO - 'LANGUAGE': 'en_US:en', 03:21:47 INFO - 'LOGNAME': 'cltbld', 03:21:47 INFO - 'MAIL': '/var/mail/cltbld', 03:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:47 INFO - 'MOZ_NO_REMOTE': '1', 03:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:47 INFO - 'NO_EM_RESTART': '1', 03:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:47 INFO - 'PWD': '/builds/slave/test', 03:21:47 INFO - 'SHELL': '/bin/bash', 03:21:47 INFO - 'SHLVL': '1', 03:21:47 INFO - 'TERM': 'linux', 03:21:47 INFO - 'TMOUT': '86400', 03:21:47 INFO - 'USER': 'cltbld', 03:21:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:47 INFO - '_': '/tools/buildbot/bin/python'} 03:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 INFO - Cleaning up... 03:21:48 INFO - Return code: 0 03:21:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:48 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:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:48 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:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:48 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:48 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:21:48 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:21:48 INFO - Using env: {'DISPLAY': ':0', 03:21:48 INFO - 'HOME': '/home/cltbld', 03:21:48 INFO - 'LANG': 'en_US.UTF-8', 03:21:48 INFO - 'LANGUAGE': 'en_US:en', 03:21:48 INFO - 'LOGNAME': 'cltbld', 03:21:48 INFO - 'MAIL': '/var/mail/cltbld', 03:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:48 INFO - 'MOZ_NO_REMOTE': '1', 03:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:48 INFO - 'NO_EM_RESTART': '1', 03:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:48 INFO - 'PWD': '/builds/slave/test', 03:21:48 INFO - 'SHELL': '/bin/bash', 03:21:48 INFO - 'SHLVL': '1', 03:21:48 INFO - 'TERM': 'linux', 03:21:48 INFO - 'TMOUT': '86400', 03:21:48 INFO - 'USER': 'cltbld', 03:21:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:48 INFO - '_': '/tools/buildbot/bin/python'} 03:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:48 INFO - Cleaning up... 03:21:48 INFO - Return code: 0 03:21:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:21:48 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:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:48 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:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:48 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 0x7fec33a86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', '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:21:48 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:21:48 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:21:48 INFO - Using env: {'DISPLAY': ':0', 03:21:48 INFO - 'HOME': '/home/cltbld', 03:21:48 INFO - 'LANG': 'en_US.UTF-8', 03:21:48 INFO - 'LANGUAGE': 'en_US:en', 03:21:48 INFO - 'LOGNAME': 'cltbld', 03:21:48 INFO - 'MAIL': '/var/mail/cltbld', 03:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:48 INFO - 'MOZ_NO_REMOTE': '1', 03:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:48 INFO - 'NO_EM_RESTART': '1', 03:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:48 INFO - 'PWD': '/builds/slave/test', 03:21:48 INFO - 'SHELL': '/bin/bash', 03:21:48 INFO - 'SHLVL': '1', 03:21:48 INFO - 'TERM': 'linux', 03:21:48 INFO - 'TMOUT': '86400', 03:21:48 INFO - 'USER': 'cltbld', 03:21:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:48 INFO - '_': '/tools/buildbot/bin/python'} 03:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:48 INFO - Downloading/unpacking flake8 03:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:21:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:21:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:21:51 INFO - no previously-included directories found matching 'docs/_build' 03:21:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:21:51 INFO - Running setup.py install for pep8 03:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:21:51 INFO - no previously-included directories found matching 'docs/_build' 03:21:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:21:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:21:51 INFO - Cleaning up... 03:21:51 INFO - Return code: 0 03:21:51 INFO - Running post-action listener: _resource_record_post_action 03:21:51 INFO - Running post-action listener: _start_resource_monitoring 03:21:51 INFO - Starting resource monitoring. 03:21:51 INFO - ##### 03:21:51 INFO - ##### Finished create-virtualenv step (success) 03:21:51 INFO - ##### 03:21:51 INFO - ##### 03:21:51 INFO - ##### Running install step. 03:21:51 INFO - ##### 03:21:51 INFO - Running pre-action listener: _resource_record_pre_action 03:21:51 INFO - Running main action method: install 03:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:51 INFO - Reading from file tmpfile_stdout 03:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:51 INFO - Reading from file tmpfile_stdout 03:21:51 INFO - Output received: 03:21:51 INFO - Usage: mozinstall [options] installer 03:21:51 INFO - Options: 03:21:51 INFO - -h, --help show this help message and exit 03:21:51 INFO - -d DEST, --destination=DEST 03:21:51 INFO - Directory to install application into. [default: 03:21:51 INFO - "/builds/slave/test"] 03:21:51 INFO - --app=APP Application being installed. [default: firefox] 03:21:51 INFO - mkdir: /builds/slave/test/build/application 03:21:51 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:21:51 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:22:07 INFO - Reading from file tmpfile_stdout 03:22:07 INFO - Output received: 03:22:07 INFO - /builds/slave/test/build/application/firefox/firefox 03:22:07 INFO - Running post-action listener: _resource_record_post_action 03:22:07 INFO - ##### 03:22:07 INFO - ##### Finished install step (success) 03:22:07 INFO - ##### 03:22:07 INFO - ##### 03:22:07 INFO - ##### Running run-tests step. 03:22:07 INFO - ##### 03:22:07 INFO - Running pre-action listener: _resource_record_pre_action 03:22:07 INFO - Running main action method: run_tests 03:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:07 INFO - Python 2.7.3 03:22:07 INFO - Return code: 0 03:22:07 INFO - grabbing minidump binary from tooltool 03:22: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:22:07 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 0x100f1c0>, '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 0x10100c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:07 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:22:07 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:22:07 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:22:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:07 INFO - Return code: 0 03:22:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:22:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:22:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:22:08 INFO - Return code: 0 03:22:08 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/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:22:08 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/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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:22:08 INFO - Using env: {'DISPLAY': ':0', 03:22:08 INFO - 'HOME': '/home/cltbld', 03:22:08 INFO - 'LANG': 'en_US.UTF-8', 03:22:08 INFO - 'LANGUAGE': 'en_US:en', 03:22:08 INFO - 'LOGNAME': 'cltbld', 03:22:08 INFO - 'MAIL': '/var/mail/cltbld', 03:22:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:08 INFO - 'MOZ_NO_REMOTE': '1', 03:22:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:08 INFO - 'NO_EM_RESTART': '1', 03:22:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:08 INFO - 'PWD': '/builds/slave/test', 03:22:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:08 INFO - 'SHELL': '/bin/bash', 03:22:08 INFO - 'SHLVL': '1', 03:22:08 INFO - 'TERM': 'linux', 03:22:08 INFO - 'TMOUT': '86400', 03:22:08 INFO - 'USER': 'cltbld', 03:22:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923', 03:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:08 INFO - '_': '/tools/buildbot/bin/python'} 03:22:08 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/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:22:08 INFO - mozversion application_buildid: 20160723004004 03:22:08 INFO - mozversion application_changeset: 02b002977b46df0249540aed40854f0905340bd4 03:22:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:22:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:08 INFO - mozversion application_name: Firefox 03:22:08 INFO - mozversion application_remotingname: firefox-dev 03:22:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:08 INFO - mozversion application_vendor: Mozilla 03:22:08 INFO - mozversion application_version: 49.0a2 03:22:08 INFO - mozversion platform_buildid: 20160723004004 03:22:08 INFO - mozversion platform_changeset: 02b002977b46df0249540aed40854f0905340bd4 03:22:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:08 INFO - mozversion platform_version: 49.0a2 03:22:08 INFO - using testdate: 1469269328 03:22:08 INFO - actual date: 1469269328 03:22:08 INFO - starting webserver on 'localhost:59361' 03:22:08 INFO - SUITE-START | Running 2 tests 03:22:08 INFO - TEST-START | dromaeo_css 03:22:08 INFO - operating with platform_type : linux_ 03:22:08 INFO - Initialising browser for dromaeo_css test... 03:22:08 INFO - TEST-INFO | started process 29742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkJbsD/profile http://localhost:59361/getInfo.html) 03:22:12 INFO - PROCESS | 29742 | __metrics Screen width/height:1600/1200 03:22:12 INFO - PROCESS | 29742 | colorDepth:24 03:22:12 INFO - PROCESS | 29742 | Browser inner width/height: 1024/697 03:22:12 INFO - PROCESS | 29742 | __metrics 03:22:13 INFO - PROCESS | 29742 | 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:22:13 ERROR - PROCESS | 29742 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:22:14 INFO - TEST-INFO | 29742: exit 0 03:22:14 INFO - Browser initialized. 03:22:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:14 INFO - TEST-INFO | started process 29834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkJbsD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:26 INFO - PROCESS | 29834 | RSS: Main: 145600512 03:22:26 INFO - PROCESS | 29834 | 03:23:17 INFO - PROCESS | 29834 | 1469269397544 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:25:25 INFO - PROCESS | 29834 | Cycle 1(1): loaded http://localhost:59361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59361/tests/dromaeo/cssquery-ext.html) 03:25:26 INFO - PROCESS | 29834 | RSS: Main: 253870080 03:25:26 INFO - PROCESS | 29834 | 03:28:28 INFO - PROCESS | 29834 | Cycle 1(1): loaded http://localhost:59361/tests/dromaeo/cssquery-ext.html (next: http://localhost:59361/tests/dromaeo/cssquery-jquery.html) 03:28:29 INFO - PROCESS | 29834 | RSS: Main: 228962304 03:28:29 INFO - PROCESS | 29834 | 03:31:31 INFO - PROCESS | 29834 | Cycle 1(1): loaded http://localhost:59361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59361/tests/dromaeo/cssquery-mootools.html) 03:31:31 INFO - PROCESS | 29834 | RSS: Main: 228388864 03:31:31 INFO - PROCESS | 29834 | 03:34:33 INFO - PROCESS | 29834 | Cycle 1(1): loaded http://localhost:59361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59361/tests/dromaeo/cssquery-prototype.html) 03:34:34 INFO - PROCESS | 29834 | RSS: Main: 220712960 03:34:34 INFO - PROCESS | 29834 | 03:37:36 INFO - PROCESS | 29834 | Cycle 1(1): loaded http://localhost:59361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59361/tests/dromaeo/cssquery-yui.html) 03:37:37 INFO - PROCESS | 29834 | RSS: Main: 222380032 03:37:37 INFO - PROCESS | 29834 | 03:40:39 INFO - PROCESS | 29834 | Cycle 1(1): loaded http://localhost:59361/tests/dromaeo/cssquery-yui.html (next: http://localhost:59361/tests/dromaeo/cssquery-dojo.html) 03:40:40 INFO - PROCESS | 29834 | RSS: Main: 262418432 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - PROCESS | 29834 | __start_tp_report 03:40:40 INFO - PROCESS | 29834 | _x_x_mozilla_page_load 03:40:40 INFO - PROCESS | 29834 | _x_x_mozilla_page_load_details 03:40:40 INFO - PROCESS | 29834 | |i|pagename|runs| 03:40:40 INFO - PROCESS | 29834 | |0;dojo.html;3323.8670453181876;3346.43110671186;3355.5637767090284;3367.545381373514;3394.626591074981;5463.726813659321;5563.054280772269;5563.499285064343;5563.916541251874;5601.131824567188;5577.051901176799;5621.184928185411;5622.803201887935;5623.381428042922;5659.490645841874;4941.4811444798315;5078.39059312883;5099.36257967754;5128.769205385748;5183.041137389576;4954.801807927696;5061.392632884059;5095.949040509603;5099.745012749348;5101.183810590306;5044.848654540369;5074.644774865761;5088.745562721868;5121.3342265505435;5135.3067335909545;5192.350956130484;5194.818181363634;5197.246399272103;5214.243934629458;5227.529522342969;4994.750262486861;5002.349694539723;5033.295338652591;5106.4382917879;5120.411152717411;5401.108817045183;5402.945970540283;5429.918551221735;5465.890682186334;5479.890402191973;6005.729742161613;6006.159137720722;6018.187544681499;6018.578699491038;6021.668808215546;5920.348761636216;5953.493953013999;5975.133605627159;6043.244594425697;6053.031514957585;5575.665460072368;5593.161025846115;5605.943940560624;5619.241402410663;5635.126555383922;5983.132445795335;6121.71479964027;6127.444870446228;6129.662868542273;6136.693165341715;5763.337216220189;5794.304683438015;5804.9419505805245;5888.057910734262;5894.17481552583;5976.193213916065;5976.910346344808;5996.5202783777195;6006.459418652343;6015.278166619946;5768.163616275617;5849.298084229919;5929.199558059693;5931.73307201177;5933;5917.852053698606;5980.192673988956;5994.040953447515;5996.370381110008;6029.758809647653;4596.448426188878;4601.401817763736;4607.7004994675235;4620.0990806793025;4640.605548528345;4040.3535434330365;4061.878143655695;4102.179564087194;4112.115895082572;4136.44158038667;5668.773249069991;5704.71476426177;5709.857253568694;5712.2288491054005;5715.714214289352;6032.276126864716;6036.275646922398;6036.426539478743;6037.0642550404755;6061.605995610271;5525.281713377235;5592.245046918614;5661.943380566224;5664.54683625309;5702.2301989231755;5178.974105129526;5186.247994040843;5188.092083885305;5189.506996835295;5191.351081114861;6214.937850621526;6227.782027629011;6232.407921247474;6243.125962365272;6244.843878902973;5868.4424979626865;5919.526437885045;5993;6010.308814486215;6105.17580126695;6177.351707609383;6225.31521532622;6233.345498722569;6234.470070044097;6237.625742455467;5882.647041177543;5889.087191485327;5889.52883769306;5890.941090589211;5930;5866.325372582208;5930.406959304035;5947.137665038632;5968.910466342922;6054;5846.766129354778;5874.735636896265;5887.470127688529;5893.086571581412;5904.704764761659;5697.202391665087;5845.18167456548;5880.294364676266;5903;5906.586538942232;5658.745356459051;5668.716564171693;5700.287464066992;5727.083666613322;5734.59857809966;5872.853178670396;5885.970570147122;5912.408759124053;5919.200907877554;5932.525397968066;5631.408702086386;5686.687232202268;5721.971390143022;5732.885342293214;5765.94234057654 03:40:40 INFO - PROCESS | 29834 | |1;ext.html;601.8555546668798;641.7144370755013;651.6871901487283;653.2291895563235;663.9966800165998;33787.66212337879;47192;48073.51926480734;48086.038279234395;52308;50495.74752126234;51128;51130;51156.74421627896;51202.74398628002;8407.747767566952;9175.63297468102;9333.533323333806;9333.859992100124;10850.457477126112;10520;11008;11010.614628488005;11019.889801102006;11020.228583999124;11032.944835275812;11095.056920161796;11100.278481898691;11100.666979990614;11102.888971110307;8423.789405264855;8610.354223433205;10809.621663241827;10927.071198948099;11055.889441105566;10551.419671918042;11054.447277636085;11054.723631909186;11086.556537738481;11102.2783519071;47298.29052564214;47803.76098119487;47808;47843.28235076477;47872.760636196945;3621.7102631789394;3634.60019397866;3643.3988391915304;3776.754510956779;4181.895452613709;35563.4665480018;36094.458583121275;36311.4553281701;36517;36602.08494787625;4711.976440117812;4774.212254977924;4860.781264843091;4899.951000490021;4987.376577927759;406361;411348;412294;412315;413164.999999997;38715.80642096828;72203.63898180476;72746.63626681939;73353.6332318335;73396.63301683564;39136.21727565433;42471.57528424738;42524.57475425206;42555;42567.57432425698;17529.29882804699;17752.733708994376;17753.644927101384;17761.200745966464;17774.822251777576;12376.62870113898;14264;14559.92720036393;14622.341994610268;14981.101133932;9282.932462766868;9380;9406.670766523139;9426.198773104226;9481.525923703788;3450.6204317525053;3490.877819276313;3491.336646037245;3502.404591219499;3544.3442963051916;1033.962376918136;1140.520981187903;1170.5083864776814;1187.5190547828142;1191.2137988927439;34736.65263347334;35632.46551301733;35673.82163089168;36118.09704757402;38597.15772478;1151.0087548540903;1156.6472225970992;1193.7194759231575;1195.9282443053444;1266.0378112634464;18245.34471071408;18270.908645456686;18741;18751.437456876316;18961.241550337832;612386;617179;617297;619558;619843;68647.3135268651;68969;68973;69031;69360.3063969364;1356.4438580182077;1415.688548519324;1456.8178977628008;1490.8583684549951;1513.6367271854897;32984.67015329816;35933;36215.45676814902;36718.44922326221;36735.63264367322;56511.43488565062;57180;57499.42500575108;57589.42410576008;57624.71187644035;488128;492795;492846;493583;494202;27476.17571472859;30440.695593043787;31030.844845775628;31198.532022019233;31772.205694857814;53078.2038269434;53922.730386347816;54058.45941540691;54681.72659136679;55182.44817551773;44330.11339773251;44866.551334486234;45008;45485.31772023488;46425;43906.780466098746;43939.78030109957;44410.555894440644;44697;45109;44547;45348.77325613351;45784;45975.3103703438;46164.76917615525;37709.4343584841;39393.60606393899;39902.40146397865;39906.80046599748;40150.79924600358;29365.39278662284;29823.70176298209;29860.552091718208;30196.5470517938;30237 03:40:40 INFO - PROCESS | 29834 | |2;jquery.html;416.7228792852752;426.65654148410556;432.45078749987516;433.69857948725627;437.2392037854133;18934.337298194565;20043.398698039065;20771.68842467364;21738.673919891215;21766.673499897515;19800.603987920233;20260.59478810423;20406.591868162628;20997.265095721654;21003.684944725843;5723.54211663067;5929;5967.850803729898;5974.432428919267;5979.372165922581;5654.321481422235;5823.737931793058;5833.620814647055;5836.970815145918;5870.002099643071;5765.192872997763;5767.653940763546;5769.24999750034;5771.365149833515;5793;5679.858003549903;5705.115707065412;5765.509931655814;5785.942140578624;5796.739146738407;5088.720120393377;5207.140821764404;5209.947900520984;5236.319278493771;5255.5795536357;24102.27693169208;24221.152259671002;24335.513289734285;24804.751952480605;24840.130595429073;2454.1165180534995;2627.4745050989686;2633.5259653262406;2849.472847523194;2909.912702618925;14665.56003319902;15123.546293611209;15155.469558565508;15368.231588420535;15670.451534196362;2062.0408815074943;2076.927307544244;2098.926537571193;2105.4210092224607;2163.5456554123652;77909.22090779076;81136.59431702863;81371;81838.18161818365;83000.58499707523;11136.498857551429;11408.88591114095;11468.770624587629;11611.825822612667;11632.651020469399;16498.092604906844;16509.6698066038;16511.587210319838;16544.42094526686;16560.337586496404;9160.267178625694;9325.487098209527;9365.531723413938;9375.62497500106;9456.196223320958;9271.211946984582;9314.115159059878;9322.114399132208;9448.04870745589;9462.337636365526;7057.717691292393;7173.964130179315;7193.352598266181;7339.633018349168;7359.77920662381;2036.175348983664;2041.3161590866928;2063.8968051597362;2066.8036536529007;2133.4559687279643;979.3683074416961;1066.6746642274181;1090.2640717515644;1113.2207454781685;1123.730304726876;19911;20645.896770516352;21018.684719729215;21186.67270672689;21288.148474060865;1039.2592407717043;1074.5862842805577;1086.163653986426;1088.733260351219;1124.9493772780245;10701.464926753632;11957.282563046245;12113.69715757113;12148.635540933787;12161.087918406154;447468;447914;506084;506810;523909;64650;72802.63598681973;87061.56469217614;90765;102700;1065.8401239813934;1091.5088210305394;1121.315997241682;1124.612008856943;1127.9097672186206;12669.873301266869;16373.345066197218;17245.56886077858;18039.278428862697;18466.446006619823;41597.58402415937;41980.37029444622;43331.35002974895;43416.56583434125;43504.34743478787;57741.13388299263;58613.4138658625;60485.39514604797;60491.69754151201;60768.39231607627;8162.142974987778;8479.2368686816;8667.0032946212;9203.217726493056;9660.855087173557;13423;14058.789118163031;14164;14235.928820355832;14374.568762937128;12421.875781242434;12589;12716.618501444971;12775.936120319338;12896.355182241037;11901.345426001653;12053.819192712292;12115.878841211475;12305.630831075083;12542.310172940575;12303.138780285652;12388.070894682754;12749.808752868528;12813.295268760308;12814.871851281368;8509.191626795444;8609.182127697859;8631.829120939445;8707.21635052823;8765.780855478664;12024.920882151373;12436.253824770543;12585.559505417266;12682.492700291885;12742.299173545543 03:40:40 INFO - PROCESS | 29834 | |3;mootools.html;1378.1180044771343;1556.5174795813298;1595.7367034439317;1753.8246175382462;1888.537308359452;8669.393142480028;9164.221041211496;9329.580168892398;9357.73670554475;9775.608975640984;9331.533423328823;9543;9550.856737148948;9558.80882382352;9594.760130996729;2136.476563242008;2195.4401627585025;2412.529556736437;2469.2839076667788;2504.874756262189;2471.8393304435244;2503.6119401492706;2504.023430861965;2508.285138735461;2509.9749002510016;2430.1008626808107;2487.987560062197;2498.1631153563576;2499.7125330587032;2499.962500562493;2104.558042811004;2379.559781440422;2391.772781585755;2433.051110067075;2439.256026911791;2399.844010139353;2409.8433601815827;2417.407735104893;2424.4666173441815;2426.7209270933718;9669;9742.025797420201;9743.12311891926;9754.658586949423;9760.121589057018;5637.267155269788;5808.564357673149;5842;5853.678047707374;5855.033919403336;3708.332500149972;3760.8495660173835;3774.226283611853;3804.3152232598122;3900.5319361676497;1280.7438512297485;1285.4665313894723;1291.767481853266;1292.3344477594046;1319.8152258683792;13925.651858703512;13932.233727144901;13950.860491395058;13974.93012534941;14011.159330440105;4966.776495057731;5056.873578160576;5168.508991645787;5177.068127737043;5177.456367081402;11408.600698975495;11524.481398337095;11525.88474115265;11550.191486596026;11557;5828.417158284223;5831;5832.50423713989;5837.970810146007;5845.970770146122;4594.540545945446;5250.264962905197;5409.486098820606;5409.675419474844;5467.972660136674;4307.5477074906685;4339.500957389878;4356.499002614676;4385.473743150842;4419.867403977822;1324.1128443942582;1366.5695305978586;1369.7945308203848;1373.3957058894255;1389.9235542045083;1033.9379637221791;1046.926715129949;1052.7420781908481;1052.8104941110673;1069.1286601419818;6666.366695163952;6791.320867913169;6861.931380686229;6883.483738719616;6963.895541566881;500.7521276967851;501.30318856788364;503.51913922204204;505.31529777152167;518.6525028231094;4686.5782079613;4756.548127927841;4764.190087685102;4793.23308270675;4795.400574928134;11864.762704745857;12060.879391206152;12440.253584784941;12489.875101249054;12546.247225166519;12205.511779528897;12282.32447215394;12299.815502767466;12308.876911230953;12333.136680432284;9018.23345015681;9196;9208.999999999865;9220;9220.769480763034;6914.827129321807;7075.964620176866;7098.6450677466955;7131.82170445743;7144.3927266182955;11321.773564528829;11372.260803047775;11557.47991340375;11577.710557236136;11614.12894032934;11607.477663505331;11609.477573509044;11779.52881884715;11890.524379024742;11894.821577676168;7934.166912474107;8391.538465384463;8422.536760478233;8515.27620152294;8590.312774978112;9580.808383832424;9590.856137158087;9635.710928672152;9650.08324209199;9681.612735490502;8380.70667526658;8569.914300856912;8597.484150950962;8622.439541429787;8720.65117395297;7949.801254968672;8077.434579579373;8154.429189956646;8213.301869341172;8245.95877020635;7705.113911900204;7886;7888.211178882066;7896.407769417431;7907.446478746662;5675.687837168995;5675.858103547444;5744.224529688438;5770.249867517364;5894.045026868165;5789.305283365855;5833.270841144857;5873.823785286449;5904.6161999471615;5941.049432090845 03:40:40 INFO - PROCESS | 29834 | |4;prototype.html;362.23026069602093;365.4499977533811;367.9208970071436;372.9720270979674;373.1250218238232;5474.863128421792;5522.282103326567;5540.063766203918;5550.5282051025715;5578.219049333096;5363.54409875161;5472.480114389136;5478.945210547893;5497.257870187534;5504.944950550494;4308.719933204347;4320.740755554661;4332.978335108328;4369.759663218521;4376.277914144162;4310.4611923509565;4331.523532411448;4335.1546448442405;4338.089001309729;4344.413504176943;4284.250256205167;4291.978540107295;4316.244657184996;4327.5239723630375;4357;4224.52141750388;4285.451261202541;4315;4322.37325587788;4325.913481730379;3835.3096442640312;3856.2480316338324;3856.980715096435;3857.4792403025795;3863.265979463893;5307.230451584537;5318.787248510055;5322.627416080876;5332.080451037624;5333.413324534298;4903.166461701484;4981.825636102755;4993;4999.625028122905;5026.371703537058;5730.283714535683;5730.9426905730825;5740.6268592541355;5756.712164391805;5764.394738552475;4288.52826189119;4289.4852617685765;4299.118680670455;4308.763018034007;4315.834724624366;5622.718864056781;5743.582568371812;5746.79886203985;5964.912280701719;6034.728437220336;4316.266234740102;4333.58830911063;4341.848035318749;4348.34774783785;4372.1692878353015;4379.824807007748;4396.472423309224;4406.339049142654;4412.448443944507;4415.227335216325;4751.192297309397;4820.060088282751;4879.316895634614;4891.413030436371;4917.729524876167;5666.17840413146;5682.914756278659;5684.658920464785;5691.573132015115;5725.198472213893;1478.5712143478486;1512.886533509991;1516.7952326436011;1516.9393224270905;1534.9846501535064;989.2629990657007;998.5798639659139;1001.6093723447862;1003.3578509753763;1003.5333569890037;4918.852434426973;5005.023015908769;5019.322391477177;5035.748212589356;5041.294218809369;5209.453007434241;5238.659487133325;5250.501202385767;5274.602230408945;5307.044731948286;4688.578027977498;4956.975215123901;4977.502249774993;5007.874803129951;5014.799408023711;2775.2229375774814;2780.263230243987;2803.9859800700865;2804.214819850404;2809.9859500702364;5449.329828384063;5460.907818436329;5494.2857428534035;5494.2857428534835;5504.146857237135;5172.818951336685;5294.205869119663;5356.330458692663;5362.578916587107;5363.758630861621;5310.734463276821;5356.517913387814;5387.461253874581;5396.2984811974975;5402.082260797439;5178.559822415137;5200.9078093600765;5213.791448342024;5215.6609820361555;5231.973840130775;4825.469198388245;5061.975209916063;5116.437191908962;5176.922346164886;5197.298364720866;5324.6006549508165;5360.249565060973;5378.3058336623835;5387.925648625386;5424.267723857387;3948.203567376779;3961.4057891316534;3969.364901615728;3980.288475955367;4004.699647526389;4885.682430641997;5191.870203244949;5196.844094677166;5209.3013960088765;5212.009718153538;5072.644914855925;5084.491550844886;5104.515071068243;5135.6405051646025;5136.614753893398;5092.675904264992;5093.821716239914;5105.540501354896;5118.360204974379;5153.304303918923;4842.83050093245;4978.7510624467905;5018.222175562793;5036.974815125901;5038.118329292286;5099.087842059228;5160.354955630546;5172.5344718975475;5181.948180518298;5193.324867767166;4866.7079975201605;4952.306677065286;5063.1645778446145;5082.237664350377;5119.257707632447 03:40:40 INFO - PROCESS | 29834 | |5;yui.html;746.6453434618556;767.5931756169225;773.4044785515157;782.8747400415934;785.4109417936547;16187.595310117253;16928.153592320396;16940.23768930398;16947.915260423695;16974.236159372827;15096.698066038673;15185.392584296615;16076;16797.83202167978;16856.494305170865;876.8640860666591;878.0166213840507;883.3728053082319;884.3102380143498;884.6063501741728;894.2041582991143;896.6144557840126;896.8116695493954;897.5422534507416;898.7618281155467;941.5292353823088;943.0663642993455;943.1794338925145;943.7499062748343;944.2398868910524;933.1508327422014;938.0150841616344;938.5635679409073;940.2759874896326;940.3558562384754;681.5774219983642;683.1426559667635;683.4839696029516;688.5524409134052;688.8725585766649;16074.75887861683;16082.276297566521;16094.356225750957;16109.033457992558;16113.516594502184;14596.12423254608;15169.317380717785;15645.765313520305;15725.764113538306;16131;12061.577844775478;12292;12292.754144917051;12408.937955310255;12581.622551323475;4058.2492238935893;4067.9186416271805;4107.958920410788;4118.6499147572495;4232.132412855357;52188.47811521874;65954.3404565953;71905.87300799275;72536;80610.59694701488;12051.819222711667;12554.81167782484;12755.228651122066;12875;12975.610731678065;19348.516287092654;19418.611627767365;19570.41288761311;19603.411897643095;19608.117634706472;8725;8872.24585910205;8919.018907920123;9036.502992335354;9171.770705732277;4752.596029337545;4784.593309568726;4852.539008794159;4897.975510122498;4907.656464047483;3889.669378102893;4007.6593489553134;4010.458588090629;4175.54069052404;4376.234159022159;704.1479809430544;707.1584814071239;710.4919982212742;718.5652680128552;730.7990302666809;723.1719680965265;746.466276612214;789.6999140326755;806.1535387842741;813.800618848386;10066.848997265048;10151.7462063449;10194.235432342604;10317.27779055459;10434.895651043544;625.1778910732372;739.563657442101;744.292921724364;770.5646309834925;774.5236679442215;4647.279671650899;4788.664793464493;4851.95148048515;5003.2745251938995;5036.471170527115;121772.39113804551;125637;129375;130492.12785424489;134441;69370.3062969374;87497;88041;109752.4512377433;111834.44082779533;88197;91380;92071.53964230136;92302;92320.53839730758;9374.5781439834;9766.21870250364;10112.59549618007;10123.493825308853;10148.289619726549;50553.49446505635;50677.49322506728;52676.20985685295;53667.92664146773;54507;76333;78968.60515697385;79113;79616;81219;13648.385822638204;13817.585472435843;14029;14229.14625122496;14265.928670356581;15498.380064797282;15614.225101600554;15742.9212853935;15773.69221942294;15885.808564357489;13901.513447029305;14596.197209153173;14829.555113346616;15016.324265407864;15069.54791356261;14480;14736.115833050051;14771.926140369229;14815;15689.215539223222;14742.336594853043;14754.704905902037;14852.405903763729;15487;15679.372825086868;10986.670399888017;10989.985551292719;11020.228583999364;11126.833097503382;11614.361210133524;11737.706557336134;11829.290242585472;11959.461824217757;12097.153199275966;12409.689757755767 03:40:40 INFO - PROCESS | 29834 | __end_tp_report 03:40:40 INFO - PROCESS | 29834 | __start_cc_report 03:40:40 INFO - PROCESS | 29834 | _x_x_mozilla_cycle_collect,873 03:40:40 INFO - PROCESS | 29834 | __end_cc_report 03:40:40 INFO - PROCESS | 29834 | __startTimestamp1469270440053__endTimestamp 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - PROCESS | 29834 | ------- Summary: start ------- 03:40:40 INFO - PROCESS | 29834 | Number of tests: 6 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - PROCESS | 29834 | [#0] dojo.html Cycles:165 Average:5558.97 Median:5727.08 stddev:613.91 (10.7%) stddev-sans-first:590.22 03:40:40 INFO - PROCESS | 29834 | Values: 3323.9 3346.4 3355.6 3367.5 3394.6 5463.7 5563.1 5563.5 5563.9 5601.1 5577.1 5621.2 5622.8 5623.4 5659.5 4941.5 5078.4 5099.4 5128.8 5183.0 4954.8 5061.4 5095.9 5099.7 5101.2 5044.8 5074.6 5088.7 5121.3 5135.3 5192.4 5194.8 5197.2 5214.2 5227.5 4994.8 5002.3 5033.3 5106.4 5120.4 5401.1 5402.9 5429.9 5465.9 5479.9 6005.7 6006.2 6018.2 6018.6 6021.7 5920.3 5953.5 5975.1 6043.2 6053.0 5575.7 5593.2 5605.9 5619.2 5635.1 5983.1 6121.7 6127.4 6129.7 6136.7 5763.3 5794.3 5804.9 5888.1 5894.2 5976.2 5976.9 5996.5 6006.5 6015.3 5768.2 5849.3 5929.2 5931.7 5933.0 5917.9 5980.2 5994.0 5996.4 6029.8 4596.4 4601.4 4607.7 4620.1 4640.6 4040.4 4061.9 4102.2 4112.1 4136.4 5668.8 5704.7 5709.9 5712.2 5715.7 6032.3 6036.3 6036.4 6037.1 6061.6 5525.3 5592.2 5661.9 5664.5 5702.2 5179.0 5186.2 5188.1 5189.5 5191.4 6214.9 6227.8 6232.4 6243.1 6244.8 5868.4 5919.5 5993.0 6010.3 6105.2 6177.4 6225.3 6233.3 6234.5 6237.6 5882.6 5889.1 5889.5 5890.9 5930.0 5866.3 5930.4 5947.1 5968.9 6054.0 5846.8 5874.7 5887.5 5893.1 5904.7 5697.2 5845.2 5880.3 5903.0 5906.6 5658.7 5668.7 5700.3 5727.1 5734.6 5872.9 5886.0 5912.4 5919.2 5932.5 5631.4 5686.7 5722.0 5732.9 5765.9 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - PROCESS | 29834 | [#1] ext.html Cycles:180 Average:67373.22 Median:223255.90 stddev:136620.80 (61.2%) stddev-sans-first:136912.08 03:40:40 INFO - PROCESS | 29834 | Values: 601.9 641.7 651.7 653.2 664.0 33787.7 47192.0 48073.5 48086.0 52308.0 50495.7 51128.0 51130.0 51156.7 51202.7 8407.7 9175.6 9333.5 9333.9 10850.5 10520.0 11008.0 11010.6 11019.9 11020.2 11032.9 11095.1 11100.3 11100.7 11102.9 8423.8 8610.4 10809.6 10927.1 11055.9 10551.4 11054.4 11054.7 11086.6 11102.3 47298.3 47803.8 47808.0 47843.3 47872.8 3621.7 3634.6 3643.4 3776.8 4181.9 35563.5 36094.5 36311.5 36517.0 36602.1 4712.0 4774.2 4860.8 4900.0 4987.4 406361.0 411348.0 412294.0 412315.0 413165.0 38715.8 72203.6 72746.6 73353.6 73396.6 39136.2 42471.6 42524.6 42555.0 42567.6 17529.3 17752.7 17753.6 17761.2 17774.8 12376.6 14264.0 14559.9 14622.3 14981.1 9282.9 9380.0 9406.7 9426.2 9481.5 3450.6 3490.9 3491.3 3502.4 3544.3 1034.0 1140.5 1170.5 1187.5 1191.2 34736.7 35632.5 35673.8 36118.1 38597.2 1151.0 1156.6 1193.7 1195.9 1266.0 18245.3 18270.9 18741.0 18751.4 18961.2 612386.0 617179.0 617297.0 619558.0 619843.0 68647.3 68969.0 68973.0 69031.0 69360.3 1356.4 1415.7 1456.8 1490.9 1513.6 32984.7 35933.0 36215.5 36718.4 36735.6 56511.4 57180.0 57499.4 57589.4 57624.7 488128.0 492795.0 492846.0 493583.0 494202.0 27476.2 30440.7 31030.8 31198.5 31772.2 53078.2 53922.7 54058.5 54681.7 55182.4 44330.1 44866.6 45008.0 45485.3 46425.0 43906.8 43939.8 44410.6 44697.0 45109.0 44547.0 45348.8 45784.0 45975.3 46164.8 37709.4 39393.6 39902.4 39906.8 40150.8 29365.4 29823.7 29860.6 30196.5 30237.0 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - PROCESS | 29834 | [#2] jquery.html Cycles:180 Average:29384.92 Median:24161.71 stddev:80157.26 (331.8%) stddev-sans-first:80352.61 03:40:40 INFO - PROCESS | 29834 | Values: 416.7 426.7 432.5 433.7 437.2 18934.3 20043.4 20771.7 21738.7 21766.7 19800.6 20260.6 20406.6 20997.3 21003.7 5723.5 5929.0 5967.9 5974.4 5979.4 5654.3 5823.7 5833.6 5837.0 5870.0 5765.2 5767.7 5769.2 5771.4 5793.0 5679.9 5705.1 5765.5 5785.9 5796.7 5088.7 5207.1 5209.9 5236.3 5255.6 24102.3 24221.2 24335.5 24804.8 24840.1 2454.1 2627.5 2633.5 2849.5 2909.9 14665.6 15123.5 15155.5 15368.2 15670.5 2062.0 2076.9 2098.9 2105.4 2163.5 77909.2 81136.6 81371.0 81838.2 83000.6 11136.5 11408.9 11468.8 11611.8 11632.7 16498.1 16509.7 16511.6 16544.4 16560.3 9160.3 9325.5 9365.5 9375.6 9456.2 9271.2 9314.1 9322.1 9448.0 9462.3 7057.7 7174.0 7193.4 7339.6 7359.8 2036.2 2041.3 2063.9 2066.8 2133.5 979.4 1066.7 1090.3 1113.2 1123.7 19911.0 20645.9 21018.7 21186.7 21288.1 1039.3 1074.6 1086.2 1088.7 1124.9 10701.5 11957.3 12113.7 12148.6 12161.1 447468.0 447914.0 506084.0 506810.0 523909.0 64650.0 72802.6 87061.6 90765.0 102700.0 1065.8 1091.5 1121.3 1124.6 1127.9 12669.9 16373.3 17245.6 18039.3 18466.4 41597.6 41980.4 43331.4 43416.6 43504.3 57741.1 58613.4 60485.4 60491.7 60768.4 8162.1 8479.2 8667.0 9203.2 9660.9 13423.0 14058.8 14164.0 14235.9 14374.6 12421.9 12589.0 12716.6 12775.9 12896.4 11901.3 12053.8 12115.9 12305.6 12542.3 12303.1 12388.1 12749.8 12813.3 12814.9 8509.2 8609.2 8631.8 8707.2 8765.8 12024.9 12436.3 12585.6 12682.5 12742.3 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - PROCESS | 29834 | [#3] mootools.html Cycles:180 Average:6441.02 Median:4881.09 stddev:3751.84 (76.9%) stddev-sans-first:3743.07 03:40:40 INFO - PROCESS | 29834 | Values: 1378.1 1556.5 1595.7 1753.8 1888.5 8669.4 9164.2 9329.6 9357.7 9775.6 9331.5 9543.0 9550.9 9558.8 9594.8 2136.5 2195.4 2412.5 2469.3 2504.9 2471.8 2503.6 2504.0 2508.3 2510.0 2430.1 2488.0 2498.2 2499.7 2500.0 2104.6 2379.6 2391.8 2433.1 2439.3 2399.8 2409.8 2417.4 2424.5 2426.7 9669.0 9742.0 9743.1 9754.7 9760.1 5637.3 5808.6 5842.0 5853.7 5855.0 3708.3 3760.8 3774.2 3804.3 3900.5 1280.7 1285.5 1291.8 1292.3 1319.8 13925.7 13932.2 13950.9 13974.9 14011.2 4966.8 5056.9 5168.5 5177.1 5177.5 11408.6 11524.5 11525.9 11550.2 11557.0 5828.4 5831.0 5832.5 5838.0 5846.0 4594.5 5250.3 5409.5 5409.7 5468.0 4307.5 4339.5 4356.5 4385.5 4419.9 1324.1 1366.6 1369.8 1373.4 1389.9 1033.9 1046.9 1052.7 1052.8 1069.1 6666.4 6791.3 6861.9 6883.5 6963.9 500.8 501.3 503.5 505.3 518.7 4686.6 4756.5 4764.2 4793.2 4795.4 11864.8 12060.9 12440.3 12489.9 12546.2 12205.5 12282.3 12299.8 12308.9 12333.1 9018.2 9196.0 9209.0 9220.0 9220.8 6914.8 7076.0 7098.6 7131.8 7144.4 11321.8 11372.3 11557.5 11577.7 11614.1 11607.5 11609.5 11779.5 11890.5 11894.8 7934.2 8391.5 8422.5 8515.3 8590.3 9580.8 9590.9 9635.7 9650.1 9681.6 8380.7 8569.9 8597.5 8622.4 8720.7 7949.8 8077.4 8154.4 8213.3 8246.0 7705.1 7886.0 7888.2 7896.4 7907.4 5675.7 5675.9 5744.2 5770.2 5894.0 5789.3 5833.3 5873.8 5904.6 5941.0 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - PROCESS | 29834 | [#4] prototype.html Cycles:180 Average:4576.89 Median:5039.71 stddev:1259.36 (25.0%) stddev-sans-first:1222.52 03:40:40 INFO - PROCESS | 29834 | Values: 362.2 365.4 367.9 373.0 373.1 5474.9 5522.3 5540.1 5550.5 5578.2 5363.5 5472.5 5478.9 5497.3 5504.9 4308.7 4320.7 4333.0 4369.8 4376.3 4310.5 4331.5 4335.2 4338.1 4344.4 4284.3 4292.0 4316.2 4327.5 4357.0 4224.5 4285.5 4315.0 4322.4 4325.9 3835.3 3856.2 3857.0 3857.5 3863.3 5307.2 5318.8 5322.6 5332.1 5333.4 4903.2 4981.8 4993.0 4999.6 5026.4 5730.3 5730.9 5740.6 5756.7 5764.4 4288.5 4289.5 4299.1 4308.8 4315.8 5622.7 5743.6 5746.8 5964.9 6034.7 4316.3 4333.6 4341.8 4348.3 4372.2 4379.8 4396.5 4406.3 4412.4 4415.2 4751.2 4820.1 4879.3 4891.4 4917.7 5666.2 5682.9 5684.7 5691.6 5725.2 1478.6 1512.9 1516.8 1516.9 1535.0 989.3 998.6 1001.6 1003.4 1003.5 4918.9 5005.0 5019.3 5035.7 5041.3 5209.5 5238.7 5250.5 5274.6 5307.0 4688.6 4957.0 4977.5 5007.9 5014.8 2775.2 2780.3 2804.0 2804.2 2810.0 5449.3 5460.9 5494.3 5494.3 5504.1 5172.8 5294.2 5356.3 5362.6 5363.8 5310.7 5356.5 5387.5 5396.3 5402.1 5178.6 5200.9 5213.8 5215.7 5232.0 4825.5 5062.0 5116.4 5176.9 5197.3 5324.6 5360.2 5378.3 5387.9 5424.3 3948.2 3961.4 3969.4 3980.3 4004.7 4885.7 5191.9 5196.8 5209.3 5212.0 5072.6 5084.5 5104.5 5135.6 5136.6 5092.7 5093.8 5105.5 5118.4 5153.3 4842.8 4978.8 5018.2 5037.0 5038.1 5099.1 5160.4 5172.5 5181.9 5193.3 4866.7 4952.3 5063.2 5082.2 5119.3 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - PROCESS | 29834 | [#5] yui.html Cycles:180 Average:21491.69 Median:4113.30 stddev:31009.78 (753.9%) stddev-sans-first:31057.65 03:40:40 INFO - PROCESS | 29834 | Values: 746.6 767.6 773.4 782.9 785.4 16187.6 16928.2 16940.2 16947.9 16974.2 15096.7 15185.4 16076.0 16797.8 16856.5 876.9 878.0 883.4 884.3 884.6 894.2 896.6 896.8 897.5 898.8 941.5 943.1 943.2 943.7 944.2 933.2 938.0 938.6 940.3 940.4 681.6 683.1 683.5 688.6 688.9 16074.8 16082.3 16094.4 16109.0 16113.5 14596.1 15169.3 15645.8 15725.8 16131.0 12061.6 12292.0 12292.8 12408.9 12581.6 4058.2 4067.9 4108.0 4118.6 4232.1 52188.5 65954.3 71905.9 72536.0 80610.6 12051.8 12554.8 12755.2 12875.0 12975.6 19348.5 19418.6 19570.4 19603.4 19608.1 8725.0 8872.2 8919.0 9036.5 9171.8 4752.6 4784.6 4852.5 4898.0 4907.7 3889.7 4007.7 4010.5 4175.5 4376.2 704.1 707.2 710.5 718.6 730.8 723.2 746.5 789.7 806.2 813.8 10066.8 10151.7 10194.2 10317.3 10434.9 625.2 739.6 744.3 770.6 774.5 4647.3 4788.7 4852.0 5003.3 5036.5 121772.4 125637.0 129375.0 130492.1 134441.0 69370.3 87497.0 88041.0 109752.5 111834.4 88197.0 91380.0 92071.5 92302.0 92320.5 9374.6 9766.2 10112.6 10123.5 10148.3 50553.5 50677.5 52676.2 53667.9 54507.0 76333.0 78968.6 79113.0 79616.0 81219.0 13648.4 13817.6 14029.0 14229.1 14265.9 15498.4 15614.2 15742.9 15773.7 15885.8 13901.5 14596.2 14829.6 15016.3 15069.5 14480.0 14736.1 14771.9 14815.0 15689.2 14742.3 14754.7 14852.4 15487.0 15679.4 10986.7 10990.0 11020.2 11126.8 11614.4 11737.7 11829.3 11959.5 12097.2 12409.7 03:40:40 INFO - PROCESS | 29834 | -------- Summary: end -------- 03:40:40 INFO - PROCESS | 29834 | 03:40:40 INFO - TEST-INFO | 29834: exit 0 03:40:40 INFO - TEST-OK | dromaeo_css | took 1111863ms 03:40:40 INFO - TEST-START | kraken 03:40:40 INFO - operating with platform_type : linux_ 03:40:40 INFO - Initialising browser for kraken test... 03:40:40 INFO - TEST-INFO | started process 30024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1svJMs/profile http://localhost:59361/getInfo.html) 03:40:44 INFO - PROCESS | 30024 | __metrics Screen width/height:1600/1200 03:40:44 INFO - PROCESS | 30024 | colorDepth:24 03:40:44 INFO - PROCESS | 30024 | Browser inner width/height: 1024/697 03:40:44 INFO - PROCESS | 30024 | __metrics 03:40:45 INFO - PROCESS | 30024 | 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:40:45 ERROR - PROCESS | 30024 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:40:46 INFO - TEST-INFO | 30024: exit 0 03:40:46 INFO - Browser initialized. 03:40:46 INFO - Running cycle 1/1 for kraken test... 03:40:46 INFO - TEST-INFO | started process 30121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1svJMs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:58 INFO - PROCESS | 30121 | RSS: Main: 146104320 03:40:58 INFO - PROCESS | 30121 | 03:41:00 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59361/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:01 INFO - PROCESS | 30121 | RSS: Main: 195334144 03:41:01 INFO - PROCESS | 30121 | 03:41:03 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59361/tests/kraken/driver.html?testName=audio-dft) 03:41:04 INFO - PROCESS | 30121 | RSS: Main: 194412544 03:41:04 INFO - PROCESS | 30121 | 03:41:07 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59361/tests/kraken/driver.html?testName=audio-fft) 03:41:07 INFO - PROCESS | 30121 | RSS: Main: 280260608 03:41:07 INFO - PROCESS | 30121 | 03:41:10 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59361/tests/kraken/driver.html?testName=audio-oscillator) 03:41:10 INFO - PROCESS | 30121 | RSS: Main: 189046784 03:41:10 INFO - PROCESS | 30121 | 03:41:12 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:13 INFO - PROCESS | 30121 | RSS: Main: 189288448 03:41:13 INFO - PROCESS | 30121 | 03:41:16 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59361/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:16 INFO - PROCESS | 30121 | RSS: Main: 224276480 03:41:16 INFO - PROCESS | 30121 | 03:41:20 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59361/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:20 INFO - PROCESS | 30121 | RSS: Main: 224555008 03:41:20 INFO - PROCESS | 30121 | 03:41:23 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59361/tests/kraken/driver.html?testName=json-parse-financial) 03:41:24 INFO - PROCESS | 30121 | RSS: Main: 223477760 03:41:24 INFO - PROCESS | 30121 | 03:41:25 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:26 INFO - PROCESS | 30121 | RSS: Main: 201220096 03:41:26 INFO - PROCESS | 30121 | 03:41:28 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59361/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:28 INFO - PROCESS | 30121 | RSS: Main: 202788864 03:41:28 INFO - PROCESS | 30121 | 03:41:30 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:31 INFO - PROCESS | 30121 | RSS: Main: 210169856 03:41:31 INFO - PROCESS | 30121 | 03:41:33 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:34 INFO - PROCESS | 30121 | RSS: Main: 214433792 03:41:34 INFO - PROCESS | 30121 | 03:41:37 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:37 INFO - PROCESS | 30121 | RSS: Main: 212897792 03:41:37 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | Cycle 1(1): loaded http://localhost:59361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59361/tests/kraken/driver.html?testName=ai-astar) 03:41:39 INFO - PROCESS | 30121 | RSS: Main: 254898176 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | __start_tp_report 03:41:39 INFO - PROCESS | 30121 | _x_x_mozilla_page_load 03:41:39 INFO - PROCESS | 30121 | _x_x_mozilla_page_load_details 03:41:39 INFO - PROCESS | 30121 | |i|pagename|runs| 03:41:39 INFO - PROCESS | 30121 | |0;ai-astar;110;102;109;111;109;109;108;109;109;107 03:41:39 INFO - PROCESS | 30121 | |1;audio-beat-detection;155;122;125;170;125;131;155;125;152;124 03:41:39 INFO - PROCESS | 30121 | |2;audio-dft;162;161;161;162;160;160;160;161;160;159 03:41:39 INFO - PROCESS | 30121 | |3;audio-fft;74;75;74;123;75;75;73;76;101;73 03:41:39 INFO - PROCESS | 30121 | |4;audio-oscillator;84;84;110;84;85;84;115;86;86;122 03:41:39 INFO - PROCESS | 30121 | |5;imaging-gaussian-blur;117;117;118;117;117;117;116;117;117;117 03:41:39 INFO - PROCESS | 30121 | |6;imaging-darkroom;146;145;145;146;146;146;146;147;145;145 03:41:39 INFO - PROCESS | 30121 | |7;imaging-desaturate;95;95;95;94;94;95;94;94;95;94 03:41:39 INFO - PROCESS | 30121 | |8;json-parse-financial;51;50;49;51;51;52;52;51;52;51 03:41:39 INFO - PROCESS | 30121 | |9;json-stringify-tinderbox;61;60;59;60;59;60;60;59;60;60 03:41:39 INFO - PROCESS | 30121 | |10;stanford-crypto-aes;75;76;78;76;76;76;76;76;102;82 03:41:39 INFO - PROCESS | 30121 | |11;stanford-crypto-ccm;122;134;137;136;127;120;116;116;126;128 03:41:39 INFO - PROCESS | 30121 | |12;stanford-crypto-pbkdf2;152;154;155;152;152;151;155;153;160;152 03:41:39 INFO - PROCESS | 30121 | |13;stanford-crypto-sha256-iterative;61;60;62;60;61;61;64;60;59;61 03:41:39 INFO - PROCESS | 30121 | __end_tp_report 03:41:39 INFO - PROCESS | 30121 | __start_cc_report 03:41:39 INFO - PROCESS | 30121 | _x_x_mozilla_cycle_collect,1555 03:41:39 INFO - PROCESS | 30121 | __end_cc_report 03:41:39 INFO - PROCESS | 30121 | __startTimestamp1469270499696__endTimestamp 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | ------- Summary: start ------- 03:41:39 INFO - PROCESS | 30121 | Number of tests: 14 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:2.45 (2.2%) stddev-sans-first:2.52 03:41:39 INFO - PROCESS | 30121 | Values: 110.0 102.0 109.0 111.0 109.0 109.0 108.0 109.0 109.0 107.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:141.50 stddev:17.65 (12.5%) stddev-sans-first:17.67 03:41:39 INFO - PROCESS | 30121 | Values: 155.0 122.0 125.0 170.0 125.0 131.0 155.0 125.0 152.0 124.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 03:41:39 INFO - PROCESS | 30121 | Values: 162.0 161.0 161.0 162.0 160.0 160.0 160.0 161.0 160.0 159.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.50 stddev:16.72 (22.4%) stddev-sans-first:17.48 03:41:39 INFO - PROCESS | 30121 | Values: 74.0 75.0 74.0 123.0 75.0 75.0 73.0 76.0 101.0 73.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.00 stddev:15.24 (18.1%) stddev-sans-first:15.73 03:41:39 INFO - PROCESS | 30121 | Values: 84.0 84.0 110.0 84.0 85.0 84.0 115.0 86.0 86.0 122.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 03:41:39 INFO - PROCESS | 30121 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:41:39 INFO - PROCESS | 30121 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 146.0 147.0 145.0 145.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:41:39 INFO - PROCESS | 30121 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 03:41:39 INFO - PROCESS | 30121 | Values: 51.0 50.0 49.0 51.0 51.0 52.0 52.0 51.0 52.0 51.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 03:41:39 INFO - PROCESS | 30121 | Values: 61.0 60.0 59.0 60.0 59.0 60.0 60.0 59.0 60.0 60.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:76.00 stddev:8.22 (10.8%) stddev-sans-first:8.57 03:41:39 INFO - PROCESS | 30121 | Values: 75.0 76.0 78.0 76.0 76.0 76.0 76.0 76.0 102.0 82.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.50 stddev:7.76 (6.1%) stddev-sans-first:8.08 03:41:39 INFO - PROCESS | 30121 | Values: 122.0 134.0 137.0 136.0 127.0 120.0 116.0 116.0 126.0 128.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.50 stddev:2.63 (1.7%) stddev-sans-first:2.73 03:41:39 INFO - PROCESS | 30121 | Values: 152.0 154.0 155.0 152.0 152.0 151.0 155.0 153.0 160.0 152.0 03:41:39 INFO - PROCESS | 30121 | 03:41:39 INFO - PROCESS | 30121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.00 stddev:1.37 (2.2%) stddev-sans-first:1.45 03:41:39 INFO - PROCESS | 30121 | Values: 61.0 60.0 62.0 60.0 61.0 61.0 64.0 60.0 59.0 61.0 03:41:39 INFO - PROCESS | 30121 | -------- Summary: end -------- 03:41:39 INFO - PROCESS | 30121 | 03:41:40 INFO - TEST-INFO | 30121: exit 0 03:41:40 INFO - TEST-OK | kraken | took 59927ms 03:41:40 INFO - SUITE-END | took 1171s 03:41:40 INFO - Completed test suite (00:19:32) 03:41:40 INFO - javascript benchmark 03:41:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.8670453181876, 3346.43110671186, 3355.5637767090284, 3367.545381373514, 3394.626591074981, 5463.726813659321, 5563.054280772269, 5563.499285064343, 5563.916541251874, 5601.131824567188, 5577.051901176799, 5621.184928185411, 5622.803201887935, 5623.381428042922, 5659.490645841874, 4941.4811444798315, 5078.39059312883, 5099.36257967754, 5128.769205385748, 5183.041137389576, 4954.801807927696, 5061.392632884059, 5095.949040509603, 5099.745012749348, 5101.183810590306, 5044.848654540369, 5074.644774865761, 5088.745562721868, 5121.3342265505435, 5135.3067335909545, 5192.350956130484, 5194.818181363634, 5197.246399272103, 5214.243934629458, 5227.529522342969, 4994.750262486861, 5002.349694539723, 5033.295338652591, 5106.4382917879, 5120.411152717411, 5401.108817045183, 5402.945970540283, 5429.918551221735, 5465.890682186334, 5479.890402191973, 6005.729742161613, 6006.159137720722, 6018.187544681499, 6018.578699491038, 6021.668808215546, 5920.348761636216, 5953.493953013999, 5975.133605627159, 6043.244594425697, 6053.031514957585, 5575.665460072368, 5593.161025846115, 5605.943940560624, 5619.241402410663, 5635.126555383922, 5983.132445795335, 6121.71479964027, 6127.444870446228, 6129.662868542273, 6136.693165341715, 5763.337216220189, 5794.304683438015, 5804.9419505805245, 5888.057910734262, 5894.17481552583, 5976.193213916065, 5976.910346344808, 5996.5202783777195, 6006.459418652343, 6015.278166619946, 5768.163616275617, 5849.298084229919, 5929.199558059693, 5931.73307201177, 5933.0, 5917.852053698606, 5980.192673988956, 5994.040953447515, 5996.370381110008, 6029.758809647653, 4596.448426188878, 4601.401817763736, 4607.7004994675235, 4620.0990806793025, 4640.605548528345, 4040.3535434330365, 4061.878143655695, 4102.179564087194, 4112.115895082572, 4136.44158038667, 5668.773249069991, 5704.71476426177, 5709.857253568694, 5712.2288491054005, 5715.714214289352, 6032.276126864716, 6036.275646922398, 6036.426539478743, 6037.0642550404755, 6061.605995610271, 5525.281713377235, 5592.245046918614, 5661.943380566224, 5664.54683625309, 5702.2301989231755, 5178.974105129526, 5186.247994040843, 5188.092083885305, 5189.506996835295, 5191.351081114861, 6214.937850621526, 6227.782027629011, 6232.407921247474, 6243.125962365272, 6244.843878902973, 5868.4424979626865, 5919.526437885045, 5993.0, 6010.308814486215, 6105.17580126695, 6177.351707609383, 6225.31521532622, 6233.345498722569, 6234.470070044097, 6237.625742455467, 5882.647041177543, 5889.087191485327, 5889.52883769306, 5890.941090589211, 5930.0, 5866.325372582208, 5930.406959304035, 5947.137665038632, 5968.910466342922, 6054.0, 5846.766129354778, 5874.735636896265, 5887.470127688529, 5893.086571581412, 5904.704764761659, 5697.202391665087, 5845.18167456548, 5880.294364676266, 5903.0, 5906.586538942232, 5658.745356459051, 5668.716564171693, 5700.287464066992, 5727.083666613322, 5734.59857809966, 5872.853178670396, 5885.970570147122, 5912.408759124053, 5919.200907877554, 5932.525397968066, 5631.408702086386, 5686.687232202268, 5721.971390143022, 5732.885342293214, 5765.94234057654], "value": 5519.238591569505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.8555546668798, 641.7144370755013, 651.6871901487283, 653.2291895563235, 663.9966800165998, 33787.66212337879, 47192.0, 48073.51926480734, 48086.038279234395, 52308.0, 50495.74752126234, 51128.0, 51130.0, 51156.74421627896, 51202.74398628002, 8407.747767566952, 9175.63297468102, 9333.533323333806, 9333.859992100124, 10850.457477126112, 10520.0, 11008.0, 11010.614628488005, 11019.889801102006, 11020.228583999124, 11032.944835275812, 11095.056920161796, 11100.278481898691, 11100.666979990614, 11102.888971110307, 8423.789405264855, 8610.354223433205, 10809.621663241827, 10927.071198948099, 11055.889441105566, 10551.419671918042, 11054.447277636085, 11054.723631909186, 11086.556537738481, 11102.2783519071, 47298.29052564214, 47803.76098119487, 47808.0, 47843.28235076477, 47872.760636196945, 3621.7102631789394, 3634.60019397866, 3643.3988391915304, 3776.754510956779, 4181.895452613709, 35563.4665480018, 36094.458583121275, 36311.4553281701, 36517.0, 36602.08494787625, 4711.976440117812, 4774.212254977924, 4860.781264843091, 4899.951000490021, 4987.376577927759, 406361.0, 411348.0, 412294.0, 412315.0, 413164.999999997, 38715.80642096828, 72203.63898180476, 72746.63626681939, 73353.6332318335, 73396.63301683564, 39136.21727565433, 42471.57528424738, 42524.57475425206, 42555.0, 42567.57432425698, 17529.29882804699, 17752.733708994376, 17753.644927101384, 17761.200745966464, 17774.822251777576, 12376.62870113898, 14264.0, 14559.92720036393, 14622.341994610268, 14981.101133932, 9282.932462766868, 9380.0, 9406.670766523139, 9426.198773104226, 9481.525923703788, 3450.6204317525053, 3490.877819276313, 3491.336646037245, 3502.404591219499, 3544.3442963051916, 1033.962376918136, 1140.520981187903, 1170.5083864776814, 1187.5190547828142, 1191.2137988927439, 34736.65263347334, 35632.46551301733, 35673.82163089168, 36118.09704757402, 38597.15772478, 1151.0087548540903, 1156.6472225970992, 1193.7194759231575, 1195.9282443053444, 1266.0378112634464, 18245.34471071408, 18270.908645456686, 18741.0, 18751.437456876316, 18961.241550337832, 612386.0, 617179.0, 617297.0, 619558.0, 619843.0, 68647.3135268651, 68969.0, 68973.0, 69031.0, 69360.3063969364, 1356.4438580182077, 1415.688548519324, 1456.8178977628008, 1490.8583684549951, 1513.6367271854897, 32984.67015329816, 35933.0, 36215.45676814902, 36718.44922326221, 36735.63264367322, 56511.43488565062, 57180.0, 57499.42500575108, 57589.42410576008, 57624.71187644035, 488128.0, 492795.0, 492846.0, 493583.0, 494202.0, 27476.17571472859, 30440.695593043787, 31030.844845775628, 31198.532022019233, 31772.205694857814, 53078.2038269434, 53922.730386347816, 54058.45941540691, 54681.72659136679, 55182.44817551773, 44330.11339773251, 44866.551334486234, 45008.0, 45485.31772023488, 46425.0, 43906.780466098746, 43939.78030109957, 44410.555894440644, 44697.0, 45109.0, 44547.0, 45348.77325613351, 45784.0, 45975.3103703438, 46164.76917615525, 37709.4343584841, 39393.60606393899, 39902.40146397865, 39906.80046599748, 40150.79924600358, 29365.39278662284, 29823.70176298209, 29860.552091718208, 30196.5470517938, 30237.0], "value": 21203.732373765273, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.7228792852752, 426.65654148410556, 432.45078749987516, 433.69857948725627, 437.2392037854133, 18934.337298194565, 20043.398698039065, 20771.68842467364, 21738.673919891215, 21766.673499897515, 19800.603987920233, 20260.59478810423, 20406.591868162628, 20997.265095721654, 21003.684944725843, 5723.54211663067, 5929.0, 5967.850803729898, 5974.432428919267, 5979.372165922581, 5654.321481422235, 5823.737931793058, 5833.620814647055, 5836.970815145918, 5870.002099643071, 5765.192872997763, 5767.653940763546, 5769.24999750034, 5771.365149833515, 5793.0, 5679.858003549903, 5705.115707065412, 5765.509931655814, 5785.942140578624, 5796.739146738407, 5088.720120393377, 5207.140821764404, 5209.947900520984, 5236.319278493771, 5255.5795536357, 24102.27693169208, 24221.152259671002, 24335.513289734285, 24804.751952480605, 24840.130595429073, 2454.1165180534995, 2627.4745050989686, 2633.5259653262406, 2849.472847523194, 2909.912702618925, 14665.56003319902, 15123.546293611209, 15155.469558565508, 15368.231588420535, 15670.451534196362, 2062.0408815074943, 2076.927307544244, 2098.926537571193, 2105.4210092224607, 2163.5456554123652, 77909.22090779076, 81136.59431702863, 81371.0, 81838.18161818365, 83000.58499707523, 11136.498857551429, 11408.88591114095, 11468.770624587629, 11611.825822612667, 11632.651020469399, 16498.092604906844, 16509.6698066038, 16511.587210319838, 16544.42094526686, 16560.337586496404, 9160.267178625694, 9325.487098209527, 9365.531723413938, 9375.62497500106, 9456.196223320958, 9271.211946984582, 9314.115159059878, 9322.114399132208, 9448.04870745589, 9462.337636365526, 7057.717691292393, 7173.964130179315, 7193.352598266181, 7339.633018349168, 7359.77920662381, 2036.175348983664, 2041.3161590866928, 2063.8968051597362, 2066.8036536529007, 2133.4559687279643, 979.3683074416961, 1066.6746642274181, 1090.2640717515644, 1113.2207454781685, 1123.730304726876, 19911.0, 20645.896770516352, 21018.684719729215, 21186.67270672689, 21288.148474060865, 1039.2592407717043, 1074.5862842805577, 1086.163653986426, 1088.733260351219, 1124.9493772780245, 10701.464926753632, 11957.282563046245, 12113.69715757113, 12148.635540933787, 12161.087918406154, 447468.0, 447914.0, 506084.0, 506810.0, 523909.0, 64650.0, 72802.63598681973, 87061.56469217614, 90765.0, 102700.0, 1065.8401239813934, 1091.5088210305394, 1121.315997241682, 1124.612008856943, 1127.9097672186206, 12669.873301266869, 16373.345066197218, 17245.56886077858, 18039.278428862697, 18466.446006619823, 41597.58402415937, 41980.37029444622, 43331.35002974895, 43416.56583434125, 43504.34743478787, 57741.13388299263, 58613.4138658625, 60485.39514604797, 60491.69754151201, 60768.39231607627, 8162.142974987778, 8479.2368686816, 8667.0032946212, 9203.217726493056, 9660.855087173557, 13423.0, 14058.789118163031, 14164.0, 14235.928820355832, 14374.568762937128, 12421.875781242434, 12589.0, 12716.618501444971, 12775.936120319338, 12896.355182241037, 11901.345426001653, 12053.819192712292, 12115.878841211475, 12305.630831075083, 12542.310172940575, 12303.138780285652, 12388.070894682754, 12749.808752868528, 12813.295268760308, 12814.871851281368, 8509.191626795444, 8609.182127697859, 8631.829120939445, 8707.21635052823, 8765.780855478664, 12024.920882151373, 12436.253824770543, 12585.559505417266, 12682.492700291885, 12742.299173545543], "value": 9880.127425904291, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.1180044771343, 1556.5174795813298, 1595.7367034439317, 1753.8246175382462, 1888.537308359452, 8669.393142480028, 9164.221041211496, 9329.580168892398, 9357.73670554475, 9775.608975640984, 9331.533423328823, 9543.0, 9550.856737148948, 9558.80882382352, 9594.760130996729, 2136.476563242008, 2195.4401627585025, 2412.529556736437, 2469.2839076667788, 2504.874756262189, 2471.8393304435244, 2503.6119401492706, 2504.023430861965, 2508.285138735461, 2509.9749002510016, 2430.1008626808107, 2487.987560062197, 2498.1631153563576, 2499.7125330587032, 2499.962500562493, 2104.558042811004, 2379.559781440422, 2391.772781585755, 2433.051110067075, 2439.256026911791, 2399.844010139353, 2409.8433601815827, 2417.407735104893, 2424.4666173441815, 2426.7209270933718, 9669.0, 9742.025797420201, 9743.12311891926, 9754.658586949423, 9760.121589057018, 5637.267155269788, 5808.564357673149, 5842.0, 5853.678047707374, 5855.033919403336, 3708.332500149972, 3760.8495660173835, 3774.226283611853, 3804.3152232598122, 3900.5319361676497, 1280.7438512297485, 1285.4665313894723, 1291.767481853266, 1292.3344477594046, 1319.8152258683792, 13925.651858703512, 13932.233727144901, 13950.860491395058, 13974.93012534941, 14011.159330440105, 4966.776495057731, 5056.873578160576, 5168.508991645787, 5177.068127737043, 5177.456367081402, 11408.600698975495, 11524.481398337095, 11525.88474115265, 11550.191486596026, 11557.0, 5828.417158284223, 5831.0, 5832.50423713989, 5837.970810146007, 5845.970770146122, 4594.540545945446, 5250.264962905197, 5409.486098820606, 5409.675419474844, 5467.972660136674, 4307.5477074906685, 4339.500957389878, 4356.499002614676, 4385.473743150842, 4419.867403977822, 1324.1128443942582, 1366.5695305978586, 1369.7945308203848, 1373.3957058894255, 1389.9235542045083, 1033.9379637221791, 1046.926715129949, 1052.7420781908481, 1052.8104941110673, 1069.1286601419818, 6666.366695163952, 6791.320867913169, 6861.931380686229, 6883.483738719616, 6963.895541566881, 500.7521276967851, 501.30318856788364, 503.51913922204204, 505.31529777152167, 518.6525028231094, 4686.5782079613, 4756.548127927841, 4764.190087685102, 4793.23308270675, 4795.400574928134, 11864.762704745857, 12060.879391206152, 12440.253584784941, 12489.875101249054, 12546.247225166519, 12205.511779528897, 12282.32447215394, 12299.815502767466, 12308.876911230953, 12333.136680432284, 9018.23345015681, 9196.0, 9208.999999999865, 9220.0, 9220.769480763034, 6914.827129321807, 7075.964620176866, 7098.6450677466955, 7131.82170445743, 7144.3927266182955, 11321.773564528829, 11372.260803047775, 11557.47991340375, 11577.710557236136, 11614.12894032934, 11607.477663505331, 11609.477573509044, 11779.52881884715, 11890.524379024742, 11894.821577676168, 7934.166912474107, 8391.538465384463, 8422.536760478233, 8515.27620152294, 8590.312774978112, 9580.808383832424, 9590.856137158087, 9635.710928672152, 9650.08324209199, 9681.612735490502, 8380.70667526658, 8569.914300856912, 8597.484150950962, 8622.439541429787, 8720.65117395297, 7949.801254968672, 8077.434579579373, 8154.429189956646, 8213.301869341172, 8245.95877020635, 7705.113911900204, 7886.0, 7888.211178882066, 7896.407769417431, 7907.446478746662, 5675.687837168995, 5675.858103547444, 5744.224529688438, 5770.249867517364, 5894.045026868165, 5789.305283365855, 5833.270841144857, 5873.823785286449, 5904.6161999471615, 5941.049432090845], "value": 5019.821724073928, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.23026069602093, 365.4499977533811, 367.9208970071436, 372.9720270979674, 373.1250218238232, 5474.863128421792, 5522.282103326567, 5540.063766203918, 5550.5282051025715, 5578.219049333096, 5363.54409875161, 5472.480114389136, 5478.945210547893, 5497.257870187534, 5504.944950550494, 4308.719933204347, 4320.740755554661, 4332.978335108328, 4369.759663218521, 4376.277914144162, 4310.4611923509565, 4331.523532411448, 4335.1546448442405, 4338.089001309729, 4344.413504176943, 4284.250256205167, 4291.978540107295, 4316.244657184996, 4327.5239723630375, 4357.0, 4224.52141750388, 4285.451261202541, 4315.0, 4322.37325587788, 4325.913481730379, 3835.3096442640312, 3856.2480316338324, 3856.980715096435, 3857.4792403025795, 3863.265979463893, 5307.230451584537, 5318.787248510055, 5322.627416080876, 5332.080451037624, 5333.413324534298, 4903.166461701484, 4981.825636102755, 4993.0, 4999.625028122905, 5026.371703537058, 5730.283714535683, 5730.9426905730825, 5740.6268592541355, 5756.712164391805, 5764.394738552475, 4288.52826189119, 4289.4852617685765, 4299.118680670455, 4308.763018034007, 4315.834724624366, 5622.718864056781, 5743.582568371812, 5746.79886203985, 5964.912280701719, 6034.728437220336, 4316.266234740102, 4333.58830911063, 4341.848035318749, 4348.34774783785, 4372.1692878353015, 4379.824807007748, 4396.472423309224, 4406.339049142654, 4412.448443944507, 4415.227335216325, 4751.192297309397, 4820.060088282751, 4879.316895634614, 4891.413030436371, 4917.729524876167, 5666.17840413146, 5682.914756278659, 5684.658920464785, 5691.573132015115, 5725.198472213893, 1478.5712143478486, 1512.886533509991, 1516.7952326436011, 1516.9393224270905, 1534.9846501535064, 989.2629990657007, 998.5798639659139, 1001.6093723447862, 1003.3578509753763, 1003.5333569890037, 4918.852434426973, 5005.023015908769, 5019.322391477177, 5035.748212589356, 5041.294218809369, 5209.453007434241, 5238.659487133325, 5250.501202385767, 5274.602230408945, 5307.044731948286, 4688.578027977498, 4956.975215123901, 4977.502249774993, 5007.874803129951, 5014.799408023711, 2775.2229375774814, 2780.263230243987, 2803.9859800700865, 2804.214819850404, 2809.9859500702364, 5449.329828384063, 5460.907818436329, 5494.2857428534035, 5494.2857428534835, 5504.146857237135, 5172.818951336685, 5294.205869119663, 5356.330458692663, 5362.578916587107, 5363.758630861621, 5310.734463276821, 5356.517913387814, 5387.461253874581, 5396.2984811974975, 5402.082260797439, 5178.559822415137, 5200.9078093600765, 5213.791448342024, 5215.6609820361555, 5231.973840130775, 4825.469198388245, 5061.975209916063, 5116.437191908962, 5176.922346164886, 5197.298364720866, 5324.6006549508165, 5360.249565060973, 5378.3058336623835, 5387.925648625386, 5424.267723857387, 3948.203567376779, 3961.4057891316534, 3969.364901615728, 3980.288475955367, 4004.699647526389, 4885.682430641997, 5191.870203244949, 5196.844094677166, 5209.3013960088765, 5212.009718153538, 5072.644914855925, 5084.491550844886, 5104.515071068243, 5135.6405051646025, 5136.614753893398, 5092.675904264992, 5093.821716239914, 5105.540501354896, 5118.360204974379, 5153.304303918923, 4842.83050093245, 4978.7510624467905, 5018.222175562793, 5036.974815125901, 5038.118329292286, 5099.087842059228, 5160.354955630546, 5172.5344718975475, 5181.948180518298, 5193.324867767166, 4866.7079975201605, 4952.306677065286, 5063.1645778446145, 5082.237664350377, 5119.257707632447], "value": 4190.635909947941, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.6453434618556, 767.5931756169225, 773.4044785515157, 782.8747400415934, 785.4109417936547, 16187.595310117253, 16928.153592320396, 16940.23768930398, 16947.915260423695, 16974.236159372827, 15096.698066038673, 15185.392584296615, 16076.0, 16797.83202167978, 16856.494305170865, 876.8640860666591, 878.0166213840507, 883.3728053082319, 884.3102380143498, 884.6063501741728, 894.2041582991143, 896.6144557840126, 896.8116695493954, 897.5422534507416, 898.7618281155467, 941.5292353823088, 943.0663642993455, 943.1794338925145, 943.7499062748343, 944.2398868910524, 933.1508327422014, 938.0150841616344, 938.5635679409073, 940.2759874896326, 940.3558562384754, 681.5774219983642, 683.1426559667635, 683.4839696029516, 688.5524409134052, 688.8725585766649, 16074.75887861683, 16082.276297566521, 16094.356225750957, 16109.033457992558, 16113.516594502184, 14596.12423254608, 15169.317380717785, 15645.765313520305, 15725.764113538306, 16131.0, 12061.577844775478, 12292.0, 12292.754144917051, 12408.937955310255, 12581.622551323475, 4058.2492238935893, 4067.9186416271805, 4107.958920410788, 4118.6499147572495, 4232.132412855357, 52188.47811521874, 65954.3404565953, 71905.87300799275, 72536.0, 80610.59694701488, 12051.819222711667, 12554.81167782484, 12755.228651122066, 12875.0, 12975.610731678065, 19348.516287092654, 19418.611627767365, 19570.41288761311, 19603.411897643095, 19608.117634706472, 8725.0, 8872.24585910205, 8919.018907920123, 9036.502992335354, 9171.770705732277, 4752.596029337545, 4784.593309568726, 4852.539008794159, 4897.975510122498, 4907.656464047483, 3889.669378102893, 4007.6593489553134, 4010.458588090629, 4175.54069052404, 4376.234159022159, 704.1479809430544, 707.1584814071239, 710.4919982212742, 718.5652680128552, 730.7990302666809, 723.1719680965265, 746.466276612214, 789.6999140326755, 806.1535387842741, 813.800618848386, 10066.848997265048, 10151.7462063449, 10194.235432342604, 10317.27779055459, 10434.895651043544, 625.1778910732372, 739.563657442101, 744.292921724364, 770.5646309834925, 774.5236679442215, 4647.279671650899, 4788.664793464493, 4851.95148048515, 5003.2745251938995, 5036.471170527115, 121772.39113804551, 125637.0, 129375.0, 130492.12785424489, 134441.0, 69370.3062969374, 87497.0, 88041.0, 109752.4512377433, 111834.44082779533, 88197.0, 91380.0, 92071.53964230136, 92302.0, 92320.53839730758, 9374.5781439834, 9766.21870250364, 10112.59549618007, 10123.493825308853, 10148.289619726549, 50553.49446505635, 50677.49322506728, 52676.20985685295, 53667.92664146773, 54507.0, 76333.0, 78968.60515697385, 79113.0, 79616.0, 81219.0, 13648.385822638204, 13817.585472435843, 14029.0, 14229.14625122496, 14265.928670356581, 15498.380064797282, 15614.225101600554, 15742.9212853935, 15773.69221942294, 15885.808564357489, 13901.513447029305, 14596.197209153173, 14829.555113346616, 15016.324265407864, 15069.54791356261, 14480.0, 14736.115833050051, 14771.926140369229, 14815.0, 15689.215539223222, 14742.336594853043, 14754.704905902037, 14852.405903763729, 15487.0, 15679.372825086868, 10986.670399888017, 10989.985551292719, 11020.228583999364, 11126.833097503382, 11614.361210133524, 11737.706557336134, 11829.290242585472, 11959.461824217757, 12097.153199275966, 12409.689757755767], "value": 8005.990686533683, "unit": "score"}], "name": "dromaeo_css", "value": 7613.431256256465, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 102.0, 109.0, 111.0, 109.0, 109.0, 108.0, 109.0, 109.0, 107.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 125.0, 170.0, 125.0, 131.0, 155.0, 125.0, 152.0, 124.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 160.0, 160.0, 160.0, 161.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 123.0, 75.0, 75.0, 73.0, 76.0, 101.0, 73.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 84.0, 85.0, 84.0, 115.0, 86.0, 86.0, 122.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 51.0, 51.0, 52.0, 52.0, 51.0, 52.0, 51.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 76.0, 76.0, 76.0, 76.0, 76.0, 102.0, 82.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 134.0, 137.0, 136.0, 127.0, 120.0, 116.0, 116.0, 126.0, 128.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 155.0, 152.0, 152.0, 151.0, 155.0, 153.0, 160.0, 152.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 60.0, 61.0, 61.0, 64.0, 60.0, 59.0, 61.0], "value": 60.9, "unit": "score"}], "name": "kraken", "value": 1471.1999999999998, "alertThreshold": 2.0}]} 03:41:40 INFO - Return code: 0 03:41:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:40 ERROR - # TBPL SUCCESS # 03:41:40 INFO - Running post-action listener: _resource_record_post_action 03:41:40 INFO - ##### 03:41:40 INFO - ##### Finished run-tests step (success) 03:41:40 INFO - ##### 03:41:40 INFO - Running post-run listener: _resource_record_post_run 03:41:41 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507514880; Read time: 4; Write time: 386720 03:41:41 INFO - TinderboxPrint: CPU usage
13.2% 03:41:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 03:41:41 INFO - TinderboxPrint: I/O write bytes / time
507,514,880 / 386,720 03:41:41 INFO - TinderboxPrint: CPU idle
8,236.0 (86.8%) 03:41:41 INFO - TinderboxPrint: CPU user
1,208.6 (12.7%) 03:41:41 INFO - TinderboxPrint: Swap in / out
0 / 0 03:41:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 253095936; Read time: 0; Write time: 240788 03:41:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254418944; Read time: 4; Write time: 145932 03:41:41 INFO - Running post-run listener: _upload_blobber_files 03:41:41 INFO - Blob upload gear active. 03:41:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:41 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:41:41 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:41:41 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:41:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:41:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:41:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:42 INFO - (blobuploader) - INFO - Done attempting. 03:41:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:41:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:59 INFO - (blobuploader) - INFO - Done attempting. 03:41:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:41:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:00 INFO - (blobuploader) - INFO - Done attempting. 03:42:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:00 INFO - Return code: 0 03:42:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4488510ad876a155e8a3e7b6f960d2fcacb449df7a3eddbffb344fb9546d7a1ba86a1c8497f121f28d58c9760baa0a19f9bdd7100112831eb2cf0ce4b27f9ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3a48c6167d6c83511e929f0ea2c62433e38705528c470b9cd2884f65a55b14d9928c0370eca87b9d6edfe89e7cc5bdba08b5b96d1e3d3f7baa812b728bad9a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53f3bcd06fdbef319165353336a4fda74b95ea5fa47ce4d92033f5652b02242b86760691f28073d73ab5aaedb9d4a5cae18b9d41f843abefa9b7212246121e46"} 03:42:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:00 INFO - Contents: 03:42:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4488510ad876a155e8a3e7b6f960d2fcacb449df7a3eddbffb344fb9546d7a1ba86a1c8497f121f28d58c9760baa0a19f9bdd7100112831eb2cf0ce4b27f9ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3a48c6167d6c83511e929f0ea2c62433e38705528c470b9cd2884f65a55b14d9928c0370eca87b9d6edfe89e7cc5bdba08b5b96d1e3d3f7baa812b728bad9a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53f3bcd06fdbef319165353336a4fda74b95ea5fa47ce4d92033f5652b02242b86760691f28073d73ab5aaedb9d4a5cae18b9d41f843abefa9b7212246121e46"} 03:42:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:00 INFO - Copying logs to upload dir... 03:42:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.114852 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-23 03:41:59.341022) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-23 03:41:59.344716) ========= 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=ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923 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/4488510ad876a155e8a3e7b6f960d2fcacb449df7a3eddbffb344fb9546d7a1ba86a1c8497f121f28d58c9760baa0a19f9bdd7100112831eb2cf0ce4b27f9ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3a48c6167d6c83511e929f0ea2c62433e38705528c470b9cd2884f65a55b14d9928c0370eca87b9d6edfe89e7cc5bdba08b5b96d1e3d3f7baa812b728bad9a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53f3bcd06fdbef319165353336a4fda74b95ea5fa47ce4d92033f5652b02242b86760691f28073d73ab5aaedb9d4a5cae18b9d41f843abefa9b7212246121e46"} build_url:https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/Vd4ZzlbdSHGEu2A0IebLAw/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/4488510ad876a155e8a3e7b6f960d2fcacb449df7a3eddbffb344fb9546d7a1ba86a1c8497f121f28d58c9760baa0a19f9bdd7100112831eb2cf0ce4b27f9ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3a48c6167d6c83511e929f0ea2c62433e38705528c470b9cd2884f65a55b14d9928c0370eca87b9d6edfe89e7cc5bdba08b5b96d1e3d3f7baa812b728bad9a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53f3bcd06fdbef319165353336a4fda74b95ea5fa47ce4d92033f5652b02242b86760691f28073d73ab5aaedb9d4a5cae18b9d41f843abefa9b7212246121e46"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-23 03:41:59.373828) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 03:41:59.374188) ========= 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=ed14279e38b05397cf4aa391000001a4-1469251916.198553-1444844923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 03:41:59.458291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-23 03:41:59.458619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-23 03:41:59.458923) ========= ========= Total master_lag: 0.17 =========