builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1469615174.57 results: success (0) buildid: 20160727004019 builduid: 2fc58a4d5c144b7c97bb4b8cbf273105 revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.572523) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.572982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.573426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.607246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.607530) ========= 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=337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 03:26:14-- 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% 27.1M=0s 2016-07-27 03:26:15 (27.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.426650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.048211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.048523) ========= 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=337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.098781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.099132) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebd239b4cbfb8eff833560f72b163275ac4026d3 --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 ebd239b4cbfb8eff833560f72b163275ac4026d3 --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=337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 03:26:15,243 truncating revision to first 12 chars 2016-07-27 03:26:15,243 Setting DEBUG logging. 2016-07-27 03:26:15,243 attempt 1/10 2016-07-27 03:26:15,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ebd239b4cbfb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 03:26:15,550 unpacking tar archive at: mozilla-aurora-ebd239b4cbfb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625014 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.737640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.737956) ========= script_repo_revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.738352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.738613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.747803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-27 03:26:15.748083) ========= /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=337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:15 INFO - MultiFileLogger online at 20160727 03:26:15 in /builds/slave/test 03:26:15 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:26:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:15 INFO - {'append_to_log': False, 03:26:15 INFO - 'base_work_dir': '/builds/slave/test', 03:26:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:15 INFO - 'branch': 'Mozilla-Aurora', 03:26:15 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:15 INFO - 'config_files': ('talos/linux_config.py',), 03:26:15 INFO - 'default_actions': ('clobber', 03:26:15 INFO - 'read-buildbot-config', 03:26:15 INFO - 'download-and-extract', 03:26:15 INFO - 'populate-webroot', 03:26:15 INFO - 'create-virtualenv', 03:26:15 INFO - 'install', 03:26:15 INFO - 'run-tests'), 03:26:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:15 INFO - 'download_minidump_stackwalk': True, 03:26:15 INFO - 'download_symbols': 'ondemand', 03:26:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:15 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:15 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:15 INFO - 'installer_path': 'installer.exe', 03:26:15 INFO - 'log_level': 'info', 03:26:15 INFO - 'log_name': 'talos', 03:26:15 INFO - 'log_to_console': True, 03:26:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:15 INFO - 'opt_config_files': (), 03:26:15 INFO - 'pip_index': False, 03:26:15 INFO - 'sps_profile': False, 03:26:15 INFO - 'sps_profile_interval': 0, 03:26:15 INFO - 'suite': 'dromaeojs', 03:26:15 INFO - 'system_bits': '32', 03:26:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:15 INFO - 'title': 'talos-linux64-ix-060', 03:26:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:15 INFO - 'use_talos_json': True, 03:26:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:15 INFO - 'work_dir': 'build'} 03:26:15 INFO - ##### 03:26:15 INFO - ##### Running clobber step. 03:26:15 INFO - ##### 03:26:15 INFO - Running pre-action listener: _resource_record_pre_action 03:26:15 INFO - Running main action method: clobber 03:26:15 INFO - rmtree: /builds/slave/test/build 03:26:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:16 INFO - Running post-action listener: _resource_record_post_action 03:26:16 INFO - ##### 03:26:16 INFO - ##### Finished clobber step (success) 03:26:16 INFO - ##### 03:26:16 INFO - ##### 03:26:16 INFO - ##### Running read-buildbot-config step. 03:26:16 INFO - ##### 03:26:16 INFO - Running pre-action listener: _resource_record_pre_action 03:26:16 INFO - Running main action method: read_buildbot_config 03:26:16 INFO - Using buildbot properties: 03:26:16 INFO - { 03:26:16 INFO - "project": "", 03:26:16 INFO - "product": "firefox", 03:26:16 INFO - "script_repo_revision": "production", 03:26:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:26:16 INFO - "repository": "", 03:26:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:26:16 INFO - "buildid": "20160727004019", 03:26:16 INFO - "stage_platform": "linux64-pgo", 03:26:16 INFO - "basedir": "/builds/slave/test", 03:26:16 INFO - "nightly_build": "True", 03:26:16 INFO - "buildnumber": 425, 03:26:16 INFO - "slavename": "talos-linux64-ix-060", 03:26:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:26:16 INFO - "platform": "ubuntu64_hw", 03:26:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:26:16 INFO - "branch": "mozilla-aurora", 03:26:16 INFO - "repo_path": "releases/mozilla-aurora", 03:26:16 INFO - "revision": "ebd239b4cbfb8eff833560f72b163275ac4026d3", 03:26:16 INFO - "pgo_build": "True", 03:26:16 INFO - "builduid": "2fc58a4d5c144b7c97bb4b8cbf273105", 03:26:16 INFO - "slavebuilddir": "test" 03:26:16 INFO - } 03:26:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:26:16 INFO - Running post-action listener: _resource_record_post_action 03:26:16 INFO - ##### 03:26:16 INFO - ##### Finished read-buildbot-config step (success) 03:26:16 INFO - ##### 03:26:16 INFO - ##### 03:26:16 INFO - ##### Running download-and-extract step. 03:26:16 INFO - ##### 03:26:16 INFO - Running pre-action listener: _resource_record_pre_action 03:26:16 INFO - Running main action method: download_and_extract 03:26:16 INFO - mkdir: /builds/slave/test/build/tests 03:26:16 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:26:16 INFO - https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:26:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:18 INFO - Downloaded 1361 bytes. 03:26:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:18 INFO - Using the following test package requirements: 03:26:18 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:18 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:26:18 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:26:18 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:18 INFO - u'jsshell-linux-x86_64.zip'], 03:26:18 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:26:18 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:18 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:26:18 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:26:18 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:26:18 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:26:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:18 INFO - https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:19 INFO - Downloaded 24493586 bytes. 03:26: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:26: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:26:20 INFO - Return code: 0 03:26:20 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:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:20 INFO - https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:21 INFO - Downloaded 24493586 bytes. 03:26:21 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:26:21 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:26:22 INFO - Return code: 0 03:26:22 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:26:22 INFO - https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:23 INFO - Downloaded 10833369 bytes. 03:26:23 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:26:23 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:26:23 INFO - Return code: 0 03:26: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:26:23 INFO - https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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:26:25 INFO - Downloaded 63631484 bytes. 03:26:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:25 INFO - mkdir: /builds/slave/test/properties 03:26:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:25 INFO - Contents: 03:26:25 INFO - build_url:https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:25 INFO - Running post-action listener: _resource_record_post_action 03:26:25 INFO - Running post-action listener: set_extra_try_arguments 03:26:25 INFO - ##### 03:26:25 INFO - ##### Finished download-and-extract step (success) 03:26:25 INFO - ##### 03:26:25 INFO - ##### 03:26:25 INFO - ##### Running populate-webroot step. 03:26:25 INFO - ##### 03:26:25 INFO - Running pre-action listener: _resource_record_pre_action 03:26:25 INFO - Running main action method: populate_webroot 03:26:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:25 INFO - '--tppagecycles', 03:26:25 INFO - '7'], 03:26:25 INFO - 'tests': ['tsvgm']}}, 03:26:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:25 INFO - 'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:25 INFO - 'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['damp', 'tps']}, 03:26:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:25 INFO - 'tests': ['damp', 'tps']}, 03:26:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['dromaeo_dom']}, 03:26:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['a11yr', 03:26:25 INFO - 'ts_paint', 03:26:25 INFO - 'tpaint', 03:26:25 INFO - 'sessionrestore', 03:26:25 INFO - 'sessionrestore_no_auto_restore', 03:26:25 INFO - 'tabpaint']}, 03:26:25 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:25 INFO - 'ts_paint', 03:26:25 INFO - 'tpaint', 03:26:25 INFO - 'sessionrestore', 03:26:25 INFO - 'sessionrestore_no_auto_restore', 03:26:25 INFO - 'tabpaint']}, 03:26:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:25 INFO - 'ts_paint', 03:26:25 INFO - 'tpaint', 03:26:25 INFO - 'sessionrestore', 03:26:25 INFO - 'sessionrestore_no_auto_restore', 03:26:25 INFO - 'tabpaint']}, 03:26:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:25 INFO - 'ts_paint', 03:26:25 INFO - 'tpaint', 03:26:25 INFO - 'sessionrestore', 03:26:25 INFO - 'sessionrestore_no_auto_restore', 03:26:25 INFO - 'tabpaint']}, 03:26:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['a11yr', 03:26:25 INFO - 'ts_paint', 03:26:25 INFO - 'tpaint', 03:26:25 INFO - 'sessionrestore', 03:26:25 INFO - 'sessionrestore_no_auto_restore', 03:26:25 INFO - 'tabpaint']}, 03:26:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['a11yr', 03:26:25 INFO - 'ts_paint', 03:26:25 INFO - 'tpaint', 03:26:25 INFO - 'sessionrestore', 03:26:25 INFO - 'sessionrestore_no_auto_restore', 03:26:25 INFO - 'tabpaint']}, 03:26:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['tsvgx', 03:26:25 INFO - 'tsvgr_opacity', 03:26:25 INFO - 'tart', 03:26:25 INFO - 'tscrollx', 03:26:25 INFO - 'cart']}, 03:26:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:25 INFO - 'tsvgr_opacity', 03:26:25 INFO - 'tart', 03:26:25 INFO - 'tscrollx', 03:26:25 INFO - 'cart']}, 03:26:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:25 INFO - 'talos_options': ['--disable-e10s'], 03:26:25 INFO - 'tests': ['tp5o']}, 03:26:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:25 INFO - 'tests': ['tp5o']}, 03:26:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:25 INFO - 'talos_options': ['--disable-e10s', 03:26:25 INFO - '--xperf_path', 03:26:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:25 INFO - 'tests': ['tp5n']}, 03:26:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:25 INFO - 'talos_options': ['--xperf_path', 03:26:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:25 INFO - 'tests': ['tp5n']}}, 03:26:25 INFO - 'talos.zip': {'path': '', 03:26:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:25 INFO - Running post-action listener: _resource_record_post_action 03:26:25 INFO - ##### 03:26:25 INFO - ##### Finished populate-webroot step (success) 03:26:25 INFO - ##### 03:26:25 INFO - ##### 03:26:25 INFO - ##### Running create-virtualenv step. 03:26:25 INFO - ##### 03:26:25 INFO - Running pre-action listener: _resource_record_pre_action 03:26:25 INFO - Running main action method: create_virtualenv 03:26:25 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:25 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:26:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:25 INFO - Using real prefix '/usr' 03:26:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:28 INFO - Installing pip.................done. 03:26:28 INFO - Return code: 0 03:26:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:26:28 INFO - Using env: {'DISPLAY': ':0', 03:26:28 INFO - 'HOME': '/home/cltbld', 03:26:28 INFO - 'LANG': 'en_US.UTF-8', 03:26:28 INFO - 'LANGUAGE': 'en_US:en', 03:26:28 INFO - 'LOGNAME': 'cltbld', 03:26:28 INFO - 'MAIL': '/var/mail/cltbld', 03:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:28 INFO - 'MOZ_NO_REMOTE': '1', 03:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:28 INFO - 'NO_EM_RESTART': '1', 03:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:28 INFO - 'PWD': '/builds/slave/test', 03:26:28 INFO - 'SHELL': '/bin/bash', 03:26:28 INFO - 'SHLVL': '1', 03:26:28 INFO - 'TERM': 'linux', 03:26:28 INFO - 'TMOUT': '86400', 03:26:28 INFO - 'USER': 'cltbld', 03:26:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:28 INFO - '_': '/tools/buildbot/bin/python'} 03:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:28 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:26:28 INFO - Cleaning up... 03:26:28 INFO - Return code: 0 03:26:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:26:28 INFO - Using env: {'DISPLAY': ':0', 03:26:28 INFO - 'HOME': '/home/cltbld', 03:26:28 INFO - 'LANG': 'en_US.UTF-8', 03:26:28 INFO - 'LANGUAGE': 'en_US:en', 03:26:28 INFO - 'LOGNAME': 'cltbld', 03:26:28 INFO - 'MAIL': '/var/mail/cltbld', 03:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:28 INFO - 'MOZ_NO_REMOTE': '1', 03:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:28 INFO - 'NO_EM_RESTART': '1', 03:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:28 INFO - 'PWD': '/builds/slave/test', 03:26:28 INFO - 'SHELL': '/bin/bash', 03:26:28 INFO - 'SHLVL': '1', 03:26:28 INFO - 'TERM': 'linux', 03:26:28 INFO - 'TMOUT': '86400', 03:26:28 INFO - 'USER': 'cltbld', 03:26:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:28 INFO - '_': '/tools/buildbot/bin/python'} 03:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:28 INFO - Downloading/unpacking psutil>=3.1.1 03:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:30 INFO - Installing collected packages: psutil 03:26:30 INFO - Running setup.py install for psutil 03:26:30 INFO - building 'psutil._psutil_linux' extension 03:26:30 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:26:31 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:26:31 INFO - building 'psutil._psutil_posix' extension 03:26:31 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:26:31 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:26:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:31 INFO - Successfully installed psutil 03:26:31 INFO - Cleaning up... 03:26:31 INFO - Return code: 0 03:26:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:26:31 INFO - Using env: {'DISPLAY': ':0', 03:26:31 INFO - 'HOME': '/home/cltbld', 03:26:31 INFO - 'LANG': 'en_US.UTF-8', 03:26:31 INFO - 'LANGUAGE': 'en_US:en', 03:26:31 INFO - 'LOGNAME': 'cltbld', 03:26:31 INFO - 'MAIL': '/var/mail/cltbld', 03:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:31 INFO - 'MOZ_NO_REMOTE': '1', 03:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:31 INFO - 'NO_EM_RESTART': '1', 03:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:31 INFO - 'PWD': '/builds/slave/test', 03:26:31 INFO - 'SHELL': '/bin/bash', 03:26:31 INFO - 'SHLVL': '1', 03:26:31 INFO - 'TERM': 'linux', 03:26:31 INFO - 'TMOUT': '86400', 03:26:31 INFO - 'USER': 'cltbld', 03:26:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:31 INFO - '_': '/tools/buildbot/bin/python'} 03:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:33 INFO - Installing collected packages: mozsystemmonitor 03:26:33 INFO - Running setup.py install for mozsystemmonitor 03:26:33 INFO - Successfully installed mozsystemmonitor 03:26:33 INFO - Cleaning up... 03:26:33 INFO - Return code: 0 03:26:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:33 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:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:33 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:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:33 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 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:33 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:26:33 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:26:33 INFO - Using env: {'DISPLAY': ':0', 03:26:33 INFO - 'HOME': '/home/cltbld', 03:26:33 INFO - 'LANG': 'en_US.UTF-8', 03:26:33 INFO - 'LANGUAGE': 'en_US:en', 03:26:33 INFO - 'LOGNAME': 'cltbld', 03:26:33 INFO - 'MAIL': '/var/mail/cltbld', 03:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:33 INFO - 'MOZ_NO_REMOTE': '1', 03:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:33 INFO - 'NO_EM_RESTART': '1', 03:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:33 INFO - 'PWD': '/builds/slave/test', 03:26:33 INFO - 'SHELL': '/bin/bash', 03:26:33 INFO - 'SHLVL': '1', 03:26:33 INFO - 'TERM': 'linux', 03:26:33 INFO - 'TMOUT': '86400', 03:26:33 INFO - 'USER': 'cltbld', 03:26:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:33 INFO - '_': '/tools/buildbot/bin/python'} 03:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:36 INFO - warning: no files found matching '*.txt' 03:26:36 INFO - no previously-included directories found matching 'build' 03:26:36 INFO - no previously-included directories found matching 'dist' 03:26:36 INFO - no previously-included directories found matching '.git*' 03:26:36 INFO - Installing collected packages: jsonschema, functools32 03:26:36 INFO - Running setup.py install for functools32 03:26:36 INFO - warning: no files found matching '*.txt' 03:26:36 INFO - no previously-included directories found matching 'build' 03:26:36 INFO - no previously-included directories found matching 'dist' 03:26:36 INFO - no previously-included directories found matching '.git*' 03:26:36 INFO - Successfully installed jsonschema functools32 03:26:36 INFO - Cleaning up... 03:26:36 INFO - Return code: 0 03:26:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:36 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:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:36 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:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:36 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 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:36 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:26:36 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:26:36 INFO - Using env: {'DISPLAY': ':0', 03:26:36 INFO - 'HOME': '/home/cltbld', 03:26:36 INFO - 'LANG': 'en_US.UTF-8', 03:26:36 INFO - 'LANGUAGE': 'en_US:en', 03:26:36 INFO - 'LOGNAME': 'cltbld', 03:26:36 INFO - 'MAIL': '/var/mail/cltbld', 03:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:36 INFO - 'MOZ_NO_REMOTE': '1', 03:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:36 INFO - 'NO_EM_RESTART': '1', 03:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:36 INFO - 'PWD': '/builds/slave/test', 03:26:36 INFO - 'SHELL': '/bin/bash', 03:26:36 INFO - 'SHLVL': '1', 03:26:36 INFO - 'TERM': 'linux', 03:26:36 INFO - 'TMOUT': '86400', 03:26:36 INFO - 'USER': 'cltbld', 03:26:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:36 INFO - '_': '/tools/buildbot/bin/python'} 03:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:26: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:26: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:26: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:26: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:26: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:26: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:26:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:39 INFO - Downloading docopt-0.6.1.tar.gz 03:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:39 INFO - Running setup.py install for blobuploader 03:26:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:39 INFO - Running setup.py install for requests 03:26:39 INFO - Running setup.py install for docopt 03:26:39 INFO - Successfully installed blobuploader requests docopt 03:26:39 INFO - Cleaning up... 03:26:39 INFO - Return code: 0 03:26:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:39 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 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:39 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:26:39 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:26:39 INFO - Using env: {'DISPLAY': ':0', 03:26:39 INFO - 'HOME': '/home/cltbld', 03:26:39 INFO - 'LANG': 'en_US.UTF-8', 03:26:39 INFO - 'LANGUAGE': 'en_US:en', 03:26:39 INFO - 'LOGNAME': 'cltbld', 03:26:39 INFO - 'MAIL': '/var/mail/cltbld', 03:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:39 INFO - 'MOZ_NO_REMOTE': '1', 03:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:39 INFO - 'NO_EM_RESTART': '1', 03:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:39 INFO - 'PWD': '/builds/slave/test', 03:26:39 INFO - 'SHELL': '/bin/bash', 03:26:39 INFO - 'SHLVL': '1', 03:26:39 INFO - 'TERM': 'linux', 03:26:39 INFO - 'TMOUT': '86400', 03:26:39 INFO - 'USER': 'cltbld', 03:26:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:39 INFO - '_': '/tools/buildbot/bin/python'} 03:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:39 INFO - Running setup.py (path:/tmp/pip-0N6JKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:40 INFO - Running setup.py (path:/tmp/pip-ikuSgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:40 INFO - Running setup.py (path:/tmp/pip-czIkKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:40 INFO - Running setup.py (path:/tmp/pip-9Wq5ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:40 INFO - Running setup.py (path:/tmp/pip-9WiX0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:40 INFO - Running setup.py (path:/tmp/pip-jAIXWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:40 INFO - Running setup.py (path:/tmp/pip-46BpoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:40 INFO - Running setup.py (path:/tmp/pip-cFmR0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:40 INFO - Running setup.py (path:/tmp/pip-VrCocA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:40 INFO - Running setup.py (path:/tmp/pip-HmW2ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:40 INFO - Running setup.py (path:/tmp/pip-EEZD0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:40 INFO - Running setup.py (path:/tmp/pip-z5DcGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:40 INFO - Running setup.py (path:/tmp/pip-8RB1JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:40 INFO - Running setup.py (path:/tmp/pip-VXAfxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:41 INFO - Running setup.py (path:/tmp/pip-f5L0Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:41 INFO - Running setup.py (path:/tmp/pip-Wpl52v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:41 INFO - Running setup.py (path:/tmp/pip-OmI9Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:41 INFO - Running setup.py install for manifestparser 03:26:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:41 INFO - Running setup.py install for mozcrash 03:26:41 INFO - Running setup.py install for mozdebug 03:26:41 INFO - Running setup.py install for mozdevice 03:26:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:41 INFO - Running setup.py install for mozfile 03:26:41 INFO - Running setup.py install for mozhttpd 03:26:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:41 INFO - Running setup.py install for mozinfo 03:26:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:41 INFO - Running setup.py install for mozInstall 03:26:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for mozleak 03:26:42 INFO - Running setup.py install for mozlog 03:26:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for moznetwork 03:26:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for mozprocess 03:26:42 INFO - Running setup.py install for mozprofile 03:26:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for mozrunner 03:26:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for mozscreenshot 03:26:42 INFO - Running setup.py install for moztest 03:26:42 INFO - Running setup.py install for mozversion 03:26:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:42 INFO - Cleaning up... 03:26:43 INFO - Return code: 0 03:26:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:43 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 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:43 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:26:43 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:26:43 INFO - Using env: {'DISPLAY': ':0', 03:26:43 INFO - 'HOME': '/home/cltbld', 03:26:43 INFO - 'LANG': 'en_US.UTF-8', 03:26:43 INFO - 'LANGUAGE': 'en_US:en', 03:26:43 INFO - 'LOGNAME': 'cltbld', 03:26:43 INFO - 'MAIL': '/var/mail/cltbld', 03:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:43 INFO - 'MOZ_NO_REMOTE': '1', 03:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:43 INFO - 'NO_EM_RESTART': '1', 03:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:43 INFO - 'PWD': '/builds/slave/test', 03:26:43 INFO - 'SHELL': '/bin/bash', 03:26:43 INFO - 'SHLVL': '1', 03:26:43 INFO - 'TERM': 'linux', 03:26:43 INFO - 'TMOUT': '86400', 03:26:43 INFO - 'USER': 'cltbld', 03:26:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:43 INFO - '_': '/tools/buildbot/bin/python'} 03:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:43 INFO - Running setup.py (path:/tmp/pip-vTsbfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:43 INFO - Running setup.py (path:/tmp/pip-jrhzgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:43 INFO - Running setup.py (path:/tmp/pip-i356I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:43 INFO - Running setup.py (path:/tmp/pip-kXMNHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:43 INFO - Running setup.py (path:/tmp/pip-AE4lJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:43 INFO - Running setup.py (path:/tmp/pip-YTurO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:43 INFO - Running setup.py (path:/tmp/pip-0GGDLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:43 INFO - Running setup.py (path:/tmp/pip-rEXPNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:43 INFO - Running setup.py (path:/tmp/pip-ND9a3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:43 INFO - Running setup.py (path:/tmp/pip-YBCJWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:43 INFO - Running setup.py (path:/tmp/pip-touFCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:44 INFO - Running setup.py (path:/tmp/pip-DBhw0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:44 INFO - Running setup.py (path:/tmp/pip-Y8yDrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:44 INFO - Running setup.py (path:/tmp/pip-_PWney-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:44 INFO - Running setup.py (path:/tmp/pip-k0S0M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:44 INFO - Running setup.py (path:/tmp/pip-3P8RTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:44 INFO - Running setup.py (path:/tmp/pip-DMichH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:46 INFO - Downloading blessings-1.6.tar.gz 03:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:46 INFO - Installing collected packages: blessings 03:26:46 INFO - Running setup.py install for blessings 03:26:46 INFO - Successfully installed blessings 03:26:46 INFO - Cleaning up... 03:26:46 INFO - Return code: 0 03:26:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:46 INFO - Reading from file tmpfile_stdout 03:26:46 INFO - Current package versions: 03:26:46 INFO - argparse == 1.2.1 03:26:46 INFO - blessings == 1.6 03:26:46 INFO - blobuploader == 1.2.4 03:26:46 INFO - docopt == 0.6.1 03:26:46 INFO - functools32 == 3.2.3-2 03:26:46 INFO - jsonschema == 2.5.1 03:26:46 INFO - manifestparser == 1.1 03:26:46 INFO - mozInstall == 1.12 03:26:46 INFO - mozcrash == 0.17 03:26:46 INFO - mozdebug == 0.1 03:26:46 INFO - mozdevice == 0.48 03:26:46 INFO - mozfile == 1.2 03:26:46 INFO - mozhttpd == 0.7 03:26:46 INFO - mozinfo == 0.9 03:26:46 INFO - mozleak == 0.1 03:26:46 INFO - mozlog == 3.2 03:26:46 INFO - moznetwork == 0.27 03:26:46 INFO - mozprocess == 0.23 03:26:46 INFO - mozprofile == 0.28 03:26:46 INFO - mozrunner == 6.12 03:26:46 INFO - mozscreenshot == 0.1 03:26:46 INFO - mozsystemmonitor == 0.3 03:26:46 INFO - moztest == 0.7 03:26:46 INFO - mozversion == 1.4 03:26:46 INFO - psutil == 3.1.1 03:26:46 INFO - requests == 1.2.3 03:26:46 INFO - wsgiref == 0.1.2 03:26:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:46 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 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:46 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:26:46 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:26:46 INFO - Using env: {'DISPLAY': ':0', 03:26:46 INFO - 'HOME': '/home/cltbld', 03:26:46 INFO - 'LANG': 'en_US.UTF-8', 03:26:46 INFO - 'LANGUAGE': 'en_US:en', 03:26:46 INFO - 'LOGNAME': 'cltbld', 03:26:46 INFO - 'MAIL': '/var/mail/cltbld', 03:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:46 INFO - 'MOZ_NO_REMOTE': '1', 03:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:46 INFO - 'NO_EM_RESTART': '1', 03:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:46 INFO - 'PWD': '/builds/slave/test', 03:26:46 INFO - 'SHELL': '/bin/bash', 03:26:46 INFO - 'SHLVL': '1', 03:26:46 INFO - 'TERM': 'linux', 03:26:46 INFO - 'TMOUT': '86400', 03:26:46 INFO - 'USER': 'cltbld', 03:26:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:46 INFO - '_': '/tools/buildbot/bin/python'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 INFO - Cleaning up... 03:26:47 INFO - Return code: 0 03:26:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26: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:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 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 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:47 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:26:47 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:26:47 INFO - Using env: {'DISPLAY': ':0', 03:26:47 INFO - 'HOME': '/home/cltbld', 03:26:47 INFO - 'LANG': 'en_US.UTF-8', 03:26:47 INFO - 'LANGUAGE': 'en_US:en', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MAIL': '/var/mail/cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SHLVL': '1', 03:26:47 INFO - 'TERM': 'linux', 03:26:47 INFO - 'TMOUT': '86400', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - '_': '/tools/buildbot/bin/python'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:47 INFO - Cleaning up... 03:26:47 INFO - Return code: 0 03:26:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26: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:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 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 0x7fdcd0e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2420350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, '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': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', '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:26:47 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:26:47 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:26:47 INFO - Using env: {'DISPLAY': ':0', 03:26:47 INFO - 'HOME': '/home/cltbld', 03:26:47 INFO - 'LANG': 'en_US.UTF-8', 03:26:47 INFO - 'LANGUAGE': 'en_US:en', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MAIL': '/var/mail/cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SHLVL': '1', 03:26:47 INFO - 'TERM': 'linux', 03:26:47 INFO - 'TMOUT': '86400', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - '_': '/tools/buildbot/bin/python'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 INFO - Downloading/unpacking flake8 03:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:50 INFO - no previously-included directories found matching 'docs/_build' 03:26:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:50 INFO - Running setup.py install for pep8 03:26:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:50 INFO - no previously-included directories found matching 'docs/_build' 03:26:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:50 INFO - Cleaning up... 03:26:50 INFO - Return code: 0 03:26:50 INFO - Running post-action listener: _resource_record_post_action 03:26:50 INFO - Running post-action listener: _start_resource_monitoring 03:26:50 INFO - Starting resource monitoring. 03:26:50 INFO - ##### 03:26:50 INFO - ##### Finished create-virtualenv step (success) 03:26:50 INFO - ##### 03:26:50 INFO - ##### 03:26:50 INFO - ##### Running install step. 03:26:50 INFO - ##### 03:26:50 INFO - Running pre-action listener: _resource_record_pre_action 03:26:50 INFO - Running main action method: install 03:26:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:50 INFO - Reading from file tmpfile_stdout 03:26:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:50 INFO - Reading from file tmpfile_stdout 03:26:50 INFO - Output received: 03:26:50 INFO - Usage: mozinstall [options] installer 03:26:50 INFO - Options: 03:26:50 INFO - -h, --help show this help message and exit 03:26:50 INFO - -d DEST, --destination=DEST 03:26:50 INFO - Directory to install application into. [default: 03:26:50 INFO - "/builds/slave/test"] 03:26:50 INFO - --app=APP Application being installed. [default: firefox] 03:26:50 INFO - mkdir: /builds/slave/test/build/application 03:26:50 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:26:50 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:27:06 INFO - Reading from file tmpfile_stdout 03:27:06 INFO - Output received: 03:27:06 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:06 INFO - Running post-action listener: _resource_record_post_action 03:27:06 INFO - ##### 03:27:06 INFO - ##### Finished install step (success) 03:27:06 INFO - ##### 03:27:06 INFO - ##### 03:27:06 INFO - ##### Running run-tests step. 03:27:06 INFO - ##### 03:27:06 INFO - Running pre-action listener: _resource_record_pre_action 03:27:06 INFO - Running main action method: run_tests 03:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:06 INFO - Python 2.7.3 03:27:06 INFO - Return code: 0 03:27:06 INFO - grabbing minidump binary from tooltool 03:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:06 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 0x24af1c0>, '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 0x24b00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:06 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:27:06 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:27:06 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:27:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:06 INFO - Return code: 0 03:27:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:27:07 INFO - Return code: 0 03:27:07 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/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:27:07 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/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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:27:07 INFO - Using env: {'DISPLAY': ':0', 03:27:07 INFO - 'HOME': '/home/cltbld', 03:27:07 INFO - 'LANG': 'en_US.UTF-8', 03:27:07 INFO - 'LANGUAGE': 'en_US:en', 03:27:07 INFO - 'LOGNAME': 'cltbld', 03:27:07 INFO - 'MAIL': '/var/mail/cltbld', 03:27:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:07 INFO - 'MOZ_NO_REMOTE': '1', 03:27:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:07 INFO - 'NO_EM_RESTART': '1', 03:27:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:07 INFO - 'PWD': '/builds/slave/test', 03:27:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:07 INFO - 'SHELL': '/bin/bash', 03:27:07 INFO - 'SHLVL': '1', 03:27:07 INFO - 'TERM': 'linux', 03:27:07 INFO - 'TMOUT': '86400', 03:27:07 INFO - 'USER': 'cltbld', 03:27:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449', 03:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:07 INFO - '_': '/tools/buildbot/bin/python'} 03:27:07 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/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:27:07 INFO - mozversion application_buildid: 20160727004019 03:27:07 INFO - mozversion application_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 03:27:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:07 INFO - mozversion application_name: Firefox 03:27:07 INFO - mozversion application_remotingname: firefox-dev 03:27:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:07 INFO - mozversion application_vendor: Mozilla 03:27:07 INFO - mozversion application_version: 49.0a2 03:27:07 INFO - mozversion platform_buildid: 20160727004019 03:27:07 INFO - mozversion platform_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 03:27:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:07 INFO - mozversion platform_version: 49.0a2 03:27:07 INFO - using testdate: 1469615227 03:27:07 INFO - actual date: 1469615227 03:27:07 INFO - starting webserver on 'localhost:39477' 03:27:07 INFO - SUITE-START | Running 2 tests 03:27:07 INFO - TEST-START | dromaeo_css 03:27:07 INFO - operating with platform_type : linux_ 03:27:07 INFO - Initialising browser for dromaeo_css test... 03:27:07 INFO - TEST-INFO | started process 18325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8SIzrn/profile http://localhost:39477/getInfo.html) 03:27:12 INFO - PROCESS | 18325 | __metrics Screen width/height:1600/1200 03:27:12 INFO - PROCESS | 18325 | colorDepth:24 03:27:12 INFO - PROCESS | 18325 | Browser inner width/height: 1024/697 03:27:12 INFO - PROCESS | 18325 | __metrics 03:27:13 INFO - PROCESS | 18325 | 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:27:13 ERROR - PROCESS | 18325 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:27:14 INFO - TEST-INFO | 18325: exit 0 03:27:14 INFO - Browser initialized. 03:27:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:14 INFO - TEST-INFO | started process 18418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8SIzrn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:26 INFO - PROCESS | 18418 | RSS: Main: 144744448 03:27:26 INFO - PROCESS | 18418 | 03:28:17 INFO - PROCESS | 18418 | 1469615297679 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:30:25 INFO - PROCESS | 18418 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39477/tests/dromaeo/cssquery-ext.html) 03:30:26 INFO - PROCESS | 18418 | RSS: Main: 254398464 03:30:26 INFO - PROCESS | 18418 | 03:33:28 INFO - PROCESS | 18418 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-ext.html (next: http://localhost:39477/tests/dromaeo/cssquery-jquery.html) 03:33:29 INFO - PROCESS | 18418 | RSS: Main: 230379520 03:33:29 INFO - PROCESS | 18418 | 03:36:31 INFO - PROCESS | 18418 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39477/tests/dromaeo/cssquery-mootools.html) 03:36:31 INFO - PROCESS | 18418 | RSS: Main: 221118464 03:36:31 INFO - PROCESS | 18418 | 03:39:33 INFO - PROCESS | 18418 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39477/tests/dromaeo/cssquery-prototype.html) 03:39:34 INFO - PROCESS | 18418 | RSS: Main: 224698368 03:39:34 INFO - PROCESS | 18418 | 03:42:36 INFO - PROCESS | 18418 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39477/tests/dromaeo/cssquery-yui.html) 03:42:37 INFO - PROCESS | 18418 | RSS: Main: 194187264 03:42:37 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-yui.html (next: http://localhost:39477/tests/dromaeo/cssquery-dojo.html) 03:45:39 INFO - PROCESS | 18418 | RSS: Main: 259264512 03:45:39 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | __start_tp_report 03:45:39 INFO - PROCESS | 18418 | _x_x_mozilla_page_load 03:45:39 INFO - PROCESS | 18418 | _x_x_mozilla_page_load_details 03:45:39 INFO - PROCESS | 18418 | |i|pagename|runs| 03:45:39 INFO - PROCESS | 18418 | |0;dojo.html;3286.1620286826865;3312.53624492571;3316.485944678574;3347.882824101157;3367.848446819893;5418.160185171299;5476.561875049996;5481.314835645544;5484.670919744818;5528.060229760935;5489.945100549004;5539.196816461611;5545;5558.194061861028;5583.05088135017;4901.460839307673;4902.828401005965;5008.6493945423745;5016.122178618745;5032.622553308498;4909.386326709161;4996.525330093654;5000.1249781288125;5003.724795136284;5008.474110218411;5119.385673719159;5123.948760512403;5125.179971204608;5127.897442051157;5129.743512824362;5099.107656160194;5108.948910510884;5110.948890511085;5118.10433174193;5155.845324640267;4849.078675051765;4930.457649658535;4950.158473059589;5028.673136246132;5053.69677819332;5223.921641175385;5311.946880531223;5314.787408503656;5348.438413966516;5353.625246232766;5821.388754180793;5824.271966004249;5860.238169038041;5869.85325366865;5873.530117590625;5699.116636921242;5738.397468265855;5801.448862358069;5829.300483941912;5919.763209471616;5387.703676297802;5393.568514518868;5414.864628384283;5496.120620700669;5496.340439147248;5963.761449541969;5973.37279585646;5975.163477113208;5975.462208401264;5979.953508136059;5615.410381909841;5672.943270567242;5744.138379243147;5750.1949727038245;5824.592278540546;5851.970740146272;5870.26621672291;5885.440883116097;5896.1450589664255;5908.261467316585;5678.744456499468;5820.592558520948;5845.795397161079;5847.181394604759;5849;5738.397468265772;5783.248177736868;5800.506956908625;5833.329167145747;5843.211166492554;4503.842365517191;4506.59440650343;4507.639388848885;4513.9322910155715;4514.25514790056;3963.7621742694955;3992.48097747291;4038.5557588665224;4059.411385349108;4071.2468193383725;5561.721913904288;5583.972080139573;5595.608307418442;5600.943990560042;5617.213590097308;5881.235439392937;5912.645241285537;5913.881722365614;5915.3788852170765;5940.8811823764145;5432.511074003359;5575.609707320448;5607.8317650469735;5625.578081643811;5626.43735626434;4992.301077849104;5019.974900125476;5022.341999471979;5022.773975171126;5025.321581586439;6181.412765787243;6210.7515699372425;6234.345393733593;6235.189425374672;6238.75044998195;5743.655380677173;5773.1051686988585;5823.621464604787;5826.533877289722;5887.352391236875;6097.634141951497;6104.603200791934;6108.877822443437;6113.29697084841;6122.204113465221;5584.134459158837;5745.253117094918;5747.3103227612955;5762.942370576408;5767.769289228551;5856.970715146397;5892.440218179438;5908.468237858613;5954.464098231007;5962.5528085394635;5807;5811.56413268998;5835.620684655484;5847.766089356378;5864.208331875313;5498.532624726783;5705.372409035086;5804.82585522435;5806.6516009037905;5812.651240925389;5646.407127251744;5704.429557044263;5708.429157084424;5711.143328500758;5747.971260143672;5787.421257874179;5821.185034095145;5869.559783016205;5869.706514674163;5871.178035075179;5481.123020316731;5620.325560932714;5668.829935101953;5707.200991861226;5739.770409183586 03:45:39 INFO - PROCESS | 18418 | |1;ext.html;605.8333958161505;648.2771709543857;659.2352870670022;665.0456594786485;673.373762400967;34785.82607086964;46153.307700384525;47312;47384.52615473844;51554;48347.51652483474;48965;48966.26550601744;49134;49146.26280605785;8297.253247207751;8979.775505612362;9135;10518.421486818223;10842.783144337109;10763.892361076407;10766.623168189115;10840.78318433631;10884.673459796179;10885.455727213608;10947.781044379108;10967;10973.83539246912;10983;10996.23026388153;8289.792755181108;10579.841302380431;10839.67480975572;10850.728731781768;11157.944210278896;10672.359658420519;10888.510017049251;10889.183311251687;10890.945545272223;10896.509657065371;45626.77186614046;45986.54013459856;46110.53889461096;46120;46124;3704.833282502294;3811.8856434307013;3833.821481492491;4078.7960601969785;4327.675424343155;35121;35355;35395.469067964004;35679.4648080279;35787.28425431477;4708.816486322656;4752.382190315237;4784.952150478485;4845.515448455161;4911.214205727067;376931;376973;377132;377628;377698;36701.81649091791;62364.37635623677;62674;62709;62827;38425;40658.79670601628;40740.79629601833;40796.59203407928;40844;13576.389062492211;17299.74050389245;17385.65228695419;17443.65112697739;17448.47654570365;10882.238243322892;11231.157663175294;12764.80852787209;12858.614241572768;12874.67813304675;9130.543472826464;9214.63141474347;9223.631054757734;9258.95370523143;9277.257819374434;3469.2541103662834;3494.4583589543663;3496.9300613988084;3505.1938054247667;3551.627079156703;1023.7287118913493;1075.0593230922943;1087.581281206741;1164.953401863916;1165.7493638867684;31265;31601;31965.68034319627;32236;32770.214531765065;1125.7917285302244;1251.3680591301516;1274.8024056271292;1296.9870301297055;1320.6962398648366;17457.650846983244;17613;17739.822601773816;17848.375306864196;18188.36340728068;645800;650890;651489;653570;654704;63747.36252637414;64489.35510644833;64493.67753161298;64574;64702.029469557994;1337.1175024483794;1448.66680663448;1475.1370448287657;1481.8740407065304;1505.4128889733013;34634;35152.47271290984;35867.461988070725;36119.638803611626;36122.819385902905;54612.45387546233;55191.17213241885;55419;55421.16868246899;55515.612109697584;404260;405620;406902;407172;407710;26419.471610568067;44984.32523512215;49729.75135124301;50961;54509.182362263804;48893.2666010003;50214.246786298965;50726.23910641417;55629.653222917135;55926.72036639791;43420.56579434165;43711.344329835716;44669.56391428221;45049.77475112603;45121.32318015167;43869;43923.78038109789;44711.329330060726;44755.776221118685;45491;46301.30548041715;46618;47079;47195.764021179675;47292.7635361821;38405;40805;40885.59114408937;41007.58992410038;41091;30504.542431863098;30572.388552228385;30577.388452230385;30662.233444164074;31217.84391078121 03:45:39 INFO - PROCESS | 18418 | |2;jquery.html;430.0779639048722;430.38240125420015;434.5676052327934;440.10438757129236;448.05236923905926;18778.248870045198;19829.40511784647;20694.89652551739;20816.959152042415;20817.375478735623;19686.60626787467;20496.69254961177;21040.789592104073;21055.789442105575;21058.052387642594;5733.283339582563;5911.527077833763;5912.9113063304085;5956.672383018932;5956.88086238275;4082.6937979651498;5658.377578466366;5707.800226992056;5869.50109240715;5954.851128721795;5941.494972927307;5995.700214989255;6006.0390337546005;6026;6036.909446358308;5868.97065514674;5994.910076348837;6034.69826508675;6104.847378815521;6109.511239100883;5609.467100625475;5832.445917637818;5834.620749651259;5843.298804143487;5852.268466441695;14953.626159345995;15130.54608361751;15146.848531514654;15181.544553663407;18678;2388.845457334273;2484.1802205272215;2577.3298942274955;2883.3944871576996;3103.5810165627577;10290.79418411635;10621.84067238992;10971.23201375904;11110;11197.552097916074;1968.3897991622644;1971.8816870987787;2057.4856285928518;2084.8540602157855;2140.5076832328496;86771.56614216951;88233;88751.55624221903;88771.55614221888;91120.54439727825;11650.592229271935;11869.5845645402;11969.222000569935;12015.279083255033;12045.39773011346;17001.744973825404;17161.313547458212;17197;17238.482845514656;17242.396516122128;8797.076306987801;8832.77918052041;8837.823243535093;8925.866112008196;9016.233620142362;8528.275096616733;8597.828043439096;8612.5693715314;8743.91256087431;8798.120187981278;5003.124453220672;5131.384233891957;5167.224916262516;5192.532672059533;5216.504432078947;1779.3800682369463;1850.6391253705667;2014.4359579317816;2059.7116403703494;2106.7577228618597;976.8095221431895;993.7515621094726;1016.898310168992;1017.7964407118606;1117.017831430946;19859.602807944048;19971.60056798856;20151.496212594804;20239.797602024086;20537.075831587616;1050.5167622893555;1073.5974009746344;1076.2950267574752;1088.5482524752297;1094.3379255550437;11000.944995275133;11261.042811361127;11303.491342889425;11330.546778128948;11421.543138274375;391408;486077;513233;513967;514733;90240;110565;111645.44177279224;112521.43739281414;113596;1097.155190503308;1101.3336931156696;1103.8564986551858;1146.4439746722833;1159.5187996981158;18505.90747046256;18587.628247435245;19011.619767604847;19206.61586768285;19331.4200573983;41301.1739765197;43920.78039609909;45144.54855451403;45752.31371529363;46473.302900457194;57093;57316;62966.37033629605;63596.68201658962;63765.36234637594;8822.779430514289;9213.401128926598;9289.674861379819;9432.952835236054;9571.952140239255;11021.889781102407;13207.339633018502;13572.52496162669;13663.453461861813;13778.931105344811;11817.290962542274;12315.69210769738;12342.629721108382;12450;12454.750904982031;12015.158938874545;12169.634910952685;12331.445084971378;12449.37753112359;12649.114561980941;12503.187292825936;12563.18339307942;12582.811257831323;12669.936650317059;12838.871611284141;8077.071136819106;8268.627911744106;8780.341474389574;8827.823443531222;9259.76850578741;9363.953180234055;12148.453319600816;12542.749145016865;12585.559505417266;12631.242125472134 03:45:39 INFO - PROCESS | 18418 | |3;mootools.html;1417.5888992192265;1547.512533551931;1583.9128847913364;1777.6711308407946;1906.68539690951;8595.613197406115;8769.824603507926;8819.955900220506;9061.411008284456;9080.409773364743;8867.42361746486;9012.54937253138;9025.142611451918;9047.09529047095;9047.185753282203;2182.7271591051117;2443.3647251714506;2478.652988581591;2483.3170878008514;2550.3624093976505;2534.1383929463977;2544.8982040718347;2547.4395632960814;2550.413404916861;2555.872206389673;2515.6226566015152;2553.502067096917;2560.1423523119684;2560.6287088372173;2563.9743602564017;2113.5561532078204;2392.2464423706565;2398.3164798032476;2461.2862269941875;2462.815288853343;2484.76394742501;2496.8501889886666;2514.0446630280558;2514.5976643736913;2540.0347867810297;9278.814423711488;9373.671921482784;9377.76555586109;9389.38968967015;9410.058994100604;5719.542436605062;5857.912131318034;5858.648481091148;5861.824145275648;5863.472287494146;3610.4403817408343;3710.628937106295;3771.622837716234;3858.3633700439395;3864.265789499986;1191.6305945157028;1205.5780476833127;1223.2232532341939;1228.6314105768324;1236.5733821831454;13340.33298335089;13341.332933353293;13369.131006484547;13407.195568265837;13410.597682069554;5203.9219411708855;5224.003637217532;5262.236975638511;5266.368035835724;5298.576113910878;11371.772564548663;11423.029042531312;11426.200165988468;11426.428678566039;11460.656180314603;5821.621594596338;5877.23595932526;5888.440598143169;5891.05743081105;5925.259342582177;4557.977210113994;5162.096633089194;5285.392179899284;5300.522952934254;5368;4354.020345422318;4358.084802191512;4430.069685366109;4453.955460445419;4466.173757854807;1366.590022993098;1368.6304697731557;1375.05121466188;1391.3252072744913;1399.979000314996;1027.845823126537;1040.0483557544912;1042.8227201375785;1046.4192373232777;1063.9414832184304;6069.666168360694;6220.7511699531515;6282.434580887742;6343.851851116928;6382.808515744535;471.67459438976584;478.4856279499552;479.0419161676647;1071.1912506058031;1112.0880877680386;4250.06498570314;4266.1254442839145;4296.248156572649;4297.247981603207;4301.2257793597455;11679.299242045505;11843;11892.464839082262;11953.701157471132;11959.342236177094;11785.528578856749;11868.228565143238;11898.10764192689;11911.463984120735;11926.761464770656;8329.583520823935;8547.615357308936;8555;8774.078721734253;8781.912180878237;6231;6408.647524386017;6476.805695829133;6483.448906842783;6554.016897465418;10978.066864316303;10996.06533444634;11032.834507482234;11159.49782259784;11190.160737944849;10498.47507624631;10764.46177691128;10785.784284314426;11015.394153321644;11061.94469027682;7284.781456556099;7385.593792341473;7392.334689877936;8430.704925327584;8596.312295016509;8075;9198.310126740387;9229.953850230706;9464.763380915532;9482.762930926507;8308.70919517814;8437.915620843713;8619.353548484014;8702.738917832476;8728.825423491367;8099.271065604124;8101.594920253846;8226.30076443509;8331.958340208503;8347.83304333922;7698.307152356091;7822.06135263772;7825.608719564113;7830.725924592612;7841.843163136591;5485.725713714378;5521.003060048542;5544.251526043932;5572.665640061609;5668.348139963957;5383.676979381093;5548.778048878;5604.85987850307;5746.597738158456;5789.986752318412 03:45:39 INFO - PROCESS | 18418 | |4;prototype.html;360.5475128713465;366.5180287921383;367.5589292848581;369.2614770459082;370.885025642051;5440.836774896755;5454.127339625661;5475.425080366564;5511.834644960648;5516.696581688006;5264.210368444726;5353.116735738608;5421.918671219925;5425.562226010111;5433.4566543345645;4256.787160641971;4260.552641972595;4294.806733696991;4305.22505948929;4308.332208507686;4285.978570107145;4293.205756934977;4307.763073030982;4311.611954924057;4332.505285676452;4209.284421648327;4238.427812245338;4298.355246712987;4328.285832837578;4330.618160011996;4036.3541833306676;4247.384129301265;4248.957510424887;4261.296886013804;4332.436783218177;3734.8692795752017;3749.6313845446216;3754.6433088856515;3758.530183727034;3762.811859407019;5128.743562821881;5188.742896839887;5284.894302113936;5296.894062118736;5330.866728331784;4583.862484125481;4818.180909245437;4826.300186472977;4855.223164293696;4895;5613.635113717595;5613.775448982035;5619.578531610146;5641.971790141064;5656.830295091154;4109.0959988802715;4118.155778065489;4122.361034039699;4126.91746165078;4129.483814523184;5762.222100016486;5845.357010728816;5883.294004719418;5911.556633252523;5935.910961335583;4210.157968406331;4217.810198541073;4219.641330486943;4238.19474299882;4240.533541310453;4274.807633656493;4280.16536775332;4281.336392859112;4283.507396649363;4311.655067594585;4746.145693775154;4820.975895120502;4832.95167048325;4875;4875.488073752276;5611.523020543218;5620.606557540933;5645.826356852641;5649.994252040467;5656.830295091154;1458.139697578434;1463.436576917873;1466.5600319903986;1471.565888063024;1479.6387323662257;898.7753061734567;921.1111277617132;925.5048549026374;931.7577429868147;937.9671711490201;4884.681136093235;4907.312976183337;4925.729084900293;4960.479149689303;4972.925406118911;5126.333941469037;5156.226566015052;5178.223266510054;5206.713630750345;5227.973860130675;4573.765083427456;4993.625478089158;4999.375078115236;5003.974980125076;5045.621578381636;2819.873105710248;2822.3348224547617;2824.901128460494;2825.90109346176;2839.701831307683;5274.551663108678;5403.135498320328;5417.674939503563;5469.234307196995;5497.532709719639;5148.279240906276;5340.25236466895;5371.301730774974;5640.618048578124;5762.567807414377;6022.879542409215;6049.909251361233;6066.817995460055;6068.423499767515;6073.939260607426;5736.971315143398;5803.9419605803405;5813.447722466359;5840.8247752567495;5846.824595262149;5131.717755523482;5553.334399488187;5723.370429252695;5781.566382521243;5812.912806307824;5875.73559189846;6025.246844144482;6045.576809623284;6061.696915154136;6144;4076.205139997672;4185.246655602021;4203.64269037123;4229.429027081428;4236.406903033516;5736.512396446349;5753.539716822728;5790.189373487631;5791.507721843691;5846.632113993839;5645.971770141123;5649.067903795992;5670.688112153871;5676.68778217202;5687.118496633028;5521.834344969658;5649.350324712546;5662.876421341996;5683.60214784961;5688.232088667977;5462.317210348707;5487.835364939058;5497.175423686319;5589.664620122806;5612.943870561406;5485.862853428696;5658.462446067617;5715.2855893013375;5730.971345143247;5775.7400916957995;5550.55595552363;5584.134459158837;5585.916211256753;5587.804426845203;5595.272614560081 03:45:39 INFO - PROCESS | 18418 | |5;yui.html;783.4594130050265;784.843031393721;786.3630459327943;793.2107552984781;909.4588719711769;16535.09057001863;16561.08914009729;16567.337306507754;16731.498055058353;17575.648487030267;16366.263518141683;16402.425915092976;16489.752653710173;16504.092274924875;16522.42171523997;711.6833009310859;836.7322456813822;836.8493671139192;859.6346552715103;864.0107077396377;840.6595328891779;842.6882053640131;844.6832437835811;846.6571038729294;847.559269180026;899.163777686751;902.8104098139398;905.1808113657117;905.7373361725125;906.0803284666069;747.5477336211568;878.89892662344;886.2599729226104;893.7229458867772;900.9729708108767;663.5852592129919;663.7146027208298;664.2095905872045;664.2162248546713;664.3987191591617;16820.74768878468;16852.662946740995;16856.57858553534;16882.15589220534;16893.57766055846;15767;16013.759793603105;16028.519144425685;16060.75908861368;16226.756598651029;13717.161870467848;14139.293035348293;14229.14625122496;14239.572812815632;14465;4816.54242846929;4855.732934688591;4884.511548845123;4927.90144197114;4938.678985865908;78034;78419;78589.60705196437;78757.60621196915;86072.13927860766;12413.875861241453;12553.748925021448;12589.685257868443;12867.356632168354;13050.869491305155;23618.64572031421;23631.409214769425;23636.881815590812;23651.645225321634;23670.64494032591;9057.547122643842;9165.679201227926;9166.67916622915;9227.53862306882;9275.536223188814;5031.094403007421;5065.901551152209;5135.2553879687985;5177.637565370388;5193.480651934777;3856.8650097246464;4019;4026.1947610478023;4026.2350153471334;4030.7581545107387;654.8501706790354;658.9505787065989;679.9796006119824;703.1491894807341;748.9363404110711;694.6457306773582;700.4886432903907;768.5273556762662;787.7715462515921;789.3961119743401;10452.372857628567;10472.790544189074;10495.632652857113;10547.894521054845;10760.3543787373;632.4150161100963;648.2965981909587;728.9635518224068;731.9707211711578;779.3103103753219;4861.27080937855;4982.177940639826;5004.574611158092;5039.193729003342;5071.2139618359215;87323.56338218396;88198.11801881899;88481.55759221292;110981;125829.37085314514;80574;93055.53472232596;116907;118679.40660296644;118727;102646;103558.48220758847;103813.48093259486;103844;105976.47011764892;9478.431294122374;9515.809683806423;9633.662821801203;9636.614535418505;9682.70951871445;51895.481045189066;59495.70252148712;59831;61338.38661613327;61683.07475387783;83957;85584.57207713922;92155;93914;94406;12919.677008074874;13227.470901163846;13470.595882123553;13604.387802549107;13771.724565508433;15245.771313430529;15642.843571564139;15700.92149539245;15737.606559835638;16185.67628647444;9617.56720947573;11555;13398.665033374244;13745.055556659938;14197.219152946687;12861.549845755353;13131.474741010252;13156.868431315565;13580.456781729015;14001.579952601438;12306.75386492283;12736.554220602606;12836.229826210458;13251.734965300833;13416.664583385493;10760.946195268974;10828;11048.779024419306;11094.278871873303;11562.421878906189;10853.782924341627;10985.725356866142;11187.878968757228;11281.09751219884;11347.262427942158 03:45:39 INFO - PROCESS | 18418 | __end_tp_report 03:45:39 INFO - PROCESS | 18418 | __start_cc_report 03:45:39 INFO - PROCESS | 18418 | _x_x_mozilla_cycle_collect,892 03:45:39 INFO - PROCESS | 18418 | __end_cc_report 03:45:39 INFO - PROCESS | 18418 | __startTimestamp1469616339771__endTimestamp 03:45:39 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | ------- Summary: start ------- 03:45:39 INFO - PROCESS | 18418 | Number of tests: 6 03:45:39 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | [#0] dojo.html Cycles:165 Average:5462.00 Median:5672.94 stddev:601.27 (10.6%) stddev-sans-first:578.38 03:45:39 INFO - PROCESS | 18418 | Values: 3286.2 3312.5 3316.5 3347.9 3367.8 5418.2 5476.6 5481.3 5484.7 5528.1 5489.9 5539.2 5545.0 5558.2 5583.1 4901.5 4902.8 5008.6 5016.1 5032.6 4909.4 4996.5 5000.1 5003.7 5008.5 5119.4 5123.9 5125.2 5127.9 5129.7 5099.1 5108.9 5110.9 5118.1 5155.8 4849.1 4930.5 4950.2 5028.7 5053.7 5223.9 5311.9 5314.8 5348.4 5353.6 5821.4 5824.3 5860.2 5869.9 5873.5 5699.1 5738.4 5801.4 5829.3 5919.8 5387.7 5393.6 5414.9 5496.1 5496.3 5963.8 5973.4 5975.2 5975.5 5980.0 5615.4 5672.9 5744.1 5750.2 5824.6 5852.0 5870.3 5885.4 5896.1 5908.3 5678.7 5820.6 5845.8 5847.2 5849.0 5738.4 5783.2 5800.5 5833.3 5843.2 4503.8 4506.6 4507.6 4513.9 4514.3 3963.8 3992.5 4038.6 4059.4 4071.2 5561.7 5584.0 5595.6 5600.9 5617.2 5881.2 5912.6 5913.9 5915.4 5940.9 5432.5 5575.6 5607.8 5625.6 5626.4 4992.3 5020.0 5022.3 5022.8 5025.3 6181.4 6210.8 6234.3 6235.2 6238.8 5743.7 5773.1 5823.6 5826.5 5887.4 6097.6 6104.6 6108.9 6113.3 6122.2 5584.1 5745.3 5747.3 5762.9 5767.8 5857.0 5892.4 5908.5 5954.5 5962.6 5807.0 5811.6 5835.6 5847.8 5864.2 5498.5 5705.4 5804.8 5806.7 5812.7 5646.4 5704.4 5708.4 5711.1 5748.0 5787.4 5821.2 5869.6 5869.7 5871.2 5481.1 5620.3 5668.8 5707.2 5739.8 03:45:39 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | [#1] ext.html Cycles:180 Average:64589.60 Median:223139.40 stddev:131482.41 (58.9%) stddev-sans-first:131763.50 03:45:39 INFO - PROCESS | 18418 | Values: 605.8 648.3 659.2 665.0 673.4 34785.8 46153.3 47312.0 47384.5 51554.0 48347.5 48965.0 48966.3 49134.0 49146.3 8297.3 8979.8 9135.0 10518.4 10842.8 10763.9 10766.6 10840.8 10884.7 10885.5 10947.8 10967.0 10973.8 10983.0 10996.2 8289.8 10579.8 10839.7 10850.7 11157.9 10672.4 10888.5 10889.2 10890.9 10896.5 45626.8 45986.5 46110.5 46120.0 46124.0 3704.8 3811.9 3833.8 4078.8 4327.7 35121.0 35355.0 35395.5 35679.5 35787.3 4708.8 4752.4 4785.0 4845.5 4911.2 376931.0 376973.0 377132.0 377628.0 377698.0 36701.8 62364.4 62674.0 62709.0 62827.0 38425.0 40658.8 40740.8 40796.6 40844.0 13576.4 17299.7 17385.7 17443.7 17448.5 10882.2 11231.2 12764.8 12858.6 12874.7 9130.5 9214.6 9223.6 9259.0 9277.3 3469.3 3494.5 3496.9 3505.2 3551.6 1023.7 1075.1 1087.6 1165.0 1165.7 31265.0 31601.0 31965.7 32236.0 32770.2 1125.8 1251.4 1274.8 1297.0 1320.7 17457.7 17613.0 17739.8 17848.4 18188.4 645800.0 650890.0 651489.0 653570.0 654704.0 63747.4 64489.4 64493.7 64574.0 64702.0 1337.1 1448.7 1475.1 1481.9 1505.4 34634.0 35152.5 35867.5 36119.6 36122.8 54612.5 55191.2 55419.0 55421.2 55515.6 404260.0 405620.0 406902.0 407172.0 407710.0 26419.5 44984.3 49729.8 50961.0 54509.2 48893.3 50214.2 50726.2 55629.7 55926.7 43420.6 43711.3 44669.6 45049.8 45121.3 43869.0 43923.8 44711.3 44755.8 45491.0 46301.3 46618.0 47079.0 47195.8 47292.8 38405.0 40805.0 40885.6 41007.6 41091.0 30504.5 30572.4 30577.4 30662.2 31217.8 03:45:39 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | [#2] jquery.html Cycles:180 Average:29860.28 Median:11562.82 stddev:80744.29 (698.3%) stddev-sans-first:80940.56 03:45:39 INFO - PROCESS | 18418 | Values: 430.1 430.4 434.6 440.1 448.1 18778.2 19829.4 20694.9 20817.0 20817.4 19686.6 20496.7 21040.8 21055.8 21058.1 5733.3 5911.5 5912.9 5956.7 5956.9 4082.7 5658.4 5707.8 5869.5 5954.9 5941.5 5995.7 6006.0 6026.0 6036.9 5869.0 5994.9 6034.7 6104.8 6109.5 5609.5 5832.4 5834.6 5843.3 5852.3 14953.6 15130.5 15146.8 15181.5 18678.0 2388.8 2484.2 2577.3 2883.4 3103.6 10290.8 10621.8 10971.2 11110.0 11197.6 1968.4 1971.9 2057.5 2084.9 2140.5 86771.6 88233.0 88751.6 88771.6 91120.5 11650.6 11869.6 11969.2 12015.3 12045.4 17001.7 17161.3 17197.0 17238.5 17242.4 8797.1 8832.8 8837.8 8925.9 9016.2 8528.3 8597.8 8612.6 8743.9 8798.1 5003.1 5131.4 5167.2 5192.5 5216.5 1779.4 1850.6 2014.4 2059.7 2106.8 976.8 993.8 1016.9 1017.8 1117.0 19859.6 19971.6 20151.5 20239.8 20537.1 1050.5 1073.6 1076.3 1088.5 1094.3 11000.9 11261.0 11303.5 11330.5 11421.5 391408.0 486077.0 513233.0 513967.0 514733.0 90240.0 110565.0 111645.4 112521.4 113596.0 1097.2 1101.3 1103.9 1146.4 1159.5 18505.9 18587.6 19011.6 19206.6 19331.4 41301.2 43920.8 45144.5 45752.3 46473.3 57093.0 57316.0 62966.4 63596.7 63765.4 8822.8 9213.4 9289.7 9433.0 9572.0 11021.9 13207.3 13572.5 13663.5 13778.9 11817.3 12315.7 12342.6 12450.0 12454.8 12015.2 12169.6 12331.4 12449.4 12649.1 12503.2 12563.2 12582.8 12669.9 12838.9 8077.1 8268.6 8780.3 8827.8 9259.8 9364.0 12148.5 12542.7 12585.6 12631.2 03:45:39 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | [#3] mootools.html Cycles:180 Average:6238.58 Median:4460.06 stddev:3559.59 (79.8%) stddev-sans-first:3551.14 03:45:39 INFO - PROCESS | 18418 | Values: 1417.6 1547.5 1583.9 1777.7 1906.7 8595.6 8769.8 8820.0 9061.4 9080.4 8867.4 9012.5 9025.1 9047.1 9047.2 2182.7 2443.4 2478.7 2483.3 2550.4 2534.1 2544.9 2547.4 2550.4 2555.9 2515.6 2553.5 2560.1 2560.6 2564.0 2113.6 2392.2 2398.3 2461.3 2462.8 2484.8 2496.9 2514.0 2514.6 2540.0 9278.8 9373.7 9377.8 9389.4 9410.1 5719.5 5857.9 5858.6 5861.8 5863.5 3610.4 3710.6 3771.6 3858.4 3864.3 1191.6 1205.6 1223.2 1228.6 1236.6 13340.3 13341.3 13369.1 13407.2 13410.6 5203.9 5224.0 5262.2 5266.4 5298.6 11371.8 11423.0 11426.2 11426.4 11460.7 5821.6 5877.2 5888.4 5891.1 5925.3 4558.0 5162.1 5285.4 5300.5 5368.0 4354.0 4358.1 4430.1 4454.0 4466.2 1366.6 1368.6 1375.1 1391.3 1400.0 1027.8 1040.0 1042.8 1046.4 1063.9 6069.7 6220.8 6282.4 6343.9 6382.8 471.7 478.5 479.0 1071.2 1112.1 4250.1 4266.1 4296.2 4297.2 4301.2 11679.3 11843.0 11892.5 11953.7 11959.3 11785.5 11868.2 11898.1 11911.5 11926.8 8329.6 8547.6 8555.0 8774.1 8781.9 6231.0 6408.6 6476.8 6483.4 6554.0 10978.1 10996.1 11032.8 11159.5 11190.2 10498.5 10764.5 10785.8 11015.4 11061.9 7284.8 7385.6 7392.3 8430.7 8596.3 8075.0 9198.3 9230.0 9464.8 9482.8 8308.7 8437.9 8619.4 8702.7 8728.8 8099.3 8101.6 8226.3 8332.0 8347.8 7698.3 7822.1 7825.6 7830.7 7841.8 5485.7 5521.0 5544.3 5572.7 5668.3 5383.7 5548.8 5604.9 5746.6 5790.0 03:45:39 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | [#4] prototype.html Cycles:180 Average:4705.18 Median:5279.72 stddev:1366.03 (25.9%) stddev-sans-first:1330.37 03:45:39 INFO - PROCESS | 18418 | Values: 360.5 366.5 367.6 369.3 370.9 5440.8 5454.1 5475.4 5511.8 5516.7 5264.2 5353.1 5421.9 5425.6 5433.5 4256.8 4260.6 4294.8 4305.2 4308.3 4286.0 4293.2 4307.8 4311.6 4332.5 4209.3 4238.4 4298.4 4328.3 4330.6 4036.4 4247.4 4249.0 4261.3 4332.4 3734.9 3749.6 3754.6 3758.5 3762.8 5128.7 5188.7 5284.9 5296.9 5330.9 4583.9 4818.2 4826.3 4855.2 4895.0 5613.6 5613.8 5619.6 5642.0 5656.8 4109.1 4118.2 4122.4 4126.9 4129.5 5762.2 5845.4 5883.3 5911.6 5935.9 4210.2 4217.8 4219.6 4238.2 4240.5 4274.8 4280.2 4281.3 4283.5 4311.7 4746.1 4821.0 4833.0 4875.0 4875.5 5611.5 5620.6 5645.8 5650.0 5656.8 1458.1 1463.4 1466.6 1471.6 1479.6 898.8 921.1 925.5 931.8 938.0 4884.7 4907.3 4925.7 4960.5 4972.9 5126.3 5156.2 5178.2 5206.7 5228.0 4573.8 4993.6 4999.4 5004.0 5045.6 2819.9 2822.3 2824.9 2825.9 2839.7 5274.6 5403.1 5417.7 5469.2 5497.5 5148.3 5340.3 5371.3 5640.6 5762.6 6022.9 6049.9 6066.8 6068.4 6073.9 5737.0 5803.9 5813.4 5840.8 5846.8 5131.7 5553.3 5723.4 5781.6 5812.9 5875.7 6025.2 6045.6 6061.7 6144.0 4076.2 4185.2 4203.6 4229.4 4236.4 5736.5 5753.5 5790.2 5791.5 5846.6 5646.0 5649.1 5670.7 5676.7 5687.1 5521.8 5649.4 5662.9 5683.6 5688.2 5462.3 5487.8 5497.2 5589.7 5612.9 5485.9 5658.5 5715.3 5731.0 5775.7 5550.6 5584.1 5585.9 5587.8 5595.3 03:45:39 INFO - PROCESS | 18418 | 03:45:39 INFO - PROCESS | 18418 | [#5] yui.html Cycles:180 Average:22238.15 Median:4858.50 stddev:31825.37 (655.0%) stddev-sans-first:31873.88 03:45:39 INFO - PROCESS | 18418 | Values: 783.5 784.8 786.4 793.2 909.5 16535.1 16561.1 16567.3 16731.5 17575.6 16366.3 16402.4 16489.8 16504.1 16522.4 711.7 836.7 836.8 859.6 864.0 840.7 842.7 844.7 846.7 847.6 899.2 902.8 905.2 905.7 906.1 747.5 878.9 886.3 893.7 901.0 663.6 663.7 664.2 664.2 664.4 16820.7 16852.7 16856.6 16882.2 16893.6 15767.0 16013.8 16028.5 16060.8 16226.8 13717.2 14139.3 14229.1 14239.6 14465.0 4816.5 4855.7 4884.5 4927.9 4938.7 78034.0 78419.0 78589.6 78757.6 86072.1 12413.9 12553.7 12589.7 12867.4 13050.9 23618.6 23631.4 23636.9 23651.6 23670.6 9057.5 9165.7 9166.7 9227.5 9275.5 5031.1 5065.9 5135.3 5177.6 5193.5 3856.9 4019.0 4026.2 4026.2 4030.8 654.9 659.0 680.0 703.1 748.9 694.6 700.5 768.5 787.8 789.4 10452.4 10472.8 10495.6 10547.9 10760.4 632.4 648.3 729.0 732.0 779.3 4861.3 4982.2 5004.6 5039.2 5071.2 87323.6 88198.1 88481.6 110981.0 125829.4 80574.0 93055.5 116907.0 118679.4 118727.0 102646.0 103558.5 103813.5 103844.0 105976.5 9478.4 9515.8 9633.7 9636.6 9682.7 51895.5 59495.7 59831.0 61338.4 61683.1 83957.0 85584.6 92155.0 93914.0 94406.0 12919.7 13227.5 13470.6 13604.4 13771.7 15245.8 15642.8 15700.9 15737.6 16185.7 9617.6 11555.0 13398.7 13745.1 14197.2 12861.5 13131.5 13156.9 13580.5 14001.6 12306.8 12736.6 12836.2 13251.7 13416.7 10760.9 10828.0 11048.8 11094.3 11562.4 10853.8 10985.7 11187.9 11281.1 11347.3 03:45:39 INFO - PROCESS | 18418 | -------- Summary: end -------- 03:45:39 INFO - PROCESS | 18418 | 03:45:40 INFO - TEST-INFO | 18418: exit 0 03:45:40 INFO - TEST-OK | dromaeo_css | took 1112687ms 03:45:40 INFO - TEST-START | kraken 03:45:40 INFO - operating with platform_type : linux_ 03:45:40 INFO - Initialising browser for kraken test... 03:45:40 INFO - TEST-INFO | started process 18609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXIjF2/profile http://localhost:39477/getInfo.html) 03:45:44 INFO - PROCESS | 18609 | __metrics Screen width/height:1600/1200 03:45:44 INFO - PROCESS | 18609 | colorDepth:24 03:45:44 INFO - PROCESS | 18609 | Browser inner width/height: 1024/697 03:45:44 INFO - PROCESS | 18609 | __metrics 03:45:45 INFO - PROCESS | 18609 | 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:45:45 ERROR - PROCESS | 18609 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:45:46 INFO - TEST-INFO | 18609: exit 0 03:45:46 INFO - Browser initialized. 03:45:46 INFO - Running cycle 1/1 for kraken test... 03:45:46 INFO - TEST-INFO | started process 18698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXIjF2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:58 INFO - PROCESS | 18698 | RSS: Main: 145555456 03:45:58 INFO - PROCESS | 18698 | 03:46:00 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39477/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:01 INFO - PROCESS | 18698 | RSS: Main: 194682880 03:46:01 INFO - PROCESS | 18698 | 03:46:04 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39477/tests/kraken/driver.html?testName=audio-dft) 03:46:04 INFO - PROCESS | 18698 | RSS: Main: 193335296 03:46:04 INFO - PROCESS | 18698 | 03:46:07 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39477/tests/kraken/driver.html?testName=audio-fft) 03:46:08 INFO - PROCESS | 18698 | RSS: Main: 279703552 03:46:08 INFO - PROCESS | 18698 | 03:46:10 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39477/tests/kraken/driver.html?testName=audio-oscillator) 03:46:10 INFO - PROCESS | 18698 | RSS: Main: 188862464 03:46:10 INFO - PROCESS | 18698 | 03:46:13 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:13 INFO - PROCESS | 18698 | RSS: Main: 189083648 03:46:13 INFO - PROCESS | 18698 | 03:46:16 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39477/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:17 INFO - PROCESS | 18698 | RSS: Main: 223956992 03:46:17 INFO - PROCESS | 18698 | 03:46:20 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39477/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:21 INFO - PROCESS | 18698 | RSS: Main: 224137216 03:46:21 INFO - PROCESS | 18698 | 03:46:24 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39477/tests/kraken/driver.html?testName=json-parse-financial) 03:46:24 INFO - PROCESS | 18698 | RSS: Main: 223113216 03:46:24 INFO - PROCESS | 18698 | 03:46:26 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:26 INFO - PROCESS | 18698 | RSS: Main: 201338880 03:46:26 INFO - PROCESS | 18698 | 03:46:28 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:29 INFO - PROCESS | 18698 | RSS: Main: 202137600 03:46:29 INFO - PROCESS | 18698 | 03:46:31 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:31 INFO - PROCESS | 18698 | RSS: Main: 208859136 03:46:31 INFO - PROCESS | 18698 | 03:46:34 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:34 INFO - PROCESS | 18698 | RSS: Main: 215859200 03:46:34 INFO - PROCESS | 18698 | 03:46:37 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:38 INFO - PROCESS | 18698 | RSS: Main: 216985600 03:46:38 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39477/tests/kraken/driver.html?testName=ai-astar) 03:46:39 INFO - PROCESS | 18698 | RSS: Main: 258760704 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | __start_tp_report 03:46:39 INFO - PROCESS | 18698 | _x_x_mozilla_page_load 03:46:39 INFO - PROCESS | 18698 | _x_x_mozilla_page_load_details 03:46:39 INFO - PROCESS | 18698 | |i|pagename|runs| 03:46:39 INFO - PROCESS | 18698 | |0;ai-astar;112;104;111;111;111;110;110;111;110;111 03:46:39 INFO - PROCESS | 18698 | |1;audio-beat-detection;160;123;124;174;125;128;150;123;175;124 03:46:39 INFO - PROCESS | 18698 | |2;audio-dft;159;160;161;160;161;159;159;161;160;159 03:46:39 INFO - PROCESS | 18698 | |3;audio-fft;76;75;76;120;76;76;75;75;98;75 03:46:39 INFO - PROCESS | 18698 | |4;audio-oscillator;84;83;116;84;85;85;118;83;83;138 03:46:39 INFO - PROCESS | 18698 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 03:46:39 INFO - PROCESS | 18698 | |6;imaging-darkroom;146;145;146;145;146;146;145;146;146;146 03:46:39 INFO - PROCESS | 18698 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;95;94 03:46:39 INFO - PROCESS | 18698 | |8;json-parse-financial;51;52;52;53;53;55;53;53;54;53 03:46:39 INFO - PROCESS | 18698 | |9;json-stringify-tinderbox;61;60;60;60;61;60;60;60;60;61 03:46:39 INFO - PROCESS | 18698 | |10;stanford-crypto-aes;77;76;77;76;82;77;78;78;110;83 03:46:39 INFO - PROCESS | 18698 | |11;stanford-crypto-ccm;126;121;118;118;117;125;120;120;128;121 03:46:39 INFO - PROCESS | 18698 | |12;stanford-crypto-pbkdf2;155;155;155;161;156;161;155;153;158;152 03:46:39 INFO - PROCESS | 18698 | |13;stanford-crypto-sha256-iterative;62;61;66;63;61;63;62;61;60;63 03:46:39 INFO - PROCESS | 18698 | __end_tp_report 03:46:39 INFO - PROCESS | 18698 | __start_cc_report 03:46:39 INFO - PROCESS | 18698 | _x_x_mozilla_cycle_collect,1632 03:46:39 INFO - PROCESS | 18698 | __end_cc_report 03:46:39 INFO - PROCESS | 18698 | __startTimestamp1469616399952__endTimestamp 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | ------- Summary: start ------- 03:46:39 INFO - PROCESS | 18698 | Number of tests: 14 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.23 (2.0%) stddev-sans-first:2.26 03:46:39 INFO - PROCESS | 18698 | Values: 112.0 104.0 111.0 111.0 111.0 110.0 110.0 111.0 110.0 111.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:139.00 stddev:21.95 (15.8%) stddev-sans-first:22.13 03:46:39 INFO - PROCESS | 18698 | Values: 160.0 123.0 124.0 174.0 125.0 128.0 150.0 123.0 175.0 124.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 03:46:39 INFO - PROCESS | 18698 | Values: 159.0 160.0 161.0 160.0 161.0 159.0 159.0 161.0 160.0 159.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:15.05 (19.8%) stddev-sans-first:15.80 03:46:39 INFO - PROCESS | 18698 | Values: 76.0 75.0 76.0 120.0 76.0 76.0 75.0 75.0 98.0 75.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:83.50 stddev:20.23 (24.2%) stddev-sans-first:21.00 03:46:39 INFO - PROCESS | 18698 | Values: 84.0 83.0 116.0 84.0 85.0 85.0 118.0 83.0 83.0 138.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:46:39 INFO - PROCESS | 18698 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:46:39 INFO - PROCESS | 18698 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:46:39 INFO - PROCESS | 18698 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.10 (2.1%) stddev-sans-first:0.93 03:46:39 INFO - PROCESS | 18698 | Values: 51.0 52.0 52.0 53.0 53.0 55.0 53.0 53.0 54.0 53.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 03:46:39 INFO - PROCESS | 18698 | Values: 61.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:77.50 stddev:10.33 (13.3%) stddev-sans-first:10.83 03:46:39 INFO - PROCESS | 18698 | Values: 77.0 76.0 77.0 76.0 82.0 77.0 78.0 78.0 110.0 83.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:121.00 stddev:3.72 (3.1%) stddev-sans-first:3.55 03:46:39 INFO - PROCESS | 18698 | Values: 126.0 121.0 118.0 118.0 117.0 125.0 120.0 120.0 128.0 121.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:155.50 stddev:3.03 (2.0%) stddev-sans-first:3.19 03:46:39 INFO - PROCESS | 18698 | Values: 155.0 155.0 155.0 161.0 156.0 161.0 155.0 153.0 158.0 152.0 03:46:39 INFO - PROCESS | 18698 | 03:46:39 INFO - PROCESS | 18698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.69 (2.7%) stddev-sans-first:1.79 03:46:39 INFO - PROCESS | 18698 | Values: 62.0 61.0 66.0 63.0 61.0 63.0 62.0 61.0 60.0 63.0 03:46:39 INFO - PROCESS | 18698 | -------- Summary: end -------- 03:46:39 INFO - PROCESS | 18698 | 03:46:40 INFO - TEST-INFO | 18698: exit 0 03:46:40 INFO - TEST-OK | kraken | took 60404ms 03:46:40 INFO - SUITE-END | took 1173s 03:46:41 INFO - Completed test suite (00:19:33) 03:46:41 INFO - javascript benchmark 03:46:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.1620286826865, 3312.53624492571, 3316.485944678574, 3347.882824101157, 3367.848446819893, 5418.160185171299, 5476.561875049996, 5481.314835645544, 5484.670919744818, 5528.060229760935, 5489.945100549004, 5539.196816461611, 5545.0, 5558.194061861028, 5583.05088135017, 4901.460839307673, 4902.828401005965, 5008.6493945423745, 5016.122178618745, 5032.622553308498, 4909.386326709161, 4996.525330093654, 5000.1249781288125, 5003.724795136284, 5008.474110218411, 5119.385673719159, 5123.948760512403, 5125.179971204608, 5127.897442051157, 5129.743512824362, 5099.107656160194, 5108.948910510884, 5110.948890511085, 5118.10433174193, 5155.845324640267, 4849.078675051765, 4930.457649658535, 4950.158473059589, 5028.673136246132, 5053.69677819332, 5223.921641175385, 5311.946880531223, 5314.787408503656, 5348.438413966516, 5353.625246232766, 5821.388754180793, 5824.271966004249, 5860.238169038041, 5869.85325366865, 5873.530117590625, 5699.116636921242, 5738.397468265855, 5801.448862358069, 5829.300483941912, 5919.763209471616, 5387.703676297802, 5393.568514518868, 5414.864628384283, 5496.120620700669, 5496.340439147248, 5963.761449541969, 5973.37279585646, 5975.163477113208, 5975.462208401264, 5979.953508136059, 5615.410381909841, 5672.943270567242, 5744.138379243147, 5750.1949727038245, 5824.592278540546, 5851.970740146272, 5870.26621672291, 5885.440883116097, 5896.1450589664255, 5908.261467316585, 5678.744456499468, 5820.592558520948, 5845.795397161079, 5847.181394604759, 5849.0, 5738.397468265772, 5783.248177736868, 5800.506956908625, 5833.329167145747, 5843.211166492554, 4503.842365517191, 4506.59440650343, 4507.639388848885, 4513.9322910155715, 4514.25514790056, 3963.7621742694955, 3992.48097747291, 4038.5557588665224, 4059.411385349108, 4071.2468193383725, 5561.721913904288, 5583.972080139573, 5595.608307418442, 5600.943990560042, 5617.213590097308, 5881.235439392937, 5912.645241285537, 5913.881722365614, 5915.3788852170765, 5940.8811823764145, 5432.511074003359, 5575.609707320448, 5607.8317650469735, 5625.578081643811, 5626.43735626434, 4992.301077849104, 5019.974900125476, 5022.341999471979, 5022.773975171126, 5025.321581586439, 6181.412765787243, 6210.7515699372425, 6234.345393733593, 6235.189425374672, 6238.75044998195, 5743.655380677173, 5773.1051686988585, 5823.621464604787, 5826.533877289722, 5887.352391236875, 6097.634141951497, 6104.603200791934, 6108.877822443437, 6113.29697084841, 6122.204113465221, 5584.134459158837, 5745.253117094918, 5747.3103227612955, 5762.942370576408, 5767.769289228551, 5856.970715146397, 5892.440218179438, 5908.468237858613, 5954.464098231007, 5962.5528085394635, 5807.0, 5811.56413268998, 5835.620684655484, 5847.766089356378, 5864.208331875313, 5498.532624726783, 5705.372409035086, 5804.82585522435, 5806.6516009037905, 5812.651240925389, 5646.407127251744, 5704.429557044263, 5708.429157084424, 5711.143328500758, 5747.971260143672, 5787.421257874179, 5821.185034095145, 5869.559783016205, 5869.706514674163, 5871.178035075179, 5481.123020316731, 5620.325560932714, 5668.829935101953, 5707.200991861226, 5739.770409183586], "value": 5423.442279995386, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.8333958161505, 648.2771709543857, 659.2352870670022, 665.0456594786485, 673.373762400967, 34785.82607086964, 46153.307700384525, 47312.0, 47384.52615473844, 51554.0, 48347.51652483474, 48965.0, 48966.26550601744, 49134.0, 49146.26280605785, 8297.253247207751, 8979.775505612362, 9135.0, 10518.421486818223, 10842.783144337109, 10763.892361076407, 10766.623168189115, 10840.78318433631, 10884.673459796179, 10885.455727213608, 10947.781044379108, 10967.0, 10973.83539246912, 10983.0, 10996.23026388153, 8289.792755181108, 10579.841302380431, 10839.67480975572, 10850.728731781768, 11157.944210278896, 10672.359658420519, 10888.510017049251, 10889.183311251687, 10890.945545272223, 10896.509657065371, 45626.77186614046, 45986.54013459856, 46110.53889461096, 46120.0, 46124.0, 3704.833282502294, 3811.8856434307013, 3833.821481492491, 4078.7960601969785, 4327.675424343155, 35121.0, 35355.0, 35395.469067964004, 35679.4648080279, 35787.28425431477, 4708.816486322656, 4752.382190315237, 4784.952150478485, 4845.515448455161, 4911.214205727067, 376931.0, 376973.0, 377132.0, 377628.0, 377698.0, 36701.81649091791, 62364.37635623677, 62674.0, 62709.0, 62827.0, 38425.0, 40658.79670601628, 40740.79629601833, 40796.59203407928, 40844.0, 13576.389062492211, 17299.74050389245, 17385.65228695419, 17443.65112697739, 17448.47654570365, 10882.238243322892, 11231.157663175294, 12764.80852787209, 12858.614241572768, 12874.67813304675, 9130.543472826464, 9214.63141474347, 9223.631054757734, 9258.95370523143, 9277.257819374434, 3469.2541103662834, 3494.4583589543663, 3496.9300613988084, 3505.1938054247667, 3551.627079156703, 1023.7287118913493, 1075.0593230922943, 1087.581281206741, 1164.953401863916, 1165.7493638867684, 31265.0, 31601.0, 31965.68034319627, 32236.0, 32770.214531765065, 1125.7917285302244, 1251.3680591301516, 1274.8024056271292, 1296.9870301297055, 1320.6962398648366, 17457.650846983244, 17613.0, 17739.822601773816, 17848.375306864196, 18188.36340728068, 645800.0, 650890.0, 651489.0, 653570.0, 654704.0, 63747.36252637414, 64489.35510644833, 64493.67753161298, 64574.0, 64702.029469557994, 1337.1175024483794, 1448.66680663448, 1475.1370448287657, 1481.8740407065304, 1505.4128889733013, 34634.0, 35152.47271290984, 35867.461988070725, 36119.638803611626, 36122.819385902905, 54612.45387546233, 55191.17213241885, 55419.0, 55421.16868246899, 55515.612109697584, 404260.0, 405620.0, 406902.0, 407172.0, 407710.0, 26419.471610568067, 44984.32523512215, 49729.75135124301, 50961.0, 54509.182362263804, 48893.2666010003, 50214.246786298965, 50726.23910641417, 55629.653222917135, 55926.72036639791, 43420.56579434165, 43711.344329835716, 44669.56391428221, 45049.77475112603, 45121.32318015167, 43869.0, 43923.78038109789, 44711.329330060726, 44755.776221118685, 45491.0, 46301.30548041715, 46618.0, 47079.0, 47195.764021179675, 47292.7635361821, 38405.0, 40805.0, 40885.59114408937, 41007.58992410038, 41091.0, 30504.542431863098, 30572.388552228385, 30577.388452230385, 30662.233444164074, 31217.84391078121], "value": 20906.38155252303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.0779639048722, 430.38240125420015, 434.5676052327934, 440.10438757129236, 448.05236923905926, 18778.248870045198, 19829.40511784647, 20694.89652551739, 20816.959152042415, 20817.375478735623, 19686.60626787467, 20496.69254961177, 21040.789592104073, 21055.789442105575, 21058.052387642594, 5733.283339582563, 5911.527077833763, 5912.9113063304085, 5956.672383018932, 5956.88086238275, 4082.6937979651498, 5658.377578466366, 5707.800226992056, 5869.50109240715, 5954.851128721795, 5941.494972927307, 5995.700214989255, 6006.0390337546005, 6026.0, 6036.909446358308, 5868.97065514674, 5994.910076348837, 6034.69826508675, 6104.847378815521, 6109.511239100883, 5609.467100625475, 5832.445917637818, 5834.620749651259, 5843.298804143487, 5852.268466441695, 14953.626159345995, 15130.54608361751, 15146.848531514654, 15181.544553663407, 18678.0, 2388.845457334273, 2484.1802205272215, 2577.3298942274955, 2883.3944871576996, 3103.5810165627577, 10290.79418411635, 10621.84067238992, 10971.23201375904, 11110.0, 11197.552097916074, 1968.3897991622644, 1971.8816870987787, 2057.4856285928518, 2084.8540602157855, 2140.5076832328496, 86771.56614216951, 88233.0, 88751.55624221903, 88771.55614221888, 91120.54439727825, 11650.592229271935, 11869.5845645402, 11969.222000569935, 12015.279083255033, 12045.39773011346, 17001.744973825404, 17161.313547458212, 17197.0, 17238.482845514656, 17242.396516122128, 8797.076306987801, 8832.77918052041, 8837.823243535093, 8925.866112008196, 9016.233620142362, 8528.275096616733, 8597.828043439096, 8612.5693715314, 8743.91256087431, 8798.120187981278, 5003.124453220672, 5131.384233891957, 5167.224916262516, 5192.532672059533, 5216.504432078947, 1779.3800682369463, 1850.6391253705667, 2014.4359579317816, 2059.7116403703494, 2106.7577228618597, 976.8095221431895, 993.7515621094726, 1016.898310168992, 1017.7964407118606, 1117.017831430946, 19859.602807944048, 19971.60056798856, 20151.496212594804, 20239.797602024086, 20537.075831587616, 1050.5167622893555, 1073.5974009746344, 1076.2950267574752, 1088.5482524752297, 1094.3379255550437, 11000.944995275133, 11261.042811361127, 11303.491342889425, 11330.546778128948, 11421.543138274375, 391408.0, 486077.0, 513233.0, 513967.0, 514733.0, 90240.0, 110565.0, 111645.44177279224, 112521.43739281414, 113596.0, 1097.155190503308, 1101.3336931156696, 1103.8564986551858, 1146.4439746722833, 1159.5187996981158, 18505.90747046256, 18587.628247435245, 19011.619767604847, 19206.61586768285, 19331.4200573983, 41301.1739765197, 43920.78039609909, 45144.54855451403, 45752.31371529363, 46473.302900457194, 57093.0, 57316.0, 62966.37033629605, 63596.68201658962, 63765.36234637594, 8822.779430514289, 9213.401128926598, 9289.674861379819, 9432.952835236054, 9571.952140239255, 11021.889781102407, 13207.339633018502, 13572.52496162669, 13663.453461861813, 13778.931105344811, 11817.290962542274, 12315.69210769738, 12342.629721108382, 12450.0, 12454.750904982031, 12015.158938874545, 12169.634910952685, 12331.445084971378, 12449.37753112359, 12649.114561980941, 12503.187292825936, 12563.18339307942, 12582.811257831323, 12669.936650317059, 12838.871611284141, 8077.071136819106, 8268.627911744106, 8780.341474389574, 8827.823443531222, 9259.76850578741, 9363.953180234055, 12148.453319600816, 12542.749145016865, 12585.559505417266, 12631.242125472134], "value": 9662.851475662444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.5888992192265, 1547.512533551931, 1583.9128847913364, 1777.6711308407946, 1906.68539690951, 8595.613197406115, 8769.824603507926, 8819.955900220506, 9061.411008284456, 9080.409773364743, 8867.42361746486, 9012.54937253138, 9025.142611451918, 9047.09529047095, 9047.185753282203, 2182.7271591051117, 2443.3647251714506, 2478.652988581591, 2483.3170878008514, 2550.3624093976505, 2534.1383929463977, 2544.8982040718347, 2547.4395632960814, 2550.413404916861, 2555.872206389673, 2515.6226566015152, 2553.502067096917, 2560.1423523119684, 2560.6287088372173, 2563.9743602564017, 2113.5561532078204, 2392.2464423706565, 2398.3164798032476, 2461.2862269941875, 2462.815288853343, 2484.76394742501, 2496.8501889886666, 2514.0446630280558, 2514.5976643736913, 2540.0347867810297, 9278.814423711488, 9373.671921482784, 9377.76555586109, 9389.38968967015, 9410.058994100604, 5719.542436605062, 5857.912131318034, 5858.648481091148, 5861.824145275648, 5863.472287494146, 3610.4403817408343, 3710.628937106295, 3771.622837716234, 3858.3633700439395, 3864.265789499986, 1191.6305945157028, 1205.5780476833127, 1223.2232532341939, 1228.6314105768324, 1236.5733821831454, 13340.33298335089, 13341.332933353293, 13369.131006484547, 13407.195568265837, 13410.597682069554, 5203.9219411708855, 5224.003637217532, 5262.236975638511, 5266.368035835724, 5298.576113910878, 11371.772564548663, 11423.029042531312, 11426.200165988468, 11426.428678566039, 11460.656180314603, 5821.621594596338, 5877.23595932526, 5888.440598143169, 5891.05743081105, 5925.259342582177, 4557.977210113994, 5162.096633089194, 5285.392179899284, 5300.522952934254, 5368.0, 4354.020345422318, 4358.084802191512, 4430.069685366109, 4453.955460445419, 4466.173757854807, 1366.590022993098, 1368.6304697731557, 1375.05121466188, 1391.3252072744913, 1399.979000314996, 1027.845823126537, 1040.0483557544912, 1042.8227201375785, 1046.4192373232777, 1063.9414832184304, 6069.666168360694, 6220.7511699531515, 6282.434580887742, 6343.851851116928, 6382.808515744535, 471.67459438976584, 478.4856279499552, 479.0419161676647, 1071.1912506058031, 1112.0880877680386, 4250.06498570314, 4266.1254442839145, 4296.248156572649, 4297.247981603207, 4301.2257793597455, 11679.299242045505, 11843.0, 11892.464839082262, 11953.701157471132, 11959.342236177094, 11785.528578856749, 11868.228565143238, 11898.10764192689, 11911.463984120735, 11926.761464770656, 8329.583520823935, 8547.615357308936, 8555.0, 8774.078721734253, 8781.912180878237, 6231.0, 6408.647524386017, 6476.805695829133, 6483.448906842783, 6554.016897465418, 10978.066864316303, 10996.06533444634, 11032.834507482234, 11159.49782259784, 11190.160737944849, 10498.47507624631, 10764.46177691128, 10785.784284314426, 11015.394153321644, 11061.94469027682, 7284.781456556099, 7385.593792341473, 7392.334689877936, 8430.704925327584, 8596.312295016509, 8075.0, 9198.310126740387, 9229.953850230706, 9464.763380915532, 9482.762930926507, 8308.70919517814, 8437.915620843713, 8619.353548484014, 8702.738917832476, 8728.825423491367, 8099.271065604124, 8101.594920253846, 8226.30076443509, 8331.958340208503, 8347.83304333922, 7698.307152356091, 7822.06135263772, 7825.608719564113, 7830.725924592612, 7841.843163136591, 5485.725713714378, 5521.003060048542, 5544.251526043932, 5572.665640061609, 5668.348139963957, 5383.676979381093, 5548.778048878, 5604.85987850307, 5746.597738158456, 5789.986752318412], "value": 4954.560705439535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.5475128713465, 366.5180287921383, 367.5589292848581, 369.2614770459082, 370.885025642051, 5440.836774896755, 5454.127339625661, 5475.425080366564, 5511.834644960648, 5516.696581688006, 5264.210368444726, 5353.116735738608, 5421.918671219925, 5425.562226010111, 5433.4566543345645, 4256.787160641971, 4260.552641972595, 4294.806733696991, 4305.22505948929, 4308.332208507686, 4285.978570107145, 4293.205756934977, 4307.763073030982, 4311.611954924057, 4332.505285676452, 4209.284421648327, 4238.427812245338, 4298.355246712987, 4328.285832837578, 4330.618160011996, 4036.3541833306676, 4247.384129301265, 4248.957510424887, 4261.296886013804, 4332.436783218177, 3734.8692795752017, 3749.6313845446216, 3754.6433088856515, 3758.530183727034, 3762.811859407019, 5128.743562821881, 5188.742896839887, 5284.894302113936, 5296.894062118736, 5330.866728331784, 4583.862484125481, 4818.180909245437, 4826.300186472977, 4855.223164293696, 4895.0, 5613.635113717595, 5613.775448982035, 5619.578531610146, 5641.971790141064, 5656.830295091154, 4109.0959988802715, 4118.155778065489, 4122.361034039699, 4126.91746165078, 4129.483814523184, 5762.222100016486, 5845.357010728816, 5883.294004719418, 5911.556633252523, 5935.910961335583, 4210.157968406331, 4217.810198541073, 4219.641330486943, 4238.19474299882, 4240.533541310453, 4274.807633656493, 4280.16536775332, 4281.336392859112, 4283.507396649363, 4311.655067594585, 4746.145693775154, 4820.975895120502, 4832.95167048325, 4875.0, 4875.488073752276, 5611.523020543218, 5620.606557540933, 5645.826356852641, 5649.994252040467, 5656.830295091154, 1458.139697578434, 1463.436576917873, 1466.5600319903986, 1471.565888063024, 1479.6387323662257, 898.7753061734567, 921.1111277617132, 925.5048549026374, 931.7577429868147, 937.9671711490201, 4884.681136093235, 4907.312976183337, 4925.729084900293, 4960.479149689303, 4972.925406118911, 5126.333941469037, 5156.226566015052, 5178.223266510054, 5206.713630750345, 5227.973860130675, 4573.765083427456, 4993.625478089158, 4999.375078115236, 5003.974980125076, 5045.621578381636, 2819.873105710248, 2822.3348224547617, 2824.901128460494, 2825.90109346176, 2839.701831307683, 5274.551663108678, 5403.135498320328, 5417.674939503563, 5469.234307196995, 5497.532709719639, 5148.279240906276, 5340.25236466895, 5371.301730774974, 5640.618048578124, 5762.567807414377, 6022.879542409215, 6049.909251361233, 6066.817995460055, 6068.423499767515, 6073.939260607426, 5736.971315143398, 5803.9419605803405, 5813.447722466359, 5840.8247752567495, 5846.824595262149, 5131.717755523482, 5553.334399488187, 5723.370429252695, 5781.566382521243, 5812.912806307824, 5875.73559189846, 6025.246844144482, 6045.576809623284, 6061.696915154136, 6144.0, 4076.205139997672, 4185.246655602021, 4203.64269037123, 4229.429027081428, 4236.406903033516, 5736.512396446349, 5753.539716822728, 5790.189373487631, 5791.507721843691, 5846.632113993839, 5645.971770141123, 5649.067903795992, 5670.688112153871, 5676.68778217202, 5687.118496633028, 5521.834344969658, 5649.350324712546, 5662.876421341996, 5683.60214784961, 5688.232088667977, 5462.317210348707, 5487.835364939058, 5497.175423686319, 5589.664620122806, 5612.943870561406, 5485.862853428696, 5658.462446067617, 5715.2855893013375, 5730.971345143247, 5775.7400916957995, 5550.55595552363, 5584.134459158837, 5585.916211256753, 5587.804426845203, 5595.272614560081], "value": 4276.7010445226315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.4594130050265, 784.843031393721, 786.3630459327943, 793.2107552984781, 909.4588719711769, 16535.09057001863, 16561.08914009729, 16567.337306507754, 16731.498055058353, 17575.648487030267, 16366.263518141683, 16402.425915092976, 16489.752653710173, 16504.092274924875, 16522.42171523997, 711.6833009310859, 836.7322456813822, 836.8493671139192, 859.6346552715103, 864.0107077396377, 840.6595328891779, 842.6882053640131, 844.6832437835811, 846.6571038729294, 847.559269180026, 899.163777686751, 902.8104098139398, 905.1808113657117, 905.7373361725125, 906.0803284666069, 747.5477336211568, 878.89892662344, 886.2599729226104, 893.7229458867772, 900.9729708108767, 663.5852592129919, 663.7146027208298, 664.2095905872045, 664.2162248546713, 664.3987191591617, 16820.74768878468, 16852.662946740995, 16856.57858553534, 16882.15589220534, 16893.57766055846, 15767.0, 16013.759793603105, 16028.519144425685, 16060.75908861368, 16226.756598651029, 13717.161870467848, 14139.293035348293, 14229.14625122496, 14239.572812815632, 14465.0, 4816.54242846929, 4855.732934688591, 4884.511548845123, 4927.90144197114, 4938.678985865908, 78034.0, 78419.0, 78589.60705196437, 78757.60621196915, 86072.13927860766, 12413.875861241453, 12553.748925021448, 12589.685257868443, 12867.356632168354, 13050.869491305155, 23618.64572031421, 23631.409214769425, 23636.881815590812, 23651.645225321634, 23670.64494032591, 9057.547122643842, 9165.679201227926, 9166.67916622915, 9227.53862306882, 9275.536223188814, 5031.094403007421, 5065.901551152209, 5135.2553879687985, 5177.637565370388, 5193.480651934777, 3856.8650097246464, 4019.0, 4026.1947610478023, 4026.2350153471334, 4030.7581545107387, 654.8501706790354, 658.9505787065989, 679.9796006119824, 703.1491894807341, 748.9363404110711, 694.6457306773582, 700.4886432903907, 768.5273556762662, 787.7715462515921, 789.3961119743401, 10452.372857628567, 10472.790544189074, 10495.632652857113, 10547.894521054845, 10760.3543787373, 632.4150161100963, 648.2965981909587, 728.9635518224068, 731.9707211711578, 779.3103103753219, 4861.27080937855, 4982.177940639826, 5004.574611158092, 5039.193729003342, 5071.2139618359215, 87323.56338218396, 88198.11801881899, 88481.55759221292, 110981.0, 125829.37085314514, 80574.0, 93055.53472232596, 116907.0, 118679.40660296644, 118727.0, 102646.0, 103558.48220758847, 103813.48093259486, 103844.0, 105976.47011764892, 9478.431294122374, 9515.809683806423, 9633.662821801203, 9636.614535418505, 9682.70951871445, 51895.481045189066, 59495.70252148712, 59831.0, 61338.38661613327, 61683.07475387783, 83957.0, 85584.57207713922, 92155.0, 93914.0, 94406.0, 12919.677008074874, 13227.470901163846, 13470.595882123553, 13604.387802549107, 13771.724565508433, 15245.771313430529, 15642.843571564139, 15700.92149539245, 15737.606559835638, 16185.67628647444, 9617.56720947573, 11555.0, 13398.665033374244, 13745.055556659938, 14197.219152946687, 12861.549845755353, 13131.474741010252, 13156.868431315565, 13580.456781729015, 14001.579952601438, 12306.75386492283, 12736.554220602606, 12836.229826210458, 13251.734965300833, 13416.664583385493, 10760.946195268974, 10828.0, 11048.779024419306, 11094.278871873303, 11562.421878906189, 10853.782924341627, 10985.725356866142, 11187.878968757228, 11281.09751219884, 11347.262427942158], "value": 8050.438450031792, "unit": "score"}], "name": "dromaeo_css", "value": 7561.469137037535, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 111.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 124.0, 174.0, 125.0, 128.0, 150.0, 123.0, 175.0, 124.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 160.0, 161.0, 159.0, 159.0, 161.0, 160.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 120.0, 76.0, 76.0, 75.0, 75.0, 98.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 84.0, 85.0, 85.0, 118.0, 83.0, 83.0, 138.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 53.0, 53.0, 55.0, 53.0, 53.0, 54.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 76.0, 82.0, 77.0, 78.0, 78.0, 110.0, 83.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 118.0, 118.0, 117.0, 125.0, 120.0, 120.0, 128.0, 121.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 155.0, 161.0, 156.0, 161.0, 155.0, 153.0, 158.0, 152.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 66.0, 63.0, 61.0, 63.0, 62.0, 61.0, 60.0, 63.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1480.2000000000003, "alertThreshold": 2.0}]} 03:46:41 INFO - Return code: 0 03:46:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:41 ERROR - # TBPL SUCCESS # 03:46:41 INFO - Running post-action listener: _resource_record_post_action 03:46:41 INFO - ##### 03:46:41 INFO - ##### Finished run-tests step (success) 03:46:41 INFO - ##### 03:46:41 INFO - Running post-run listener: _resource_record_post_run 03:46:41 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 290816; Write bytes: 505229312; Read time: 40; Write time: 354332 03:46:41 INFO - TinderboxPrint: CPU usage
13.1% 03:46:41 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 40 03:46:41 INFO - TinderboxPrint: I/O write bytes / time
505,229,312 / 354,332 03:46:41 INFO - TinderboxPrint: CPU idle
8,253.2 (86.9%) 03:46:41 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 03:46:41 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252731392; Read time: 0; Write time: 229928 03:46:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252497920; Read time: 24; Write time: 124404 03:46:41 INFO - Running post-run listener: _upload_blobber_files 03:46:41 INFO - Blob upload gear active. 03:46:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46: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:46: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:46: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:46:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:46:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:46:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:43 INFO - (blobuploader) - INFO - Done attempting. 03:46:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:46:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:46:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:43 INFO - (blobuploader) - INFO - Done attempting. 03:46:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:57 INFO - (blobuploader) - INFO - Done attempting. 03:46:57 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:57 INFO - Return code: 0 03:46:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e00b2a353e113ead8c879e9a47fcf4f3ff91650f773b4f5f3cc7b31cc5bc09cae47d0a39a5ac06adea6e8839444b161cdb02b86ca88e5ab77b50133253e5cf95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c915ece586e744ce838a35a90fa032aa31f54181a345b621d2b932333365c8f0adb5860ea5777ed57a5f1ec3926e867ed4c96a3af855be8fab8d960622b03c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0006c940bedb9a38bfc863b7f10d7968ad5ea20456c9681d0b7becce5231925c64806b65921e8e04d5ecded1abe337bfad32e7b91e147ca51f7778cd36d6c17"} 03:46:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:57 INFO - Contents: 03:46:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e00b2a353e113ead8c879e9a47fcf4f3ff91650f773b4f5f3cc7b31cc5bc09cae47d0a39a5ac06adea6e8839444b161cdb02b86ca88e5ab77b50133253e5cf95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c915ece586e744ce838a35a90fa032aa31f54181a345b621d2b932333365c8f0adb5860ea5777ed57a5f1ec3926e867ed4c96a3af855be8fab8d960622b03c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0006c940bedb9a38bfc863b7f10d7968ad5ea20456c9681d0b7becce5231925c64806b65921e8e04d5ecded1abe337bfad32e7b91e147ca51f7778cd36d6c17"} 03:46:57 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:57 INFO - Copying logs to upload dir... 03:46:57 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.552322 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-27 03:46:57.916015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 03:46:57.920288) ========= 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=337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449 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/e00b2a353e113ead8c879e9a47fcf4f3ff91650f773b4f5f3cc7b31cc5bc09cae47d0a39a5ac06adea6e8839444b161cdb02b86ca88e5ab77b50133253e5cf95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c915ece586e744ce838a35a90fa032aa31f54181a345b621d2b932333365c8f0adb5860ea5777ed57a5f1ec3926e867ed4c96a3af855be8fab8d960622b03c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0006c940bedb9a38bfc863b7f10d7968ad5ea20456c9681d0b7becce5231925c64806b65921e8e04d5ecded1abe337bfad32e7b91e147ca51f7778cd36d6c17"} build_url:https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/BLJy7x6DRrWhlCw8xrqfKQ/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/e00b2a353e113ead8c879e9a47fcf4f3ff91650f773b4f5f3cc7b31cc5bc09cae47d0a39a5ac06adea6e8839444b161cdb02b86ca88e5ab77b50133253e5cf95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c915ece586e744ce838a35a90fa032aa31f54181a345b621d2b932333365c8f0adb5860ea5777ed57a5f1ec3926e867ed4c96a3af855be8fab8d960622b03c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0006c940bedb9a38bfc863b7f10d7968ad5ea20456c9681d0b7becce5231925c64806b65921e8e04d5ecded1abe337bfad32e7b91e147ca51f7778cd36d6c17"}' ========= master_lag: 0.34 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 03:46:58.272086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:46:58.272402) ========= 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=337fe3f4b1febe37b85fccc40000019e-1469615127.277594-1830750449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004037 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:46:58.288641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 03:46:58.288904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 03:46:58.289193) ========= ========= Total master_lag: 1.03 =========